builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0254 starttime: 1485323963.22 results: success (0) buildid: 20170124193347 builduid: 4112813809f74e4caa2725cd22ceadc8 revision: 9c78f6d58ab9691a46f640ff3a81d7a55ad7a848 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 21:59:23.220522) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 21:59:23.221019) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 21:59:23.221354) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 21:59:23.248062) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 21:59:23.248398) ========= 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.oB4bhv6sh7/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.EmJ74aZmLN/Listeners TMPDIR=/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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 --2017-01-24 21:59:23-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 76.9M=0s 2017-01-24 21:59:23 (76.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.392446 ========= master_lag: 0.11 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 21:59:23.755764) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 21:59:23.756459) ========= 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.oB4bhv6sh7/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.EmJ74aZmLN/Listeners TMPDIR=/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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.025556 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 21:59:23.808230) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 21:59:23.809039) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9c78f6d58ab9691a46f640ff3a81d7a55ad7a848 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9c78f6d58ab9691a46f640ff3a81d7a55ad7a848 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oB4bhv6sh7/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.EmJ74aZmLN/Listeners TMPDIR=/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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 2017-01-24 21:59:23,916 truncating revision to first 12 chars 2017-01-24 21:59:23,916 Setting DEBUG logging. 2017-01-24 21:59:23,917 attempt 1/10 2017-01-24 21:59:23,917 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9c78f6d58ab9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-24 21:59:25,317 unpacking tar archive at: mozilla-beta-9c78f6d58ab9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.650933 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 21:59:25.483571) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 21:59:25.483890) ========= script_repo_revision: 9c78f6d58ab9691a46f640ff3a81d7a55ad7a848 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 21:59:25.484268) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 21:59:25.484547) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 21:59:25.502519) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-24 21:59:25.502795) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oB4bhv6sh7/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.EmJ74aZmLN/Listeners TMPDIR=/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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 21:59:25 INFO - MultiFileLogger online at 20170124 21:59:25 in /builds/slave/test 21:59:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 21:59:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:59:25 INFO - {'append_to_log': False, 21:59:25 INFO - 'base_work_dir': '/builds/slave/test', 21:59:25 INFO - 'blob_upload_branch': 'Mozilla-Beta', 21:59:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:59:25 INFO - 'branch': 'Mozilla-Beta', 21:59:25 INFO - 'buildbot_json_path': 'buildprops.json', 21:59:25 INFO - 'config_files': ('talos/mac_config.py',), 21:59:25 INFO - 'default_actions': ('clobber', 21:59:25 INFO - 'read-buildbot-config', 21:59:25 INFO - 'download-and-extract', 21:59:25 INFO - 'populate-webroot', 21:59:25 INFO - 'create-virtualenv', 21:59:25 INFO - 'install', 21:59:25 INFO - 'run-tests'), 21:59:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:59:25 INFO - 'download_minidump_stackwalk': True, 21:59:25 INFO - 'download_symbols': 'ondemand', 21:59:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:59:25 INFO - 'tooltool.py': '/tools/tooltool.py', 21:59:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:59:25 INFO - '/tools/misc-python/virtualenv.py')}, 21:59:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:59:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:59:25 INFO - 'installer_path': 'installer.exe', 21:59:25 INFO - 'log_level': 'info', 21:59:25 INFO - 'log_name': 'talos', 21:59:25 INFO - 'log_to_console': True, 21:59:25 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:59:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:59:25 INFO - 'opt_config_files': (), 21:59:25 INFO - 'pip_index': False, 21:59:25 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:59:25 INFO - 'cmd': ('bash', 21:59:25 INFO - '-c', 21:59:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:59:25 INFO - 'enabled': True, 21:59:25 INFO - 'halt_on_failure': False, 21:59:25 INFO - 'name': 'check_screen_resolution'},), 21:59:25 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:59:25 INFO - 'cmd': ('bash', 21:59:25 INFO - '-c', 21:59:25 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:59:25 INFO - 'enabled': True, 21:59:25 INFO - 'halt_on_failure': False, 21:59:25 INFO - 'name': 'check_screen_resolution'},), 21:59:25 INFO - 'run_cmd_checks_enabled': True, 21:59:25 INFO - 'sps_profile': False, 21:59:25 INFO - 'sps_profile_interval': 0, 21:59:25 INFO - 'suite': 'dromaeojs', 21:59:25 INFO - 'system_bits': '32', 21:59:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:59:25 INFO - 'title': 't-yosemite-r7-0254', 21:59:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:59:25 INFO - 'use_talos_json': True, 21:59:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:59:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:59:25 INFO - 'work_dir': 'build'} 21:59:25 INFO - [mozharness: 2017-01-25 05:59:25.715380Z] Running clobber step. 21:59:25 INFO - Running pre-action listener: _resource_record_pre_action 21:59:25 INFO - Running main action method: clobber 21:59:25 INFO - rmtree: /builds/slave/test/build 21:59:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:59:28 INFO - Running post-action listener: _resource_record_post_action 21:59:28 INFO - [mozharness: 2017-01-25 05:59:28.115189Z] Finished clobber step (success) 21:59:28 INFO - [mozharness: 2017-01-25 05:59:28.115389Z] Running read-buildbot-config step. 21:59:28 INFO - Running pre-action listener: _resource_record_pre_action 21:59:28 INFO - Running main action method: read_buildbot_config 21:59:28 INFO - Using buildbot properties: 21:59:28 INFO - { 21:59:28 INFO - "project": "", 21:59:28 INFO - "product": "firefox", 21:59:28 INFO - "script_repo_revision": "production", 21:59:28 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 21:59:28 INFO - "repository": "", 21:59:28 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 21:59:28 INFO - "buildid": "20170124193347", 21:59:28 INFO - "pgo_build": "False", 21:59:28 INFO - "basedir": "/builds/slave/test", 21:59:28 INFO - "buildnumber": 18, 21:59:28 INFO - "slavename": "t-yosemite-r7-0254", 21:59:28 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 21:59:28 INFO - "platform": "yosemite_r7", 21:59:28 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 21:59:28 INFO - "branch": "mozilla-beta", 21:59:28 INFO - "repo_path": "releases/mozilla-beta", 21:59:28 INFO - "revision": "9c78f6d58ab9691a46f640ff3a81d7a55ad7a848", 21:59:28 INFO - "stage_platform": "macosx64", 21:59:28 INFO - "builduid": "4112813809f74e4caa2725cd22ceadc8", 21:59:28 INFO - "slavebuilddir": "test" 21:59:28 INFO - } 21:59:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg. 21:59:28 INFO - Running post-action listener: _resource_record_post_action 21:59:28 INFO - [mozharness: 2017-01-25 05:59:28.120923Z] Finished read-buildbot-config step (success) 21:59:28 INFO - [mozharness: 2017-01-25 05:59:28.121079Z] Running download-and-extract step. 21:59:28 INFO - Running pre-action listener: _resource_record_pre_action 21:59:28 INFO - Running main action method: download_and_extract 21:59:28 INFO - mkdir: /builds/slave/test/build/tests 21:59: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')]} 21:59:28 INFO - trying https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json 21:59:28 INFO - Downloading https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 21:59:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json'}, attempt #1 21:59:29 INFO - Downloaded 1165 bytes. 21:59:29 INFO - Reading from file /builds/slave/test/build/firefox-52.0.en-US.mac.test_packages.json 21:59:29 INFO - Using the following test package requirements: 21:59:29 INFO - {u'common': [u'firefox-52.0.en-US.mac.common.tests.zip'], 21:59:29 INFO - u'cppunittest': [u'firefox-52.0.en-US.mac.common.tests.zip', 21:59:29 INFO - u'firefox-52.0.en-US.mac.cppunittest.tests.zip'], 21:59:29 INFO - u'gtest': [u'firefox-52.0.en-US.mac.common.tests.zip', 21:59:29 INFO - u'firefox-52.0.en-US.mac.gtest.tests.zip'], 21:59:29 INFO - u'jittest': [u'firefox-52.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 21:59:29 INFO - u'mochitest': [u'firefox-52.0.en-US.mac.common.tests.zip', 21:59:29 INFO - u'firefox-52.0.en-US.mac.mochitest.tests.zip'], 21:59:29 INFO - u'mozbase': [u'firefox-52.0.en-US.mac.common.tests.zip'], 21:59:29 INFO - u'reftest': [u'firefox-52.0.en-US.mac.common.tests.zip', 21:59:29 INFO - u'firefox-52.0.en-US.mac.reftest.tests.zip'], 21:59:29 INFO - u'talos': [u'firefox-52.0.en-US.mac.common.tests.zip', 21:59:29 INFO - u'firefox-52.0.en-US.mac.talos.tests.zip'], 21:59:29 INFO - u'web-platform': [u'firefox-52.0.en-US.mac.common.tests.zip', 21:59:29 INFO - u'firefox-52.0.en-US.mac.web-platform.tests.zip'], 21:59:29 INFO - u'xpcshell': [u'firefox-52.0.en-US.mac.common.tests.zip', 21:59:29 INFO - u'firefox-52.0.en-US.mac.xpcshell.tests.zip']} 21:59:29 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip'] for test suite category: common 21:59:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 21:59:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 21:59:29 INFO - Fetch https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 21:59:29 INFO - Http code: 200 21:59:29 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 21:59:29 INFO - x-amz-cf-id: SPzy4XDcYqBVF4h6JeA9fkGza1mmQS5br2cbMSyjgehyMgcTKBP15g== 21:59:29 INFO - x-amz-version-id: 1WxjECT9NhxFE6pYgHle.iC5GmWIDCnw 21:59:29 INFO - Expected file size: 16086201 21:59:29 INFO - Obtained file size: 16086201 21:59:36 INFO - Downloading packages: [u'firefox-52.0.en-US.mac.common.tests.zip', u'firefox-52.0.en-US.mac.talos.tests.zip'] for test suite category: talos 21:59:36 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip 21:59:36 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip'}, attempt #1 21:59:36 INFO - Fetch https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.common.tests.zip into memory 21:59:37 INFO - Http code: 200 21:59:37 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 21:59:37 INFO - x-amz-cf-id: YPPiDhlMRNzkcfvVh1O7sbsoN0qARX50NtmwQ-elvuUQYG1NEFnkug== 21:59:37 INFO - x-amz-version-id: 1WxjECT9NhxFE6pYgHle.iC5GmWIDCnw 21:59:37 INFO - Expected file size: 16086201 21:59:37 INFO - Obtained file size: 16086201 21:59:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip 21:59:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip'}, attempt #1 21:59:43 INFO - Fetch https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.talos.tests.zip into memory 21:59:44 INFO - Http code: 200 21:59:44 INFO - via: 1.1 ff555a0cc6346f82fe74596f8ed6cc33.cloudfront.net (CloudFront) 21:59:44 INFO - x-amz-cf-id: tfJihcx9SrzKbh3mLSbsZRf7I5PkWgaGMu_HZposbMAS9LGd00y-Ww== 21:59:44 INFO - x-amz-version-id: tZdzzCgzER_.G4lMnlAaAVoIRut.jHq2 21:59:45 INFO - Expected file size: 14402992 21:59:45 INFO - Obtained file size: 14402992 21:59:45 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')]} 21:59:45 INFO - trying https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 21:59:45 INFO - Downloading https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0.en-US.mac.dmg 21:59:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg'}, attempt #1 21:59:47 INFO - Downloaded 82123167 bytes. 21:59:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 21:59:47 INFO - mkdir: /builds/slave/test/properties 21:59:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:59:47 INFO - Writing to file /builds/slave/test/properties/build_url 21:59:47 INFO - Contents: 21:59:47 INFO - build_url:https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg 21:59:48 INFO - Running post-action listener: _resource_record_post_action 21:59:48 INFO - Running post-action listener: set_extra_try_arguments 21:59:48 INFO - [mozharness: 2017-01-25 05:59:48.274285Z] Finished download-and-extract step (success) 21:59:48 INFO - [mozharness: 2017-01-25 05:59:48.274421Z] Running populate-webroot step. 21:59:48 INFO - Running pre-action listener: _resource_record_pre_action 21:59:48 INFO - Running main action method: populate_webroot 21:59:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:59:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:59:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:59:48 INFO - '--tppagecycles', 21:59:48 INFO - '7'], 21:59:48 INFO - 'tests': ['tsvgm']}}, 21:59:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:59:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:59:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:59:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:59:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:59:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:59:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:48 INFO - 'talos_options': ['--disable-e10s'], 21:59:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:59:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:48 INFO - 'talos_options': ['--disable-e10s'], 21:59:48 INFO - 'tests': ['damp', 'tps']}, 21:59:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:48 INFO - 'tests': ['damp', 'tps']}, 21:59:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:59:48 INFO - 'tests': ['dromaeo_dom']}, 21:59:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:59:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:59:48 INFO - 'tests': ['basic_compositor_video']}, 21:59:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:59:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:59:48 INFO - 'tests': ['a11yr', 21:59:48 INFO - 'ts_paint', 21:59:48 INFO - 'tpaint', 21:59:48 INFO - 'sessionrestore', 21:59:48 INFO - 'sessionrestore_no_auto_restore', 21:59:48 INFO - 'tabpaint']}, 21:59:48 INFO - 'other-e10s': {'tests': ['a11yr', 21:59:48 INFO - 'ts_paint', 21:59:48 INFO - 'tpaint', 21:59:48 INFO - 'sessionrestore', 21:59:48 INFO - 'sessionrestore_no_auto_restore', 21:59:48 INFO - 'tabpaint']}, 21:59:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:59:48 INFO - 'ts_paint', 21:59:48 INFO - 'tpaint', 21:59:48 INFO - 'sessionrestore', 21:59:48 INFO - 'sessionrestore_no_auto_restore', 21:59:48 INFO - 'tabpaint']}, 21:59:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:59:48 INFO - 'ts_paint', 21:59:48 INFO - 'tpaint', 21:59:48 INFO - 'sessionrestore', 21:59:48 INFO - 'sessionrestore_no_auto_restore', 21:59:48 INFO - 'tabpaint']}, 21:59:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:59:48 INFO - 'tests': ['a11yr', 21:59:48 INFO - 'ts_paint', 21:59:48 INFO - 'tpaint', 21:59:48 INFO - 'sessionrestore', 21:59:48 INFO - 'sessionrestore_no_auto_restore', 21:59:48 INFO - 'tabpaint']}, 21:59:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:59:48 INFO - 'tests': ['a11yr', 21:59:48 INFO - 'ts_paint', 21:59:48 INFO - 'tpaint', 21:59:48 INFO - 'sessionrestore', 21:59:48 INFO - 'sessionrestore_no_auto_restore', 21:59:48 INFO - 'tabpaint']}, 21:59:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:59:48 INFO - 'tests': ['tsvgx', 21:59:48 INFO - 'tsvgr_opacity', 21:59:48 INFO - 'tart', 21:59:48 INFO - 'tscrollx', 21:59:48 INFO - 'cart']}, 21:59:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:59:48 INFO - 'tsvgr_opacity', 21:59:48 INFO - 'tart', 21:59:48 INFO - 'tscrollx', 21:59:48 INFO - 'cart']}, 21:59:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:48 INFO - 'talos_options': ['--disable-e10s'], 21:59:48 INFO - 'tests': ['tp5o']}, 21:59:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:48 INFO - 'tests': ['tp5o']}, 21:59:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:48 INFO - 'talos_options': ['--disable-e10s', 21:59:48 INFO - '--xperf_path', 21:59:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:48 INFO - 'tests': ['tp5n']}, 21:59:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:59:48 INFO - 'talos_options': ['--xperf_path', 21:59:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:59:48 INFO - 'tests': ['tp5n']}}, 21:59:48 INFO - 'talos.zip': {'path': '', 21:59:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:59:48 INFO - Running post-action listener: _resource_record_post_action 21:59:48 INFO - [mozharness: 2017-01-25 05:59:48.292922Z] Finished populate-webroot step (success) 21:59:48 INFO - [mozharness: 2017-01-25 05:59:48.293050Z] Running create-virtualenv step. 21:59:48 INFO - Running pre-action listener: _resource_record_pre_action 21:59:48 INFO - Running main action method: create_virtualenv 21:59:48 INFO - Creating virtualenv /builds/slave/test/build/venv 21:59:48 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 21:59:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:59:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:59:48 INFO - Using real prefix '/tools/python27' 21:59:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:59:49 INFO - Installing distribute.............................................................................................................................................................................................done. 21:59:51 INFO - Installing pip.................done. 21:59:51 INFO - Return code: 0 21:59:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:59:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:59:52 INFO - Reading from file tmpfile_stdout 21:59:52 INFO - Output received: 21:59:52 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) 21:59:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:59:52 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')]} 21:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:52 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')]} 21:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:52 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 0x10517b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fb25ab750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f8fd30>, '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 0x104df5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f87b20>, '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.oB4bhv6sh7/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.EmJ74aZmLN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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 21:59:52 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 21:59:52 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 21:59:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oB4bhv6sh7/Render', 21:59:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:52 INFO - 'HOME': '/Users/cltbld', 21:59:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:52 INFO - 'LOGNAME': 'cltbld', 21:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:52 INFO - 'MOZ_NO_REMOTE': '1', 21:59:52 INFO - 'NO_EM_RESTART': '1', 21:59:52 INFO - 'PAGER': '/bin/cat', 21:59:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:52 INFO - 'PWD': '/builds/slave/test', 21:59:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:52 INFO - 'SHELL': '/bin/bash', 21:59:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EmJ74aZmLN/Listeners', 21:59:52 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 21:59:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:52 INFO - 'USER': 'cltbld', 21:59:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:52 INFO - 'XPC_FLAGS': '0x0', 21:59:52 INFO - 'XPC_SERVICE_NAME': '0', 21:59:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:52 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 21:59:52 INFO - Cleaning up... 21:59:52 INFO - Return code: 0 21:59:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:59:52 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')]} 21:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:52 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')]} 21:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:52 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 0x10517b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fb25ab750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f8fd30>, '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 0x104df5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f87b20>, '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.oB4bhv6sh7/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.EmJ74aZmLN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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 21:59:52 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 21:59:52 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 21:59:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oB4bhv6sh7/Render', 21:59:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:52 INFO - 'HOME': '/Users/cltbld', 21:59:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:52 INFO - 'LOGNAME': 'cltbld', 21:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:52 INFO - 'MOZ_NO_REMOTE': '1', 21:59:52 INFO - 'NO_EM_RESTART': '1', 21:59:52 INFO - 'PAGER': '/bin/cat', 21:59:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:52 INFO - 'PWD': '/builds/slave/test', 21:59:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:52 INFO - 'SHELL': '/bin/bash', 21:59:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EmJ74aZmLN/Listeners', 21:59:52 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 21:59:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:52 INFO - 'USER': 'cltbld', 21:59:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:52 INFO - 'XPC_FLAGS': '0x0', 21:59:52 INFO - 'XPC_SERVICE_NAME': '0', 21:59:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:52 INFO - Downloading/unpacking psutil>=3.1.1 21:59:52 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 21:59:52 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 21:59:52 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 21:59:52 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 21:59:52 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 21:59:52 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 21:59:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:59:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:56 INFO - Installing collected packages: psutil 21:59:56 INFO - Running setup.py install for psutil 21:59:56 INFO - building 'psutil._psutil_osx' extension 21:59:56 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 21:59:56 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 21:59:56 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 21:59:57 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 21:59:57 INFO - building 'psutil._psutil_posix' extension 21:59:57 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 21:59:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:59:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:59:57 INFO - ^ 21:59:57 INFO - 1 warning generated. 21:59:57 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 21:59:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:59:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:59:57 INFO - Successfully installed psutil 21:59:57 INFO - Cleaning up... 21:59:57 INFO - Return code: 0 21:59:57 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:59:57 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')]} 21:59:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:59:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:57 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')]} 21:59:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:59:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:59:57 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 0x10517b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fb25ab750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f8fd30>, '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 0x104df5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f87b20>, '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.oB4bhv6sh7/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.EmJ74aZmLN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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 21:59:57 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 21:59:57 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 21:59:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oB4bhv6sh7/Render', 21:59:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:59:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:59:57 INFO - 'HOME': '/Users/cltbld', 21:59:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:59:57 INFO - 'LOGNAME': 'cltbld', 21:59:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:59:57 INFO - 'MOZ_NO_REMOTE': '1', 21:59:57 INFO - 'NO_EM_RESTART': '1', 21:59:57 INFO - 'PAGER': '/bin/cat', 21:59:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:59:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:59:57 INFO - 'PWD': '/builds/slave/test', 21:59:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:59:57 INFO - 'SHELL': '/bin/bash', 21:59:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EmJ74aZmLN/Listeners', 21:59:57 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 21:59:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:59:57 INFO - 'USER': 'cltbld', 21:59:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:59:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:59:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:59:57 INFO - 'XPC_FLAGS': '0x0', 21:59:57 INFO - 'XPC_SERVICE_NAME': '0', 21:59:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:59:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:59:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:59:57 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 21:59:57 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 21:59:57 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 21:59:57 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 21:59:57 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 21:59:57 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 22:00:00 INFO - Downloading mozsystemmonitor-0.3.tar.gz 22:00:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:00:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 22:00:00 INFO - Installing collected packages: mozsystemmonitor 22:00:00 INFO - Running setup.py install for mozsystemmonitor 22:00:00 INFO - Successfully installed mozsystemmonitor 22:00:00 INFO - Cleaning up... 22:00:00 INFO - Return code: 0 22:00:00 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 22:00:00 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')]} 22:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:00 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')]} 22:00:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:00 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 0x10517b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fb25ab750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f8fd30>, '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 0x104df5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f87b20>, '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.oB4bhv6sh7/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.EmJ74aZmLN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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 22:00:00 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 22:00:00 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 22:00:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oB4bhv6sh7/Render', 22:00:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:00:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:00:00 INFO - 'HOME': '/Users/cltbld', 22:00:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:00:00 INFO - 'LOGNAME': 'cltbld', 22:00:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:00 INFO - 'MOZ_NO_REMOTE': '1', 22:00:00 INFO - 'NO_EM_RESTART': '1', 22:00:00 INFO - 'PAGER': '/bin/cat', 22:00:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:00:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:00 INFO - 'PWD': '/builds/slave/test', 22:00:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:00:00 INFO - 'SHELL': '/bin/bash', 22:00:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EmJ74aZmLN/Listeners', 22:00:00 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 22:00:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:00:00 INFO - 'USER': 'cltbld', 22:00:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:00:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:00:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:00 INFO - 'XPC_FLAGS': '0x0', 22:00:00 INFO - 'XPC_SERVICE_NAME': '0', 22:00:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:00:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:00 INFO - Downloading/unpacking jsonschema==2.5.1 22:00:00 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 22:00:00 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 22:00:00 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 22:00:00 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 22:00:00 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 22:00:00 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 22:00:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:00:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 22:00:03 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 22:00:03 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 22:00:03 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 22:00:03 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 22:00:03 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 22:00:03 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 22:00:03 INFO - Downloading functools32-3.2.3-2.tar.gz 22:00:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:00:03 INFO - warning: no files found matching '*.txt' 22:00:03 INFO - no previously-included directories found matching 'build' 22:00:03 INFO - no previously-included directories found matching 'dist' 22:00:03 INFO - no previously-included directories found matching '.git*' 22:00:03 INFO - Installing collected packages: jsonschema, functools32 22:00:03 INFO - Running setup.py install for functools32 22:00:04 INFO - warning: no files found matching '*.txt' 22:00:04 INFO - no previously-included directories found matching 'build' 22:00:04 INFO - no previously-included directories found matching 'dist' 22:00:04 INFO - no previously-included directories found matching '.git*' 22:00:04 INFO - Successfully installed jsonschema functools32 22:00:04 INFO - Cleaning up... 22:00:04 INFO - Return code: 0 22:00:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 22:00:04 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')]} 22:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:04 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')]} 22:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:04 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 0x10517b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fb25ab750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f8fd30>, '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 0x104df5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f87b20>, '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.oB4bhv6sh7/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.EmJ74aZmLN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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 22:00:04 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 22:00:04 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 22:00:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oB4bhv6sh7/Render', 22:00:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:00:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:00:04 INFO - 'HOME': '/Users/cltbld', 22:00:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:00:04 INFO - 'LOGNAME': 'cltbld', 22:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:04 INFO - 'MOZ_NO_REMOTE': '1', 22:00:04 INFO - 'NO_EM_RESTART': '1', 22:00:04 INFO - 'PAGER': '/bin/cat', 22:00:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:04 INFO - 'PWD': '/builds/slave/test', 22:00:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:00:04 INFO - 'SHELL': '/bin/bash', 22:00:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EmJ74aZmLN/Listeners', 22:00:04 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 22:00:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:00:04 INFO - 'USER': 'cltbld', 22:00:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:00:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:04 INFO - 'XPC_FLAGS': '0x0', 22:00:04 INFO - 'XPC_SERVICE_NAME': '0', 22:00:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 22:00:04 INFO - Cleaning up... 22:00:04 INFO - Return code: 0 22:00:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:00:04 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')]} 22:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:04 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')]} 22:00:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:04 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 0x10517b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fb25ab750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f8fd30>, '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 0x104df5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f87b20>, '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.oB4bhv6sh7/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.EmJ74aZmLN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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 22:00:04 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 22:00:04 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 22:00:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oB4bhv6sh7/Render', 22:00:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:00:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:00:04 INFO - 'HOME': '/Users/cltbld', 22:00:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:00:04 INFO - 'LOGNAME': 'cltbld', 22:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:04 INFO - 'MOZ_NO_REMOTE': '1', 22:00:04 INFO - 'NO_EM_RESTART': '1', 22:00:04 INFO - 'PAGER': '/bin/cat', 22:00:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:04 INFO - 'PWD': '/builds/slave/test', 22:00:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:00:04 INFO - 'SHELL': '/bin/bash', 22:00:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EmJ74aZmLN/Listeners', 22:00:04 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 22:00:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:00:04 INFO - 'USER': 'cltbld', 22:00:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:00:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:04 INFO - 'XPC_FLAGS': '0x0', 22:00:04 INFO - 'XPC_SERVICE_NAME': '0', 22:00:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:00:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:04 INFO - Downloading/unpacking blobuploader==1.2.4 22:00:04 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 22:00:04 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 22:00:04 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 22:00:04 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 22:00:04 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 22:00:04 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 22:00:07 INFO - Downloading blobuploader-1.2.4.tar.gz 22:00:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:00:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:00:07 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 22:00:07 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 22:00:07 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 22:00:07 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 22:00:07 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 22:00:07 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 22:00:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:00:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:00:08 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 22:00:08 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 22:00:08 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 22:00:08 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 22:00:08 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 22:00:08 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 22:00:08 INFO - Downloading docopt-0.6.1.tar.gz 22:00:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:00:08 INFO - Installing collected packages: blobuploader, requests, docopt 22:00:08 INFO - Running setup.py install for blobuploader 22:00:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:00:08 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:00:08 INFO - Running setup.py install for requests 22:00:09 INFO - Running setup.py install for docopt 22:00:09 INFO - Successfully installed blobuploader requests docopt 22:00:09 INFO - Cleaning up... 22:00:09 INFO - Return code: 0 22:00:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:00:09 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')]} 22:00:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:09 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')]} 22:00:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:09 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 0x10517b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fb25ab750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f8fd30>, '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 0x104df5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f87b20>, '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.oB4bhv6sh7/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.EmJ74aZmLN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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 22:00:09 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 22:00:09 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 22:00:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oB4bhv6sh7/Render', 22:00:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:00:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:00:09 INFO - 'HOME': '/Users/cltbld', 22:00:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:00:09 INFO - 'LOGNAME': 'cltbld', 22:00:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:09 INFO - 'MOZ_NO_REMOTE': '1', 22:00:09 INFO - 'NO_EM_RESTART': '1', 22:00:09 INFO - 'PAGER': '/bin/cat', 22:00:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:00:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:09 INFO - 'PWD': '/builds/slave/test', 22:00:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:00:09 INFO - 'SHELL': '/bin/bash', 22:00:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EmJ74aZmLN/Listeners', 22:00:09 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 22:00:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:00:09 INFO - 'USER': 'cltbld', 22:00:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:00:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:00:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:09 INFO - 'XPC_FLAGS': '0x0', 22:00:09 INFO - 'XPC_SERVICE_NAME': '0', 22:00:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:00:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:00:09 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-4hwmQe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:00:09 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-j_BaXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:00:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:00:09 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-faWgGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:00:10 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-dLSkt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:00:10 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-aFW1pO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:00:10 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-A_v4Rg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:00:10 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-x0aGeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:00:10 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-0pZVT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:00:10 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-bT6jDw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:00:10 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-rXNFri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:00:10 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-CF4WH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:00:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:00:10 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-E2iuJ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:00:11 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-dYUNZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:00:11 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-Pc6GFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:11 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-nQcuKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:00:11 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-teLMKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:00:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:00:11 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-J1m29i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:00:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:00:11 INFO - Running setup.py install for manifestparser 22:00:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:00:11 INFO - Running setup.py install for mozcrash 22:00:11 INFO - Running setup.py install for mozdebug 22:00:11 INFO - Running setup.py install for mozdevice 22:00:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:00:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:00:12 INFO - Running setup.py install for mozfile 22:00:12 INFO - Running setup.py install for mozhttpd 22:00:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:00:12 INFO - Running setup.py install for mozinfo 22:00:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:00:12 INFO - Running setup.py install for mozInstall 22:00:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:00:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:00:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:00:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:00:12 INFO - Running setup.py install for mozleak 22:00:12 INFO - Running setup.py install for mozlog 22:00:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:00:13 INFO - Running setup.py install for moznetwork 22:00:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:00:13 INFO - Running setup.py install for mozprocess 22:00:13 INFO - Running setup.py install for mozprofile 22:00:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:00:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:00:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:00:13 INFO - Running setup.py install for mozrunner 22:00:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:00:13 INFO - Running setup.py install for mozscreenshot 22:00:13 INFO - Running setup.py install for moztest 22:00:13 INFO - Running setup.py install for mozversion 22:00:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:00:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:00:14 INFO - Cleaning up... 22:00:14 INFO - Return code: 0 22:00:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:00:14 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')]} 22:00:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:14 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')]} 22:00:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:14 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 0x10517b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fb25ab750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f8fd30>, '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 0x104df5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f87b20>, '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.oB4bhv6sh7/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.EmJ74aZmLN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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 22:00:14 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 22:00:14 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 22:00:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oB4bhv6sh7/Render', 22:00:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:00:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:00:14 INFO - 'HOME': '/Users/cltbld', 22:00:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:00:14 INFO - 'LOGNAME': 'cltbld', 22:00:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:14 INFO - 'MOZ_NO_REMOTE': '1', 22:00:14 INFO - 'NO_EM_RESTART': '1', 22:00:14 INFO - 'PAGER': '/bin/cat', 22:00:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:00:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:14 INFO - 'PWD': '/builds/slave/test', 22:00:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:00:14 INFO - 'SHELL': '/bin/bash', 22:00:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EmJ74aZmLN/Listeners', 22:00:14 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 22:00:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:00:14 INFO - 'USER': 'cltbld', 22:00:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:00:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:00:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:14 INFO - 'XPC_FLAGS': '0x0', 22:00:14 INFO - 'XPC_SERVICE_NAME': '0', 22:00:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:00:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:00:14 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-5eostd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:00:14 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)) 22:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:00:14 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-3QAq4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:00:14 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 22:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:00:14 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-8OTdp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:00:14 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)) 22:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:00:14 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-vFip8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:00:14 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)) 22:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:00:14 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-GDMbOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:00:14 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)) 22:00:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:00:14 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-vfAP60-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:00:15 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)) 22:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:00:15 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-isLNvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:00:15 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)) 22:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:00:15 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-cdX1Ax-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:00:15 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)) 22:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:00:15 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-pr9OK9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:00:15 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)) 22:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:00:15 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-nwOWbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:00:15 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)) 22:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:00:15 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-iPEuzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:00:15 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)) 22:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:00:15 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-LFF2nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:00:15 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)) 22:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:00:15 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-aDqNqw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:00:15 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)) 22:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:00:15 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-qw1Vd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:00:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 22:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:15 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-mtGbEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:00:15 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)) 22:00:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:00:15 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-17YinG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 22:00:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:00:16 INFO - Running setup.py (path:/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/pip-6voItu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:00:16 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)) 22:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:00:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:00:16 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)) 22:00:16 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)) 22:00:16 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)) 22:00:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:00:16 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 22:00:16 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 22:00:16 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 22:00:16 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 22:00:16 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 22:00:16 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 22:00:18 INFO - Downloading blessings-1.6.tar.gz 22:00:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:00:18 INFO - Installing collected packages: blessings 22:00:18 INFO - Running setup.py install for blessings 22:00:19 INFO - Successfully installed blessings 22:00:19 INFO - Cleaning up... 22:00:19 INFO - Return code: 0 22:00:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:00:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:00:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:00:19 INFO - Reading from file tmpfile_stdout 22:00:19 INFO - Current package versions: 22:00:19 INFO - blessings == 1.6 22:00:19 INFO - blobuploader == 1.2.4 22:00:19 INFO - docopt == 0.6.1 22:00:19 INFO - functools32 == 3.2.3-2 22:00:19 INFO - jsonschema == 2.5.1 22:00:19 INFO - manifestparser == 1.1 22:00:19 INFO - mozInstall == 1.12 22:00:19 INFO - mozcrash == 1.0 22:00:19 INFO - mozdebug == 0.1 22:00:19 INFO - mozdevice == 0.48 22:00:19 INFO - mozfile == 1.2 22:00:19 INFO - mozhttpd == 0.7 22:00:19 INFO - mozinfo == 0.9 22:00:19 INFO - mozleak == 0.1 22:00:19 INFO - mozlog == 3.4 22:00:19 INFO - moznetwork == 0.27 22:00:19 INFO - mozprocess == 0.23 22:00:19 INFO - mozprofile == 0.28 22:00:19 INFO - mozrunner == 6.13 22:00:19 INFO - mozscreenshot == 0.1 22:00:19 INFO - mozsystemmonitor == 0.3 22:00:19 INFO - moztest == 0.8 22:00:19 INFO - mozversion == 1.4 22:00:19 INFO - psutil == 3.1.1 22:00:19 INFO - requests == 1.2.3 22:00:19 INFO - wsgiref == 0.1.2 22:00:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:00: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')]} 22:00:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00: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')]} 22:00:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00:20 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 0x10517b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fb25ab750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f8fd30>, '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 0x104df5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f87b20>, '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.oB4bhv6sh7/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.EmJ74aZmLN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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 22:00:20 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 22:00:20 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 22:00:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oB4bhv6sh7/Render', 22:00:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:00:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:00:20 INFO - 'HOME': '/Users/cltbld', 22:00:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:00:20 INFO - 'LOGNAME': 'cltbld', 22:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:20 INFO - 'MOZ_NO_REMOTE': '1', 22:00:20 INFO - 'NO_EM_RESTART': '1', 22:00:20 INFO - 'PAGER': '/bin/cat', 22:00:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:20 INFO - 'PWD': '/builds/slave/test', 22:00:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:00:20 INFO - 'SHELL': '/bin/bash', 22:00:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EmJ74aZmLN/Listeners', 22:00:20 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 22:00:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:00:20 INFO - 'USER': 'cltbld', 22:00:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:00:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:20 INFO - 'XPC_FLAGS': '0x0', 22:00:20 INFO - 'XPC_SERVICE_NAME': '0', 22:00:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:00:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:20 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)) 22:00:20 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)) 22:00:20 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)) 22:00:20 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)) 22:00:20 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)) 22:00:20 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)) 22:00:20 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)) 22:00:20 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)) 22:00:20 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)) 22:00:20 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)) 22:00:20 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)) 22:00:20 INFO - Cleaning up... 22:00:20 INFO - Return code: 0 22:00:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:00: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')]} 22:00:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:00:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00: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')]} 22:00:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:00:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:00: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10517b490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1050f1570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9fb25ab750>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f8fd30>, '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 0x104df5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f87b20>, '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.oB4bhv6sh7/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.EmJ74aZmLN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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 22:00: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', 'jsonschema'] in /builds/slave/test/build 22:00: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 jsonschema 22:00:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oB4bhv6sh7/Render', 22:00:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:00:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:00:20 INFO - 'HOME': '/Users/cltbld', 22:00:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:00:20 INFO - 'LOGNAME': 'cltbld', 22:00:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:20 INFO - 'MOZ_NO_REMOTE': '1', 22:00:20 INFO - 'NO_EM_RESTART': '1', 22:00:20 INFO - 'PAGER': '/bin/cat', 22:00:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:00:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:20 INFO - 'PWD': '/builds/slave/test', 22:00:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:00:20 INFO - 'SHELL': '/bin/bash', 22:00:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EmJ74aZmLN/Listeners', 22:00:20 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 22:00:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:00:20 INFO - 'USER': 'cltbld', 22:00:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:00:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:00:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:20 INFO - 'XPC_FLAGS': '0x0', 22:00:20 INFO - 'XPC_SERVICE_NAME': '0', 22:00:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:00:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:00:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 22:00:21 INFO - Cleaning up... 22:00:21 INFO - Return code: 0 22:00:21 INFO - Running post-action listener: _resource_record_post_action 22:00:21 INFO - Running post-action listener: _start_resource_monitoring 22:00:21 INFO - Starting resource monitoring. 22:00:21 INFO - [mozharness: 2017-01-25 06:00:21.134957Z] Finished create-virtualenv step (success) 22:00:21 INFO - [mozharness: 2017-01-25 06:00:21.135750Z] Running install step. 22:00:21 INFO - Running pre-action listener: _resource_record_pre_action 22:00:21 INFO - Running main action method: install 22:00:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:00:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:00:21 INFO - Reading from file tmpfile_stdout 22:00:21 INFO - Detecting whether we're running mozinstall >=1.0... 22:00:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:00:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:00:21 INFO - Reading from file tmpfile_stdout 22:00:21 INFO - Output received: 22:00:21 INFO - Usage: mozinstall [options] installer 22:00:21 INFO - Options: 22:00:21 INFO - -h, --help show this help message and exit 22:00:21 INFO - -d DEST, --destination=DEST 22:00:21 INFO - Directory to install application into. [default: 22:00:21 INFO - "/builds/slave/test"] 22:00:21 INFO - --app=APP Application being installed. [default: firefox] 22:00:21 INFO - mkdir: /builds/slave/test/build/application 22:00:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 22:00:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0.en-US.mac.dmg --destination /builds/slave/test/build/application 22:00:42 INFO - Reading from file tmpfile_stdout 22:00:42 INFO - Output received: 22:00:42 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 22:00:42 INFO - Running post-action listener: _resource_record_post_action 22:00:42 INFO - [mozharness: 2017-01-25 06:00:42.975974Z] Finished install step (success) 22:00:42 INFO - [mozharness: 2017-01-25 06:00:42.976113Z] Running run-tests step. 22:00:42 INFO - Running pre-action listener: _resource_record_pre_action 22:00:42 INFO - Running main action method: run_tests 22:00:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:00:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:00:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:00:42 INFO - 2017-01-24 22:00:42.990 screenresolution[1622:7236] starting screenresolution argv=screenresolution get 22:00:42 INFO - 2017-01-24 22:00:42.993 screenresolution[1622:7236] Display 0: 1600x1200x32@60 22:00:43 INFO - 2017-01-24 22:00:42.999 screenresolution[1623:7238] starting screenresolution argv=screenresolution list 22:00:43 INFO - Available Modes on Display 0 22:00:43 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:00:43 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:00:43 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:00:43 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:00:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:00:43 INFO - Intel Iris: 22:00:43 INFO - Chipset Model: Intel Iris 22:00:43 INFO - Type: GPU 22:00:43 INFO - Bus: Built-In 22:00:43 INFO - VRAM (Dynamic, Max): 1536 MB 22:00:43 INFO - Vendor: Intel (0x8086) 22:00:43 INFO - Device ID: 0x0a2e 22:00:43 INFO - Revision ID: 0x0009 22:00:43 INFO - Displays: 22:00:43 INFO - Display: 22:00:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:00:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:00:43 INFO - Display Serial Number: 1600x1200 60 22:00:43 INFO - Main Display: Yes 22:00:43 INFO - Mirror: Off 22:00:43 INFO - Online: Yes 22:00:43 INFO - Rotation: Supported 22:00:43 INFO - Return code: 0 22:00:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:00:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:00:43 INFO - Python 2.7.3 22:00:43 INFO - Return code: 0 22:00:43 INFO - grabbing minidump binary from tooltool 22:00:43 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')]} 22:00:43 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 0x104f8fd30>, '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 0x104df5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104f87b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:00:43 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 22:00:43 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 22:00:43 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 22:00:43 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:00:43 INFO - Return code: 0 22:00:43 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 22:00:43 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:00:43 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:00:43 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 22:00:43 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:00:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0254', '--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 22:00:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0254 --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 22:00:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oB4bhv6sh7/Render', 22:00:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 22:00:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 22:00:43 INFO - 'HOME': '/Users/cltbld', 22:00:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 22:00:43 INFO - 'LOGNAME': 'cltbld', 22:00:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:00:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 22:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:00:43 INFO - 'MOZ_NO_REMOTE': '1', 22:00:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:00:43 INFO - 'NO_EM_RESTART': '1', 22:00:43 INFO - 'PAGER': '/bin/cat', 22:00:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 22:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:00:43 INFO - 'PWD': '/builds/slave/test', 22:00:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:00:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 22:00:43 INFO - 'SHELL': '/bin/bash', 22:00:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.EmJ74aZmLN/Listeners', 22:00:43 INFO - 'TMPDIR': '/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/', 22:00:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 22:00:43 INFO - 'USER': 'cltbld', 22:00:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 22:00:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 22:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:00:43 INFO - 'XPC_FLAGS': '0x0', 22:00:43 INFO - 'XPC_SERVICE_NAME': '0', 22:00:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 22:00:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0254', '--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 22:00:43 INFO - mozversion application_buildid: 20170124193347 22:00:43 INFO - mozversion application_changeset: 9c78f6d58ab9691a46f640ff3a81d7a55ad7a848 22:00:43 INFO - mozversion application_display_name: Firefox 22:00:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:00:43 INFO - mozversion application_name: Firefox 22:00:43 INFO - mozversion application_remotingname: firefox 22:00:43 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 22:00:43 INFO - mozversion application_vendor: Mozilla 22:00:43 INFO - mozversion application_version: 52.0 22:00:43 INFO - mozversion platform_buildid: 20170124193347 22:00:43 INFO - mozversion platform_changeset: 9c78f6d58ab9691a46f640ff3a81d7a55ad7a848 22:00:43 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 22:00:43 INFO - mozversion platform_version: 52.0 22:00:43 INFO - using testdate: 1485324043 22:00:43 INFO - actual date: 1485324043 22:00:43 INFO - starting webserver on 'localhost:49235' 22:00:43 INFO - SUITE-START | Running 2 tests 22:00:43 INFO - TEST-START | dromaeo_css 22:00:43 INFO - operating with platform_type : mac_ 22:00:43 INFO - Initialising browser for dromaeo_css test... 22:00:43 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/tmpFveVfO/profile http://localhost:49235/getInfo.html) 22:00:46 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 22:00:46 INFO - PROCESS | 1633 | colorDepth:24 22:00:46 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 22:00:46 INFO - PROCESS | 1633 | __metrics 22:00:46 INFO - PROCESS | 1633 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:00:46 INFO - PROCESS | 1633 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:00:47 INFO - TEST-INFO | 1633: exit 0 22:00:47 INFO - Browser initialized. 22:00:47 INFO - Running cycle 1/1 for dromaeo_css test... 22:00:47 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/tmpFveVfO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:00:59 INFO - PROCESS | 1636 | RSS: Main: 167706624 22:00:59 INFO - PROCESS | 1636 | 22:04:04 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49235/tests/dromaeo/cssquery-ext.html) 22:04:05 INFO - PROCESS | 1636 | RSS: Main: 278515712 22:04:05 INFO - PROCESS | 1636 | 22:07:08 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-ext.html (next: http://localhost:49235/tests/dromaeo/cssquery-jquery.html) 22:07:08 INFO - PROCESS | 1636 | RSS: Main: 298438656 22:07:08 INFO - PROCESS | 1636 | 22:10:11 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49235/tests/dromaeo/cssquery-mootools.html) 22:10:11 INFO - PROCESS | 1636 | RSS: Main: 260644864 22:10:11 INFO - PROCESS | 1636 | 22:13:14 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49235/tests/dromaeo/cssquery-prototype.html) 22:13:14 INFO - PROCESS | 1636 | RSS: Main: 284745728 22:13:14 INFO - PROCESS | 1636 | 22:16:17 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49235/tests/dromaeo/cssquery-yui.html) 22:16:18 INFO - PROCESS | 1636 | RSS: Main: 256262144 22:16:18 INFO - PROCESS | 1636 | 22:19:21 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49235/tests/dromaeo/cssquery-yui.html (next: http://localhost:49235/tests/dromaeo/cssquery-dojo.html) 22:19:21 INFO - PROCESS | 1636 | RSS: Main: 358785024 22:19:21 INFO - PROCESS | 1636 | 22:19:21 INFO - PROCESS | 1636 | __start_tp_report 22:19:21 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 22:19:21 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 22:19:21 INFO - PROCESS | 1636 | |i|pagename|runs| 22:19:21 INFO - PROCESS | 1636 | |0;dojo.html;3426.948595771064;3530.2762933598633;3547.645235476453;3553.147244661282;3603.58558765742;5830.12548117782;5835.153902684108;5863.296404431463;5880.5883588148845;5904.734286957087;5968.79109231177;6010.57925945184;6022.427869352416;6032.69836508175;6057.606255593394;4138.855140070098;5014.991005396751;5335.813246536372;5365.678059316453;5384.838454846361;5336.9733151334385;5353.678779273237;5355.303810504648;5481.342238931334;5490.231367608538;5390;5415.512603865652;5432.619716619838;5443.237946687467;5447.972760136194;5413.215083812845;5430.782768689248;5490.862728431781;5496.230527726081;5502.532284755801;5270;5387.326584176978;5400.756965936543;5417.783288668448;5498.395176530618;5827.912581311284;5853.326867410217;5855.677937713424;5873.060310350366;5927.851803704899;6270.3144629005365;6272.466840318579;6318.368163183691;6329.272133704637;6364.968175159141;6313.779017734358;6325.746970121189;6343.587666801689;6344.555881088326;6384.201974753156;5908.350081490989;5945.881082378328;6026;6050.909236361458;6064.241969753781;6402;6455.096286519797;6456.0961465394885;6463.967680161663;6471;6366.713497892513;6388.361163883575;6397.296297407282;6403.711832967528;6413.102165696806;6246.437820596168;6255.186825712628;6272.717727702265;6305.117283580303;6330.177076979963;6332.651704156316;6357.682115894187;6381.585196962183;6382.106505089291;6396.136521569621;6294.716737746812;6323.399277068763;6349.46029587481;6370.331115232834;6384.968075159594;5004.724740139327;5063.873403164876;5071.239314102914;5092.898142037138;5105.285260063594;4613.700109492872;4627.143978363946;4629.837955671535;4666.719996800203;4696.2720778278735;6037.63774173551;6141.907871381933;6144.078388241799;6154.753809847556;6160;6127.097902969301;6256.718447669866;6309.305976342691;6339.651319177489;6346.777862774873;5971.954907891101;6105.283054531754;6110.649890384107;6116.914073580098;6154.969225153935;5641.464060914206;5663.980483513007;5665.6034077614995;5685.403032681592;5710.2862142232225;6293.685315734287;6585.143931288998;6593.934060659332;6611.66941652925;6613.173353330833;6215.223097112861;6236.126942228182;6243.656598887105;6263.060540918898;6277.058441233851;6581.967090164519;6593.769218077345;6598.901016484852;6600;6610.206775187008;6258.780942666985;6323.652199129092;6328.114064030948;6331.778387756406;6334.9366506334345;6223.190985171898;6230.844228894314;6235.844103897439;6239.78160764371;6333.145025421693;5288;5477.863053423696;6217.347178546188;6323.104341705217;6365.949618313111;6290.874182516232;6304.5586808922935;6327.841803954938;6335.3981371769605;6338;6040.818775436744;6096.237970253718;6111.964830093352;6119.694015299128;6130.237616550872;6176.289726681489;6282.685865706605;6291.087792270187;6302.338254483213;6326.620402775849;6089.786857459968;6169.907451388143;6182.876342473215;6185.134081228722;6191.659458729813 22:19:21 INFO - PROCESS | 1636 | |1;ext.html;500.3845270317509;538.5341679447276;548.9505944465;562.1876388618448;579.7391173971711;23616.29151125467;40440.59559404405;41592.16815663685;41641.791791041;43271;42986.57013429865;43204.13591728164;43358.78320608393;43382.78308608453;43545.34681979765;9582.041795820414;9725.27060470464;9755.707328780112;9756.268279879003;9757.024297570257;9544.95227523865;9671.613135474572;9673.274504412162;9675.080867317594;9690.127888490035;9656.372335798185;9676.467794271312;9684.951575242148;9691.854622180674;9696;9655.855162172573;9659.565319560637;9668.564914578825;9677.370970886941;9707.90292097077;9537.761555961088;9594;9626;9634.373765705206;9639.036096390375;39854.80072599618;40200.597994019976;40278;40315.596844031774;40344.798276008725;3352.279259959096;3366.646502117267;3407.693307602328;3467.7572569920117;3889.9416508752392;29178.708212917812;29583.852080739674;29911.252218694488;31074.84462577673;31573.368532629447;3283.770136090475;3286.7699261051735;3288.753343499247;3331.53358529806;3359.0426728382295;516031;516347;517672;518283.40858295845;520942.3952880249;34470.31059378798;35038;35295.11762205965;59881;60611.69694151501;36335.4549681755;36480.27039459196;36555.26889462249;36580;36646.816765916;14384.35270412834;14474.059186152866;14512.492062777752;14527.983041187226;14563.708725825636;12617;12770.744585108247;12771;12780.808287875689;12782.360881955865;8038.517688938682;8049.798755031171;8058.556779377191;8122.106568277485;8129.634166462523;3318.352921180395;3327.517509961042;3344.39800835847;3346.0798280473064;3366.6969972702573;933.7198840347869;936.6674830435097;957.636098282662;1045.075108528942;1094.5457635081511;29579;29807.850960745058;30088.398232035237;30250.09249722512;30429.391412171633;932.846080396727;1077.6336045744486;1096.1285777806663;1168.4917061078459;1186.988130118705;15449.5365139046;15493.922530387275;15557.377704891678;15909.68180636404;15941.521754347388;601905;712767;712942;714495;717237;57332.71333643305;57832.421675783546;57972;57983;58144;1259.7165637731437;1299.9870001299867;1372.2246930484243;1395.5534229046812;1412.9788053179211;29606.703932961256;30767;30866.0740177795;31036.22409439782;31581.52627710632;49587.504124959734;50018;50199;50245.49754502408;50368.496315037846;518327;520177;520692;525649.7435025753;528176.5138220143;24048.75951240535;24692.629610556214;26333.34166645849;26912.461750765266;27012.72987270102;46339;46578;46841.76579117082;47197.76401117972;47825;38185;38443.615563844;39325.60674393219;40409;40624.390634141106;38314;38358.23283534258;38875.80562097171;39674.801625991684;39859.40210896897;37442;38085;38302.42546361862;38494.615053849106;38814;32762;34032.65967340394;34767.30465390627;34802.477962830075;34956;25017.374565636004;25763.40646709026;25803.870980644977;26825.587360724126;26920.865395673678 22:19:21 INFO - PROCESS | 1636 | |2;jquery.html;329.4169320303062;376.9038895081754;389.5062435559628;397.66397394201925;413.9813708383123;15203.239838008083;15821.60445988851;19037.82196610306;21217.99999999998;21340.57318853622;17053.82946170538;17913.552161195945;20069;20752;20938.26716064938;5716.77132914685;5896.292444906617;6184.350643182469;6190.164327815754;6201.875962480748;5342.171963345688;6091.756329746805;6135.9079613805825;6137.2942111657285;6141.293751218623;4321;4538.863834084967;6088.238970128734;6379.744810207586;6647.734090636369;6543.357100445577;6653.700583473756;6736.696848641823;6755.966220168917;6763.729450821986;5855.970720146414;5871.55963302754;5878.970605146947;5879.970600146972;5894.911576326359;24655.753442465524;25686.229413117635;25745.613815792778;25982.610260846104;26089.478210435875;2371.34787933318;2606.739326067397;2729.849858257795;2765.2533815869806;3004.744596709282;15187.468438604596;15584.688306233811;15911.283992220262;16486.505404837873;16521.92607480522;1671.2729962466367;1832.395309547846;1937.409090227494;1991.800819918011;2037.5313677854028;104511.47744261306;122137;124489.37755311166;126618;128811.35594322062;10618.628348007782;10664.146868250522;11163.27438716497;11227.831582526269;11326.773464530663;14053.85946140546;14069.929650351683;14081.859181408056;14106.365213565414;14119.43522259098;7078.362947334765;8199.262066414052;8480.151984801594;8483.194096560817;8567.014793298726;8450.028246751703;8480.491170529787;8516.574171291535;8615.052344242129;8632.525211113449;5448.700321482356;5504.532114770209;6252.718627661675;6622.569532980341;6694.196696396463;1707.1208327711238;1759.7008508553577;1825.799162092169;1826.2603645523584;1897;880.326550189093;906.3881879731155;961.5817119552877;1010.282699283517;1037.4397825174321;21404.678929816066;21515;21837.235696750857;21958;22178.556428871332;925.5372313843078;942.7171848445439;953.1040821627648;976.702105857706;1008.7528555503949;10355.844662330072;11642.126840486828;11720.765584688428;11756.23584467024;11789.76420471603;608166;617384;623599;633495;637906.8104659447;90158.54920725354;113838;118414;120235;123194.76805231832;1019.7195771162841;1028.717102796737;1062.2776511971779;1090.3294473898654;1094.0809719835217;18668.813311866706;19178.616427671648;19409.70885436748;19440.513987150436;19499;46664.84621304353;52570;53337;53640.463595363544;55205.171922422;60624;72199.63900180465;72987.63506182435;77190;81383.5930820342;11122.777544448903;11932.642020739391;12192.390380481118;12313.13808033429;12544.87455125437;13439;13495.797563036758;13827.51603693866;13897.706878364956;13933.651658708208;11519.42402879836;11828.940855295668;11907.46416411281;12053.939730301292;12154.270743755404;11515.36665483373;11652.650420487398;11673.416329183337;11855.58505452305;12122.878771212176;10402.73993150147;11732.296062236293;11933.880661193278;12219.938900305442;12290.877091229331;11699.649010529698;12039.03687704999;12065.879341206475;12277.75444491123;12318.260904345769;10700.732481688021;11314.925082117516;11842.585509507126;11972.700682482659;12215.389230538616 22:19:21 INFO - PROCESS | 1636 | |3;mootools.html;1348.8381394232695;1467.0244287548778;1622.7079125757366;1831.2308830291277;1835.8347748702622;6738.663066846657;8591.742247732562;8624.784380390493;8627.396082274243;8627.870581941268;7668.769936901902;7823.061232652076;7828.960855195716;8173.468724532916;8422.36832237583;2373.7626237376253;2416.250962201714;2418.842775219614;2420.056178090546;2426.7815896569305;2421.4672771990136;2442.9144979925704;2450.803935685141;2464.125235541384;2472.134752836502;2186.5736181444627;2333.6849525314037;2375.8574485530835;2403.3150552092657;2404.761547802883;2395.9880200598886;2400.2079313826484;2421.140495124223;2424.7454017328105;2428.380762905457;2429.769171928664;2449.7182823975295;2449.9755002449924;2454.2637208837277;2455.693038370204;8358.749237522885;8541.060483346826;8548.487090774574;8559.48643081411;8562.229399354088;5171.50870667286;5328.120860058086;5337.946620533784;5341.278927344798;5360.115580929142;3348.916277093068;3457.187560923181;3629.256002519477;3674.393725035366;3678.7608805427562;1039.9928138692321;1049.769240364226;1071.7159952612565;1073.9194560408;1095.3044816541553;11049.674039115278;11164.330140191614;11167.609133680364;11169.162312826571;11203.607873724462;4682.765861706969;4689.343491911135;4854.077725232195;4872.074305881942;4875.146849301429;9607.471589062528;9632.75918102039;9635.951820240994;9639.518024098767;9655.179309758749;5369.24830523727;5376.91934620981;5379.35447746273;5379.67721936685;5399.433059528771;4267.8292868284925;4326;4844.612431005511;4939.283803848493;4955.380577427822;3919.7648141111627;3923.803809809498;3982.143839074613;4021.3364794809113;4024.8390064397095;1297.7209899871384;1306.0857399819974;1308.2019967819622;1320.1748906933167;1320.458611969088;792.4452882981935;885.2608072259607;896.8878890138733;911.444019148319;932.2076235200026;5693.430656934273;5814.883702325929;5848.2397288353095;5970.8655355482315;6120.938790612126;961.8990006049404;970.3450171134456;970.8009857979098;985.2758222706306;990.6136606723384;3844.6732027777953;3954.367301231789;4063.89840253996;4079.97960010204;4158.708890377645;10048.949755251177;10283.588656453658;10431.269811113149;10435.060844524029;10459.790804183875;10399.636012739518;10407.375557466576;10411.635592754217;10418.062374386342;10423.478826058818;7593.924060759322;7902.960485197537;7939.444238903221;8054.436189466798;8151.5924203790755;5892.469677729025;5945.524358051432;6004.459598636144;6010.278766548042;6110.938890611037;9213.953930230306;9432.151106400457;9536.475493847905;9559.856602151112;9571.33000689945;8236.752897413087;9555.378900371454;9627.711168664951;9654;9792.902070979484;6676.332366763285;7256.7097316106765;7420.740274090597;7728.111267204344;7948.602569871599;7920.762377128695;8134.308583770446;8141.633626486704;8145.144759800136;8151.062627797879;7147.749828755968;7176.607954686524;7221.819454513679;7249.238829922782;7261.673224704795;7009.894851577128;7015.543989640657;7061.6822243000215;7273.490855640054;7298.525595836254;6702.430293425114;6788;6854.862902741817;6855.760048398482;6884.51808373409;4785.784639691153;4951.653384263211;4954.281629163823;4979.601631869514;5032.62255330859;4853.272009198648;4871.658983871095;4919.631027672867;5052.444231134498;5076.11168045598 22:19:21 INFO - PROCESS | 1636 | |4;prototype.html;301.95772591837135;303.6553511764148;313.6502799378693;320.48082106986686;321.11532727336186;4997.1754660481065;5162.612804039693;5276.8075314434745;5311.388255985928;5320.669832541865;4616.961183733658;5100.77046532906;5318.840434786953;5354.554270347004;5374.167004114359;4109.095998880257;4136.544980052192;4139.503259608844;4143.875683729493;4146.606072423115;3741.1021354874906;3900.1614652849776;3938.6258305460933;4125.360569111793;4151.481064866892;3593.2633810068874;3988.9800550997206;4101.9179616407655;4109.383592461125;4120;3525.9118522036897;3571.749977501576;4085.775282359469;4134.855280065183;4149.33610622299;3500.8074555899416;3581.1763294442426;3648.3615367310613;3649.653282938143;3655.670989610921;4461.196984542781;5023.32185155003;5153.510416510426;5177.689338639656;5186.688798672054;4147.5483580746795;4154.50145982484;4672.644932969435;4696.553827386427;4700.929486057712;3876.8061596920043;5633.267675202197;5657.915131273035;5667.627761481953;5670.121131224667;3557.964420355789;4025.4364388985564;4027.9194416111804;4030.2141082488924;4059.918801623951;4983.476734942815;5902;5990.610610310359;6014.097885317194;6014.75940962361;3921;3974.82113304902;4037.7779222143063;4076.735012224196;4089.652379547772;3865.6714179294513;4063.512378514597;4113.341865301538;4128.431196145446;4131.938020929689;3553.911152221215;3947.8618248361745;4327.026419055687;4527.275635898241;4749.928751068736;3987.5613682494904;4996.150654388763;5533.972330138324;5679.602427830012;5716.228309178291;1252.8496580410226;1316.6181807275975;1339.9062065655505;1347.6765576261625;1357.6537982814516;795.9283664470225;925.5557332480313;926.5321012888583;930.5855100247586;936.6019441737235;4536.637069034536;4808.341122312797;4892.9663608562205;5113.463086375951;5113.854979187773;5493.945060549423;5513.917291240635;5529.447055294519;5571.687749583958;5578.414266501959;4170.416141740159;4898.755062246873;5099.69401835891;5154.7164905929785;5173.663711858717;2528.620706893944;2864.6562412510634;2904.5912732324805;2912.7961042726806;2929.853507324668;4898.338724272249;5593.461798005581;5627.8593035174445;5791.247137872134;5851.765929362778;4805.327254184417;4906.803727850917;5000.64995450315;5216.982688375806;5415.377231618336;5237.685738855681;5752.769889204553;5755.22304488897;5757.481826635623;5777.913331300034;4869.6591238612955;5164.561012313995;5477.260569823023;5521.972390138024;5559.749811258584;3966.662833659171;5695.572832037531;5877.147813567094;5881.529477641693;5885.440883116268;5636.182753500638;5965.642061476326;6179.940929240055;6207.286162091417;6215.254169499689;3768.6419790119894;3866.2267546491375;3894.5269753706034;3901.6878649707387;3979.184267225154;5790.363060063474;5864.296284445893;5868.501177399798;5909.438603332676;6159.19930409044;5538.25856201183;5716.941436331543;5735.655860648208;5744.885102297847;5752.079667253387;5582.86042848932;5623.3533143689;5636.788090560549;5672;5720.427957204246;4754.833580824655;5159.9164175523565;5200.6619569727845;5572.4706152915405;5590.86022849432;4791.55630628389;5367.329083864517;5669.291338582677;5670.716464176692;5684.317881854038;5568.470995255444;5616.3260408749575;5630.565355133447;5632.085091068892;5635.520980716685 22:19:21 INFO - PROCESS | 1636 | |5;yui.html;706.5442789400839;712.2485777504733;774.6320497763563;820.2289847543312;823.3660081737061;14973.775393369095;15761.842381576182;15914.612808078795;15932.044077355353;15970.961887477306;14071.859281407184;14281.785773213383;14290.285485725724;14297.857021429783;14314.212718300489;680.8740383029143;707.7805880177136;708.5961002228731;709.9503034787567;710.6091649592729;715.6064164709416;823.736404350608;849.8512760266959;851.8764779107025;855.7047818502638;906.0667512462174;919.0396036142214;921.2906062332;921.9953900230489;922.6355589542127;910.0308171797014;910.0899100899101;910.7131253655077;912.1152482092393;914.5381582300929;675.378651640492;675.4191395399952;675.5676367125044;676.9458443324522;678.5385937562455;14290.857091429056;14297.142171469744;14344.49794257196;14408.423663053465;15114.09315441066;14011.509597164051;14365.281735913268;14510.201938893357;14629.414823407158;14703.485378011717;9582.28132890036;11078;11439.942800286028;11683.948444640024;11951.940240298829;4603.355530225771;4605.470370907355;4631.768411579441;4645.6980296280635;4783.449903261135;95796;98026.50986745092;98823;99714;101378.99999999926;10355.601253719227;10773.515191816387;10903.945480272707;11026.228164028602;11039.172062095375;19783;19822.60354792896;19991.500212494804;20062.598748024957;20344.491387715425;7820.46413080412;7831.765047048598;7846.882296765553;7919.881201781978;7936.682532698743;4260.978695106504;4359.825606975685;4477.708948918375;4487.5961163494785;4562.520935301745;3337.098983274502;3407.795532268072;3410.0110967819055;3445.6554344565343;3448.9480708384185;598.7545904518591;614.6250787019915;620.1411045701645;621.8227805075531;624.3475568031419;560.3555910702725;618.3692633513881;627.2504357293083;629.1789215074281;642.142739442849;8479;8895.73312800617;8908.797312362878;8963.238124759468;9172.633094676139;526.6649044671815;564.6470955652717;584.8391692284571;610.5085406247924;632.1529150937765;4119.423280740699;4403.735775853459;4444.644428445717;4451.354553589711;4465.196264672325;76113.61943190248;76942.61528692432;93355;94012;129821;75148;107072.46463767631;109461.45269273603;109962;111838.88161118285;79492;94216;97024.51487742516;98796;99377.50311248397;8356.456830306011;8611.224989750952;8661.350398719995;8663.826723465621;8821.382503224713;59291;61700;62256.68871655794;62613.68693156505;62917;85455.57272213598;89626.55186724024;89943.55028224816;90827.82102626376;91129.6330555029;10292.948535257276;10620.575176992834;10759.892401076202;10860.565577376816;11393.202475826612;11895.524179032742;12350.75298494043;12382;12825.422855971317;12825.743485130059;11762.059035277329;11837.704057398634;11838.467268972745;11853.466594003463;11916.761664766484;9958.452285124387;10856.185786065918;11030.944845276043;11966.58116965902;12425.13024088305;10662.89337106619;10737.194710396596;11684.649460516199;11812.173147879566;11929.403529823301;9248.583813728264;9455;9564.904350956402;9655.565499552396;9821.656242031495;9459.621615135318;9878.357906736039;9879.110880020833;9888.406695598287;9891.752706182404 22:19:21 INFO - PROCESS | 1636 | __end_tp_report 22:19:21 INFO - PROCESS | 1636 | __start_cc_report 22:19:21 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,1331 22:19:21 INFO - PROCESS | 1636 | __end_cc_report 22:19:21 INFO - PROCESS | 1636 | __startTimestamp1485325161628__endTimestamp 22:19:21 INFO - PROCESS | 1636 | 22:19:21 INFO - PROCESS | 1636 | ------- Summary: start ------- 22:19:21 INFO - PROCESS | 1636 | Number of tests: 6 22:19:21 INFO - PROCESS | 1636 | 22:19:21 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5913.35 Median:6154.97 stddev:642.16 (10.4%) stddev-sans-first:613.79 22:19:21 INFO - PROCESS | 1636 | Values: 3426.9 3530.3 3547.6 3553.1 3603.6 5830.1 5835.2 5863.3 5880.6 5904.7 5968.8 6010.6 6022.4 6032.7 6057.6 4138.9 5015.0 5335.8 5365.7 5384.8 5337.0 5353.7 5355.3 5481.3 5490.2 5390.0 5415.5 5432.6 5443.2 5448.0 5413.2 5430.8 5490.9 5496.2 5502.5 5270.0 5387.3 5400.8 5417.8 5498.4 5827.9 5853.3 5855.7 5873.1 5927.9 6270.3 6272.5 6318.4 6329.3 6365.0 6313.8 6325.7 6343.6 6344.6 6384.2 5908.4 5945.9 6026.0 6050.9 6064.2 6402.0 6455.1 6456.1 6464.0 6471.0 6366.7 6388.4 6397.3 6403.7 6413.1 6246.4 6255.2 6272.7 6305.1 6330.2 6332.7 6357.7 6381.6 6382.1 6396.1 6294.7 6323.4 6349.5 6370.3 6385.0 5004.7 5063.9 5071.2 5092.9 5105.3 4613.7 4627.1 4629.8 4666.7 4696.3 6037.6 6141.9 6144.1 6154.8 6160.0 6127.1 6256.7 6309.3 6339.7 6346.8 5972.0 6105.3 6110.6 6116.9 6155.0 5641.5 5664.0 5665.6 5685.4 5710.3 6293.7 6585.1 6593.9 6611.7 6613.2 6215.2 6236.1 6243.7 6263.1 6277.1 6582.0 6593.8 6598.9 6600.0 6610.2 6258.8 6323.7 6328.1 6331.8 6334.9 6223.2 6230.8 6235.8 6239.8 6333.1 5288.0 5477.9 6217.3 6323.1 6365.9 6290.9 6304.6 6327.8 6335.4 6338.0 6040.8 6096.2 6112.0 6119.7 6130.2 6176.3 6282.7 6291.1 6302.3 6326.6 6089.8 6169.9 6182.9 6185.1 6191.7 22:19:21 INFO - PROCESS | 1636 | 22:19:21 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:69380.22 Median:39500.20 stddev:156454.63 (396.1%) stddev-sans-first:156808.05 22:19:21 INFO - PROCESS | 1636 | Values: 500.4 538.5 549.0 562.2 579.7 23616.3 40440.6 41592.2 41641.8 43271.0 42986.6 43204.1 43358.8 43382.8 43545.3 9582.0 9725.3 9755.7 9756.3 9757.0 9545.0 9671.6 9673.3 9675.1 9690.1 9656.4 9676.5 9685.0 9691.9 9696.0 9655.9 9659.6 9668.6 9677.4 9707.9 9537.8 9594.0 9626.0 9634.4 9639.0 39854.8 40200.6 40278.0 40315.6 40344.8 3352.3 3366.6 3407.7 3467.8 3889.9 29178.7 29583.9 29911.3 31074.8 31573.4 3283.8 3286.8 3288.8 3331.5 3359.0 516031.0 516347.0 517672.0 518283.4 520942.4 34470.3 35038.0 35295.1 59881.0 60611.7 36335.5 36480.3 36555.3 36580.0 36646.8 14384.4 14474.1 14512.5 14528.0 14563.7 12617.0 12770.7 12771.0 12780.8 12782.4 8038.5 8049.8 8058.6 8122.1 8129.6 3318.4 3327.5 3344.4 3346.1 3366.7 933.7 936.7 957.6 1045.1 1094.5 29579.0 29807.9 30088.4 30250.1 30429.4 932.8 1077.6 1096.1 1168.5 1187.0 15449.5 15493.9 15557.4 15909.7 15941.5 601905.0 712767.0 712942.0 714495.0 717237.0 57332.7 57832.4 57972.0 57983.0 58144.0 1259.7 1300.0 1372.2 1395.6 1413.0 29606.7 30767.0 30866.1 31036.2 31581.5 49587.5 50018.0 50199.0 50245.5 50368.5 518327.0 520177.0 520692.0 525649.7 528176.5 24048.8 24692.6 26333.3 26912.5 27012.7 46339.0 46578.0 46841.8 47197.8 47825.0 38185.0 38443.6 39325.6 40409.0 40624.4 38314.0 38358.2 38875.8 39674.8 39859.4 37442.0 38085.0 38302.4 38494.6 38814.0 32762.0 34032.7 34767.3 34802.5 34956.0 25017.4 25763.4 25803.9 26825.6 26920.9 22:19:21 INFO - PROCESS | 1636 | 22:19:21 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:35785.56 Median:11030.40 stddev:103529.05 (938.6%) stddev-sans-first:103785.24 22:19:21 INFO - PROCESS | 1636 | Values: 329.4 376.9 389.5 397.7 414.0 15203.2 15821.6 19037.8 21218.0 21340.6 17053.8 17913.6 20069.0 20752.0 20938.3 5716.8 5896.3 6184.4 6190.2 6201.9 5342.2 6091.8 6135.9 6137.3 6141.3 4321.0 4538.9 6088.2 6379.7 6647.7 6543.4 6653.7 6736.7 6756.0 6763.7 5856.0 5871.6 5879.0 5880.0 5894.9 24655.8 25686.2 25745.6 25982.6 26089.5 2371.3 2606.7 2729.8 2765.3 3004.7 15187.5 15584.7 15911.3 16486.5 16521.9 1671.3 1832.4 1937.4 1991.8 2037.5 104511.5 122137.0 124489.4 126618.0 128811.4 10618.6 10664.1 11163.3 11227.8 11326.8 14053.9 14069.9 14081.9 14106.4 14119.4 7078.4 8199.3 8480.2 8483.2 8567.0 8450.0 8480.5 8516.6 8615.1 8632.5 5448.7 5504.5 6252.7 6622.6 6694.2 1707.1 1759.7 1825.8 1826.3 1897.0 880.3 906.4 961.6 1010.3 1037.4 21404.7 21515.0 21837.2 21958.0 22178.6 925.5 942.7 953.1 976.7 1008.8 10355.8 11642.1 11720.8 11756.2 11789.8 608166.0 617384.0 623599.0 633495.0 637906.8 90158.5 113838.0 118414.0 120235.0 123194.8 1019.7 1028.7 1062.3 1090.3 1094.1 18668.8 19178.6 19409.7 19440.5 19499.0 46664.8 52570.0 53337.0 53640.5 55205.2 60624.0 72199.6 72987.6 77190.0 81383.6 11122.8 11932.6 12192.4 12313.1 12544.9 13439.0 13495.8 13827.5 13897.7 13933.7 11519.4 11828.9 11907.5 12053.9 12154.3 11515.4 11652.7 11673.4 11855.6 12122.9 10402.7 11732.3 11933.9 12219.9 12290.9 11699.6 12039.0 12065.9 12277.8 12318.3 10700.7 11314.9 11842.6 11972.7 12215.4 22:19:21 INFO - PROCESS | 1636 | 22:19:21 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:5586.10 Median:5249.81 stddev:3022.52 (57.6%) stddev-sans-first:3014.22 22:19:21 INFO - PROCESS | 1636 | Values: 1348.8 1467.0 1622.7 1831.2 1835.8 6738.7 8591.7 8624.8 8627.4 8627.9 7668.8 7823.1 7829.0 8173.5 8422.4 2373.8 2416.3 2418.8 2420.1 2426.8 2421.5 2442.9 2450.8 2464.1 2472.1 2186.6 2333.7 2375.9 2403.3 2404.8 2396.0 2400.2 2421.1 2424.7 2428.4 2429.8 2449.7 2450.0 2454.3 2455.7 8358.7 8541.1 8548.5 8559.5 8562.2 5171.5 5328.1 5337.9 5341.3 5360.1 3348.9 3457.2 3629.3 3674.4 3678.8 1040.0 1049.8 1071.7 1073.9 1095.3 11049.7 11164.3 11167.6 11169.2 11203.6 4682.8 4689.3 4854.1 4872.1 4875.1 9607.5 9632.8 9636.0 9639.5 9655.2 5369.2 5376.9 5379.4 5379.7 5399.4 4267.8 4326.0 4844.6 4939.3 4955.4 3919.8 3923.8 3982.1 4021.3 4024.8 1297.7 1306.1 1308.2 1320.2 1320.5 792.4 885.3 896.9 911.4 932.2 5693.4 5814.9 5848.2 5970.9 6120.9 961.9 970.3 970.8 985.3 990.6 3844.7 3954.4 4063.9 4080.0 4158.7 10048.9 10283.6 10431.3 10435.1 10459.8 10399.6 10407.4 10411.6 10418.1 10423.5 7593.9 7903.0 7939.4 8054.4 8151.6 5892.5 5945.5 6004.5 6010.3 6110.9 9214.0 9432.2 9536.5 9559.9 9571.3 8236.8 9555.4 9627.7 9654.0 9792.9 6676.3 7256.7 7420.7 7728.1 7948.6 7920.8 8134.3 8141.6 8145.1 8151.1 7147.7 7176.6 7221.8 7249.2 7261.7 7009.9 7015.5 7061.7 7273.5 7298.5 6702.4 6788.0 6854.9 6855.8 6884.5 4785.8 4951.7 4954.3 4979.6 5032.6 4853.3 4871.7 4919.6 5052.4 5076.1 22:19:21 INFO - PROCESS | 1636 | 22:19:21 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4532.98 Median:5061.51 stddev:1387.82 (27.4%) stddev-sans-first:1354.89 22:19:21 INFO - PROCESS | 1636 | Values: 302.0 303.7 313.7 320.5 321.1 4997.2 5162.6 5276.8 5311.4 5320.7 4617.0 5100.8 5318.8 5354.6 5374.2 4109.1 4136.5 4139.5 4143.9 4146.6 3741.1 3900.2 3938.6 4125.4 4151.5 3593.3 3989.0 4101.9 4109.4 4120.0 3525.9 3571.7 4085.8 4134.9 4149.3 3500.8 3581.2 3648.4 3649.7 3655.7 4461.2 5023.3 5153.5 5177.7 5186.7 4147.5 4154.5 4672.6 4696.6 4700.9 3876.8 5633.3 5657.9 5667.6 5670.1 3558.0 4025.4 4027.9 4030.2 4059.9 4983.5 5902.0 5990.6 6014.1 6014.8 3921.0 3974.8 4037.8 4076.7 4089.7 3865.7 4063.5 4113.3 4128.4 4131.9 3553.9 3947.9 4327.0 4527.3 4749.9 3987.6 4996.2 5534.0 5679.6 5716.2 1252.8 1316.6 1339.9 1347.7 1357.7 795.9 925.6 926.5 930.6 936.6 4536.6 4808.3 4893.0 5113.5 5113.9 5493.9 5513.9 5529.4 5571.7 5578.4 4170.4 4898.8 5099.7 5154.7 5173.7 2528.6 2864.7 2904.6 2912.8 2929.9 4898.3 5593.5 5627.9 5791.2 5851.8 4805.3 4906.8 5000.6 5217.0 5415.4 5237.7 5752.8 5755.2 5757.5 5777.9 4869.7 5164.6 5477.3 5522.0 5559.7 3966.7 5695.6 5877.1 5881.5 5885.4 5636.2 5965.6 6179.9 6207.3 6215.3 3768.6 3866.2 3894.5 3901.7 3979.2 5790.4 5864.3 5868.5 5909.4 6159.2 5538.3 5716.9 5735.7 5744.9 5752.1 5582.9 5623.4 5636.8 5672.0 5720.4 4754.8 5159.9 5200.7 5572.5 5590.9 4791.6 5367.3 5669.3 5670.7 5684.3 5568.5 5616.3 5630.6 5632.1 5635.5 22:19:21 INFO - PROCESS | 1636 | 22:19:21 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:21310.98 Median:612.57 stddev:32012.34 (5225.9%) stddev-sans-first:32064.76 22:19:21 INFO - PROCESS | 1636 | Values: 706.5 712.2 774.6 820.2 823.4 14973.8 15761.8 15914.6 15932.0 15971.0 14071.9 14281.8 14290.3 14297.9 14314.2 680.9 707.8 708.6 710.0 710.6 715.6 823.7 849.9 851.9 855.7 906.1 919.0 921.3 922.0 922.6 910.0 910.1 910.7 912.1 914.5 675.4 675.4 675.6 676.9 678.5 14290.9 14297.1 14344.5 14408.4 15114.1 14011.5 14365.3 14510.2 14629.4 14703.5 9582.3 11078.0 11439.9 11683.9 11951.9 4603.4 4605.5 4631.8 4645.7 4783.4 95796.0 98026.5 98823.0 99714.0 101379.0 10355.6 10773.5 10903.9 11026.2 11039.2 19783.0 19822.6 19991.5 20062.6 20344.5 7820.5 7831.8 7846.9 7919.9 7936.7 4261.0 4359.8 4477.7 4487.6 4562.5 3337.1 3407.8 3410.0 3445.7 3448.9 598.8 614.6 620.1 621.8 624.3 560.4 618.4 627.3 629.2 642.1 8479.0 8895.7 8908.8 8963.2 9172.6 526.7 564.6 584.8 610.5 632.2 4119.4 4403.7 4444.6 4451.4 4465.2 76113.6 76942.6 93355.0 94012.0 129821.0 75148.0 107072.5 109461.5 109962.0 111838.9 79492.0 94216.0 97024.5 98796.0 99377.5 8356.5 8611.2 8661.4 8663.8 8821.4 59291.0 61700.0 62256.7 62613.7 62917.0 85455.6 89626.6 89943.6 90827.8 91129.6 10292.9 10620.6 10759.9 10860.6 11393.2 11895.5 12350.8 12382.0 12825.4 12825.7 11762.1 11837.7 11838.5 11853.5 11916.8 9958.5 10856.2 11030.9 11966.6 12425.1 10662.9 10737.2 11684.6 11812.2 11929.4 9248.6 9455.0 9564.9 9655.6 9821.7 9459.6 9878.4 9879.1 9888.4 9891.8 22:19:21 INFO - PROCESS | 1636 | -------- Summary: end -------- 22:19:21 INFO - PROCESS | 1636 | 22:19:22 INFO - TEST-INFO | 1636: exit 0 22:19:22 INFO - TEST-OK | dromaeo_css | took 1118679ms 22:19:22 INFO - TEST-START | kraken 22:19:22 INFO - operating with platform_type : mac_ 22:19:22 INFO - Initialising browser for kraken test... 22:19:22 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/tmphIjjId/profile http://localhost:49235/getInfo.html) 22:19:24 INFO - PROCESS | 1648 | __metrics Screen width/height:1600/1200 22:19:24 INFO - PROCESS | 1648 | colorDepth:24 22:19:24 INFO - PROCESS | 1648 | Browser inner width/height: 1024/689 22:19:24 INFO - PROCESS | 1648 | __metrics 22:19:24 INFO - PROCESS | 1648 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 22:19:24 INFO - PROCESS | 1648 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:19:25 INFO - TEST-INFO | 1648: exit 0 22:19:25 INFO - Browser initialized. 22:19:25 INFO - Running cycle 1/1 for kraken test... 22:19:25 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/T/tmphIjjId/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:19:37 INFO - PROCESS | 1650 | RSS: Main: 171810816 22:19:37 INFO - PROCESS | 1650 | 22:19:40 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection) 22:19:41 INFO - PROCESS | 1650 | RSS: Main: 221392896 22:19:41 INFO - PROCESS | 1650 | 22:19:43 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-dft) 22:19:44 INFO - PROCESS | 1650 | RSS: Main: 233824256 22:19:44 INFO - PROCESS | 1650 | 22:19:47 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-fft) 22:19:48 INFO - PROCESS | 1650 | RSS: Main: 331235328 22:19:48 INFO - PROCESS | 1650 | 22:19:50 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator) 22:19:50 INFO - PROCESS | 1650 | RSS: Main: 233111552 22:19:50 INFO - PROCESS | 1650 | 22:19:52 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:19:53 INFO - PROCESS | 1650 | RSS: Main: 233951232 22:19:53 INFO - PROCESS | 1650 | 22:19:56 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom) 22:19:56 INFO - PROCESS | 1650 | RSS: Main: 275054592 22:19:56 INFO - PROCESS | 1650 | 22:19:59 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate) 22:20:00 INFO - PROCESS | 1650 | RSS: Main: 276193280 22:20:00 INFO - PROCESS | 1650 | 22:20:02 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial) 22:20:03 INFO - PROCESS | 1650 | RSS: Main: 272957440 22:20:03 INFO - PROCESS | 1650 | 22:20:05 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:20:05 INFO - PROCESS | 1650 | RSS: Main: 248803328 22:20:05 INFO - PROCESS | 1650 | 22:20:07 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:20:08 INFO - PROCESS | 1650 | RSS: Main: 250880000 22:20:08 INFO - PROCESS | 1650 | 22:20:10 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:20:10 INFO - PROCESS | 1650 | RSS: Main: 253800448 22:20:10 INFO - PROCESS | 1650 | 22:20:13 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:20:14 INFO - PROCESS | 1650 | RSS: Main: 266248192 22:20:14 INFO - PROCESS | 1650 | 22:20:17 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:20:18 INFO - PROCESS | 1650 | RSS: Main: 266846208 22:20:18 INFO - PROCESS | 1650 | 22:20:19 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49235/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49235/tests/kraken/driver.html?testName=ai-astar) 22:20:20 INFO - PROCESS | 1650 | RSS: Main: 310456320 22:20:20 INFO - PROCESS | 1650 | 22:20:20 INFO - PROCESS | 1650 | __start_tp_report 22:20:20 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 22:20:20 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 22:20:20 INFO - PROCESS | 1650 | |i|pagename|runs| 22:20:20 INFO - PROCESS | 1650 | |0;ai-astar;115;114;115;115;113;115;114;113;114;114 22:20:20 INFO - PROCESS | 1650 | |1;audio-beat-detection;175;108;111;142;109;109;109;109;139;110 22:20:20 INFO - PROCESS | 1650 | |2;audio-dft;179;182;186;184;182;182;182;183;184;229 22:20:20 INFO - PROCESS | 1650 | |3;audio-fft;81;59;59;87;62;59;58;59;81;57 22:20:20 INFO - PROCESS | 1650 | |4;audio-oscillator;89;70;94;70;69;68;88;68;68;91 22:20:20 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;89;87;94;87;89;86;90;86;90;86 22:20:20 INFO - PROCESS | 1650 | |6;imaging-darkroom;96;116;162;98;96;97;101;96;96;97 22:20:20 INFO - PROCESS | 1650 | |7;imaging-desaturate;81;81;78;78;81;82;82;83;82;84 22:20:20 INFO - PROCESS | 1650 | |8;json-parse-financial;55;53;52;53;55;56;58;57;55;56 22:20:20 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;63;70;64;76;73;71;68;69;69;68 22:20:20 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;82;80;86;83;82;82;83;81;84;79 22:20:20 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;140;135;136;122;177;144;155;133;174;146 22:20:20 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;163;161;162;163;165;165;220;199;164;160 22:20:20 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;66;65;66;66;65;66;65;64;65;65 22:20:20 INFO - PROCESS | 1650 | __end_tp_report 22:20:20 INFO - PROCESS | 1650 | __start_cc_report 22:20:20 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,1873 22:20:20 INFO - PROCESS | 1650 | __end_cc_report 22:20:20 INFO - PROCESS | 1650 | __startTimestamp1485325220044__endTimestamp 22:20:20 INFO - PROCESS | 1650 | 22:20:20 INFO - PROCESS | 1650 | ------- Summary: start ------- 22:20:20 INFO - PROCESS | 1650 | Number of tests: 14 22:20:20 INFO - PROCESS | 1650 | 22:20:20 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:114.20 Median:114.50 stddev:0.79 (0.7%) stddev-sans-first:0.78 22:20:20 INFO - PROCESS | 1650 | Values: 115.0 114.0 115.0 115.0 113.0 115.0 114.0 113.0 114.0 114.0 22:20:20 INFO - PROCESS | 1650 | 22:20:20 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:122.10 Median:110.50 stddev:22.69 (20.5%) stddev-sans-first:13.81 22:20:20 INFO - PROCESS | 1650 | Values: 175.0 108.0 111.0 142.0 109.0 109.0 109.0 109.0 139.0 110.0 22:20:20 INFO - PROCESS | 1650 | 22:20:20 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:187.30 Median:183.50 stddev:14.77 (8.0%) stddev-sans-first:15.35 22:20:20 INFO - PROCESS | 1650 | Values: 179.0 182.0 186.0 184.0 182.0 182.0 182.0 183.0 184.0 229.0 22:20:20 INFO - PROCESS | 1650 | 22:20:20 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:66.20 Median:60.50 stddev:11.77 (19.5%) stddev-sans-first:11.20 22:20:20 INFO - PROCESS | 1650 | Values: 81.0 59.0 59.0 87.0 62.0 59.0 58.0 59.0 81.0 57.0 22:20:20 INFO - PROCESS | 1650 | 22:20:20 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:79.00 stddev:11.32 (14.3%) stddev-sans-first:11.21 22:20:20 INFO - PROCESS | 1650 | Values: 89.0 70.0 94.0 70.0 69.0 68.0 88.0 68.0 68.0 91.0 22:20:20 INFO - PROCESS | 1650 | 22:20:20 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:88.40 Median:89.00 stddev:2.55 (2.9%) stddev-sans-first:2.69 22:20:20 INFO - PROCESS | 1650 | Values: 89.0 87.0 94.0 87.0 89.0 86.0 90.0 86.0 90.0 86.0 22:20:20 INFO - PROCESS | 1650 | 22:20:20 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:105.50 Median:96.00 stddev:20.78 (21.6%) stddev-sans-first:21.75 22:20:20 INFO - PROCESS | 1650 | Values: 96.0 116.0 162.0 98.0 96.0 97.0 101.0 96.0 96.0 97.0 22:20:20 INFO - PROCESS | 1650 | 22:20:20 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:81.20 Median:82.00 stddev:1.93 (2.4%) stddev-sans-first:2.05 22:20:20 INFO - PROCESS | 1650 | Values: 81.0 81.0 78.0 78.0 81.0 82.0 82.0 83.0 82.0 84.0 22:20:20 INFO - PROCESS | 1650 | 22:20:20 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:55.00 Median:55.50 stddev:1.89 (3.4%) stddev-sans-first:2.00 22:20:20 INFO - PROCESS | 1650 | Values: 55.0 53.0 52.0 53.0 55.0 56.0 58.0 57.0 55.0 56.0 22:20:20 INFO - PROCESS | 1650 | 22:20:20 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.50 stddev:3.84 (5.5%) stddev-sans-first:3.38 22:20:20 INFO - PROCESS | 1650 | Values: 63.0 70.0 64.0 76.0 73.0 71.0 68.0 69.0 69.0 68.0 22:20:20 INFO - PROCESS | 1650 | 22:20:20 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.50 stddev:1.99 (2.4%) stddev-sans-first:2.11 22:20:20 INFO - PROCESS | 1650 | Values: 82.0 80.0 86.0 83.0 82.0 82.0 83.0 81.0 84.0 79.0 22:20:20 INFO - PROCESS | 1650 | 22:20:20 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:146.20 Median:145.00 stddev:17.74 (12.2%) stddev-sans-first:18.67 22:20:20 INFO - PROCESS | 1650 | Values: 140.0 135.0 136.0 122.0 177.0 144.0 155.0 133.0 174.0 146.0 22:20:20 INFO - PROCESS | 1650 | 22:20:20 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:164.50 stddev:20.33 (12.4%) stddev-sans-first:21.29 22:20:20 INFO - PROCESS | 1650 | Values: 163.0 161.0 162.0 163.0 165.0 165.0 220.0 199.0 164.0 160.0 22:20:20 INFO - PROCESS | 1650 | 22:20:20 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:0.67 (1.0%) stddev-sans-first:0.67 22:20:20 INFO - PROCESS | 1650 | Values: 66.0 65.0 66.0 66.0 65.0 66.0 65.0 64.0 65.0 65.0 22:20:20 INFO - PROCESS | 1650 | -------- Summary: end -------- 22:20:20 INFO - PROCESS | 1650 | 22:20:21 INFO - TEST-INFO | 1650: exit 0 22:20:21 INFO - TEST-OK | kraken | took 58857ms 22:20:21 INFO - SUITE-END | took 1177s 22:20:21 INFO - Completed test suite (00:19:37) 22:20:21 INFO - javascript benchmark 22:20:21 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3426.948595771064, 3530.2762933598633, 3547.645235476453, 3553.147244661282, 3603.58558765742, 5830.12548117782, 5835.153902684108, 5863.296404431463, 5880.5883588148845, 5904.734286957087, 5968.79109231177, 6010.57925945184, 6022.427869352416, 6032.69836508175, 6057.606255593394, 4138.855140070098, 5014.991005396751, 5335.813246536372, 5365.678059316453, 5384.838454846361, 5336.9733151334385, 5353.678779273237, 5355.303810504648, 5481.342238931334, 5490.231367608538, 5390.0, 5415.512603865652, 5432.619716619838, 5443.237946687467, 5447.972760136194, 5413.215083812845, 5430.782768689248, 5490.862728431781, 5496.230527726081, 5502.532284755801, 5270.0, 5387.326584176978, 5400.756965936543, 5417.783288668448, 5498.395176530618, 5827.912581311284, 5853.326867410217, 5855.677937713424, 5873.060310350366, 5927.851803704899, 6270.3144629005365, 6272.466840318579, 6318.368163183691, 6329.272133704637, 6364.968175159141, 6313.779017734358, 6325.746970121189, 6343.587666801689, 6344.555881088326, 6384.201974753156, 5908.350081490989, 5945.881082378328, 6026.0, 6050.909236361458, 6064.241969753781, 6402.0, 6455.096286519797, 6456.0961465394885, 6463.967680161663, 6471.0, 6366.713497892513, 6388.361163883575, 6397.296297407282, 6403.711832967528, 6413.102165696806, 6246.437820596168, 6255.186825712628, 6272.717727702265, 6305.117283580303, 6330.177076979963, 6332.651704156316, 6357.682115894187, 6381.585196962183, 6382.106505089291, 6396.136521569621, 6294.716737746812, 6323.399277068763, 6349.46029587481, 6370.331115232834, 6384.968075159594, 5004.724740139327, 5063.873403164876, 5071.239314102914, 5092.898142037138, 5105.285260063594, 4613.700109492872, 4627.143978363946, 4629.837955671535, 4666.719996800203, 4696.2720778278735, 6037.63774173551, 6141.907871381933, 6144.078388241799, 6154.753809847556, 6160.0, 6127.097902969301, 6256.718447669866, 6309.305976342691, 6339.651319177489, 6346.777862774873, 5971.954907891101, 6105.283054531754, 6110.649890384107, 6116.914073580098, 6154.969225153935, 5641.464060914206, 5663.980483513007, 5665.6034077614995, 5685.403032681592, 5710.2862142232225, 6293.685315734287, 6585.143931288998, 6593.934060659332, 6611.66941652925, 6613.173353330833, 6215.223097112861, 6236.126942228182, 6243.656598887105, 6263.060540918898, 6277.058441233851, 6581.967090164519, 6593.769218077345, 6598.901016484852, 6600.0, 6610.206775187008, 6258.780942666985, 6323.652199129092, 6328.114064030948, 6331.778387756406, 6334.9366506334345, 6223.190985171898, 6230.844228894314, 6235.844103897439, 6239.78160764371, 6333.145025421693, 5288.0, 5477.863053423696, 6217.347178546188, 6323.104341705217, 6365.949618313111, 6290.874182516232, 6304.5586808922935, 6327.841803954938, 6335.3981371769605, 6338.0, 6040.818775436744, 6096.237970253718, 6111.964830093352, 6119.694015299128, 6130.237616550872, 6176.289726681489, 6282.685865706605, 6291.087792270187, 6302.338254483213, 6326.620402775849, 6089.786857459968, 6169.907451388143, 6182.876342473215, 6185.134081228722, 6191.659458729813], "value": 5873.625739223642, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.3845270317509, 538.5341679447276, 548.9505944465, 562.1876388618448, 579.7391173971711, 23616.29151125467, 40440.59559404405, 41592.16815663685, 41641.791791041, 43271.0, 42986.57013429865, 43204.13591728164, 43358.78320608393, 43382.78308608453, 43545.34681979765, 9582.041795820414, 9725.27060470464, 9755.707328780112, 9756.268279879003, 9757.024297570257, 9544.95227523865, 9671.613135474572, 9673.274504412162, 9675.080867317594, 9690.127888490035, 9656.372335798185, 9676.467794271312, 9684.951575242148, 9691.854622180674, 9696.0, 9655.855162172573, 9659.565319560637, 9668.564914578825, 9677.370970886941, 9707.90292097077, 9537.761555961088, 9594.0, 9626.0, 9634.373765705206, 9639.036096390375, 39854.80072599618, 40200.597994019976, 40278.0, 40315.596844031774, 40344.798276008725, 3352.279259959096, 3366.646502117267, 3407.693307602328, 3467.7572569920117, 3889.9416508752392, 29178.708212917812, 29583.852080739674, 29911.252218694488, 31074.84462577673, 31573.368532629447, 3283.770136090475, 3286.7699261051735, 3288.753343499247, 3331.53358529806, 3359.0426728382295, 516031.0, 516347.0, 517672.0, 518283.40858295845, 520942.3952880249, 34470.31059378798, 35038.0, 35295.11762205965, 59881.0, 60611.69694151501, 36335.4549681755, 36480.27039459196, 36555.26889462249, 36580.0, 36646.816765916, 14384.35270412834, 14474.059186152866, 14512.492062777752, 14527.983041187226, 14563.708725825636, 12617.0, 12770.744585108247, 12771.0, 12780.808287875689, 12782.360881955865, 8038.517688938682, 8049.798755031171, 8058.556779377191, 8122.106568277485, 8129.634166462523, 3318.352921180395, 3327.517509961042, 3344.39800835847, 3346.0798280473064, 3366.6969972702573, 933.7198840347869, 936.6674830435097, 957.636098282662, 1045.075108528942, 1094.5457635081511, 29579.0, 29807.850960745058, 30088.398232035237, 30250.09249722512, 30429.391412171633, 932.846080396727, 1077.6336045744486, 1096.1285777806663, 1168.4917061078459, 1186.988130118705, 15449.5365139046, 15493.922530387275, 15557.377704891678, 15909.68180636404, 15941.521754347388, 601905.0, 712767.0, 712942.0, 714495.0, 717237.0, 57332.71333643305, 57832.421675783546, 57972.0, 57983.0, 58144.0, 1259.7165637731437, 1299.9870001299867, 1372.2246930484243, 1395.5534229046812, 1412.9788053179211, 29606.703932961256, 30767.0, 30866.0740177795, 31036.22409439782, 31581.52627710632, 49587.504124959734, 50018.0, 50199.0, 50245.49754502408, 50368.496315037846, 518327.0, 520177.0, 520692.0, 525649.7435025753, 528176.5138220143, 24048.75951240535, 24692.629610556214, 26333.34166645849, 26912.461750765266, 27012.72987270102, 46339.0, 46578.0, 46841.76579117082, 47197.76401117972, 47825.0, 38185.0, 38443.615563844, 39325.60674393219, 40409.0, 40624.390634141106, 38314.0, 38358.23283534258, 38875.80562097171, 39674.801625991684, 39859.40210896897, 37442.0, 38085.0, 38302.42546361862, 38494.615053849106, 38814.0, 32762.0, 34032.65967340394, 34767.30465390627, 34802.477962830075, 34956.0, 25017.374565636004, 25763.40646709026, 25803.870980644977, 26825.587360724126, 26920.865395673678], "value": 18727.569040449394, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.4169320303062, 376.9038895081754, 389.5062435559628, 397.66397394201925, 413.9813708383123, 15203.239838008083, 15821.60445988851, 19037.82196610306, 21217.99999999998, 21340.57318853622, 17053.82946170538, 17913.552161195945, 20069.0, 20752.0, 20938.26716064938, 5716.77132914685, 5896.292444906617, 6184.350643182469, 6190.164327815754, 6201.875962480748, 5342.171963345688, 6091.756329746805, 6135.9079613805825, 6137.2942111657285, 6141.293751218623, 4321.0, 4538.863834084967, 6088.238970128734, 6379.744810207586, 6647.734090636369, 6543.357100445577, 6653.700583473756, 6736.696848641823, 6755.966220168917, 6763.729450821986, 5855.970720146414, 5871.55963302754, 5878.970605146947, 5879.970600146972, 5894.911576326359, 24655.753442465524, 25686.229413117635, 25745.613815792778, 25982.610260846104, 26089.478210435875, 2371.34787933318, 2606.739326067397, 2729.849858257795, 2765.2533815869806, 3004.744596709282, 15187.468438604596, 15584.688306233811, 15911.283992220262, 16486.505404837873, 16521.92607480522, 1671.2729962466367, 1832.395309547846, 1937.409090227494, 1991.800819918011, 2037.5313677854028, 104511.47744261306, 122137.0, 124489.37755311166, 126618.0, 128811.35594322062, 10618.628348007782, 10664.146868250522, 11163.27438716497, 11227.831582526269, 11326.773464530663, 14053.85946140546, 14069.929650351683, 14081.859181408056, 14106.365213565414, 14119.43522259098, 7078.362947334765, 8199.262066414052, 8480.151984801594, 8483.194096560817, 8567.014793298726, 8450.028246751703, 8480.491170529787, 8516.574171291535, 8615.052344242129, 8632.525211113449, 5448.700321482356, 5504.532114770209, 6252.718627661675, 6622.569532980341, 6694.196696396463, 1707.1208327711238, 1759.7008508553577, 1825.799162092169, 1826.2603645523584, 1897.0, 880.326550189093, 906.3881879731155, 961.5817119552877, 1010.282699283517, 1037.4397825174321, 21404.678929816066, 21515.0, 21837.235696750857, 21958.0, 22178.556428871332, 925.5372313843078, 942.7171848445439, 953.1040821627648, 976.702105857706, 1008.7528555503949, 10355.844662330072, 11642.126840486828, 11720.765584688428, 11756.23584467024, 11789.76420471603, 608166.0, 617384.0, 623599.0, 633495.0, 637906.8104659447, 90158.54920725354, 113838.0, 118414.0, 120235.0, 123194.76805231832, 1019.7195771162841, 1028.717102796737, 1062.2776511971779, 1090.3294473898654, 1094.0809719835217, 18668.813311866706, 19178.616427671648, 19409.70885436748, 19440.513987150436, 19499.0, 46664.84621304353, 52570.0, 53337.0, 53640.463595363544, 55205.171922422, 60624.0, 72199.63900180465, 72987.63506182435, 77190.0, 81383.5930820342, 11122.777544448903, 11932.642020739391, 12192.390380481118, 12313.13808033429, 12544.87455125437, 13439.0, 13495.797563036758, 13827.51603693866, 13897.706878364956, 13933.651658708208, 11519.42402879836, 11828.940855295668, 11907.46416411281, 12053.939730301292, 12154.270743755404, 11515.36665483373, 11652.650420487398, 11673.416329183337, 11855.58505452305, 12122.878771212176, 10402.73993150147, 11732.296062236293, 11933.880661193278, 12219.938900305442, 12290.877091229331, 11699.649010529698, 12039.03687704999, 12065.879341206475, 12277.75444491123, 12318.260904345769, 10700.732481688021, 11314.925082117516, 11842.585509507126, 11972.700682482659, 12215.389230538616], "value": 10125.763582472064, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1348.8381394232695, 1467.0244287548778, 1622.7079125757366, 1831.2308830291277, 1835.8347748702622, 6738.663066846657, 8591.742247732562, 8624.784380390493, 8627.396082274243, 8627.870581941268, 7668.769936901902, 7823.061232652076, 7828.960855195716, 8173.468724532916, 8422.36832237583, 2373.7626237376253, 2416.250962201714, 2418.842775219614, 2420.056178090546, 2426.7815896569305, 2421.4672771990136, 2442.9144979925704, 2450.803935685141, 2464.125235541384, 2472.134752836502, 2186.5736181444627, 2333.6849525314037, 2375.8574485530835, 2403.3150552092657, 2404.761547802883, 2395.9880200598886, 2400.2079313826484, 2421.140495124223, 2424.7454017328105, 2428.380762905457, 2429.769171928664, 2449.7182823975295, 2449.9755002449924, 2454.2637208837277, 2455.693038370204, 8358.749237522885, 8541.060483346826, 8548.487090774574, 8559.48643081411, 8562.229399354088, 5171.50870667286, 5328.120860058086, 5337.946620533784, 5341.278927344798, 5360.115580929142, 3348.916277093068, 3457.187560923181, 3629.256002519477, 3674.393725035366, 3678.7608805427562, 1039.9928138692321, 1049.769240364226, 1071.7159952612565, 1073.9194560408, 1095.3044816541553, 11049.674039115278, 11164.330140191614, 11167.609133680364, 11169.162312826571, 11203.607873724462, 4682.765861706969, 4689.343491911135, 4854.077725232195, 4872.074305881942, 4875.146849301429, 9607.471589062528, 9632.75918102039, 9635.951820240994, 9639.518024098767, 9655.179309758749, 5369.24830523727, 5376.91934620981, 5379.35447746273, 5379.67721936685, 5399.433059528771, 4267.8292868284925, 4326.0, 4844.612431005511, 4939.283803848493, 4955.380577427822, 3919.7648141111627, 3923.803809809498, 3982.143839074613, 4021.3364794809113, 4024.8390064397095, 1297.7209899871384, 1306.0857399819974, 1308.2019967819622, 1320.1748906933167, 1320.458611969088, 792.4452882981935, 885.2608072259607, 896.8878890138733, 911.444019148319, 932.2076235200026, 5693.430656934273, 5814.883702325929, 5848.2397288353095, 5970.8655355482315, 6120.938790612126, 961.8990006049404, 970.3450171134456, 970.8009857979098, 985.2758222706306, 990.6136606723384, 3844.6732027777953, 3954.367301231789, 4063.89840253996, 4079.97960010204, 4158.708890377645, 10048.949755251177, 10283.588656453658, 10431.269811113149, 10435.060844524029, 10459.790804183875, 10399.636012739518, 10407.375557466576, 10411.635592754217, 10418.062374386342, 10423.478826058818, 7593.924060759322, 7902.960485197537, 7939.444238903221, 8054.436189466798, 8151.5924203790755, 5892.469677729025, 5945.524358051432, 6004.459598636144, 6010.278766548042, 6110.938890611037, 9213.953930230306, 9432.151106400457, 9536.475493847905, 9559.856602151112, 9571.33000689945, 8236.752897413087, 9555.378900371454, 9627.711168664951, 9654.0, 9792.902070979484, 6676.332366763285, 7256.7097316106765, 7420.740274090597, 7728.111267204344, 7948.602569871599, 7920.762377128695, 8134.308583770446, 8141.633626486704, 8145.144759800136, 8151.062627797879, 7147.749828755968, 7176.607954686524, 7221.819454513679, 7249.238829922782, 7261.673224704795, 7009.894851577128, 7015.543989640657, 7061.6822243000215, 7273.490855640054, 7298.525595836254, 6702.430293425114, 6788.0, 6854.862902741817, 6855.760048398482, 6884.51808373409, 4785.784639691153, 4951.653384263211, 4954.281629163823, 4979.601631869514, 5032.62255330859, 4853.272009198648, 4871.658983871095, 4919.631027672867, 5052.444231134498, 5076.11168045598], "value": 4548.168942506037, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.95772591837135, 303.6553511764148, 313.6502799378693, 320.48082106986686, 321.11532727336186, 4997.1754660481065, 5162.612804039693, 5276.8075314434745, 5311.388255985928, 5320.669832541865, 4616.961183733658, 5100.77046532906, 5318.840434786953, 5354.554270347004, 5374.167004114359, 4109.095998880257, 4136.544980052192, 4139.503259608844, 4143.875683729493, 4146.606072423115, 3741.1021354874906, 3900.1614652849776, 3938.6258305460933, 4125.360569111793, 4151.481064866892, 3593.2633810068874, 3988.9800550997206, 4101.9179616407655, 4109.383592461125, 4120.0, 3525.9118522036897, 3571.749977501576, 4085.775282359469, 4134.855280065183, 4149.33610622299, 3500.8074555899416, 3581.1763294442426, 3648.3615367310613, 3649.653282938143, 3655.670989610921, 4461.196984542781, 5023.32185155003, 5153.510416510426, 5177.689338639656, 5186.688798672054, 4147.5483580746795, 4154.50145982484, 4672.644932969435, 4696.553827386427, 4700.929486057712, 3876.8061596920043, 5633.267675202197, 5657.915131273035, 5667.627761481953, 5670.121131224667, 3557.964420355789, 4025.4364388985564, 4027.9194416111804, 4030.2141082488924, 4059.918801623951, 4983.476734942815, 5902.0, 5990.610610310359, 6014.097885317194, 6014.75940962361, 3921.0, 3974.82113304902, 4037.7779222143063, 4076.735012224196, 4089.652379547772, 3865.6714179294513, 4063.512378514597, 4113.341865301538, 4128.431196145446, 4131.938020929689, 3553.911152221215, 3947.8618248361745, 4327.026419055687, 4527.275635898241, 4749.928751068736, 3987.5613682494904, 4996.150654388763, 5533.972330138324, 5679.602427830012, 5716.228309178291, 1252.8496580410226, 1316.6181807275975, 1339.9062065655505, 1347.6765576261625, 1357.6537982814516, 795.9283664470225, 925.5557332480313, 926.5321012888583, 930.5855100247586, 936.6019441737235, 4536.637069034536, 4808.341122312797, 4892.9663608562205, 5113.463086375951, 5113.854979187773, 5493.945060549423, 5513.917291240635, 5529.447055294519, 5571.687749583958, 5578.414266501959, 4170.416141740159, 4898.755062246873, 5099.69401835891, 5154.7164905929785, 5173.663711858717, 2528.620706893944, 2864.6562412510634, 2904.5912732324805, 2912.7961042726806, 2929.853507324668, 4898.338724272249, 5593.461798005581, 5627.8593035174445, 5791.247137872134, 5851.765929362778, 4805.327254184417, 4906.803727850917, 5000.64995450315, 5216.982688375806, 5415.377231618336, 5237.685738855681, 5752.769889204553, 5755.22304488897, 5757.481826635623, 5777.913331300034, 4869.6591238612955, 5164.561012313995, 5477.260569823023, 5521.972390138024, 5559.749811258584, 3966.662833659171, 5695.572832037531, 5877.147813567094, 5881.529477641693, 5885.440883116268, 5636.182753500638, 5965.642061476326, 6179.940929240055, 6207.286162091417, 6215.254169499689, 3768.6419790119894, 3866.2267546491375, 3894.5269753706034, 3901.6878649707387, 3979.184267225154, 5790.363060063474, 5864.296284445893, 5868.501177399798, 5909.438603332676, 6159.19930409044, 5538.25856201183, 5716.941436331543, 5735.655860648208, 5744.885102297847, 5752.079667253387, 5582.86042848932, 5623.3533143689, 5636.788090560549, 5672.0, 5720.427957204246, 4754.833580824655, 5159.9164175523565, 5200.6619569727845, 5572.4706152915405, 5590.86022849432, 4791.55630628389, 5367.329083864517, 5669.291338582677, 5670.716464176692, 5684.317881854038, 5568.470995255444, 5616.3260408749575, 5630.565355133447, 5632.085091068892, 5635.520980716685], "value": 4095.9388429585624, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.5442789400839, 712.2485777504733, 774.6320497763563, 820.2289847543312, 823.3660081737061, 14973.775393369095, 15761.842381576182, 15914.612808078795, 15932.044077355353, 15970.961887477306, 14071.859281407184, 14281.785773213383, 14290.285485725724, 14297.857021429783, 14314.212718300489, 680.8740383029143, 707.7805880177136, 708.5961002228731, 709.9503034787567, 710.6091649592729, 715.6064164709416, 823.736404350608, 849.8512760266959, 851.8764779107025, 855.7047818502638, 906.0667512462174, 919.0396036142214, 921.2906062332, 921.9953900230489, 922.6355589542127, 910.0308171797014, 910.0899100899101, 910.7131253655077, 912.1152482092393, 914.5381582300929, 675.378651640492, 675.4191395399952, 675.5676367125044, 676.9458443324522, 678.5385937562455, 14290.857091429056, 14297.142171469744, 14344.49794257196, 14408.423663053465, 15114.09315441066, 14011.509597164051, 14365.281735913268, 14510.201938893357, 14629.414823407158, 14703.485378011717, 9582.28132890036, 11078.0, 11439.942800286028, 11683.948444640024, 11951.940240298829, 4603.355530225771, 4605.470370907355, 4631.768411579441, 4645.6980296280635, 4783.449903261135, 95796.0, 98026.50986745092, 98823.0, 99714.0, 101378.99999999926, 10355.601253719227, 10773.515191816387, 10903.945480272707, 11026.228164028602, 11039.172062095375, 19783.0, 19822.60354792896, 19991.500212494804, 20062.598748024957, 20344.491387715425, 7820.46413080412, 7831.765047048598, 7846.882296765553, 7919.881201781978, 7936.682532698743, 4260.978695106504, 4359.825606975685, 4477.708948918375, 4487.5961163494785, 4562.520935301745, 3337.098983274502, 3407.795532268072, 3410.0110967819055, 3445.6554344565343, 3448.9480708384185, 598.7545904518591, 614.6250787019915, 620.1411045701645, 621.8227805075531, 624.3475568031419, 560.3555910702725, 618.3692633513881, 627.2504357293083, 629.1789215074281, 642.142739442849, 8479.0, 8895.73312800617, 8908.797312362878, 8963.238124759468, 9172.633094676139, 526.6649044671815, 564.6470955652717, 584.8391692284571, 610.5085406247924, 632.1529150937765, 4119.423280740699, 4403.735775853459, 4444.644428445717, 4451.354553589711, 4465.196264672325, 76113.61943190248, 76942.61528692432, 93355.0, 94012.0, 129821.0, 75148.0, 107072.46463767631, 109461.45269273603, 109962.0, 111838.88161118285, 79492.0, 94216.0, 97024.51487742516, 98796.0, 99377.50311248397, 8356.456830306011, 8611.224989750952, 8661.350398719995, 8663.826723465621, 8821.382503224713, 59291.0, 61700.0, 62256.68871655794, 62613.68693156505, 62917.0, 85455.57272213598, 89626.55186724024, 89943.55028224816, 90827.82102626376, 91129.6330555029, 10292.948535257276, 10620.575176992834, 10759.892401076202, 10860.565577376816, 11393.202475826612, 11895.524179032742, 12350.75298494043, 12382.0, 12825.422855971317, 12825.743485130059, 11762.059035277329, 11837.704057398634, 11838.467268972745, 11853.466594003463, 11916.761664766484, 9958.452285124387, 10856.185786065918, 11030.944845276043, 11966.58116965902, 12425.13024088305, 10662.89337106619, 10737.194710396596, 11684.649460516199, 11812.173147879566, 11929.403529823301, 9248.583813728264, 9455.0, 9564.904350956402, 9655.565499552396, 9821.656242031495, 9459.621615135318, 9878.357906736039, 9879.110880020833, 9888.406695598287, 9891.752706182404], "value": 7282.77644479543, "unit": "score"}], "name": "dromaeo_css", "value": 7298.345785931704, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 115.0, 113.0, 115.0, 114.0, 113.0, 114.0, 114.0], "value": 114.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 108.0, 111.0, 142.0, 109.0, 109.0, 109.0, 109.0, 139.0, 110.0], "value": 122.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 182.0, 186.0, 184.0, 182.0, 182.0, 182.0, 183.0, 184.0, 229.0], "value": 187.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 59.0, 87.0, 62.0, 59.0, 58.0, 59.0, 81.0, 57.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 94.0, 70.0, 69.0, 68.0, 88.0, 68.0, 68.0, 91.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 94.0, 87.0, 89.0, 86.0, 90.0, 86.0, 90.0, 86.0], "value": 88.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 116.0, 162.0, 98.0, 96.0, 97.0, 101.0, 96.0, 96.0, 97.0], "value": 105.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 81.0, 78.0, 78.0, 81.0, 82.0, 82.0, 83.0, 82.0, 84.0], "value": 81.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 52.0, 53.0, 55.0, 56.0, 58.0, 57.0, 55.0, 56.0], "value": 55.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 70.0, 64.0, 76.0, 73.0, 71.0, 68.0, 69.0, 69.0, 68.0], "value": 69.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 86.0, 83.0, 82.0, 82.0, 83.0, 81.0, 84.0, 79.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 135.0, 136.0, 122.0, 177.0, 144.0, 155.0, 133.0, 174.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 162.0, 163.0, 165.0, 165.0, 220.0, 199.0, 164.0, 160.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 66.0, 66.0, 65.0, 66.0, 65.0, 64.0, 65.0, 65.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1432.4, "alertThreshold": 2.0}]} 22:20:21 INFO - Return code: 0 22:20:21 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 22:20:21 INFO - # TBPL SUCCESS # 22:20:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:20:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:20:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:20:21 INFO - 2017-01-24 22:20:21.362 screenresolution[1654:9685] starting screenresolution argv=screenresolution get 22:20:21 INFO - 2017-01-24 22:20:21.365 screenresolution[1654:9685] Display 0: 1600x1200x32@60 22:20:21 INFO - 2017-01-24 22:20:21.371 screenresolution[1655:9688] starting screenresolution argv=screenresolution list 22:20:21 INFO - Available Modes on Display 0 22:20:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:20:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:20:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:20:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:20:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:20:21 INFO - Intel Iris: 22:20:21 INFO - Chipset Model: Intel Iris 22:20:21 INFO - Type: GPU 22:20:21 INFO - Bus: Built-In 22:20:21 INFO - VRAM (Dynamic, Max): 1536 MB 22:20:21 INFO - Vendor: Intel (0x8086) 22:20:21 INFO - Device ID: 0x0a2e 22:20:21 INFO - Revision ID: 0x0009 22:20:21 INFO - Displays: 22:20:21 INFO - Display: 22:20:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:20:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:20:21 INFO - Display Serial Number: 1600x1200 60 22:20:21 INFO - Main Display: Yes 22:20:21 INFO - Mirror: Off 22:20:21 INFO - Online: Yes 22:20:21 INFO - Rotation: Supported 22:20:21 INFO - Return code: 0 22:20:21 INFO - Running post-action listener: _resource_record_post_action 22:20:21 INFO - [mozharness: 2017-01-25 06:20:21.620307Z] Finished run-tests step (success) 22:20:21 INFO - Running post-run listener: _resource_record_post_run 22:20:21 INFO - Total resource usage - Wall time: 1200s; CPU: 54.0%; Read bytes: 38147072; Write bytes: 500866048; Read time: 244; Write time: 1611 22:20:21 INFO - TinderboxPrint: CPU usage
53.5% 22:20:21 INFO - TinderboxPrint: I/O read bytes / time
38,147,072 / 244 22:20:21 INFO - TinderboxPrint: I/O write bytes / time
500,866,048 / 1,611 22:20:21 INFO - TinderboxPrint: CPU idle
2,230.6 (46.5%) 22:20:21 INFO - TinderboxPrint: CPU system
962.9 (20.1%) 22:20:21 INFO - TinderboxPrint: CPU user
1,608.1 (33.5%) 22:20:21 INFO - TinderboxPrint: Swap in / out
229,687,296 / 0 22:20:21 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 181045760; Write bytes: 176154624; Read time: 16700; Write time: 403 22:20:21 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 37217280; Write bytes: 306979840; Read time: 233; Write time: 1155 22:20:22 INFO - Running post-run listener: _upload_blobber_files 22:20:22 INFO - Blob upload gear active. 22:20:22 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:20:22 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 22:20:22 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 22:20:22 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 22:20:22 INFO - (blobuploader) - INFO - Open directory for files ... 22:20:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:20:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:20:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:23 INFO - (blobuploader) - INFO - Done attempting. 22:20:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:20:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:20:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:24 INFO - (blobuploader) - INFO - Done attempting. 22:20:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 22:20:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:20:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:20:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 22:20:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:20:26 INFO - (blobuploader) - INFO - Done attempting. 22:20:26 INFO - (blobuploader) - INFO - Iteration through files over. 22:20:26 INFO - Return code: 0 22:20:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:20:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:20:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0afaa0b800088a6374c820af9e06b4c69e83fae07bab202ec45484ca4dc15879a60448bf64040111225f0f9476c9720620a04280ab4cca886299c9fc1a84a0a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ed96ab9d97fbf58817a3d500386ea6bad038168eaefed434c40222e6e5db7707586035c1f5b22abacbe9e4d86d65893d29f83096cac8ca618be9d08e8bf66a8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b21766043fd0cb413cda074640b693483861414a67cc66688eb960741d4f1f9b9de9efd5ec206682897a78e31af018ed15c43252d13533d87e050d5959433495"} 22:20:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:20:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:20:26 INFO - Contents: 22:20:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0afaa0b800088a6374c820af9e06b4c69e83fae07bab202ec45484ca4dc15879a60448bf64040111225f0f9476c9720620a04280ab4cca886299c9fc1a84a0a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ed96ab9d97fbf58817a3d500386ea6bad038168eaefed434c40222e6e5db7707586035c1f5b22abacbe9e4d86d65893d29f83096cac8ca618be9d08e8bf66a8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b21766043fd0cb413cda074640b693483861414a67cc66688eb960741d4f1f9b9de9efd5ec206682897a78e31af018ed15c43252d13533d87e050d5959433495"} 22:20:26 INFO - Running post-run listener: copy_logs_to_upload_dir 22:20:26 INFO - Copying logs to upload dir... 22:20:26 INFO - mkdir: /builds/slave/test/build/upload/logs 22:20:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.316856 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2017-01-24 22:20:26.864989) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 22:20:26.868828) ========= 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.oB4bhv6sh7/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.EmJ74aZmLN/Listeners TMPDIR=/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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/Mozilla-Beta/sha512/0afaa0b800088a6374c820af9e06b4c69e83fae07bab202ec45484ca4dc15879a60448bf64040111225f0f9476c9720620a04280ab4cca886299c9fc1a84a0a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ed96ab9d97fbf58817a3d500386ea6bad038168eaefed434c40222e6e5db7707586035c1f5b22abacbe9e4d86d65893d29f83096cac8ca618be9d08e8bf66a8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b21766043fd0cb413cda074640b693483861414a67cc66688eb960741d4f1f9b9de9efd5ec206682897a78e31af018ed15c43252d13533d87e050d5959433495"} build_url:https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011439 build_url: 'https://queue.taskcluster.net/v1/task/dttS1XalS9aqhvF9pkm7zQ/artifacts/public/build/firefox-52.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/0afaa0b800088a6374c820af9e06b4c69e83fae07bab202ec45484ca4dc15879a60448bf64040111225f0f9476c9720620a04280ab4cca886299c9fc1a84a0a0", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ed96ab9d97fbf58817a3d500386ea6bad038168eaefed434c40222e6e5db7707586035c1f5b22abacbe9e4d86d65893d29f83096cac8ca618be9d08e8bf66a8f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b21766043fd0cb413cda074640b693483861414a67cc66688eb960741d4f1f9b9de9efd5ec206682897a78e31af018ed15c43252d13533d87e050d5959433495"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 22:20:26.904435) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 22:20:26.904845) ========= 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.oB4bhv6sh7/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.EmJ74aZmLN/Listeners TMPDIR=/var/folders/pp/6_6758z1201by_tg1kk5wjkh00000w/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.005258 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 22:20:26.953696) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 22:20:26.954054) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 22:20:26.954437) ========= ========= Total master_lag: 0.28 =========