builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0354 starttime: 1476219950.17 results: success (0) buildid: 20161011121046 builduid: a24d6d5684e04daa944da3b55c28972d revision: fe1d7c28668f0eb07c2f91bd0b3b0fa635d82387 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 14:05:50.169749) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-11 14:05:50.170175) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 14:05:50.170470) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-11 14:05:50.304774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 14:05:50.305072) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cs5mKRrkIr/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-11 14:05:50-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 58.1M=0s 2016-10-11 14:05:50 (58.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.536509 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 14:05:50.866359) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 14:05:50.869678) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cs5mKRrkIr/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020527 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 14:05:50.918389) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-11 14:05:50.920283) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fe1d7c28668f0eb07c2f91bd0b3b0fa635d82387 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev fe1d7c28668f0eb07c2f91bd0b3b0fa635d82387 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cs5mKRrkIr/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-11 14:05:50,983 truncating revision to first 12 chars 2016-10-11 14:05:50,983 Setting DEBUG logging. 2016-10-11 14:05:50,983 attempt 1/10 2016-10-11 14:05:50,983 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fe1d7c28668f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-11 14:05:52,887 unpacking tar archive at: fx-team-fe1d7c28668f/testing/mozharness/ program finished with exit code 0 elapsedTime=2.155600 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-10-11 14:05:53.109462) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 14:05:53.109797) ========= script_repo_revision: fe1d7c28668f0eb07c2f91bd0b3b0fa635d82387 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-11 14:05:53.110181) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 14:05:53.110474) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-11 14:05:53.168845) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-11 14:05:53.169193) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cs5mKRrkIr/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 14:05:53 INFO - MultiFileLogger online at 20161011 14:05:53 in /builds/slave/test 14:05:53 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 14:05:53 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:05:53 INFO - {'append_to_log': False, 14:05:53 INFO - 'base_work_dir': '/builds/slave/test', 14:05:53 INFO - 'blob_upload_branch': 'Fx-Team', 14:05:53 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:05:53 INFO - 'branch': 'Fx-Team', 14:05:53 INFO - 'buildbot_json_path': 'buildprops.json', 14:05:53 INFO - 'config_files': ('talos/mac_config.py',), 14:05:53 INFO - 'default_actions': ('clobber', 14:05:53 INFO - 'read-buildbot-config', 14:05:53 INFO - 'download-and-extract', 14:05:53 INFO - 'populate-webroot', 14:05:53 INFO - 'create-virtualenv', 14:05:53 INFO - 'install', 14:05:53 INFO - 'run-tests'), 14:05:53 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:05:53 INFO - 'download_minidump_stackwalk': True, 14:05:53 INFO - 'download_symbols': 'ondemand', 14:05:53 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:05:53 INFO - 'tooltool.py': '/tools/tooltool.py', 14:05:53 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:05:53 INFO - '/tools/misc-python/virtualenv.py')}, 14:05:53 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:05:53 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:05:53 INFO - 'installer_path': 'installer.exe', 14:05:53 INFO - 'log_level': 'info', 14:05:53 INFO - 'log_name': 'talos', 14:05:53 INFO - 'log_to_console': True, 14:05:53 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:05:53 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:05:53 INFO - 'opt_config_files': (), 14:05:53 INFO - 'pip_index': False, 14:05:53 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:05:53 INFO - 'cmd': ('bash', 14:05:53 INFO - '-c', 14:05:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:05:53 INFO - 'enabled': True, 14:05:53 INFO - 'halt_on_failure': False, 14:05:53 INFO - 'name': 'check_screen_resolution'},), 14:05:53 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:05:53 INFO - 'cmd': ('bash', 14:05:53 INFO - '-c', 14:05:53 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:05:53 INFO - 'enabled': True, 14:05:53 INFO - 'halt_on_failure': False, 14:05:53 INFO - 'name': 'check_screen_resolution'},), 14:05:53 INFO - 'run_cmd_checks_enabled': True, 14:05:53 INFO - 'sps_profile': False, 14:05:53 INFO - 'sps_profile_interval': 0, 14:05:53 INFO - 'suite': 'dromaeojs', 14:05:53 INFO - 'system_bits': '32', 14:05:53 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:05:53 INFO - 'title': 't-yosemite-r7-0354', 14:05:53 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:05:53 INFO - 'use_talos_json': True, 14:05:53 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:05:53 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:05:53 INFO - 'work_dir': 'build'} 14:05:53 INFO - [mozharness: 2016-10-11 21:05:53.346980Z] Running clobber step. 14:05:53 INFO - Running pre-action listener: _resource_record_pre_action 14:05:53 INFO - Running main action method: clobber 14:05:53 INFO - rmtree: /builds/slave/test/build 14:05:53 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:05:54 INFO - Running post-action listener: _resource_record_post_action 14:05:54 INFO - [mozharness: 2016-10-11 21:05:54.250976Z] Finished clobber step (success) 14:05:54 INFO - [mozharness: 2016-10-11 21:05:54.251176Z] Running read-buildbot-config step. 14:05:54 INFO - Running pre-action listener: _resource_record_pre_action 14:05:54 INFO - Running main action method: read_buildbot_config 14:05:54 INFO - Using buildbot properties: 14:05:54 INFO - { 14:05:54 INFO - "project": "", 14:05:54 INFO - "product": "firefox", 14:05:54 INFO - "script_repo_revision": "production", 14:05:54 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 14:05:54 INFO - "repository": "", 14:05:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 14:05:54 INFO - "buildid": "20161011121046", 14:05:54 INFO - "pgo_build": "False", 14:05:54 INFO - "basedir": "/builds/slave/test", 14:05:54 INFO - "buildnumber": 182, 14:05:54 INFO - "slavename": "t-yosemite-r7-0354", 14:05:54 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 14:05:54 INFO - "platform": "yosemite_r7", 14:05:54 INFO - "scheduler": "tests-fx-team-macosx64-talos", 14:05:54 INFO - "branch": "fx-team", 14:05:54 INFO - "repo_path": "integration/fx-team", 14:05:54 INFO - "revision": "fe1d7c28668f0eb07c2f91bd0b3b0fa635d82387", 14:05:54 INFO - "stage_platform": "macosx64", 14:05:54 INFO - "builduid": "a24d6d5684e04daa944da3b55c28972d", 14:05:54 INFO - "slavebuilddir": "test" 14:05:54 INFO - } 14:05:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/G6kgXkztStegcAzn1FwINA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 14:05:54 INFO - Running post-action listener: _resource_record_post_action 14:05:54 INFO - [mozharness: 2016-10-11 21:05:54.254453Z] Finished read-buildbot-config step (success) 14:05:54 INFO - [mozharness: 2016-10-11 21:05:54.254591Z] Running download-and-extract step. 14:05:54 INFO - Running pre-action listener: _resource_record_pre_action 14:05:54 INFO - Running main action method: download_and_extract 14:05:54 INFO - mkdir: /builds/slave/test/build/tests 14:05:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:05:54 INFO - trying https://queue.taskcluster.net/v1/task/G6kgXkztStegcAzn1FwINA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 14:05:54 INFO - Downloading https://queue.taskcluster.net/v1/task/G6kgXkztStegcAzn1FwINA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 14:05:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G6kgXkztStegcAzn1FwINA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 14:05:55 INFO - Downloaded 1199 bytes. 14:05:55 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 14:05:55 INFO - Using the following test package requirements: 14:05:55 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 14:05:55 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:05:55 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 14:05:55 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:05:55 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 14:05:55 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:05:55 INFO - u'jsshell-mac.zip'], 14:05:55 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:05:55 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 14:05:55 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 14:05:55 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:05:55 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 14:05:55 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:05:55 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 14:05:55 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:05:55 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 14:05:55 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 14:05:55 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 14:05:55 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:05:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G6kgXkztStegcAzn1FwINA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 14:05:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G6kgXkztStegcAzn1FwINA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:05:55 INFO - Fetch https://queue.taskcluster.net/v1/task/G6kgXkztStegcAzn1FwINA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 14:05:56 INFO - Http code: 200 14:05:56 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 14:05:56 INFO - x-amz-cf-id: s82K0tocRQTsFsOyBuvSC5L7ydrNErVY2PU-0ZC-B_KZ9Mt052fZhg== 14:05:56 INFO - x-amz-version-id: 1TdWUQN4OHFiYDFUhbq7VZthMjv28fMH 14:05:56 INFO - Expected file size: 16508479 14:05:56 INFO - Obtained file size: 16508479 14:06:03 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:06:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G6kgXkztStegcAzn1FwINA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 14:06:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G6kgXkztStegcAzn1FwINA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:06:03 INFO - Fetch https://queue.taskcluster.net/v1/task/G6kgXkztStegcAzn1FwINA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 14:06:04 INFO - Http code: 200 14:06:04 INFO - via: 1.1 336f0e6ef9a3462f682d6ca49029b665.cloudfront.net (CloudFront) 14:06:04 INFO - x-amz-cf-id: RuuQlRZV8nXocwTdSk84qgNIv-tIusVyaWR7nsyAdpfsCM69gDsPmA== 14:06:04 INFO - x-amz-version-id: 1TdWUQN4OHFiYDFUhbq7VZthMjv28fMH 14:06:04 INFO - Expected file size: 16508479 14:06:04 INFO - Obtained file size: 16508479 14:06:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/G6kgXkztStegcAzn1FwINA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 14:06:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/G6kgXkztStegcAzn1FwINA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:06:10 INFO - Fetch https://queue.taskcluster.net/v1/task/G6kgXkztStegcAzn1FwINA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 14:06:11 INFO - Http code: 200 14:06:11 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 14:06:11 INFO - x-amz-cf-id: zFd9XrEg-6J--2EoqwWWOlsDoDlCX84V3ExmwcmOTW0Bghm9P8adzQ== 14:06:11 INFO - x-amz-version-id: flbRT7LOV.v_105HXx9ebXZvukeXdhvr 14:06:12 INFO - Expected file size: 14409006 14:06:12 INFO - Obtained file size: 14409006 14:06:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:12 INFO - trying https://queue.taskcluster.net/v1/task/G6kgXkztStegcAzn1FwINA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:06:12 INFO - Downloading https://queue.taskcluster.net/v1/task/G6kgXkztStegcAzn1FwINA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 14:06:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/G6kgXkztStegcAzn1FwINA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 14:06:15 INFO - Downloaded 111677843 bytes. 14:06:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/G6kgXkztStegcAzn1FwINA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:06:15 INFO - mkdir: /builds/slave/test/properties 14:06:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:06:15 INFO - Writing to file /builds/slave/test/properties/build_url 14:06:15 INFO - Contents: 14:06:15 INFO - build_url:https://queue.taskcluster.net/v1/task/G6kgXkztStegcAzn1FwINA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 14:06:15 INFO - Running post-action listener: _resource_record_post_action 14:06:15 INFO - Running post-action listener: set_extra_try_arguments 14:06:15 INFO - [mozharness: 2016-10-11 21:06:15.924031Z] Finished download-and-extract step (success) 14:06:15 INFO - [mozharness: 2016-10-11 21:06:15.924154Z] Running populate-webroot step. 14:06:15 INFO - Running pre-action listener: _resource_record_pre_action 14:06:15 INFO - Running main action method: populate_webroot 14:06:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:06:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:06:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:06:15 INFO - '--tppagecycles', 14:06:15 INFO - '7'], 14:06:15 INFO - 'tests': ['tsvgm']}}, 14:06:15 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:06:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:06:15 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:06:15 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:06:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:06:15 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:06:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:15 INFO - 'talos_options': ['--disable-e10s'], 14:06:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:06:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:06:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:15 INFO - 'talos_options': ['--disable-e10s'], 14:06:15 INFO - 'tests': ['damp', 'tps']}, 14:06:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:15 INFO - 'tests': ['damp', 'tps']}, 14:06:15 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:06:15 INFO - 'tests': ['dromaeo_dom']}, 14:06:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:06:15 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:06:15 INFO - 'tests': ['basic_compositor_video']}, 14:06:15 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:06:15 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:06:15 INFO - 'tests': ['a11yr', 14:06:15 INFO - 'ts_paint', 14:06:15 INFO - 'tpaint', 14:06:15 INFO - 'sessionrestore', 14:06:15 INFO - 'sessionrestore_no_auto_restore', 14:06:15 INFO - 'tabpaint']}, 14:06:15 INFO - 'other-e10s': {'tests': ['a11yr', 14:06:15 INFO - 'ts_paint', 14:06:15 INFO - 'tpaint', 14:06:15 INFO - 'sessionrestore', 14:06:15 INFO - 'sessionrestore_no_auto_restore', 14:06:15 INFO - 'tabpaint']}, 14:06:15 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:06:15 INFO - 'ts_paint', 14:06:15 INFO - 'tpaint', 14:06:15 INFO - 'sessionrestore', 14:06:15 INFO - 'sessionrestore_no_auto_restore', 14:06:15 INFO - 'tabpaint']}, 14:06:15 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:06:15 INFO - 'ts_paint', 14:06:15 INFO - 'tpaint', 14:06:15 INFO - 'sessionrestore', 14:06:15 INFO - 'sessionrestore_no_auto_restore', 14:06:15 INFO - 'tabpaint']}, 14:06:15 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:06:15 INFO - 'tests': ['a11yr', 14:06:15 INFO - 'ts_paint', 14:06:15 INFO - 'tpaint', 14:06:15 INFO - 'sessionrestore', 14:06:15 INFO - 'sessionrestore_no_auto_restore', 14:06:15 INFO - 'tabpaint']}, 14:06:15 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:06:15 INFO - 'tests': ['a11yr', 14:06:15 INFO - 'ts_paint', 14:06:15 INFO - 'tpaint', 14:06:15 INFO - 'sessionrestore', 14:06:15 INFO - 'sessionrestore_no_auto_restore', 14:06:15 INFO - 'tabpaint']}, 14:06:15 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:06:15 INFO - 'tests': ['tsvgx', 14:06:15 INFO - 'tsvgr_opacity', 14:06:15 INFO - 'tart', 14:06:15 INFO - 'tscrollx', 14:06:15 INFO - 'cart']}, 14:06:15 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:06:15 INFO - 'tsvgr_opacity', 14:06:15 INFO - 'tart', 14:06:15 INFO - 'tscrollx', 14:06:15 INFO - 'cart']}, 14:06:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:15 INFO - 'talos_options': ['--disable-e10s'], 14:06:15 INFO - 'tests': ['tp5o']}, 14:06:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:15 INFO - 'tests': ['tp5o']}, 14:06:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:15 INFO - 'talos_options': ['--disable-e10s', 14:06:15 INFO - '--xperf_path', 14:06:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:06:15 INFO - 'tests': ['tp5n']}, 14:06:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 14:06:15 INFO - 'talos_options': ['--xperf_path', 14:06:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:06:15 INFO - 'tests': ['tp5n']}}, 14:06:15 INFO - 'talos.zip': {'path': '', 14:06:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:06:15 INFO - Running post-action listener: _resource_record_post_action 14:06:15 INFO - [mozharness: 2016-10-11 21:06:15.943091Z] Finished populate-webroot step (success) 14:06:15 INFO - [mozharness: 2016-10-11 21:06:15.943221Z] Running create-virtualenv step. 14:06:15 INFO - Running pre-action listener: _resource_record_pre_action 14:06:15 INFO - Running main action method: create_virtualenv 14:06:15 INFO - Creating virtualenv /builds/slave/test/build/venv 14:06:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 14:06:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:06:16 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:06:16 INFO - Using real prefix '/tools/python27' 14:06:16 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:06:16 INFO - Installing distribute.............................................................................................................................................................................................done. 14:06:19 INFO - Installing pip.................done. 14:06:19 INFO - Return code: 0 14:06:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:06:19 INFO - Reading from file tmpfile_stdout 14:06:19 INFO - Output received: 14:06:19 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 14:06:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:19 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e143490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc409d84db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df57d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df4fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cs5mKRrkIr/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:06:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 14:06:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 14:06:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cs5mKRrkIr/Render', 14:06:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:19 INFO - 'HOME': '/Users/cltbld', 14:06:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:19 INFO - 'LOGNAME': 'cltbld', 14:06:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:19 INFO - 'MOZ_NO_REMOTE': '1', 14:06:19 INFO - 'NO_EM_RESTART': '1', 14:06:19 INFO - 'PAGER': '/bin/cat', 14:06:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:19 INFO - 'PWD': '/builds/slave/test', 14:06:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:19 INFO - 'SHELL': '/bin/bash', 14:06:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners', 14:06:19 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 14:06:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:19 INFO - 'USER': 'cltbld', 14:06:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:19 INFO - 'XPC_FLAGS': '0x0', 14:06:19 INFO - 'XPC_SERVICE_NAME': '0', 14:06:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:20 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 14:06:20 INFO - Cleaning up... 14:06:20 INFO - Return code: 0 14:06:20 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e143490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc409d84db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df57d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df4fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cs5mKRrkIr/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:06:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 14:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 14:06:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cs5mKRrkIr/Render', 14:06:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:20 INFO - 'HOME': '/Users/cltbld', 14:06:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:20 INFO - 'LOGNAME': 'cltbld', 14:06:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:20 INFO - 'MOZ_NO_REMOTE': '1', 14:06:20 INFO - 'NO_EM_RESTART': '1', 14:06:20 INFO - 'PAGER': '/bin/cat', 14:06:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:20 INFO - 'PWD': '/builds/slave/test', 14:06:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:20 INFO - 'SHELL': '/bin/bash', 14:06:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners', 14:06:20 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 14:06:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:20 INFO - 'USER': 'cltbld', 14:06:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:20 INFO - 'XPC_FLAGS': '0x0', 14:06:20 INFO - 'XPC_SERVICE_NAME': '0', 14:06:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:20 INFO - Downloading/unpacking psutil>=3.1.1 14:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:06:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:06:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:06:24 INFO - Installing collected packages: psutil 14:06:24 INFO - Running setup.py install for psutil 14:06:24 INFO - building 'psutil._psutil_osx' extension 14:06:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 14:06:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 14:06:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 14:06:24 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 14:06:24 INFO - building 'psutil._psutil_posix' extension 14:06:24 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 14:06:24 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:06:24 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:06:24 INFO - ^ 14:06:24 INFO - 1 warning generated. 14:06:24 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 14:06:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:06:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:06:24 INFO - Successfully installed psutil 14:06:24 INFO - Cleaning up... 14:06:24 INFO - Return code: 0 14:06:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e143490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc409d84db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df57d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df4fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cs5mKRrkIr/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:06:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:06:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:06:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cs5mKRrkIr/Render', 14:06:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:24 INFO - 'HOME': '/Users/cltbld', 14:06:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:24 INFO - 'LOGNAME': 'cltbld', 14:06:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:24 INFO - 'MOZ_NO_REMOTE': '1', 14:06:24 INFO - 'NO_EM_RESTART': '1', 14:06:24 INFO - 'PAGER': '/bin/cat', 14:06:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:24 INFO - 'PWD': '/builds/slave/test', 14:06:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:24 INFO - 'SHELL': '/bin/bash', 14:06:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners', 14:06:24 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 14:06:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:24 INFO - 'USER': 'cltbld', 14:06:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:24 INFO - 'XPC_FLAGS': '0x0', 14:06:24 INFO - 'XPC_SERVICE_NAME': '0', 14:06:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:06:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:06:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:06:27 INFO - Installing collected packages: mozsystemmonitor 14:06:27 INFO - Running setup.py install for mozsystemmonitor 14:06:27 INFO - Successfully installed mozsystemmonitor 14:06:27 INFO - Cleaning up... 14:06:28 INFO - Return code: 0 14:06:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e143490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc409d84db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df57d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df4fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cs5mKRrkIr/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:06:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 14:06:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 14:06:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cs5mKRrkIr/Render', 14:06:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:28 INFO - 'HOME': '/Users/cltbld', 14:06:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:28 INFO - 'LOGNAME': 'cltbld', 14:06:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:28 INFO - 'MOZ_NO_REMOTE': '1', 14:06:28 INFO - 'NO_EM_RESTART': '1', 14:06:28 INFO - 'PAGER': '/bin/cat', 14:06:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:28 INFO - 'PWD': '/builds/slave/test', 14:06:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:28 INFO - 'SHELL': '/bin/bash', 14:06:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners', 14:06:28 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 14:06:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:28 INFO - 'USER': 'cltbld', 14:06:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:28 INFO - 'XPC_FLAGS': '0x0', 14:06:28 INFO - 'XPC_SERVICE_NAME': '0', 14:06:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:28 INFO - Downloading/unpacking jsonschema==2.5.1 14:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:06:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:31 INFO - Downloading functools32-3.2.3-2.tar.gz 14:06:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:06:31 INFO - warning: no files found matching '*.txt' 14:06:31 INFO - no previously-included directories found matching 'build' 14:06:31 INFO - no previously-included directories found matching 'dist' 14:06:31 INFO - no previously-included directories found matching '.git*' 14:06:31 INFO - Installing collected packages: jsonschema, functools32 14:06:31 INFO - Running setup.py install for functools32 14:06:31 INFO - warning: no files found matching '*.txt' 14:06:31 INFO - no previously-included directories found matching 'build' 14:06:31 INFO - no previously-included directories found matching 'dist' 14:06:31 INFO - no previously-included directories found matching '.git*' 14:06:31 INFO - Successfully installed jsonschema functools32 14:06:31 INFO - Cleaning up... 14:06:31 INFO - Return code: 0 14:06:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e143490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc409d84db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df57d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df4fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cs5mKRrkIr/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:06:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 14:06:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cs5mKRrkIr/Render', 14:06:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:31 INFO - 'HOME': '/Users/cltbld', 14:06:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:31 INFO - 'LOGNAME': 'cltbld', 14:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:31 INFO - 'MOZ_NO_REMOTE': '1', 14:06:31 INFO - 'NO_EM_RESTART': '1', 14:06:31 INFO - 'PAGER': '/bin/cat', 14:06:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:31 INFO - 'PWD': '/builds/slave/test', 14:06:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:31 INFO - 'SHELL': '/bin/bash', 14:06:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners', 14:06:31 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 14:06:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:31 INFO - 'USER': 'cltbld', 14:06:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:31 INFO - 'XPC_FLAGS': '0x0', 14:06:31 INFO - 'XPC_SERVICE_NAME': '0', 14:06:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:06:31 INFO - Cleaning up... 14:06:31 INFO - Return code: 0 14:06:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e143490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc409d84db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df57d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df4fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cs5mKRrkIr/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:06:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:06:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 14:06:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cs5mKRrkIr/Render', 14:06:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:31 INFO - 'HOME': '/Users/cltbld', 14:06:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:31 INFO - 'LOGNAME': 'cltbld', 14:06:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:31 INFO - 'MOZ_NO_REMOTE': '1', 14:06:31 INFO - 'NO_EM_RESTART': '1', 14:06:31 INFO - 'PAGER': '/bin/cat', 14:06:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:31 INFO - 'PWD': '/builds/slave/test', 14:06:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:31 INFO - 'SHELL': '/bin/bash', 14:06:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners', 14:06:31 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 14:06:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:31 INFO - 'USER': 'cltbld', 14:06:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:31 INFO - 'XPC_FLAGS': '0x0', 14:06:31 INFO - 'XPC_SERVICE_NAME': '0', 14:06:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:32 INFO - Downloading/unpacking blobuploader==1.2.4 14:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:34 INFO - Downloading blobuploader-1.2.4.tar.gz 14:06:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:06:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:06:35 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:35 INFO - Downloading docopt-0.6.1.tar.gz 14:06:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:06:35 INFO - Installing collected packages: blobuploader, requests, docopt 14:06:35 INFO - Running setup.py install for blobuploader 14:06:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:06:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:06:35 INFO - Running setup.py install for requests 14:06:36 INFO - Running setup.py install for docopt 14:06:36 INFO - Successfully installed blobuploader requests docopt 14:06:36 INFO - Cleaning up... 14:06:36 INFO - Return code: 0 14:06:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e143490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc409d84db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df57d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df4fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cs5mKRrkIr/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:06:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:06:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:06:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cs5mKRrkIr/Render', 14:06:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:36 INFO - 'HOME': '/Users/cltbld', 14:06:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:36 INFO - 'LOGNAME': 'cltbld', 14:06:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:36 INFO - 'MOZ_NO_REMOTE': '1', 14:06:36 INFO - 'NO_EM_RESTART': '1', 14:06:36 INFO - 'PAGER': '/bin/cat', 14:06:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:36 INFO - 'PWD': '/builds/slave/test', 14:06:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:36 INFO - 'SHELL': '/bin/bash', 14:06:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners', 14:06:36 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 14:06:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:36 INFO - 'USER': 'cltbld', 14:06:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:36 INFO - 'XPC_FLAGS': '0x0', 14:06:36 INFO - 'XPC_SERVICE_NAME': '0', 14:06:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:06:36 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-u52wGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:06:37 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-wAhg58-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:06:37 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-z2x4mS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:06:37 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-vVVwff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:06:37 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-d1NrFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:06:37 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-mCTt2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:06:37 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-JYHyy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:06:37 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-BH3xPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:06:37 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-UQxjos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:06:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:06:37 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-RhO9SL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:06:38 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-IbcQOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:06:38 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-IJsJAM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:06:38 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-7lAdmU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:06:38 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-SwiLdh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:38 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-bju97u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:06:38 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-7wJKvw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:06:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:06:38 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-R3wxZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:06:38 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:06:38 INFO - Running setup.py install for manifestparser 14:06:38 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:06:38 INFO - Running setup.py install for mozcrash 14:06:39 INFO - Running setup.py install for mozdebug 14:06:39 INFO - Running setup.py install for mozdevice 14:06:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 14:06:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:06:39 INFO - Running setup.py install for mozfile 14:06:39 INFO - Running setup.py install for mozhttpd 14:06:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:06:39 INFO - Running setup.py install for mozinfo 14:06:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:06:39 INFO - Running setup.py install for mozInstall 14:06:39 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:06:39 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:06:39 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:06:39 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:06:39 INFO - Running setup.py install for mozleak 14:06:40 INFO - Running setup.py install for mozlog 14:06:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:06:40 INFO - Running setup.py install for moznetwork 14:06:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:06:40 INFO - Running setup.py install for mozprocess 14:06:40 INFO - Running setup.py install for mozprofile 14:06:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:06:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:06:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:06:40 INFO - Running setup.py install for mozrunner 14:06:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:06:40 INFO - Running setup.py install for mozscreenshot 14:06:41 INFO - Running setup.py install for moztest 14:06:41 INFO - Running setup.py install for mozversion 14:06:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:06:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:06:41 INFO - Cleaning up... 14:06:41 INFO - Return code: 0 14:06:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e143490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc409d84db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df57d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df4fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cs5mKRrkIr/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:06:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 14:06:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:06:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cs5mKRrkIr/Render', 14:06:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:41 INFO - 'HOME': '/Users/cltbld', 14:06:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:41 INFO - 'LOGNAME': 'cltbld', 14:06:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:41 INFO - 'MOZ_NO_REMOTE': '1', 14:06:41 INFO - 'NO_EM_RESTART': '1', 14:06:41 INFO - 'PAGER': '/bin/cat', 14:06:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:41 INFO - 'PWD': '/builds/slave/test', 14:06:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:41 INFO - 'SHELL': '/bin/bash', 14:06:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners', 14:06:41 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 14:06:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:41 INFO - 'USER': 'cltbld', 14:06:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:41 INFO - 'XPC_FLAGS': '0x0', 14:06:41 INFO - 'XPC_SERVICE_NAME': '0', 14:06:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:06:41 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-I86O12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 14:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:06:41 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-JnmtEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:06:41 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-gL9joM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:06:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:06:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:06:41 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-HSUF4S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:06:42 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-Tbqyf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 14:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:06:42 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-w1wafS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 14:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:06:42 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-drOLdH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 14:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:06:42 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-SPEEa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 14:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:06:42 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-frZEYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 14:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:06:42 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-1vj2Lr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:06:42 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-ta3xNe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 14:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:06:42 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-2f10ZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 14:06:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:06:42 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-5GuheR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 14:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:06:43 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-VRH2R5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 14:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:43 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-9lJyoZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 14:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:06:43 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-WV79vv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 14:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:06:43 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-eYuoHJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 14:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 14:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 14:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 14:06:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:06:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:06:45 INFO - Downloading blessings-1.6.tar.gz 14:06:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:06:46 INFO - Installing collected packages: blessings 14:06:46 INFO - Running setup.py install for blessings 14:06:46 INFO - Successfully installed blessings 14:06:46 INFO - Cleaning up... 14:06:46 INFO - Return code: 0 14:06:46 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:06:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:06:46 INFO - Reading from file tmpfile_stdout 14:06:46 INFO - Current package versions: 14:06:46 INFO - blessings == 1.6 14:06:46 INFO - blobuploader == 1.2.4 14:06:46 INFO - docopt == 0.6.1 14:06:46 INFO - functools32 == 3.2.3-2 14:06:46 INFO - jsonschema == 2.5.1 14:06:46 INFO - manifestparser == 1.1 14:06:46 INFO - mozInstall == 1.12 14:06:46 INFO - mozcrash == 0.17 14:06:46 INFO - mozdebug == 0.1 14:06:46 INFO - mozdevice == 0.48 14:06:46 INFO - mozfile == 1.2 14:06:46 INFO - mozhttpd == 0.7 14:06:46 INFO - mozinfo == 0.9 14:06:46 INFO - mozleak == 0.1 14:06:46 INFO - mozlog == 3.4 14:06:46 INFO - moznetwork == 0.27 14:06:46 INFO - mozprocess == 0.23 14:06:46 INFO - mozprofile == 0.28 14:06:46 INFO - mozrunner == 6.12 14:06:46 INFO - mozscreenshot == 0.1 14:06:46 INFO - mozsystemmonitor == 0.3 14:06:46 INFO - moztest == 0.7 14:06:46 INFO - mozversion == 1.4 14:06:46 INFO - psutil == 3.1.1 14:06:46 INFO - requests == 1.2.3 14:06:46 INFO - wsgiref == 0.1.2 14:06:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e143490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc409d84db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df57d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df4fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cs5mKRrkIr/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:06:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 14:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 14:06:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cs5mKRrkIr/Render', 14:06:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:46 INFO - 'HOME': '/Users/cltbld', 14:06:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:46 INFO - 'LOGNAME': 'cltbld', 14:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:46 INFO - 'MOZ_NO_REMOTE': '1', 14:06:46 INFO - 'NO_EM_RESTART': '1', 14:06:46 INFO - 'PAGER': '/bin/cat', 14:06:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:46 INFO - 'PWD': '/builds/slave/test', 14:06:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:46 INFO - 'SHELL': '/bin/bash', 14:06:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners', 14:06:46 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 14:06:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:46 INFO - 'USER': 'cltbld', 14:06:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:46 INFO - 'XPC_FLAGS': '0x0', 14:06:46 INFO - 'XPC_SERVICE_NAME': '0', 14:06:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 14:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 14:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 14:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 14:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 14:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 14:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 14:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 14:06:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 14:06:46 INFO - Cleaning up... 14:06:46 INFO - Return code: 0 14:06:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:06:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:06:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:06:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:06:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e143490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e0b9570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc409d84db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df57d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df4fb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cs5mKRrkIr/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 14:06:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 14:06:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 14:06:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cs5mKRrkIr/Render', 14:06:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:06:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:06:46 INFO - 'HOME': '/Users/cltbld', 14:06:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:06:46 INFO - 'LOGNAME': 'cltbld', 14:06:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:06:46 INFO - 'MOZ_NO_REMOTE': '1', 14:06:46 INFO - 'NO_EM_RESTART': '1', 14:06:46 INFO - 'PAGER': '/bin/cat', 14:06:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:06:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:06:46 INFO - 'PWD': '/builds/slave/test', 14:06:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:06:46 INFO - 'SHELL': '/bin/bash', 14:06:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners', 14:06:46 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 14:06:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:06:46 INFO - 'USER': 'cltbld', 14:06:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:06:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:06:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:06:46 INFO - 'XPC_FLAGS': '0x0', 14:06:46 INFO - 'XPC_SERVICE_NAME': '0', 14:06:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:06:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:06:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:06:47 INFO - Cleaning up... 14:06:47 INFO - Return code: 0 14:06:47 INFO - Running post-action listener: _resource_record_post_action 14:06:47 INFO - Running post-action listener: _start_resource_monitoring 14:06:47 INFO - Starting resource monitoring. 14:06:47 INFO - [mozharness: 2016-10-11 21:06:47.158499Z] Finished create-virtualenv step (success) 14:06:47 INFO - [mozharness: 2016-10-11 21:06:47.159517Z] Running install step. 14:06:47 INFO - Running pre-action listener: _resource_record_pre_action 14:06:47 INFO - Running main action method: install 14:06:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:06:47 INFO - Reading from file tmpfile_stdout 14:06:47 INFO - Detecting whether we're running mozinstall >=1.0... 14:06:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:06:47 INFO - Reading from file tmpfile_stdout 14:06:47 INFO - Output received: 14:06:47 INFO - Usage: mozinstall [options] installer 14:06:47 INFO - Options: 14:06:47 INFO - -h, --help show this help message and exit 14:06:47 INFO - -d DEST, --destination=DEST 14:06:47 INFO - Directory to install application into. [default: 14:06:47 INFO - "/builds/slave/test"] 14:06:47 INFO - --app=APP Application being installed. [default: firefox] 14:06:47 INFO - mkdir: /builds/slave/test/build/application 14:06:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:06:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:07:21 INFO - Reading from file tmpfile_stdout 14:07:21 INFO - Output received: 14:07:21 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:07:21 INFO - Running post-action listener: _resource_record_post_action 14:07:21 INFO - [mozharness: 2016-10-11 21:07:21.794736Z] Finished install step (success) 14:07:21 INFO - [mozharness: 2016-10-11 21:07:21.794830Z] Running run-tests step. 14:07:21 INFO - Running pre-action listener: _resource_record_pre_action 14:07:21 INFO - Running main action method: run_tests 14:07:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:07:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:07:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:07:21 INFO - 2016-10-11 14:07:21.809 screenresolution[1932:15853] starting screenresolution argv=screenresolution get 14:07:21 INFO - 2016-10-11 14:07:21.812 screenresolution[1932:15853] Display 0: 1600x1200x32@60 14:07:21 INFO - 2016-10-11 14:07:21.817 screenresolution[1933:15855] starting screenresolution argv=screenresolution list 14:07:21 INFO - Available Modes on Display 0 14:07:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:07:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:07:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:07:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:07:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:07:22 INFO - Intel Iris: 14:07:22 INFO - Chipset Model: Intel Iris 14:07:22 INFO - Type: GPU 14:07:22 INFO - Bus: Built-In 14:07:22 INFO - VRAM (Dynamic, Max): 1536 MB 14:07:22 INFO - Vendor: Intel (0x8086) 14:07:22 INFO - Device ID: 0x0a2e 14:07:22 INFO - Revision ID: 0x0009 14:07:22 INFO - Displays: 14:07:22 INFO - Display: 14:07:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:07:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:07:22 INFO - Display Serial Number: 1600x1200 60 14:07:22 INFO - Main Display: Yes 14:07:22 INFO - Mirror: Off 14:07:22 INFO - Online: Yes 14:07:22 INFO - Rotation: Supported 14:07:22 INFO - Return code: 0 14:07:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:07:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:07:22 INFO - Python 2.7.3 14:07:22 INFO - Return code: 0 14:07:22 INFO - grabbing minidump binary from tooltool 14:07:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:07:22 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10df57d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dd7ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10df4fb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:07:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 14:07:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 14:07:22 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 14:07:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:07:22 INFO - Return code: 0 14:07:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:07:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:07:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:07:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:07:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:07:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G6kgXkztStegcAzn1FwINA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0354', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 14:07:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/G6kgXkztStegcAzn1FwINA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0354 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 14:07:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cs5mKRrkIr/Render', 14:07:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:07:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:07:22 INFO - 'HOME': '/Users/cltbld', 14:07:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:07:22 INFO - 'LOGNAME': 'cltbld', 14:07:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:07:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:07:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:07:22 INFO - 'MOZ_NO_REMOTE': '1', 14:07:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:07:22 INFO - 'NO_EM_RESTART': '1', 14:07:22 INFO - 'PAGER': '/bin/cat', 14:07:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:07:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:07:22 INFO - 'PWD': '/builds/slave/test', 14:07:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:07:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:07:22 INFO - 'SHELL': '/bin/bash', 14:07:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners', 14:07:22 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 14:07:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:07:22 INFO - 'USER': 'cltbld', 14:07:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:07:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:07:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:07:22 INFO - 'XPC_FLAGS': '0x0', 14:07:22 INFO - 'XPC_SERVICE_NAME': '0', 14:07:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:07:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/G6kgXkztStegcAzn1FwINA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0354', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 14:07:22 INFO - mozversion application_buildid: 20161011121046 14:07:22 INFO - mozversion application_changeset: fe1d7c28668f0eb07c2f91bd0b3b0fa635d82387 14:07:22 INFO - mozversion application_display_name: Nightly 14:07:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:07:22 INFO - mozversion application_name: Firefox 14:07:22 INFO - mozversion application_remotingname: firefox 14:07:22 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 14:07:22 INFO - mozversion application_vendor: Mozilla 14:07:22 INFO - mozversion application_version: 52.0a1 14:07:22 INFO - mozversion platform_buildid: 20161011121046 14:07:22 INFO - mozversion platform_changeset: fe1d7c28668f0eb07c2f91bd0b3b0fa635d82387 14:07:22 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 14:07:22 INFO - mozversion platform_version: 52.0a1 14:07:22 INFO - using testdate: 1476220042 14:07:22 INFO - actual date: 1476220042 14:07:22 INFO - starting webserver on 'localhost:49436' 14:07:22 INFO - SUITE-START | Running 2 tests 14:07:22 INFO - TEST-START | dromaeo_css 14:07:22 INFO - operating with platform_type : mac_ 14:07:22 INFO - Initialising browser for dromaeo_css test... 14:07:22 INFO - TEST-INFO | started process 1943 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmpvg0yw8/profile http://localhost:49436/getInfo.html) 14:07:24 INFO - PROCESS | 1943 | __metrics Screen width/height:1600/1200 14:07:24 INFO - PROCESS | 1943 | colorDepth:24 14:07:24 INFO - PROCESS | 1943 | Browser inner width/height: 1024/689 14:07:24 INFO - PROCESS | 1943 | __metrics 14:07:25 INFO - PROCESS | 1943 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:07:25 INFO - PROCESS | 1943 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:07:25 INFO - TEST-INFO | 1943: exit 0 14:07:25 INFO - Browser initialized. 14:07:25 INFO - Running cycle 1/1 for dromaeo_css test... 14:07:25 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmpvg0yw8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:07:37 INFO - PROCESS | 1945 | RSS: Main: 235171840 14:07:37 INFO - PROCESS | 1945 | 14:08:28 INFO - PROCESS | 1945 | 1476220108624 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 14:10:39 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:49436/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49436/tests/dromaeo/cssquery-ext.html) 14:10:45 INFO - PROCESS | 1945 | RSS: Main: 515137536 14:10:45 INFO - PROCESS | 1945 | 14:13:48 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:49436/tests/dromaeo/cssquery-ext.html (next: http://localhost:49436/tests/dromaeo/cssquery-jquery.html) 14:13:49 INFO - PROCESS | 1945 | RSS: Main: 370331648 14:13:49 INFO - PROCESS | 1945 | 14:16:51 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:49436/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49436/tests/dromaeo/cssquery-mootools.html) 14:16:51 INFO - PROCESS | 1945 | RSS: Main: 345112576 14:16:51 INFO - PROCESS | 1945 | 14:19:54 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:49436/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49436/tests/dromaeo/cssquery-prototype.html) 14:19:54 INFO - PROCESS | 1945 | RSS: Main: 346275840 14:19:54 INFO - PROCESS | 1945 | 14:22:58 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:49436/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49436/tests/dromaeo/cssquery-yui.html) 14:22:58 INFO - PROCESS | 1945 | RSS: Main: 330723328 14:22:58 INFO - PROCESS | 1945 | 14:26:02 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:49436/tests/dromaeo/cssquery-yui.html (next: http://localhost:49436/tests/dromaeo/cssquery-dojo.html) 14:26:02 INFO - PROCESS | 1945 | RSS: Main: 412725248 14:26:02 INFO - PROCESS | 1945 | 14:26:02 INFO - PROCESS | 1945 | __start_tp_report 14:26:02 INFO - PROCESS | 1945 | _x_x_mozilla_page_load 14:26:02 INFO - PROCESS | 1945 | _x_x_mozilla_page_load_details 14:26:02 INFO - PROCESS | 1945 | |i|pagename|runs| 14:26:02 INFO - PROCESS | 1945 | |0;dojo.html;3231.7576181786367;3234.466313058345;3293.7694361394697;3313.7349012079035;3340.8162551059695;4616.422947131608;5513.58648101392;5600.467955544222;5694.060480020797;5709.71451427429;5590.502436296826;5610.943890561093;5617.831465056045;5626;5648.830535083954;5106.259592359106;5137.409197942228;5138.7173705446185;5181.300524429211;5234.947650523503;5108.182690769478;5153.330067091273;5166.095933211692;5185.55922746567;5272.92090618641;5203.505666961632;5206.114960456732;5226.5818734501145;5270.736463176826;5288.629795914288;5260.263563101169;5297.258383826248;5302.522772950414;5310.415854256029;5368.4631536846;5072.847814565569;5094.2103973884105;5147.897042059175;5204.193350030751;5231.372235331746;5514.338279406497;5632.577556683265;5649.322081350264;5662.292213473316;5668.829935101953;6204.100405441186;6216.347283535254;6216.658083805389;6224;6232.532560057968;5838.1534677471955;6115.357887421801;6138.6722360735575;6278;6292.905606415908;5694.829155125394;5713.714314284352;5746.626469279484;5769.85575360611;5823.708814559255;6269.843253918689;6274.121622972787;6296.087067375205;6296.496280297565;6303.054541818672;5873.20711703923;6059.242594675666;6085.756569737249;6103.877922441615;6133.877322453526;6120.84254996914;6128.597795181288;6131.019036954066;6198.535109866778;6262.718177682015;6201.379862013762;6202.34875338083;6203.379662033761;6212.72042758077;6215.316315205324;6207.068939659087;6229.53278504114;6233.189685340877;6236.18929539157;6236.906446403307;4740.976295118571;4839.467658557556;4841.1285968526;4886.95113048865;4888.535589119028;4363.127374525045;4381.539938306432;4390.0122472443445;4417.558244175557;4425.889352766207;5567.526760225426;5625.887482250332;5630.887382252332;5637.323521177403;5638.210650508932;6132.936844521141;6145.600535965148;6150.169727086786;6179.2584889812615;6180.227471566054;5632.098864181711;5632.690202038845;5646.830595082154;5649;5652.406497317805;5335.413104558495;5350.0904846176245;5357.08929481989;5361.517463428232;5363.597730170175;6213.565050446426;6254.499640028786;6264.185655864709;6278.089676996901;6281.403266689657;6220.657863817533;6229.12792209082;6239.0953311770445;6247.125402443752;6264.780732674334;6169.1054797053275;6255.78104766331;6257.655828929453;6274.968625156845;6280.5289603279025;5957.434043765836;6096.708114890978;6119.265688117454;6119.380693981147;6138.1713468681155;6157.599756015845;6165.784197553064;6170.290416602148;6179.104029915727;6183.81448556544;5295.232191332312;5927.377625349276;5981.953158197385;6038.788642397495;6061.6666083365835;5936.821895343147;6003;6028.397160284112;6030.4572588467245;6031.035034394476;5744.913826292525;5827.3007239131575;5833.649981001154;5847.38602446754;5856.882862342644;6028.728707208098;6040.939590604214;6136.764169924236;6142.099766648122;6145.047517634774;5955.821325360246;5962.70186490665;5973.55198360116;5984.850378740566;6002.429769171922 14:26:02 INFO - PROCESS | 1945 | |1;ext.html;466.9579737823597;484.1044068473324;525.5033992876733;525.5611564343773;541.734550070465;31662.525062124085;37436.81281593592;39033.82898513046;39136;39149.021274468156;31972.36055278899;33238.169045773866;33913.66086339142;41021.17957640845;41690.583094169124;9383.343165978384;9544.093311135432;9551.99704031077;9560.952195239013;9563.187129094036;8490.193431624017;9339.066093390675;9431.575579098957;9433.622655093788;9433.905660943372;8522.232999030086;8592.011918629343;8592.484450932963;8604.48373097613;8707.60815763289;11225.38260395682;11543.307401555849;11572.826407603809;11647.301161930227;11653.6503904883;11256.38089905055;11291.830622540669;11308.208425410225;11320.207585469021;11320.490577924013;38664.226715465535;38931;38939;38982;39054;3319.3859136059664;3422.5550678411896;3465.2722928184858;3489.825508724579;3885.320068987916;29434.146195892798;29542.70457295421;30822.691773082206;30881.845590772125;31003.534946975815;3196.1689960610174;3242.416365054289;3266.575345205108;3313.3207692422993;3340.365330587181;494311;497535;498753;501548;501722.4913875444;55203.171952420744;55572.72213638906;55608.44391556113;55713.721431393395;55755;57888.71055644779;57944;57961.71019144877;57983.710081449324;57983.8403231933;15390.384384624713;15612.219389030502;15638.45265415705;15638.765418518731;15659.060456372426;12352.197107188003;12389.256644601353;12413.317267550372;12418.75162496745;12427.689307767198;11868.88131118695;11927.403629818647;13120.343982800821;13825.032247742764;14503.274836258144;5458.235846981346;5655.745491452894;6481.449076828428;6500.869982600321;6655.134832471845;686.8827237083746;970.6748239339759;1006.2754816532085;1040.266612038511;1078.3152698036647;28870.422591548053;29054.564181537295;29127.708722912925;29830;29917.40165196684;1011.5195282240877;1054.7152268887357;1062.5324857062867;1107.789519991199;1126.2397881430002;13907.165570065828;14028;14168.362423690958;14328.641783955276;14344.713105737826;617362;622944;622962;623076;625985.8700706558;47093.76453117713;48348;55610.88778224413;55753.72123139358;55765;1212.2786941769632;1302.5245785288491;1337.71239183576;1361.673198432389;1363.9113457625222;29687.85156074292;30163.396732065674;30479.695203048574;30691.693083068883;30926.22684432907;46445.07109857851;47029;47073;47137.76431117822;47166.52833471759;436337;446728.76635616616;503908;506579;507903;21101.366958991253;24648.014079436623;24745.752542474343;24931.252062438154;24997.87501062483;37293.81353093217;43922;43981;44021;44837.103257934;36951.44572831463;37245.882623521335;37466.43800342942;37603.62396376111;38310.61689383182;36662.450063248536;36781.63218367782;37529.812350939166;37933.81033094927;37951.43072853965;35513.289734204656;35621.46567801537;36157;36184;36886.63113368832;30829.458527073108;31173.064808055795;32097.839510802296;33138;33191.668083319826;23569.646455303526;23741.762582374646;24688.753112468647;24805.875970620033;24925.252242432754 14:26:02 INFO - PROCESS | 1945 | |2;jquery.html;338.2777769462198;354.1147132169576;355.62303957804744;363.9599644039156;388.23933461750966;14647.633809154762;14973.101613903173;15696.686066278668;20243.49391265219;20851;19557.608847823034;20131.496712582193;20784.89607551964;21057.57884842302;21160.57678846426;4797.96843678609;5880.941190588103;6090.33006369299;6094.573379863411;6099.542534309922;4855.955969466564;6026;6068.6662233577135;6071.0589858571775;6088.330283668815;5676.347220069683;5998.700064996755;6002.099685047234;6002.759889604411;6002.849928751794;5812.331581868097;5907.793227237069;5930.021546444853;5930.199423077873;5938.792142275021;5091.159958606825;5181.4041385240425;5183.2743415921805;5187.844364669066;5394.163904594794;13337.266450345227;13522.797158042637;16476.505704828873;24343.782810859564;24858.757062147;2228.799408053283;2489.427431690703;2558.155808583163;2647.2190703742444;2862.8854845806145;9419.199368053723;9804.803903921953;10085;10303.227257955608;10372;1594.2014536245867;1684.3599432215801;1750.1861634339966;1757.402483155733;1830.697934840763;115459;121193;122688.9327766804;125688;145434.99999999895;19361.225550977804;20120.89939550293;20762.377128686163;20914.372568822655;21025.264115755876;34971.4754278686;34972.825135874664;35124.64875351265;35195.64804351975;35199.120021999144;10642.680719578426;10788.244822862482;10976.23166378346;11018.834717479243;11210.719732006602;8315.752637104362;8964.68623598171;8993.640254389882;9002.23481004122;9207.953960230156;8779.956100219459;9452.57463414148;9563.426194428357;9644.75888102789;9659.951700241454;3009.714077162666;3081.9537706933966;3689.501917241138;3693.1349668417815;3794.905127371838;816.2612835383987;823.5347028928636;899.8470260055806;922.2937565503898;952.7665721898179;20683.965801709855;21131.366059018255;21152.365429036847;21266.149354025976;21569;853.5346493237475;938.6949241496541;943.7782121201512;950.0594411532671;981.2248323824099;7604.201558836353;9638.662646807328;9682.951585242028;10894.18293627981;11112.388818614892;537152;588454;611328;622909;631581;133599.95611694726;134913;139687;140095;145540;1010.2019404670375;1017.954192061359;1022.1465076660922;1039.3504059962524;1042.02570596491;18097.457076287734;18746.718799218295;18752.343667971556;18892.811071889104;18893.055347232857;54804.45195547993;54861.725691371284;55064.44935550753;55386.44613553974;56115;76140;83749.74375384253;84850.72723909022;84921;86283;7956.403269754675;8162.142974987541;8176.67293308261;8307;8325.125861784667;10437.269391142547;12059.819102713642;12899.93550032244;13279.867201327863;13296.268705221306;10850.511726972147;10913;11097.889021109686;11423.086153107897;11549.538018479167;10693.786124277627;11079.612213572485;11285.266457680225;11650.359230242078;11695.181337306307;11382.772344553228;11395.316281022833;11516.42417879086;11631.302121872715;11657.475413606238;8068.1528439513;8209.425340226127;8245.587720613825;8248.83502329938;8542.017667968263;8381.123915743547;11178.876013557398;11489.540418383505;11491.195616306779;11588.188826782045 14:26:02 INFO - PROCESS | 1945 | |3;mootools.html;1463.9560813175601;1483.3473271760424;1653.5618061213781;1807.5842556212078;1844.0871768474608;7779;8056.315213206884;8263.545504997222;8735.781605459866;8737.213650771437;6731.629760363178;7869.449138560303;7936.928514650521;7962.283394494494;7987.760367188994;2266.648669456237;2320.466292752668;2322.593546129429;2335.1710142899283;2339.017612602711;2297.6094064009076;2301.666258392532;2336.6378211377264;2348.859068455898;2352.1532248390567;2311.6301391777233;2339.415146213447;2340.0522788270778;2345.4839935214227;2350.529894021194;2305.262316058862;2315.097112126272;2322.1872344679396;2325.848819826723;2332.6384410416326;2283.0525331987205;2316.061994892071;2320.7331156917003;2321;2325.6395258734756;8534.957325213396;8554.61504232311;8576.099509551532;8577.656893724306;8596.2263396294;5122.538971492546;5206.5314121729225;5277;5286.973565132188;5293.206019097128;3413.2149605590603;3509.508668786372;3650.178709790276;3651.3062518121474;3651.8174091295327;862.6118246788907;1069.4545781651336;1087.6845714742715;1092.0553721031251;1096.736783172041;10860.13118950482;10870.782584348268;11133.944330278378;11138.888611113865;11187.937145971202;3839.6928245740273;4536.56902594253;4678.789454474489;4728.219843725816;4729.456112547101;9619.230461563058;9770.658026969022;9774.413535187912;9793.706188814347;9793.755156121155;5197.454267301954;5276.261323414725;5280;5285.814996475182;5294.894102117936;4216.683748718859;4267.317229243306;4749.881252968635;4835.468098509161;4836.347093142451;3798.4112462568346;3825.5409350877517;3888.475055867478;3932.9016774580864;3935;1230.7107829660022;1251.124213050868;1253.8808813162734;1263.122130119558;1269.7079671675567;871.7210492642421;883.6112110671284;891.6388862510694;907.773056735816;917.7797328641078;5102.4897510248675;5512.834614961557;5868.471837534642;5877.52979761618;5967.910481342783;934.495372498843;935.9157675809074;943.9575219115156;954.7374472020111;992.5434300221979;3820.656140947328;3850.172212974224;3951.091249012743;3984.960150398517;3988.660963818108;8430.40987130895;10568.577256909792;10577.682669519927;10584.523696433678;10588.576456941637;10539.789204216026;10544.420056896945;10556.208284378703;10564.471776411148;10575.471226438647;7745.419093567893;7876.330511906437;7916.683332666744;8061.717839875576;8074.515529068157;5827.388124246893;5861.443162899518;5934.940650593611;5979.910301345571;6070.2412198475195;9245.583948722458;9827.901720982985;9839.409635421898;9841.065098815601;9852.852207217042;9688.273379496706;9798.118169364792;9904.504774761377;10082.495875206358;10085.495725213563;6731.697073631796;6963.895541566982;6966.442684585119;7259.818504537217;7412.518186317872;7919.722809701633;8075.717349892726;8174.877376839233;8291.212334828182;8317.750467485985;7209.315115064061;7292.1614014386905;7328.890066648898;7363.595002274927;7463.813404664709;7012.7545535906;7147.3210045045635;7221.819454513679;7257.274272572911;7277.417806575355;6777.254502004874;6794.864102717819;6898.655067246718;6899.724011039502;6915.273896241023;4206.242876282298;4916.23798311248;4939.6542242042715;4998.625103117208;5075.746212689424;4930.901381972269;4997.075541024922;5002.124628189979;5048.570871475966;5063.13926632466 14:26:02 INFO - PROCESS | 1945 | |4;prototype.html;251.6351290628588;286.2785779834816;293.88979132825176;303.8344102464157;307.23646270407863;4692.530746925306;4729.361536192613;4872.976674898276;5229.320188375511;5317.38850032246;5083.389993200812;5097.457267199298;5134.537891589756;5296.761645725942;5362.865928351793;3355.731541476676;3419.9658003419895;4005.2964249131937;4148.274052040896;4159.064210552631;4078.0833008485965;4087.89780255493;4109.794510274489;4110.157417729373;4111.568285330027;3176.7140957313836;3806.6764325032404;4102.2410853992105;4103.774292413916;4107.383892416132;3633.091727068233;3930.941035884464;4080.2451546464;4090.1819636072755;4095.9590404095875;3543.291341731638;3543.5039094526787;3551.9289614207573;3558.857645694169;3570.767900086512;5042.697438153723;5330.267663009498;5347.288867562382;5354.223637572569;5378.731063446812;3833.5016447861876;4625.051864367797;4635.68215892054;4705.741184234866;4726.976365118152;4737.692050016738;5059.976009596154;5290.68255904647;5662.462066103713;5701.6864072476;3164.9525257121163;3787.7841462744327;3853.2100919311474;3857.961420385788;3892.377219644843;5680.659160450345;5970.537088488666;5995.2206213192;6000.36996115406;6059.1216722815625;3894.7857867816974;3901.551321597996;3909.8045097745;3915.9216815663526;3931.4889064422014;3879.941800872989;3924.3524818405212;3998.900027499336;4002.799860006988;4004.4193591929006;3577.248777756648;4022.8390864365097;4093.774842383638;4646.186917289461;4656.953430465652;5209.71346575942;5658.179563963202;5661.141123732489;5666.829995100154;5714.942850571524;1086.9945650271698;1322.4461258021786;1355.9389827457787;1362.5231169090937;1364.413302280029;703.6938931564683;786.7765624454029;826.9751907442786;840.8696652018947;848.5290663681593;4422.447194100738;5244.868878277997;5254.894902101936;5281.867953301121;5301.284326615934;5736.6558006519745;5757.85605359861;5790.88418231633;5793.623414478046;5824.912626310609;4591.497633789592;4985.501449854985;5070.771815268322;5153.474797349272;5275.314209152785;2544.7455254474403;2717;2769.778417726577;3043.7564994800364;3053.9389212215633;5369.167778994262;5410.918836217381;5623.409541998031;5950.166976623276;5950.67271300074;5174.327337446108;5871.442212989759;5903.793367232212;5906.468417842415;5963.642181469126;4681.485036646034;5865.384134665969;5952.940470595326;5958.19564358806;5964.985952388104;4873.369339841841;5228.555572776357;5433.782648694008;5601.411851755507;5946.067528053313;5130.846074617767;5319.813806516753;5555.74995625981;5832.270966129234;5911.349751527243;5286.656367336111;5922.904262711412;6010.789622363196;6161.44546990773;6161.72272247741;3902.4536564881505;3927.5845355105835;3943;3957.980210098931;3968.7420317679257;5314.253451316889;5544.530699364591;5958.970205148947;5966.463018328372;6069.4840938518955;5535.596670858045;5821.534277257724;5854.795082172103;5868.67722275279;5870.647761134345;5355.902040081852;5758.280214973129;5766.394528574439;5778.971105144447;5834.620749651429;4339.761313127682;4913.312136300992;4973.602111830973;5636.210930469655;5655.236543066633;4758.714477131383;5154.561862241601;5626.2967129108865;5646.887062258814;5711.742971566373;5333;5440.673559586279;5607.214989901336;5645.548356131418;5690.715464226855 14:26:02 INFO - PROCESS | 1945 | |5;yui.html;672.7914346552566;677.99661001695;719.309462915601;721.9819504512386;774.2876553570715;14863.40546378145;15517.301721422535;15560;15563;15585.376584936617;13639.727205455885;13755.381007854645;13778.517751878686;13813.93093034536;13878.30608469575;638.7987783848096;658.2101478226124;660.7390080918035;662.3939095727428;796.8047828282079;659.4493597845805;663.3399767231612;792.2829838995718;819.868820988639;825.0965193113531;862.4351050062219;867.3451544084207;873.8995015573227;878.0736323179076;880.3925291548843;864.9091845356273;865.7446053414258;865.8657908024235;867.319154463743;871.7428358634218;498.82760577684024;640.8558074433262;642.6818724731241;644.0789670770796;644.8194505538456;12298.938505307417;14144.222067786268;14693.26533673312;14699.265036748227;15033.774493382609;13849.584512464642;14312.355943982546;14417.567472975723;14445;14487.78268325976;11729.53081876724;11746.706332341675;11842.28946263227;12032.917037466583;12435.12954093214;3707.2029513654693;3740.083679498513;3777.9622203777885;3853.113783829707;3902.746321489094;116745.83254167519;118977.40511297475;124511;131184;131467;10788.244822862482;11188.608398706006;11223.775524489465;11236.213465057368;11716.70708232284;23839.404014899766;23873.52252954931;23901.446405983555;23927;23968.28095157148;7903.012123484565;7920.960395198103;7965.56189409588;8052.832770596925;8068.314193293636;4318.935215971763;4344.109457561192;4447.644188464915;4588.990422107131;4602.2406302959635;3627.075095850594;3756.69946404287;3758.4926034985474;3762.172322089191;3764.661180493769;692.8926016467456;729.4128226777495;730.9468994425921;735.7388127214869;740.6259838781381;577.9017567013534;651.2673242602073;652.8531080506848;654.7099436552643;676.1043698945288;7444.962775186198;8588.656453741905;9042.547872606343;9197.402168859002;9527.90472095284;590.8242597231479;608.6104892868568;637.6970938804031;654.7970129259945;667.4626925325063;4372.584604462634;4436.046250056189;4515.322701594721;4594.356790049395;4633.72197668141;128567.35716321359;134546;161570;166393;166616.3338366625;138982;140240;140352;141240;142803.5738391775;116360;118009.4099529514;122374.3881280588;122992.38503807424;124264;8581.295566330615;8761.605727742139;8767.956160219414;8846.380753347461;9088.772780680536;64785.35214647982;65368.673156633915;65516.672416637615;66120.66939665271;67324;70692.93960590698;83410.16589834024;83519;84007;91479.08520914706;13029.543965961146;13043.739125217633;13079.149855259759;13207.339633018502;13244.735105298032;14957.252137393305;15114.622134446727;15142.394304227708;15195.848041519443;15382.384704612137;11499.94250028778;13754.862451375759;13764.724705506034;13981.930090349482;14061.648458788612;9536.761580960532;12326;13427.992900532303;13653.317334133055;14580.489682861049;13349.933250333686;13465.828837237379;13669.931650341685;13751.037427379988;13807.102538334975;8765.386422950332;11098.889011109786;11196.536316170275;11804.881951180721;11817.463982956126;11052.762941147172;11441.422656459392;11446.37044962535;11498.13763967689;11653.359065251154 14:26:02 INFO - PROCESS | 1945 | __end_tp_report 14:26:02 INFO - PROCESS | 1945 | __start_cc_report 14:26:02 INFO - PROCESS | 1945 | _x_x_mozilla_cycle_collect,5431 14:26:02 INFO - PROCESS | 1945 | __end_cc_report 14:26:02 INFO - PROCESS | 1945 | __startTimestamp1476221162564__endTimestamp 14:26:02 INFO - PROCESS | 1945 | 14:26:02 INFO - PROCESS | 1945 | ------- Summary: start ------- 14:26:02 INFO - PROCESS | 1945 | Number of tests: 6 14:26:02 INFO - PROCESS | 1945 | 14:26:02 INFO - PROCESS | 1945 | [#0] dojo.html Cycles:165 Average:5691.16 Median:5873.21 stddev:643.81 (11.0%) stddev-sans-first:616.20 14:26:02 INFO - PROCESS | 1945 | Values: 3231.8 3234.5 3293.8 3313.7 3340.8 4616.4 5513.6 5600.5 5694.1 5709.7 5590.5 5610.9 5617.8 5626.0 5648.8 5106.3 5137.4 5138.7 5181.3 5234.9 5108.2 5153.3 5166.1 5185.6 5272.9 5203.5 5206.1 5226.6 5270.7 5288.6 5260.3 5297.3 5302.5 5310.4 5368.5 5072.8 5094.2 5147.9 5204.2 5231.4 5514.3 5632.6 5649.3 5662.3 5668.8 6204.1 6216.3 6216.7 6224.0 6232.5 5838.2 6115.4 6138.7 6278.0 6292.9 5694.8 5713.7 5746.6 5769.9 5823.7 6269.8 6274.1 6296.1 6296.5 6303.1 5873.2 6059.2 6085.8 6103.9 6133.9 6120.8 6128.6 6131.0 6198.5 6262.7 6201.4 6202.3 6203.4 6212.7 6215.3 6207.1 6229.5 6233.2 6236.2 6236.9 4741.0 4839.5 4841.1 4887.0 4888.5 4363.1 4381.5 4390.0 4417.6 4425.9 5567.5 5625.9 5630.9 5637.3 5638.2 6132.9 6145.6 6150.2 6179.3 6180.2 5632.1 5632.7 5646.8 5649.0 5652.4 5335.4 5350.1 5357.1 5361.5 5363.6 6213.6 6254.5 6264.2 6278.1 6281.4 6220.7 6229.1 6239.1 6247.1 6264.8 6169.1 6255.8 6257.7 6275.0 6280.5 5957.4 6096.7 6119.3 6119.4 6138.2 6157.6 6165.8 6170.3 6179.1 6183.8 5295.2 5927.4 5982.0 6038.8 6061.7 5936.8 6003.0 6028.4 6030.5 6031.0 5744.9 5827.3 5833.6 5847.4 5856.9 6028.7 6040.9 6136.8 6142.1 6145.0 5955.8 5962.7 5973.6 5984.9 6002.4 14:26:02 INFO - PROCESS | 1945 | 14:26:02 INFO - PROCESS | 1945 | [#1] ext.html Cycles:180 Average:65934.46 Median:36722.04 stddev:143706.46 (391.3%) stddev-sans-first:144025.53 14:26:02 INFO - PROCESS | 1945 | Values: 467.0 484.1 525.5 525.6 541.7 31662.5 37436.8 39033.8 39136.0 39149.0 31972.4 33238.2 33913.7 41021.2 41690.6 9383.3 9544.1 9552.0 9561.0 9563.2 8490.2 9339.1 9431.6 9433.6 9433.9 8522.2 8592.0 8592.5 8604.5 8707.6 11225.4 11543.3 11572.8 11647.3 11653.7 11256.4 11291.8 11308.2 11320.2 11320.5 38664.2 38931.0 38939.0 38982.0 39054.0 3319.4 3422.6 3465.3 3489.8 3885.3 29434.1 29542.7 30822.7 30881.8 31003.5 3196.2 3242.4 3266.6 3313.3 3340.4 494311.0 497535.0 498753.0 501548.0 501722.5 55203.2 55572.7 55608.4 55713.7 55755.0 57888.7 57944.0 57961.7 57983.7 57983.8 15390.4 15612.2 15638.5 15638.8 15659.1 12352.2 12389.3 12413.3 12418.8 12427.7 11868.9 11927.4 13120.3 13825.0 14503.3 5458.2 5655.7 6481.4 6500.9 6655.1 686.9 970.7 1006.3 1040.3 1078.3 28870.4 29054.6 29127.7 29830.0 29917.4 1011.5 1054.7 1062.5 1107.8 1126.2 13907.2 14028.0 14168.4 14328.6 14344.7 617362.0 622944.0 622962.0 623076.0 625985.9 47093.8 48348.0 55610.9 55753.7 55765.0 1212.3 1302.5 1337.7 1361.7 1363.9 29687.9 30163.4 30479.7 30691.7 30926.2 46445.1 47029.0 47073.0 47137.8 47166.5 436337.0 446728.8 503908.0 506579.0 507903.0 21101.4 24648.0 24745.8 24931.3 24997.9 37293.8 43922.0 43981.0 44021.0 44837.1 36951.4 37245.9 37466.4 37603.6 38310.6 36662.5 36781.6 37529.8 37933.8 37951.4 35513.3 35621.5 36157.0 36184.0 36886.6 30829.5 31173.1 32097.8 33138.0 33191.7 23569.6 23741.8 24688.8 24805.9 24925.3 14:26:02 INFO - PROCESS | 1945 | 14:26:02 INFO - PROCESS | 1945 | [#2] jquery.html Cycles:180 Average:36542.66 Median:1710.12 stddev:100458.54 (5874.4%) stddev-sans-first:100703.57 14:26:02 INFO - PROCESS | 1945 | Values: 338.3 354.1 355.6 364.0 388.2 14647.6 14973.1 15696.7 20243.5 20851.0 19557.6 20131.5 20784.9 21057.6 21160.6 4798.0 5880.9 6090.3 6094.6 6099.5 4856.0 6026.0 6068.7 6071.1 6088.3 5676.3 5998.7 6002.1 6002.8 6002.8 5812.3 5907.8 5930.0 5930.2 5938.8 5091.2 5181.4 5183.3 5187.8 5394.2 13337.3 13522.8 16476.5 24343.8 24858.8 2228.8 2489.4 2558.2 2647.2 2862.9 9419.2 9804.8 10085.0 10303.2 10372.0 1594.2 1684.4 1750.2 1757.4 1830.7 115459.0 121193.0 122688.9 125688.0 145435.0 19361.2 20120.9 20762.4 20914.4 21025.3 34971.5 34972.8 35124.6 35195.6 35199.1 10642.7 10788.2 10976.2 11018.8 11210.7 8315.8 8964.7 8993.6 9002.2 9208.0 8780.0 9452.6 9563.4 9644.8 9660.0 3009.7 3082.0 3689.5 3693.1 3794.9 816.3 823.5 899.8 922.3 952.8 20684.0 21131.4 21152.4 21266.1 21569.0 853.5 938.7 943.8 950.1 981.2 7604.2 9638.7 9683.0 10894.2 11112.4 537152.0 588454.0 611328.0 622909.0 631581.0 133600.0 134913.0 139687.0 140095.0 145540.0 1010.2 1018.0 1022.1 1039.4 1042.0 18097.5 18746.7 18752.3 18892.8 18893.1 54804.5 54861.7 55064.4 55386.4 56115.0 76140.0 83749.7 84850.7 84921.0 86283.0 7956.4 8162.1 8176.7 8307.0 8325.1 10437.3 12059.8 12899.9 13279.9 13296.3 10850.5 10913.0 11097.9 11423.1 11549.5 10693.8 11079.6 11285.3 11650.4 11695.2 11382.8 11395.3 11516.4 11631.3 11657.5 8068.2 8209.4 8245.6 8248.8 8542.0 8381.1 11178.9 11489.5 11491.2 11588.2 14:26:02 INFO - PROCESS | 1945 | 14:26:02 INFO - PROCESS | 1945 | [#3] mootools.html Cycles:180 Average:5556.66 Median:5112.51 stddev:3069.60 (60.0%) stddev-sans-first:3062.80 14:26:02 INFO - PROCESS | 1945 | Values: 1464.0 1483.3 1653.6 1807.6 1844.1 7779.0 8056.3 8263.5 8735.8 8737.2 6731.6 7869.4 7936.9 7962.3 7987.8 2266.6 2320.5 2322.6 2335.2 2339.0 2297.6 2301.7 2336.6 2348.9 2352.2 2311.6 2339.4 2340.1 2345.5 2350.5 2305.3 2315.1 2322.2 2325.8 2332.6 2283.1 2316.1 2320.7 2321.0 2325.6 8535.0 8554.6 8576.1 8577.7 8596.2 5122.5 5206.5 5277.0 5287.0 5293.2 3413.2 3509.5 3650.2 3651.3 3651.8 862.6 1069.5 1087.7 1092.1 1096.7 10860.1 10870.8 11133.9 11138.9 11187.9 3839.7 4536.6 4678.8 4728.2 4729.5 9619.2 9770.7 9774.4 9793.7 9793.8 5197.5 5276.3 5280.0 5285.8 5294.9 4216.7 4267.3 4749.9 4835.5 4836.3 3798.4 3825.5 3888.5 3932.9 3935.0 1230.7 1251.1 1253.9 1263.1 1269.7 871.7 883.6 891.6 907.8 917.8 5102.5 5512.8 5868.5 5877.5 5967.9 934.5 935.9 944.0 954.7 992.5 3820.7 3850.2 3951.1 3985.0 3988.7 8430.4 10568.6 10577.7 10584.5 10588.6 10539.8 10544.4 10556.2 10564.5 10575.5 7745.4 7876.3 7916.7 8061.7 8074.5 5827.4 5861.4 5934.9 5979.9 6070.2 9245.6 9827.9 9839.4 9841.1 9852.9 9688.3 9798.1 9904.5 10082.5 10085.5 6731.7 6963.9 6966.4 7259.8 7412.5 7919.7 8075.7 8174.9 8291.2 8317.8 7209.3 7292.2 7328.9 7363.6 7463.8 7012.8 7147.3 7221.8 7257.3 7277.4 6777.3 6794.9 6898.7 6899.7 6915.3 4206.2 4916.2 4939.7 4998.6 5075.7 4930.9 4997.1 5002.1 5048.6 5063.1 14:26:02 INFO - PROCESS | 1945 | 14:26:02 INFO - PROCESS | 1945 | [#4] prototype.html Cycles:180 Average:4560.43 Median:5154.02 stddev:1431.04 (27.8%) stddev-sans-first:1398.03 14:26:02 INFO - PROCESS | 1945 | Values: 251.6 286.3 293.9 303.8 307.2 4692.5 4729.4 4873.0 5229.3 5317.4 5083.4 5097.5 5134.5 5296.8 5362.9 3355.7 3420.0 4005.3 4148.3 4159.1 4078.1 4087.9 4109.8 4110.2 4111.6 3176.7 3806.7 4102.2 4103.8 4107.4 3633.1 3930.9 4080.2 4090.2 4096.0 3543.3 3543.5 3551.9 3558.9 3570.8 5042.7 5330.3 5347.3 5354.2 5378.7 3833.5 4625.1 4635.7 4705.7 4727.0 4737.7 5060.0 5290.7 5662.5 5701.7 3165.0 3787.8 3853.2 3858.0 3892.4 5680.7 5970.5 5995.2 6000.4 6059.1 3894.8 3901.6 3909.8 3915.9 3931.5 3879.9 3924.4 3998.9 4002.8 4004.4 3577.2 4022.8 4093.8 4646.2 4657.0 5209.7 5658.2 5661.1 5666.8 5714.9 1087.0 1322.4 1355.9 1362.5 1364.4 703.7 786.8 827.0 840.9 848.5 4422.4 5244.9 5254.9 5281.9 5301.3 5736.7 5757.9 5790.9 5793.6 5824.9 4591.5 4985.5 5070.8 5153.5 5275.3 2544.7 2717.0 2769.8 3043.8 3053.9 5369.2 5410.9 5623.4 5950.2 5950.7 5174.3 5871.4 5903.8 5906.5 5963.6 4681.5 5865.4 5952.9 5958.2 5965.0 4873.4 5228.6 5433.8 5601.4 5946.1 5130.8 5319.8 5555.7 5832.3 5911.3 5286.7 5922.9 6010.8 6161.4 6161.7 3902.5 3927.6 3943.0 3958.0 3968.7 5314.3 5544.5 5959.0 5966.5 6069.5 5535.6 5821.5 5854.8 5868.7 5870.6 5355.9 5758.3 5766.4 5779.0 5834.6 4339.8 4913.3 4973.6 5636.2 5655.2 4758.7 5154.6 5626.3 5646.9 5711.7 5333.0 5440.7 5607.2 5645.5 5690.7 14:26:02 INFO - PROCESS | 1945 | 14:26:02 INFO - PROCESS | 1945 | [#5] yui.html Cycles:180 Average:25826.59 Median:3748.39 stddev:42129.85 (1123.9%) stddev-sans-first:42205.70 14:26:02 INFO - PROCESS | 1945 | Values: 672.8 678.0 719.3 722.0 774.3 14863.4 15517.3 15560.0 15563.0 15585.4 13639.7 13755.4 13778.5 13813.9 13878.3 638.8 658.2 660.7 662.4 796.8 659.4 663.3 792.3 819.9 825.1 862.4 867.3 873.9 878.1 880.4 864.9 865.7 865.9 867.3 871.7 498.8 640.9 642.7 644.1 644.8 12298.9 14144.2 14693.3 14699.3 15033.8 13849.6 14312.4 14417.6 14445.0 14487.8 11729.5 11746.7 11842.3 12032.9 12435.1 3707.2 3740.1 3778.0 3853.1 3902.7 116745.8 118977.4 124511.0 131184.0 131467.0 10788.2 11188.6 11223.8 11236.2 11716.7 23839.4 23873.5 23901.4 23927.0 23968.3 7903.0 7921.0 7965.6 8052.8 8068.3 4318.9 4344.1 4447.6 4589.0 4602.2 3627.1 3756.7 3758.5 3762.2 3764.7 692.9 729.4 730.9 735.7 740.6 577.9 651.3 652.9 654.7 676.1 7445.0 8588.7 9042.5 9197.4 9527.9 590.8 608.6 637.7 654.8 667.5 4372.6 4436.0 4515.3 4594.4 4633.7 128567.4 134546.0 161570.0 166393.0 166616.3 138982.0 140240.0 140352.0 141240.0 142803.6 116360.0 118009.4 122374.4 122992.4 124264.0 8581.3 8761.6 8768.0 8846.4 9088.8 64785.4 65368.7 65516.7 66120.7 67324.0 70692.9 83410.2 83519.0 84007.0 91479.1 13029.5 13043.7 13079.1 13207.3 13244.7 14957.3 15114.6 15142.4 15195.8 15382.4 11499.9 13754.9 13764.7 13981.9 14061.6 9536.8 12326.0 13428.0 13653.3 14580.5 13349.9 13465.8 13669.9 13751.0 13807.1 8765.4 11098.9 11196.5 11804.9 11817.5 11052.8 11441.4 11446.4 11498.1 11653.4 14:26:02 INFO - PROCESS | 1945 | -------- Summary: end -------- 14:26:02 INFO - PROCESS | 1945 | 14:26:03 INFO - TEST-INFO | 1945: exit 0 14:26:03 INFO - TEST-OK | dromaeo_css | took 1120784ms 14:26:03 INFO - TEST-START | kraken 14:26:03 INFO - operating with platform_type : mac_ 14:26:03 INFO - Initialising browser for kraken test... 14:26:03 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmppFfkeF/profile http://localhost:49436/getInfo.html) 14:26:05 INFO - PROCESS | 1950 | __metrics Screen width/height:1600/1200 14:26:05 INFO - PROCESS | 1950 | colorDepth:24 14:26:05 INFO - PROCESS | 1950 | Browser inner width/height: 1024/689 14:26:05 INFO - PROCESS | 1950 | __metrics 14:26:05 INFO - PROCESS | 1950 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 14:26:05 INFO - PROCESS | 1950 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:26:06 INFO - TEST-INFO | 1950: exit 0 14:26:06 INFO - Browser initialized. 14:26:06 INFO - Running cycle 1/1 for kraken test... 14:26:06 INFO - TEST-INFO | started process 1951 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmppFfkeF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:26:18 INFO - PROCESS | 1951 | RSS: Main: 234594304 14:26:18 INFO - PROCESS | 1951 | 14:26:20 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49436/tests/kraken/driver.html?testName=audio-beat-detection) 14:26:21 INFO - PROCESS | 1951 | RSS: Main: 293539840 14:26:21 INFO - PROCESS | 1951 | 14:26:24 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49436/tests/kraken/driver.html?testName=audio-dft) 14:26:25 INFO - PROCESS | 1951 | RSS: Main: 293789696 14:26:25 INFO - PROCESS | 1951 | 14:26:28 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49436/tests/kraken/driver.html?testName=audio-fft) 14:26:29 INFO - PROCESS | 1951 | RSS: Main: 382021632 14:26:29 INFO - PROCESS | 1951 | 14:26:31 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49436/tests/kraken/driver.html?testName=audio-oscillator) 14:26:31 INFO - PROCESS | 1951 | RSS: Main: 283967488 14:26:31 INFO - PROCESS | 1951 | 14:26:33 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49436/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:26:34 INFO - PROCESS | 1951 | RSS: Main: 290189312 14:26:34 INFO - PROCESS | 1951 | 14:26:37 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49436/tests/kraken/driver.html?testName=imaging-darkroom) 14:26:37 INFO - PROCESS | 1951 | RSS: Main: 327688192 14:26:37 INFO - PROCESS | 1951 | 14:26:40 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49436/tests/kraken/driver.html?testName=imaging-desaturate) 14:26:41 INFO - PROCESS | 1951 | RSS: Main: 327372800 14:26:41 INFO - PROCESS | 1951 | 14:26:44 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49436/tests/kraken/driver.html?testName=json-parse-financial) 14:26:44 INFO - PROCESS | 1951 | RSS: Main: 324534272 14:26:44 INFO - PROCESS | 1951 | 14:26:46 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49436/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:26:47 INFO - PROCESS | 1951 | RSS: Main: 300781568 14:26:47 INFO - PROCESS | 1951 | 14:26:48 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49436/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:26:49 INFO - PROCESS | 1951 | RSS: Main: 305254400 14:26:49 INFO - PROCESS | 1951 | 14:26:51 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49436/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:26:52 INFO - PROCESS | 1951 | RSS: Main: 310837248 14:26:52 INFO - PROCESS | 1951 | 14:26:55 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49436/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:26:56 INFO - PROCESS | 1951 | RSS: Main: 328163328 14:26:56 INFO - PROCESS | 1951 | 14:26:59 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49436/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:26:59 INFO - PROCESS | 1951 | RSS: Main: 321400832 14:26:59 INFO - PROCESS | 1951 | 14:27:01 INFO - PROCESS | 1951 | Cycle 1(1): loaded http://localhost:49436/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49436/tests/kraken/driver.html?testName=ai-astar) 14:27:01 INFO - PROCESS | 1951 | RSS: Main: 364367872 14:27:01 INFO - PROCESS | 1951 | 14:27:01 INFO - PROCESS | 1951 | __start_tp_report 14:27:01 INFO - PROCESS | 1951 | _x_x_mozilla_page_load 14:27:01 INFO - PROCESS | 1951 | _x_x_mozilla_page_load_details 14:27:01 INFO - PROCESS | 1951 | |i|pagename|runs| 14:27:01 INFO - PROCESS | 1951 | |0;ai-astar;113;113;113;112;112;113;112;113;112;112 14:27:01 INFO - PROCESS | 1951 | |1;audio-beat-detection;148;117;144;185;132;115;112;112;144;112 14:27:01 INFO - PROCESS | 1951 | |2;audio-dft;184;188;183;186;184;184;180;184;183;184 14:27:01 INFO - PROCESS | 1951 | |3;audio-fft;80;61;60;89;62;60;59;60;83;59 14:27:01 INFO - PROCESS | 1951 | |4;audio-oscillator;85;73;119;100;96;69;93;65;82;92 14:27:01 INFO - PROCESS | 1951 | |5;imaging-gaussian-blur;87;84;87;85;88;84;88;85;88;84 14:27:01 INFO - PROCESS | 1951 | |6;imaging-darkroom;97;97;97;98;96;99;96;98;96;102 14:27:01 INFO - PROCESS | 1951 | |7;imaging-desaturate;85;84;84;81;85;84;86;83;103;144 14:27:01 INFO - PROCESS | 1951 | |8;json-parse-financial;59;55;55;55;54;54;53;53;56;55 14:27:01 INFO - PROCESS | 1951 | |9;json-stringify-tinderbox;72;67;73;78;72;71;71;72;73;72 14:27:01 INFO - PROCESS | 1951 | |10;stanford-crypto-aes;87;90;88;86;87;87;85;88;86;87 14:27:01 INFO - PROCESS | 1951 | |11;stanford-crypto-ccm;146;143;146;146;142;153;155;153;193;256 14:27:01 INFO - PROCESS | 1951 | |12;stanford-crypto-pbkdf2;171;172;195;170;172;231;188;173;172;172 14:27:01 INFO - PROCESS | 1951 | |13;stanford-crypto-sha256-iterative;69;70;68;67;68;68;69;68;68;69 14:27:01 INFO - PROCESS | 1951 | __end_tp_report 14:27:01 INFO - PROCESS | 1951 | __start_cc_report 14:27:01 INFO - PROCESS | 1951 | _x_x_mozilla_cycle_collect,2026 14:27:01 INFO - PROCESS | 1951 | __end_cc_report 14:27:01 INFO - PROCESS | 1951 | __startTimestamp1476221221770__endTimestamp 14:27:01 INFO - PROCESS | 1951 | 14:27:01 INFO - PROCESS | 1951 | ------- Summary: start ------- 14:27:01 INFO - PROCESS | 1951 | Number of tests: 14 14:27:01 INFO - PROCESS | 1951 | 14:27:01 INFO - PROCESS | 1951 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 14:27:01 INFO - PROCESS | 1951 | Values: 113.0 113.0 113.0 112.0 112.0 113.0 112.0 113.0 112.0 112.0 14:27:01 INFO - PROCESS | 1951 | 14:27:01 INFO - PROCESS | 1951 | [#1] audio-beat-detection Cycles:10 Average:132.10 Median:138.00 stddev:23.73 (17.2%) stddev-sans-first:24.46 14:27:01 INFO - PROCESS | 1951 | Values: 148.0 117.0 144.0 185.0 132.0 115.0 112.0 112.0 144.0 112.0 14:27:01 INFO - PROCESS | 1951 | 14:27:01 INFO - PROCESS | 1951 | [#2] audio-dft Cycles:10 Average:184.00 Median:184.00 stddev:2.05 (1.1%) stddev-sans-first:2.18 14:27:01 INFO - PROCESS | 1951 | Values: 184.0 188.0 183.0 186.0 184.0 184.0 180.0 184.0 183.0 184.0 14:27:01 INFO - PROCESS | 1951 | 14:27:01 INFO - PROCESS | 1951 | [#3] audio-fft Cycles:10 Average:67.30 Median:61.50 stddev:11.76 (19.1%) stddev-sans-first:11.54 14:27:01 INFO - PROCESS | 1951 | Values: 80.0 61.0 60.0 89.0 62.0 60.0 59.0 60.0 83.0 59.0 14:27:01 INFO - PROCESS | 1951 | 14:27:01 INFO - PROCESS | 1951 | [#4] audio-oscillator Cycles:10 Average:87.40 Median:83.50 stddev:16.22 (19.4%) stddev-sans-first:17.18 14:27:01 INFO - PROCESS | 1951 | Values: 85.0 73.0 119.0 100.0 96.0 69.0 93.0 65.0 82.0 92.0 14:27:01 INFO - PROCESS | 1951 | 14:27:01 INFO - PROCESS | 1951 | [#5] imaging-gaussian-blur Cycles:10 Average:86.00 Median:87.00 stddev:1.76 (2.0%) stddev-sans-first:1.83 14:27:01 INFO - PROCESS | 1951 | Values: 87.0 84.0 87.0 85.0 88.0 84.0 88.0 85.0 88.0 84.0 14:27:01 INFO - PROCESS | 1951 | 14:27:01 INFO - PROCESS | 1951 | [#6] imaging-darkroom Cycles:10 Average:97.60 Median:97.00 stddev:1.84 (1.9%) stddev-sans-first:1.94 14:27:01 INFO - PROCESS | 1951 | Values: 97.0 97.0 97.0 98.0 96.0 99.0 96.0 98.0 96.0 102.0 14:27:01 INFO - PROCESS | 1951 | 14:27:01 INFO - PROCESS | 1951 | [#7] imaging-desaturate Cycles:10 Average:91.90 Median:84.00 stddev:19.30 (23.0%) stddev-sans-first:20.31 14:27:01 INFO - PROCESS | 1951 | Values: 85.0 84.0 84.0 81.0 85.0 84.0 86.0 83.0 103.0 144.0 14:27:01 INFO - PROCESS | 1951 | 14:27:01 INFO - PROCESS | 1951 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:1.73 (3.1%) stddev-sans-first:1.01 14:27:01 INFO - PROCESS | 1951 | Values: 59.0 55.0 55.0 55.0 54.0 54.0 53.0 53.0 56.0 55.0 14:27:01 INFO - PROCESS | 1951 | 14:27:01 INFO - PROCESS | 1951 | [#9] json-stringify-tinderbox Cycles:10 Average:72.10 Median:72.00 stddev:2.69 (3.7%) stddev-sans-first:2.85 14:27:01 INFO - PROCESS | 1951 | Values: 72.0 67.0 73.0 78.0 72.0 71.0 71.0 72.0 73.0 72.0 14:27:01 INFO - PROCESS | 1951 | 14:27:01 INFO - PROCESS | 1951 | [#10] stanford-crypto-aes Cycles:10 Average:87.10 Median:87.00 stddev:1.37 (1.6%) stddev-sans-first:1.45 14:27:01 INFO - PROCESS | 1951 | Values: 87.0 90.0 88.0 86.0 87.0 87.0 85.0 88.0 86.0 87.0 14:27:01 INFO - PROCESS | 1951 | 14:27:01 INFO - PROCESS | 1951 | [#11] stanford-crypto-ccm Cycles:10 Average:163.30 Median:153.00 stddev:35.78 (23.4%) stddev-sans-first:37.40 14:27:01 INFO - PROCESS | 1951 | Values: 146.0 143.0 146.0 146.0 142.0 153.0 155.0 153.0 193.0 256.0 14:27:01 INFO - PROCESS | 1951 | 14:27:01 INFO - PROCESS | 1951 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.60 Median:172.50 stddev:19.29 (11.2%) stddev-sans-first:20.08 14:27:01 INFO - PROCESS | 1951 | Values: 171.0 172.0 195.0 170.0 172.0 231.0 188.0 173.0 172.0 172.0 14:27:01 INFO - PROCESS | 1951 | 14:27:01 INFO - PROCESS | 1951 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:0.84 (1.2%) stddev-sans-first:0.87 14:27:01 INFO - PROCESS | 1951 | Values: 69.0 70.0 68.0 67.0 68.0 68.0 69.0 68.0 68.0 69.0 14:27:01 INFO - PROCESS | 1951 | -------- Summary: end -------- 14:27:01 INFO - PROCESS | 1951 | 14:27:02 INFO - TEST-INFO | 1951: exit 0 14:27:02 INFO - TEST-OK | kraken | took 59469ms 14:27:02 INFO - SUITE-END | took 1180s 14:27:02 INFO - Completed test suite (00:19:40) 14:27:02 INFO - javascript benchmark 14:27:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3231.7576181786367, 3234.466313058345, 3293.7694361394697, 3313.7349012079035, 3340.8162551059695, 4616.422947131608, 5513.58648101392, 5600.467955544222, 5694.060480020797, 5709.71451427429, 5590.502436296826, 5610.943890561093, 5617.831465056045, 5626.0, 5648.830535083954, 5106.259592359106, 5137.409197942228, 5138.7173705446185, 5181.300524429211, 5234.947650523503, 5108.182690769478, 5153.330067091273, 5166.095933211692, 5185.55922746567, 5272.92090618641, 5203.505666961632, 5206.114960456732, 5226.5818734501145, 5270.736463176826, 5288.629795914288, 5260.263563101169, 5297.258383826248, 5302.522772950414, 5310.415854256029, 5368.4631536846, 5072.847814565569, 5094.2103973884105, 5147.897042059175, 5204.193350030751, 5231.372235331746, 5514.338279406497, 5632.577556683265, 5649.322081350264, 5662.292213473316, 5668.829935101953, 6204.100405441186, 6216.347283535254, 6216.658083805389, 6224.0, 6232.532560057968, 5838.1534677471955, 6115.357887421801, 6138.6722360735575, 6278.0, 6292.905606415908, 5694.829155125394, 5713.714314284352, 5746.626469279484, 5769.85575360611, 5823.708814559255, 6269.843253918689, 6274.121622972787, 6296.087067375205, 6296.496280297565, 6303.054541818672, 5873.20711703923, 6059.242594675666, 6085.756569737249, 6103.877922441615, 6133.877322453526, 6120.84254996914, 6128.597795181288, 6131.019036954066, 6198.535109866778, 6262.718177682015, 6201.379862013762, 6202.34875338083, 6203.379662033761, 6212.72042758077, 6215.316315205324, 6207.068939659087, 6229.53278504114, 6233.189685340877, 6236.18929539157, 6236.906446403307, 4740.976295118571, 4839.467658557556, 4841.1285968526, 4886.95113048865, 4888.535589119028, 4363.127374525045, 4381.539938306432, 4390.0122472443445, 4417.558244175557, 4425.889352766207, 5567.526760225426, 5625.887482250332, 5630.887382252332, 5637.323521177403, 5638.210650508932, 6132.936844521141, 6145.600535965148, 6150.169727086786, 6179.2584889812615, 6180.227471566054, 5632.098864181711, 5632.690202038845, 5646.830595082154, 5649.0, 5652.406497317805, 5335.413104558495, 5350.0904846176245, 5357.08929481989, 5361.517463428232, 5363.597730170175, 6213.565050446426, 6254.499640028786, 6264.185655864709, 6278.089676996901, 6281.403266689657, 6220.657863817533, 6229.12792209082, 6239.0953311770445, 6247.125402443752, 6264.780732674334, 6169.1054797053275, 6255.78104766331, 6257.655828929453, 6274.968625156845, 6280.5289603279025, 5957.434043765836, 6096.708114890978, 6119.265688117454, 6119.380693981147, 6138.1713468681155, 6157.599756015845, 6165.784197553064, 6170.290416602148, 6179.104029915727, 6183.81448556544, 5295.232191332312, 5927.377625349276, 5981.953158197385, 6038.788642397495, 6061.6666083365835, 5936.821895343147, 6003.0, 6028.397160284112, 6030.4572588467245, 6031.035034394476, 5744.913826292525, 5827.3007239131575, 5833.649981001154, 5847.38602446754, 5856.882862342644, 6028.728707208098, 6040.939590604214, 6136.764169924236, 6142.099766648122, 6145.047517634774, 5955.821325360246, 5962.70186490665, 5973.55198360116, 5984.850378740566, 6002.429769171922], "value": 5648.806755863983, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.9579737823597, 484.1044068473324, 525.5033992876733, 525.5611564343773, 541.734550070465, 31662.525062124085, 37436.81281593592, 39033.82898513046, 39136.0, 39149.021274468156, 31972.36055278899, 33238.169045773866, 33913.66086339142, 41021.17957640845, 41690.583094169124, 9383.343165978384, 9544.093311135432, 9551.99704031077, 9560.952195239013, 9563.187129094036, 8490.193431624017, 9339.066093390675, 9431.575579098957, 9433.622655093788, 9433.905660943372, 8522.232999030086, 8592.011918629343, 8592.484450932963, 8604.48373097613, 8707.60815763289, 11225.38260395682, 11543.307401555849, 11572.826407603809, 11647.301161930227, 11653.6503904883, 11256.38089905055, 11291.830622540669, 11308.208425410225, 11320.207585469021, 11320.490577924013, 38664.226715465535, 38931.0, 38939.0, 38982.0, 39054.0, 3319.3859136059664, 3422.5550678411896, 3465.2722928184858, 3489.825508724579, 3885.320068987916, 29434.146195892798, 29542.70457295421, 30822.691773082206, 30881.845590772125, 31003.534946975815, 3196.1689960610174, 3242.416365054289, 3266.575345205108, 3313.3207692422993, 3340.365330587181, 494311.0, 497535.0, 498753.0, 501548.0, 501722.4913875444, 55203.171952420744, 55572.72213638906, 55608.44391556113, 55713.721431393395, 55755.0, 57888.71055644779, 57944.0, 57961.71019144877, 57983.710081449324, 57983.8403231933, 15390.384384624713, 15612.219389030502, 15638.45265415705, 15638.765418518731, 15659.060456372426, 12352.197107188003, 12389.256644601353, 12413.317267550372, 12418.75162496745, 12427.689307767198, 11868.88131118695, 11927.403629818647, 13120.343982800821, 13825.032247742764, 14503.274836258144, 5458.235846981346, 5655.745491452894, 6481.449076828428, 6500.869982600321, 6655.134832471845, 686.8827237083746, 970.6748239339759, 1006.2754816532085, 1040.266612038511, 1078.3152698036647, 28870.422591548053, 29054.564181537295, 29127.708722912925, 29830.0, 29917.40165196684, 1011.5195282240877, 1054.7152268887357, 1062.5324857062867, 1107.789519991199, 1126.2397881430002, 13907.165570065828, 14028.0, 14168.362423690958, 14328.641783955276, 14344.713105737826, 617362.0, 622944.0, 622962.0, 623076.0, 625985.8700706558, 47093.76453117713, 48348.0, 55610.88778224413, 55753.72123139358, 55765.0, 1212.2786941769632, 1302.5245785288491, 1337.71239183576, 1361.673198432389, 1363.9113457625222, 29687.85156074292, 30163.396732065674, 30479.695203048574, 30691.693083068883, 30926.22684432907, 46445.07109857851, 47029.0, 47073.0, 47137.76431117822, 47166.52833471759, 436337.0, 446728.76635616616, 503908.0, 506579.0, 507903.0, 21101.366958991253, 24648.014079436623, 24745.752542474343, 24931.252062438154, 24997.87501062483, 37293.81353093217, 43922.0, 43981.0, 44021.0, 44837.103257934, 36951.44572831463, 37245.882623521335, 37466.43800342942, 37603.62396376111, 38310.61689383182, 36662.450063248536, 36781.63218367782, 37529.812350939166, 37933.81033094927, 37951.43072853965, 35513.289734204656, 35621.46567801537, 36157.0, 36184.0, 36886.63113368832, 30829.458527073108, 31173.064808055795, 32097.839510802296, 33138.0, 33191.668083319826, 23569.646455303526, 23741.762582374646, 24688.753112468647, 24805.875970620033, 24925.252242432754], "value": 19045.892257657684, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.2777769462198, 354.1147132169576, 355.62303957804744, 363.9599644039156, 388.23933461750966, 14647.633809154762, 14973.101613903173, 15696.686066278668, 20243.49391265219, 20851.0, 19557.608847823034, 20131.496712582193, 20784.89607551964, 21057.57884842302, 21160.57678846426, 4797.96843678609, 5880.941190588103, 6090.33006369299, 6094.573379863411, 6099.542534309922, 4855.955969466564, 6026.0, 6068.6662233577135, 6071.0589858571775, 6088.330283668815, 5676.347220069683, 5998.700064996755, 6002.099685047234, 6002.759889604411, 6002.849928751794, 5812.331581868097, 5907.793227237069, 5930.021546444853, 5930.199423077873, 5938.792142275021, 5091.159958606825, 5181.4041385240425, 5183.2743415921805, 5187.844364669066, 5394.163904594794, 13337.266450345227, 13522.797158042637, 16476.505704828873, 24343.782810859564, 24858.757062147, 2228.799408053283, 2489.427431690703, 2558.155808583163, 2647.2190703742444, 2862.8854845806145, 9419.199368053723, 9804.803903921953, 10085.0, 10303.227257955608, 10372.0, 1594.2014536245867, 1684.3599432215801, 1750.1861634339966, 1757.402483155733, 1830.697934840763, 115459.0, 121193.0, 122688.9327766804, 125688.0, 145434.99999999895, 19361.225550977804, 20120.89939550293, 20762.377128686163, 20914.372568822655, 21025.264115755876, 34971.4754278686, 34972.825135874664, 35124.64875351265, 35195.64804351975, 35199.120021999144, 10642.680719578426, 10788.244822862482, 10976.23166378346, 11018.834717479243, 11210.719732006602, 8315.752637104362, 8964.68623598171, 8993.640254389882, 9002.23481004122, 9207.953960230156, 8779.956100219459, 9452.57463414148, 9563.426194428357, 9644.75888102789, 9659.951700241454, 3009.714077162666, 3081.9537706933966, 3689.501917241138, 3693.1349668417815, 3794.905127371838, 816.2612835383987, 823.5347028928636, 899.8470260055806, 922.2937565503898, 952.7665721898179, 20683.965801709855, 21131.366059018255, 21152.365429036847, 21266.149354025976, 21569.0, 853.5346493237475, 938.6949241496541, 943.7782121201512, 950.0594411532671, 981.2248323824099, 7604.201558836353, 9638.662646807328, 9682.951585242028, 10894.18293627981, 11112.388818614892, 537152.0, 588454.0, 611328.0, 622909.0, 631581.0, 133599.95611694726, 134913.0, 139687.0, 140095.0, 145540.0, 1010.2019404670375, 1017.954192061359, 1022.1465076660922, 1039.3504059962524, 1042.02570596491, 18097.457076287734, 18746.718799218295, 18752.343667971556, 18892.811071889104, 18893.055347232857, 54804.45195547993, 54861.725691371284, 55064.44935550753, 55386.44613553974, 56115.0, 76140.0, 83749.74375384253, 84850.72723909022, 84921.0, 86283.0, 7956.403269754675, 8162.142974987541, 8176.67293308261, 8307.0, 8325.125861784667, 10437.269391142547, 12059.819102713642, 12899.93550032244, 13279.867201327863, 13296.268705221306, 10850.511726972147, 10913.0, 11097.889021109686, 11423.086153107897, 11549.538018479167, 10693.786124277627, 11079.612213572485, 11285.266457680225, 11650.359230242078, 11695.181337306307, 11382.772344553228, 11395.316281022833, 11516.42417879086, 11631.302121872715, 11657.475413606238, 8068.1528439513, 8209.425340226127, 8245.587720613825, 8248.83502329938, 8542.017667968263, 8381.123915743547, 11178.876013557398, 11489.540418383505, 11491.195616306779, 11588.188826782045], "value": 10313.131034611892, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1463.9560813175601, 1483.3473271760424, 1653.5618061213781, 1807.5842556212078, 1844.0871768474608, 7779.0, 8056.315213206884, 8263.545504997222, 8735.781605459866, 8737.213650771437, 6731.629760363178, 7869.449138560303, 7936.928514650521, 7962.283394494494, 7987.760367188994, 2266.648669456237, 2320.466292752668, 2322.593546129429, 2335.1710142899283, 2339.017612602711, 2297.6094064009076, 2301.666258392532, 2336.6378211377264, 2348.859068455898, 2352.1532248390567, 2311.6301391777233, 2339.415146213447, 2340.0522788270778, 2345.4839935214227, 2350.529894021194, 2305.262316058862, 2315.097112126272, 2322.1872344679396, 2325.848819826723, 2332.6384410416326, 2283.0525331987205, 2316.061994892071, 2320.7331156917003, 2321.0, 2325.6395258734756, 8534.957325213396, 8554.61504232311, 8576.099509551532, 8577.656893724306, 8596.2263396294, 5122.538971492546, 5206.5314121729225, 5277.0, 5286.973565132188, 5293.206019097128, 3413.2149605590603, 3509.508668786372, 3650.178709790276, 3651.3062518121474, 3651.8174091295327, 862.6118246788907, 1069.4545781651336, 1087.6845714742715, 1092.0553721031251, 1096.736783172041, 10860.13118950482, 10870.782584348268, 11133.944330278378, 11138.888611113865, 11187.937145971202, 3839.6928245740273, 4536.56902594253, 4678.789454474489, 4728.219843725816, 4729.456112547101, 9619.230461563058, 9770.658026969022, 9774.413535187912, 9793.706188814347, 9793.755156121155, 5197.454267301954, 5276.261323414725, 5280.0, 5285.814996475182, 5294.894102117936, 4216.683748718859, 4267.317229243306, 4749.881252968635, 4835.468098509161, 4836.347093142451, 3798.4112462568346, 3825.5409350877517, 3888.475055867478, 3932.9016774580864, 3935.0, 1230.7107829660022, 1251.124213050868, 1253.8808813162734, 1263.122130119558, 1269.7079671675567, 871.7210492642421, 883.6112110671284, 891.6388862510694, 907.773056735816, 917.7797328641078, 5102.4897510248675, 5512.834614961557, 5868.471837534642, 5877.52979761618, 5967.910481342783, 934.495372498843, 935.9157675809074, 943.9575219115156, 954.7374472020111, 992.5434300221979, 3820.656140947328, 3850.172212974224, 3951.091249012743, 3984.960150398517, 3988.660963818108, 8430.40987130895, 10568.577256909792, 10577.682669519927, 10584.523696433678, 10588.576456941637, 10539.789204216026, 10544.420056896945, 10556.208284378703, 10564.471776411148, 10575.471226438647, 7745.419093567893, 7876.330511906437, 7916.683332666744, 8061.717839875576, 8074.515529068157, 5827.388124246893, 5861.443162899518, 5934.940650593611, 5979.910301345571, 6070.2412198475195, 9245.583948722458, 9827.901720982985, 9839.409635421898, 9841.065098815601, 9852.852207217042, 9688.273379496706, 9798.118169364792, 9904.504774761377, 10082.495875206358, 10085.495725213563, 6731.697073631796, 6963.895541566982, 6966.442684585119, 7259.818504537217, 7412.518186317872, 7919.722809701633, 8075.717349892726, 8174.877376839233, 8291.212334828182, 8317.750467485985, 7209.315115064061, 7292.1614014386905, 7328.890066648898, 7363.595002274927, 7463.813404664709, 7012.7545535906, 7147.3210045045635, 7221.819454513679, 7257.274272572911, 7277.417806575355, 6777.254502004874, 6794.864102717819, 6898.655067246718, 6899.724011039502, 6915.273896241023, 4206.242876282298, 4916.23798311248, 4939.6542242042715, 4998.625103117208, 5075.746212689424, 4930.901381972269, 4997.075541024922, 5002.124628189979, 5048.570871475966, 5063.13926632466], "value": 4494.971767171906, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [251.6351290628588, 286.2785779834816, 293.88979132825176, 303.8344102464157, 307.23646270407863, 4692.530746925306, 4729.361536192613, 4872.976674898276, 5229.320188375511, 5317.38850032246, 5083.389993200812, 5097.457267199298, 5134.537891589756, 5296.761645725942, 5362.865928351793, 3355.731541476676, 3419.9658003419895, 4005.2964249131937, 4148.274052040896, 4159.064210552631, 4078.0833008485965, 4087.89780255493, 4109.794510274489, 4110.157417729373, 4111.568285330027, 3176.7140957313836, 3806.6764325032404, 4102.2410853992105, 4103.774292413916, 4107.383892416132, 3633.091727068233, 3930.941035884464, 4080.2451546464, 4090.1819636072755, 4095.9590404095875, 3543.291341731638, 3543.5039094526787, 3551.9289614207573, 3558.857645694169, 3570.767900086512, 5042.697438153723, 5330.267663009498, 5347.288867562382, 5354.223637572569, 5378.731063446812, 3833.5016447861876, 4625.051864367797, 4635.68215892054, 4705.741184234866, 4726.976365118152, 4737.692050016738, 5059.976009596154, 5290.68255904647, 5662.462066103713, 5701.6864072476, 3164.9525257121163, 3787.7841462744327, 3853.2100919311474, 3857.961420385788, 3892.377219644843, 5680.659160450345, 5970.537088488666, 5995.2206213192, 6000.36996115406, 6059.1216722815625, 3894.7857867816974, 3901.551321597996, 3909.8045097745, 3915.9216815663526, 3931.4889064422014, 3879.941800872989, 3924.3524818405212, 3998.900027499336, 4002.799860006988, 4004.4193591929006, 3577.248777756648, 4022.8390864365097, 4093.774842383638, 4646.186917289461, 4656.953430465652, 5209.71346575942, 5658.179563963202, 5661.141123732489, 5666.829995100154, 5714.942850571524, 1086.9945650271698, 1322.4461258021786, 1355.9389827457787, 1362.5231169090937, 1364.413302280029, 703.6938931564683, 786.7765624454029, 826.9751907442786, 840.8696652018947, 848.5290663681593, 4422.447194100738, 5244.868878277997, 5254.894902101936, 5281.867953301121, 5301.284326615934, 5736.6558006519745, 5757.85605359861, 5790.88418231633, 5793.623414478046, 5824.912626310609, 4591.497633789592, 4985.501449854985, 5070.771815268322, 5153.474797349272, 5275.314209152785, 2544.7455254474403, 2717.0, 2769.778417726577, 3043.7564994800364, 3053.9389212215633, 5369.167778994262, 5410.918836217381, 5623.409541998031, 5950.166976623276, 5950.67271300074, 5174.327337446108, 5871.442212989759, 5903.793367232212, 5906.468417842415, 5963.642181469126, 4681.485036646034, 5865.384134665969, 5952.940470595326, 5958.19564358806, 5964.985952388104, 4873.369339841841, 5228.555572776357, 5433.782648694008, 5601.411851755507, 5946.067528053313, 5130.846074617767, 5319.813806516753, 5555.74995625981, 5832.270966129234, 5911.349751527243, 5286.656367336111, 5922.904262711412, 6010.789622363196, 6161.44546990773, 6161.72272247741, 3902.4536564881505, 3927.5845355105835, 3943.0, 3957.980210098931, 3968.7420317679257, 5314.253451316889, 5544.530699364591, 5958.970205148947, 5966.463018328372, 6069.4840938518955, 5535.596670858045, 5821.534277257724, 5854.795082172103, 5868.67722275279, 5870.647761134345, 5355.902040081852, 5758.280214973129, 5766.394528574439, 5778.971105144447, 5834.620749651429, 4339.761313127682, 4913.312136300992, 4973.602111830973, 5636.210930469655, 5655.236543066633, 4758.714477131383, 5154.561862241601, 5626.2967129108865, 5646.887062258814, 5711.742971566373, 5333.0, 5440.673559586279, 5607.214989901336, 5645.548356131418, 5690.715464226855], "value": 4089.9405975424393, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.7914346552566, 677.99661001695, 719.309462915601, 721.9819504512386, 774.2876553570715, 14863.40546378145, 15517.301721422535, 15560.0, 15563.0, 15585.376584936617, 13639.727205455885, 13755.381007854645, 13778.517751878686, 13813.93093034536, 13878.30608469575, 638.7987783848096, 658.2101478226124, 660.7390080918035, 662.3939095727428, 796.8047828282079, 659.4493597845805, 663.3399767231612, 792.2829838995718, 819.868820988639, 825.0965193113531, 862.4351050062219, 867.3451544084207, 873.8995015573227, 878.0736323179076, 880.3925291548843, 864.9091845356273, 865.7446053414258, 865.8657908024235, 867.319154463743, 871.7428358634218, 498.82760577684024, 640.8558074433262, 642.6818724731241, 644.0789670770796, 644.8194505538456, 12298.938505307417, 14144.222067786268, 14693.26533673312, 14699.265036748227, 15033.774493382609, 13849.584512464642, 14312.355943982546, 14417.567472975723, 14445.0, 14487.78268325976, 11729.53081876724, 11746.706332341675, 11842.28946263227, 12032.917037466583, 12435.12954093214, 3707.2029513654693, 3740.083679498513, 3777.9622203777885, 3853.113783829707, 3902.746321489094, 116745.83254167519, 118977.40511297475, 124511.0, 131184.0, 131467.0, 10788.244822862482, 11188.608398706006, 11223.775524489465, 11236.213465057368, 11716.70708232284, 23839.404014899766, 23873.52252954931, 23901.446405983555, 23927.0, 23968.28095157148, 7903.012123484565, 7920.960395198103, 7965.56189409588, 8052.832770596925, 8068.314193293636, 4318.935215971763, 4344.109457561192, 4447.644188464915, 4588.990422107131, 4602.2406302959635, 3627.075095850594, 3756.69946404287, 3758.4926034985474, 3762.172322089191, 3764.661180493769, 692.8926016467456, 729.4128226777495, 730.9468994425921, 735.7388127214869, 740.6259838781381, 577.9017567013534, 651.2673242602073, 652.8531080506848, 654.7099436552643, 676.1043698945288, 7444.962775186198, 8588.656453741905, 9042.547872606343, 9197.402168859002, 9527.90472095284, 590.8242597231479, 608.6104892868568, 637.6970938804031, 654.7970129259945, 667.4626925325063, 4372.584604462634, 4436.046250056189, 4515.322701594721, 4594.356790049395, 4633.72197668141, 128567.35716321359, 134546.0, 161570.0, 166393.0, 166616.3338366625, 138982.0, 140240.0, 140352.0, 141240.0, 142803.5738391775, 116360.0, 118009.4099529514, 122374.3881280588, 122992.38503807424, 124264.0, 8581.295566330615, 8761.605727742139, 8767.956160219414, 8846.380753347461, 9088.772780680536, 64785.35214647982, 65368.673156633915, 65516.672416637615, 66120.66939665271, 67324.0, 70692.93960590698, 83410.16589834024, 83519.0, 84007.0, 91479.08520914706, 13029.543965961146, 13043.739125217633, 13079.149855259759, 13207.339633018502, 13244.735105298032, 14957.252137393305, 15114.622134446727, 15142.394304227708, 15195.848041519443, 15382.384704612137, 11499.94250028778, 13754.862451375759, 13764.724705506034, 13981.930090349482, 14061.648458788612, 9536.761580960532, 12326.0, 13427.992900532303, 13653.317334133055, 14580.489682861049, 13349.933250333686, 13465.828837237379, 13669.931650341685, 13751.037427379988, 13807.102538334975, 8765.386422950332, 11098.889011109786, 11196.536316170275, 11804.881951180721, 11817.463982956126, 11052.762941147172, 11441.422656459392, 11446.37044962535, 11498.13763967689, 11653.359065251154], "value": 7788.657637406551, "unit": "score"}], "name": "dromaeo_css", "value": 7359.532710833834, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 112.0, 112.0, 113.0, 112.0, 113.0, 112.0, 112.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 117.0, 144.0, 185.0, 132.0, 115.0, 112.0, 112.0, 144.0, 112.0], "value": 132.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 188.0, 183.0, 186.0, 184.0, 184.0, 180.0, 184.0, 183.0, 184.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 61.0, 60.0, 89.0, 62.0, 60.0, 59.0, 60.0, 83.0, 59.0], "value": 67.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 73.0, 119.0, 100.0, 96.0, 69.0, 93.0, 65.0, 82.0, 92.0], "value": 87.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 84.0, 87.0, 85.0, 88.0, 84.0, 88.0, 85.0, 88.0, 84.0], "value": 86.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 97.0, 98.0, 96.0, 99.0, 96.0, 98.0, 96.0, 102.0], "value": 97.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 84.0, 81.0, 85.0, 84.0, 86.0, 83.0, 103.0, 144.0], "value": 91.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 55.0, 55.0, 55.0, 54.0, 54.0, 53.0, 53.0, 56.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 73.0, 78.0, 72.0, 71.0, 71.0, 72.0, 73.0, 72.0], "value": 72.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 90.0, 88.0, 86.0, 87.0, 87.0, 85.0, 88.0, 86.0, 87.0], "value": 87.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 143.0, 146.0, 146.0, 142.0, 153.0, 155.0, 153.0, 193.0, 256.0], "value": 163.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 172.0, 195.0, 170.0, 172.0, 231.0, 188.0, 173.0, 172.0, 172.0], "value": 181.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 68.0, 67.0, 68.0, 68.0, 69.0, 68.0, 68.0, 69.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1486.2, "alertThreshold": 2.0}]} 14:27:03 INFO - Return code: 0 14:27:03 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:27:03 INFO - # TBPL SUCCESS # 14:27:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:27:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:27:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:27:03 INFO - 2016-10-11 14:27:03.081 screenresolution[1955:18134] starting screenresolution argv=screenresolution get 14:27:03 INFO - 2016-10-11 14:27:03.085 screenresolution[1955:18134] Display 0: 1600x1200x32@60 14:27:03 INFO - 2016-10-11 14:27:03.091 screenresolution[1956:18137] starting screenresolution argv=screenresolution list 14:27:03 INFO - Available Modes on Display 0 14:27:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:27:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:27:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:27:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:27:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:27:03 INFO - Intel Iris: 14:27:03 INFO - Chipset Model: Intel Iris 14:27:03 INFO - Type: GPU 14:27:03 INFO - Bus: Built-In 14:27:03 INFO - VRAM (Dynamic, Max): 1536 MB 14:27:03 INFO - Vendor: Intel (0x8086) 14:27:03 INFO - Device ID: 0x0a2e 14:27:03 INFO - Revision ID: 0x0009 14:27:03 INFO - Displays: 14:27:03 INFO - Display: 14:27:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:27:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:27:03 INFO - Display Serial Number: 1600x1200 60 14:27:03 INFO - Main Display: Yes 14:27:03 INFO - Mirror: Off 14:27:03 INFO - Online: Yes 14:27:03 INFO - Rotation: Supported 14:27:03 INFO - Return code: 0 14:27:03 INFO - Running post-action listener: _resource_record_post_action 14:27:03 INFO - [mozharness: 2016-10-11 21:27:03.325774Z] Finished run-tests step (success) 14:27:03 INFO - Running post-run listener: _resource_record_post_run 14:27:03 INFO - Total resource usage - Wall time: 1215s; CPU: 53.0%; Read bytes: 1015808; Write bytes: 709225472; Read time: 11; Write time: 2012 14:27:03 INFO - TinderboxPrint: CPU usage
53.4% 14:27:03 INFO - TinderboxPrint: I/O read bytes / time
1,015,808 / 11 14:27:03 INFO - TinderboxPrint: I/O write bytes / time
709,225,472 / 2,012 14:27:03 INFO - TinderboxPrint: CPU idle
2,265.0 (46.6%) 14:27:03 INFO - TinderboxPrint: CPU system
975.2 (20.1%) 14:27:03 INFO - TinderboxPrint: CPU user
1,621.5 (33.4%) 14:27:03 INFO - TinderboxPrint: Swap in / out
408,203,264 / 0 14:27:03 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 395067904; Write bytes: 390076416; Read time: 29385; Write time: 811 14:27:03 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 1011712; Write bytes: 298079232; Read time: 10; Write time: 1144 14:27:03 INFO - Running post-run listener: _upload_blobber_files 14:27:03 INFO - Blob upload gear active. 14:27:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:27:03 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:27:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:27:04 INFO - (blobuploader) - INFO - Open directory for files ... 14:27:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:27:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:27:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:27:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:27:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:27:05 INFO - (blobuploader) - INFO - Done attempting. 14:27:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:27:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:27:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:27:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:27:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:27:06 INFO - (blobuploader) - INFO - Done attempting. 14:27:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:27:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:27:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:27:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:27:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:27:08 INFO - (blobuploader) - INFO - Done attempting. 14:27:08 INFO - (blobuploader) - INFO - Iteration through files over. 14:27:08 INFO - Return code: 0 14:27:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:27:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:27:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53dacc502b533e1ac7e0762ca1aaeac2e27c235a4cffb219cb1a107d127665a76e244bc954652843a1cccbd86753df041d3b2b4aba660c531a6684c3db1413c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94ef4499effdc8ea8766dc1f22f18c6925bd07a6153cb56131f017d1d5797e359588525548f137450275ed29486b57d62be24bcbc78e4f2e4611cc20de54da8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b2f8bd5f6288c5f4031b93ef95f9bca4c511f08280b58a3d6463436b58bab6fcc4c2870908103e14cdd1cd41d0f2b0a6e661da028500261ff1adecaeec9eb8e"} 14:27:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:27:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:27:08 INFO - Contents: 14:27:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53dacc502b533e1ac7e0762ca1aaeac2e27c235a4cffb219cb1a107d127665a76e244bc954652843a1cccbd86753df041d3b2b4aba660c531a6684c3db1413c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94ef4499effdc8ea8766dc1f22f18c6925bd07a6153cb56131f017d1d5797e359588525548f137450275ed29486b57d62be24bcbc78e4f2e4611cc20de54da8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b2f8bd5f6288c5f4031b93ef95f9bca4c511f08280b58a3d6463436b58bab6fcc4c2870908103e14cdd1cd41d0f2b0a6e661da028500261ff1adecaeec9eb8e"} 14:27:08 INFO - Running post-run listener: copy_logs_to_upload_dir 14:27:08 INFO - Copying logs to upload dir... 14:27:08 INFO - mkdir: /builds/slave/test/build/upload/logs 14:27:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.270287 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-11 14:27:08.494172) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 14:27:08.498789) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cs5mKRrkIr/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53dacc502b533e1ac7e0762ca1aaeac2e27c235a4cffb219cb1a107d127665a76e244bc954652843a1cccbd86753df041d3b2b4aba660c531a6684c3db1413c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94ef4499effdc8ea8766dc1f22f18c6925bd07a6153cb56131f017d1d5797e359588525548f137450275ed29486b57d62be24bcbc78e4f2e4611cc20de54da8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b2f8bd5f6288c5f4031b93ef95f9bca4c511f08280b58a3d6463436b58bab6fcc4c2870908103e14cdd1cd41d0f2b0a6e661da028500261ff1adecaeec9eb8e"} build_url:https://queue.taskcluster.net/v1/task/G6kgXkztStegcAzn1FwINA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011085 build_url: 'https://queue.taskcluster.net/v1/task/G6kgXkztStegcAzn1FwINA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/53dacc502b533e1ac7e0762ca1aaeac2e27c235a4cffb219cb1a107d127665a76e244bc954652843a1cccbd86753df041d3b2b4aba660c531a6684c3db1413c6", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/94ef4499effdc8ea8766dc1f22f18c6925bd07a6153cb56131f017d1d5797e359588525548f137450275ed29486b57d62be24bcbc78e4f2e4611cc20de54da8b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8b2f8bd5f6288c5f4031b93ef95f9bca4c511f08280b58a3d6463436b58bab6fcc4c2870908103e14cdd1cd41d0f2b0a6e661da028500261ff1adecaeec9eb8e"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-11 14:27:08.530256) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 14:27:08.533569) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cs5mKRrkIr/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.3GxrNUBbI7/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005133 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-11 14:27:08.581834) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 14:27:08.582127) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-11 14:27:08.582404) ========= ========= Total master_lag: 0.20 =========