builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0323 starttime: 1480463560.32 results: success (0) buildid: 20161129131427 builduid: f1c6d8730b094a03bce3977d9df8171a revision: 76cf4e84939e3258e654c7cc756503bcc807ff7e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 15:52:40.321331) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-29 15:52:40.321746) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 15:52:40.322031) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-29 15:52:40.345692) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:52:40.346074) ========= 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.qzpOBjailN/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.CarbeBn2lf/Listeners TMPDIR=/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-29 15:52:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 19.0M=0.001s 2016-11-29 15:52:40 (19.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.102466 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:52:40.472416) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:52:40.472727) ========= 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.qzpOBjailN/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.CarbeBn2lf/Listeners TMPDIR=/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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.024735 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 15:52:40.523407) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 15:52:40.524250) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 76cf4e84939e3258e654c7cc756503bcc807ff7e --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-aurora --rev 76cf4e84939e3258e654c7cc756503bcc807ff7e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qzpOBjailN/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.CarbeBn2lf/Listeners TMPDIR=/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-29 15:52:40,617 truncating revision to first 12 chars 2016-11-29 15:52:40,617 Setting DEBUG logging. 2016-11-29 15:52:40,617 attempt 1/10 2016-11-29 15:52:40,617 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/76cf4e84939e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-29 15:52:42,218 unpacking tar archive at: mozilla-aurora-76cf4e84939e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.884172 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-29 15:52:42.435491) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 15:52:42.435880) ========= script_repo_revision: 76cf4e84939e3258e654c7cc756503bcc807ff7e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-29 15:52:42.436327) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 15:52:42.436630) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-29 15:52:42.457985) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-11-29 15:52:42.458654) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.qzpOBjailN/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.CarbeBn2lf/Listeners TMPDIR=/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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 15:52:42 INFO - MultiFileLogger online at 20161129 15:52:42 in /builds/slave/test 15:52:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 15:52:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:52:42 INFO - {'append_to_log': False, 15:52:42 INFO - 'base_work_dir': '/builds/slave/test', 15:52:42 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 15:52:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:52:42 INFO - 'branch': 'Mozilla-Aurora', 15:52:42 INFO - 'buildbot_json_path': 'buildprops.json', 15:52:42 INFO - 'config_files': ('talos/mac_config.py',), 15:52:42 INFO - 'default_actions': ('clobber', 15:52:42 INFO - 'read-buildbot-config', 15:52:42 INFO - 'download-and-extract', 15:52:42 INFO - 'populate-webroot', 15:52:42 INFO - 'create-virtualenv', 15:52:42 INFO - 'install', 15:52:42 INFO - 'run-tests'), 15:52:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:52:42 INFO - 'download_minidump_stackwalk': True, 15:52:42 INFO - 'download_symbols': 'ondemand', 15:52:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:52:42 INFO - 'tooltool.py': '/tools/tooltool.py', 15:52:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:52:42 INFO - '/tools/misc-python/virtualenv.py')}, 15:52:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:52:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:52:42 INFO - 'installer_path': 'installer.exe', 15:52:42 INFO - 'log_level': 'info', 15:52:42 INFO - 'log_name': 'talos', 15:52:42 INFO - 'log_to_console': True, 15:52:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:52:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:52:42 INFO - 'opt_config_files': (), 15:52:42 INFO - 'pip_index': False, 15:52:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:52:42 INFO - 'cmd': ('bash', 15:52:42 INFO - '-c', 15:52:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:52:42 INFO - 'enabled': True, 15:52:42 INFO - 'halt_on_failure': False, 15:52:42 INFO - 'name': 'check_screen_resolution'},), 15:52:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:52:42 INFO - 'cmd': ('bash', 15:52:42 INFO - '-c', 15:52:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:52:42 INFO - 'enabled': True, 15:52:42 INFO - 'halt_on_failure': False, 15:52:42 INFO - 'name': 'check_screen_resolution'},), 15:52:42 INFO - 'run_cmd_checks_enabled': True, 15:52:42 INFO - 'sps_profile': False, 15:52:42 INFO - 'sps_profile_interval': 0, 15:52:42 INFO - 'suite': 'dromaeojs', 15:52:42 INFO - 'system_bits': '32', 15:52:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:52:42 INFO - 'title': 't-yosemite-r7-0323', 15:52:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:52:42 INFO - 'use_talos_json': True, 15:52:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:52:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:52:42 INFO - 'work_dir': 'build'} 15:52:42 INFO - [mozharness: 2016-11-29 23:52:42.661218Z] Running clobber step. 15:52:42 INFO - Running pre-action listener: _resource_record_pre_action 15:52:42 INFO - Running main action method: clobber 15:52:42 INFO - rmtree: /builds/slave/test/build 15:52:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:52:44 INFO - Running post-action listener: _resource_record_post_action 15:52:44 INFO - [mozharness: 2016-11-29 23:52:44.866293Z] Finished clobber step (success) 15:52:44 INFO - [mozharness: 2016-11-29 23:52:44.866417Z] Running read-buildbot-config step. 15:52:44 INFO - Running pre-action listener: _resource_record_pre_action 15:52:44 INFO - Running main action method: read_buildbot_config 15:52:44 INFO - Using buildbot properties: 15:52:44 INFO - { 15:52:44 INFO - "project": "", 15:52:44 INFO - "product": "firefox", 15:52:44 INFO - "script_repo_revision": "production", 15:52:44 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 15:52:44 INFO - "repository": "", 15:52:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 15:52:44 INFO - "buildid": "20161129131427", 15:52:44 INFO - "pgo_build": "False", 15:52:44 INFO - "basedir": "/builds/slave/test", 15:52:44 INFO - "buildnumber": 6, 15:52:44 INFO - "slavename": "t-yosemite-r7-0323", 15:52:44 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 15:52:44 INFO - "platform": "yosemite_r7", 15:52:44 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 15:52:44 INFO - "branch": "mozilla-aurora", 15:52:44 INFO - "repo_path": "releases/mozilla-aurora", 15:52:44 INFO - "revision": "76cf4e84939e3258e654c7cc756503bcc807ff7e", 15:52:44 INFO - "stage_platform": "macosx64", 15:52:44 INFO - "builduid": "f1c6d8730b094a03bce3977d9df8171a", 15:52:44 INFO - "slavebuilddir": "test" 15:52:44 INFO - } 15:52:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/P6Jub1FNQ4u7NnIHMP4W_w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg. 15:52:44 INFO - Running post-action listener: _resource_record_post_action 15:52:44 INFO - [mozharness: 2016-11-29 23:52:44.869902Z] Finished read-buildbot-config step (success) 15:52:44 INFO - [mozharness: 2016-11-29 23:52:44.869984Z] Running download-and-extract step. 15:52:44 INFO - Running pre-action listener: _resource_record_pre_action 15:52:44 INFO - Running main action method: download_and_extract 15:52:44 INFO - mkdir: /builds/slave/test/build/tests 15:52:44 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')]} 15:52:44 INFO - trying https://queue.taskcluster.net/v1/task/P6Jub1FNQ4u7NnIHMP4W_w/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json 15:52:44 INFO - Downloading https://queue.taskcluster.net/v1/task/P6Jub1FNQ4u7NnIHMP4W_w/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 15:52:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P6Jub1FNQ4u7NnIHMP4W_w/artifacts/public/build/firefox-52.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json'}, attempt #1 15:52:46 INFO - Downloaded 1199 bytes. 15:52:46 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.mac.test_packages.json 15:52:46 INFO - Using the following test package requirements: 15:52:46 INFO - {u'common': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 15:52:46 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 15:52:46 INFO - u'firefox-52.0a2.en-US.mac.cppunittest.tests.zip'], 15:52:46 INFO - u'gtest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 15:52:46 INFO - u'firefox-52.0a2.en-US.mac.gtest.tests.zip'], 15:52:46 INFO - u'jittest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 15:52:46 INFO - u'jsshell-mac.zip'], 15:52:46 INFO - u'mochitest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 15:52:46 INFO - u'firefox-52.0a2.en-US.mac.mochitest.tests.zip'], 15:52:46 INFO - u'mozbase': [u'firefox-52.0a2.en-US.mac.common.tests.zip'], 15:52:46 INFO - u'reftest': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 15:52:46 INFO - u'firefox-52.0a2.en-US.mac.reftest.tests.zip'], 15:52:46 INFO - u'talos': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 15:52:46 INFO - u'firefox-52.0a2.en-US.mac.talos.tests.zip'], 15:52:46 INFO - u'web-platform': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 15:52:46 INFO - u'firefox-52.0a2.en-US.mac.web-platform.tests.zip'], 15:52:46 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.mac.common.tests.zip', 15:52:46 INFO - u'firefox-52.0a2.en-US.mac.xpcshell.tests.zip']} 15:52:46 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip'] for test suite category: common 15:52:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P6Jub1FNQ4u7NnIHMP4W_w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 15:52:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P6Jub1FNQ4u7NnIHMP4W_w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 15:52:46 INFO - Fetch https://queue.taskcluster.net/v1/task/P6Jub1FNQ4u7NnIHMP4W_w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 15:52:46 INFO - Http code: 200 15:52:46 INFO - via: 1.1 73fa5a1ee49cf827e596b502b5927eab.cloudfront.net (CloudFront) 15:52:46 INFO - x-amz-cf-id: Ut6a02MdOMqBgITFvR7xBDUtaIUaXVh7XWlOrgxOKPemjPcNSUYHFg== 15:52:46 INFO - x-amz-version-id: WFllPeNKnvCvHS7u4BJw1EBn2IjFP.yZ 15:52:47 INFO - Expected file size: 16282926 15:52:47 INFO - Obtained file size: 16282926 15:52:53 INFO - Downloading packages: [u'firefox-52.0a2.en-US.mac.common.tests.zip', u'firefox-52.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 15:52:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P6Jub1FNQ4u7NnIHMP4W_w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip 15:52:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P6Jub1FNQ4u7NnIHMP4W_w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip'}, attempt #1 15:52:53 INFO - Fetch https://queue.taskcluster.net/v1/task/P6Jub1FNQ4u7NnIHMP4W_w/artifacts/public/build/firefox-52.0a2.en-US.mac.common.tests.zip into memory 15:52:54 INFO - Http code: 200 15:52:54 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 15:52:54 INFO - x-amz-cf-id: 1JQ_OwDvVk6kkE6aj2FBXQ111BSf-_bKpZV2GcCrpwMoQdVfeCyHEQ== 15:52:54 INFO - x-amz-version-id: WFllPeNKnvCvHS7u4BJw1EBn2IjFP.yZ 15:52:54 INFO - Expected file size: 16282926 15:52:54 INFO - Obtained file size: 16282926 15:53:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/P6Jub1FNQ4u7NnIHMP4W_w/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip 15:53:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/P6Jub1FNQ4u7NnIHMP4W_w/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip'}, attempt #1 15:53:00 INFO - Fetch https://queue.taskcluster.net/v1/task/P6Jub1FNQ4u7NnIHMP4W_w/artifacts/public/build/firefox-52.0a2.en-US.mac.talos.tests.zip into memory 15:53:01 INFO - Http code: 200 15:53:01 INFO - via: 1.1 d2bd759914e30b1d5aee2929535c55f9.cloudfront.net (CloudFront) 15:53:01 INFO - x-amz-cf-id: 9TpzGtXzkkM8RAEPZanSmxZ1Oj3EA4ScsiQQowrXxASdjw7lp00MUw== 15:53:01 INFO - x-amz-version-id: RzMt47Cjg6Smyc0S0q52Kxf3tKl9o.sq 15:53:01 INFO - Expected file size: 14409038 15:53:01 INFO - Obtained file size: 14409038 15:53:02 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')]} 15:53:02 INFO - trying https://queue.taskcluster.net/v1/task/P6Jub1FNQ4u7NnIHMP4W_w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 15:53:02 INFO - Downloading https://queue.taskcluster.net/v1/task/P6Jub1FNQ4u7NnIHMP4W_w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg 15:53:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/P6Jub1FNQ4u7NnIHMP4W_w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg'}, attempt #1 15:53:04 INFO - Downloaded 109723142 bytes. 15:53:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/P6Jub1FNQ4u7NnIHMP4W_w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 15:53:04 INFO - mkdir: /builds/slave/test/properties 15:53:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:53:04 INFO - Writing to file /builds/slave/test/properties/build_url 15:53:04 INFO - Contents: 15:53:04 INFO - build_url:https://queue.taskcluster.net/v1/task/P6Jub1FNQ4u7NnIHMP4W_w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg 15:53:05 INFO - Running post-action listener: _resource_record_post_action 15:53:05 INFO - Running post-action listener: set_extra_try_arguments 15:53:05 INFO - [mozharness: 2016-11-29 23:53:05.512532Z] Finished download-and-extract step (success) 15:53:05 INFO - [mozharness: 2016-11-29 23:53:05.512658Z] Running populate-webroot step. 15:53:05 INFO - Running pre-action listener: _resource_record_pre_action 15:53:05 INFO - Running main action method: populate_webroot 15:53:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:53:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:53:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:53:05 INFO - '--tppagecycles', 15:53:05 INFO - '7'], 15:53:05 INFO - 'tests': ['tsvgm']}}, 15:53:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:53:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:53:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:53:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:53:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:53:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:53:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:05 INFO - 'talos_options': ['--disable-e10s'], 15:53:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:53:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:05 INFO - 'talos_options': ['--disable-e10s'], 15:53:05 INFO - 'tests': ['damp', 'tps']}, 15:53:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:05 INFO - 'tests': ['damp', 'tps']}, 15:53:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:53:05 INFO - 'tests': ['dromaeo_dom']}, 15:53:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:53:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:53:05 INFO - 'tests': ['basic_compositor_video']}, 15:53:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:53:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:53:05 INFO - 'tests': ['a11yr', 15:53:05 INFO - 'ts_paint', 15:53:05 INFO - 'tpaint', 15:53:05 INFO - 'sessionrestore', 15:53:05 INFO - 'sessionrestore_no_auto_restore', 15:53:05 INFO - 'tabpaint']}, 15:53:05 INFO - 'other-e10s': {'tests': ['a11yr', 15:53:05 INFO - 'ts_paint', 15:53:05 INFO - 'tpaint', 15:53:05 INFO - 'sessionrestore', 15:53:05 INFO - 'sessionrestore_no_auto_restore', 15:53:05 INFO - 'tabpaint']}, 15:53:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:53:05 INFO - 'ts_paint', 15:53:05 INFO - 'tpaint', 15:53:05 INFO - 'sessionrestore', 15:53:05 INFO - 'sessionrestore_no_auto_restore', 15:53:05 INFO - 'tabpaint']}, 15:53:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:53:05 INFO - 'ts_paint', 15:53:05 INFO - 'tpaint', 15:53:05 INFO - 'sessionrestore', 15:53:05 INFO - 'sessionrestore_no_auto_restore', 15:53:05 INFO - 'tabpaint']}, 15:53:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:53:05 INFO - 'tests': ['a11yr', 15:53:05 INFO - 'ts_paint', 15:53:05 INFO - 'tpaint', 15:53:05 INFO - 'sessionrestore', 15:53:05 INFO - 'sessionrestore_no_auto_restore', 15:53:05 INFO - 'tabpaint']}, 15:53:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:53:05 INFO - 'tests': ['a11yr', 15:53:05 INFO - 'ts_paint', 15:53:05 INFO - 'tpaint', 15:53:05 INFO - 'sessionrestore', 15:53:05 INFO - 'sessionrestore_no_auto_restore', 15:53:05 INFO - 'tabpaint']}, 15:53:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:53:05 INFO - 'tests': ['tsvgx', 15:53:05 INFO - 'tsvgr_opacity', 15:53:05 INFO - 'tart', 15:53:05 INFO - 'tscrollx', 15:53:05 INFO - 'cart']}, 15:53:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:53:05 INFO - 'tsvgr_opacity', 15:53:05 INFO - 'tart', 15:53:05 INFO - 'tscrollx', 15:53:05 INFO - 'cart']}, 15:53:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:05 INFO - 'talos_options': ['--disable-e10s'], 15:53:05 INFO - 'tests': ['tp5o']}, 15:53:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:05 INFO - 'tests': ['tp5o']}, 15:53:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:05 INFO - 'talos_options': ['--disable-e10s', 15:53:05 INFO - '--xperf_path', 15:53:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:05 INFO - 'tests': ['tp5n']}, 15:53:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:53:05 INFO - 'talos_options': ['--xperf_path', 15:53:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:53:05 INFO - 'tests': ['tp5n']}}, 15:53:05 INFO - 'talos.zip': {'path': '', 15:53:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:53:05 INFO - Running post-action listener: _resource_record_post_action 15:53:05 INFO - [mozharness: 2016-11-29 23:53:05.531235Z] Finished populate-webroot step (success) 15:53:05 INFO - [mozharness: 2016-11-29 23:53:05.531359Z] Running create-virtualenv step. 15:53:05 INFO - Running pre-action listener: _resource_record_pre_action 15:53:05 INFO - Running main action method: create_virtualenv 15:53:05 INFO - Creating virtualenv /builds/slave/test/build/venv 15:53:05 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 15:53:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:53:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:53:05 INFO - Using real prefix '/tools/python27' 15:53:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:53:06 INFO - Installing distribute.............................................................................................................................................................................................done. 15:53:09 INFO - Installing pip.................done. 15:53:09 INFO - Return code: 0 15:53:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:53:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:53:09 INFO - Reading from file tmpfile_stdout 15:53:09 INFO - Output received: 15:53:09 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) 15:53:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:53: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')]} 15:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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')]} 15:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:09 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 0x101262490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80d0462320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101076d30>, '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 0x100edcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10106eb20>, '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.qzpOBjailN/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.CarbeBn2lf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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 15:53:09 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 15:53:09 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 15:53:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qzpOBjailN/Render', 15:53:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:09 INFO - 'HOME': '/Users/cltbld', 15:53:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:09 INFO - 'LOGNAME': 'cltbld', 15:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:09 INFO - 'MOZ_NO_REMOTE': '1', 15:53:09 INFO - 'NO_EM_RESTART': '1', 15:53:09 INFO - 'PAGER': '/bin/cat', 15:53:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:09 INFO - 'PWD': '/builds/slave/test', 15:53:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:09 INFO - 'SHELL': '/bin/bash', 15:53:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CarbeBn2lf/Listeners', 15:53:09 INFO - 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/', 15:53:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:09 INFO - 'USER': 'cltbld', 15:53:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:09 INFO - 'XPC_FLAGS': '0x0', 15:53:09 INFO - 'XPC_SERVICE_NAME': '0', 15:53:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:09 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 15:53:09 INFO - Cleaning up... 15:53:09 INFO - Return code: 0 15:53:09 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:53: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')]} 15:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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')]} 15:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:09 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 0x101262490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80d0462320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101076d30>, '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 0x100edcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10106eb20>, '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.qzpOBjailN/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.CarbeBn2lf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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 15:53:09 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 15:53:09 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 15:53:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qzpOBjailN/Render', 15:53:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:09 INFO - 'HOME': '/Users/cltbld', 15:53:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:09 INFO - 'LOGNAME': 'cltbld', 15:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:09 INFO - 'MOZ_NO_REMOTE': '1', 15:53:09 INFO - 'NO_EM_RESTART': '1', 15:53:09 INFO - 'PAGER': '/bin/cat', 15:53:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:09 INFO - 'PWD': '/builds/slave/test', 15:53:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:09 INFO - 'SHELL': '/bin/bash', 15:53:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CarbeBn2lf/Listeners', 15:53:09 INFO - 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/', 15:53:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:09 INFO - 'USER': 'cltbld', 15:53:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:09 INFO - 'XPC_FLAGS': '0x0', 15:53:09 INFO - 'XPC_SERVICE_NAME': '0', 15:53:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:10 INFO - Downloading/unpacking psutil>=3.1.1 15:53:10 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 15:53:10 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 15:53:10 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 15:53:10 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 15:53:10 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 15:53:10 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 15:53:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:53:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:13 INFO - Installing collected packages: psutil 15:53:13 INFO - Running setup.py install for psutil 15:53:13 INFO - building 'psutil._psutil_osx' extension 15:53:13 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 15:53:14 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 15:53:14 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 15:53:14 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 15:53:14 INFO - building 'psutil._psutil_posix' extension 15:53:14 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 15:53:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:53:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:53:14 INFO - ^ 15:53:14 INFO - 1 warning generated. 15:53:14 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 15:53:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:53:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:53:14 INFO - Successfully installed psutil 15:53:14 INFO - Cleaning up... 15:53:14 INFO - Return code: 0 15:53:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:53: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')]} 15:53:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53: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')]} 15:53:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:14 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 0x101262490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80d0462320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101076d30>, '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 0x100edcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10106eb20>, '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.qzpOBjailN/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.CarbeBn2lf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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 15:53:14 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 15:53:14 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 15:53:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qzpOBjailN/Render', 15:53:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:14 INFO - 'HOME': '/Users/cltbld', 15:53:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:14 INFO - 'LOGNAME': 'cltbld', 15:53:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:14 INFO - 'MOZ_NO_REMOTE': '1', 15:53:14 INFO - 'NO_EM_RESTART': '1', 15:53:14 INFO - 'PAGER': '/bin/cat', 15:53:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:14 INFO - 'PWD': '/builds/slave/test', 15:53:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:14 INFO - 'SHELL': '/bin/bash', 15:53:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CarbeBn2lf/Listeners', 15:53:14 INFO - 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/', 15:53:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:14 INFO - 'USER': 'cltbld', 15:53:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:14 INFO - 'XPC_FLAGS': '0x0', 15:53:14 INFO - 'XPC_SERVICE_NAME': '0', 15:53:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:53:14 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 15:53:14 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 15:53:14 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 15:53:14 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 15:53:14 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 15:53:14 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 15:53:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:53:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:53:17 INFO - Installing collected packages: mozsystemmonitor 15:53:17 INFO - Running setup.py install for mozsystemmonitor 15:53:17 INFO - Successfully installed mozsystemmonitor 15:53:17 INFO - Cleaning up... 15:53:17 INFO - Return code: 0 15:53:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:53:17 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')]} 15:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:17 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')]} 15:53:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:17 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 0x101262490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80d0462320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101076d30>, '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 0x100edcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10106eb20>, '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.qzpOBjailN/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.CarbeBn2lf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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 15:53:17 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 15:53:17 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 15:53:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qzpOBjailN/Render', 15:53:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:17 INFO - 'HOME': '/Users/cltbld', 15:53:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:17 INFO - 'LOGNAME': 'cltbld', 15:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:17 INFO - 'MOZ_NO_REMOTE': '1', 15:53:17 INFO - 'NO_EM_RESTART': '1', 15:53:17 INFO - 'PAGER': '/bin/cat', 15:53:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:17 INFO - 'PWD': '/builds/slave/test', 15:53:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:17 INFO - 'SHELL': '/bin/bash', 15:53:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CarbeBn2lf/Listeners', 15:53:17 INFO - 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/', 15:53:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:17 INFO - 'USER': 'cltbld', 15:53:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:17 INFO - 'XPC_FLAGS': '0x0', 15:53:17 INFO - 'XPC_SERVICE_NAME': '0', 15:53:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:17 INFO - Downloading/unpacking jsonschema==2.5.1 15:53:17 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 15:53:17 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 15:53:17 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 15:53:17 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 15:53:17 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 15:53:17 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 15:53:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:53:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:20 INFO - Downloading functools32-3.2.3-2.tar.gz 15:53:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:53:21 INFO - warning: no files found matching '*.txt' 15:53:21 INFO - no previously-included directories found matching 'build' 15:53:21 INFO - no previously-included directories found matching 'dist' 15:53:21 INFO - no previously-included directories found matching '.git*' 15:53:21 INFO - Installing collected packages: jsonschema, functools32 15:53:21 INFO - Running setup.py install for functools32 15:53:21 INFO - warning: no files found matching '*.txt' 15:53:21 INFO - no previously-included directories found matching 'build' 15:53:21 INFO - no previously-included directories found matching 'dist' 15:53:21 INFO - no previously-included directories found matching '.git*' 15:53:21 INFO - Successfully installed jsonschema functools32 15:53:21 INFO - Cleaning up... 15:53:21 INFO - Return code: 0 15:53:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:53:21 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')]} 15:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:21 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')]} 15:53:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:21 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 0x101262490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80d0462320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101076d30>, '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 0x100edcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10106eb20>, '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.qzpOBjailN/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.CarbeBn2lf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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 15:53:21 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 15:53:21 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 15:53:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qzpOBjailN/Render', 15:53:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:21 INFO - 'HOME': '/Users/cltbld', 15:53:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:21 INFO - 'LOGNAME': 'cltbld', 15:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:21 INFO - 'MOZ_NO_REMOTE': '1', 15:53:21 INFO - 'NO_EM_RESTART': '1', 15:53:21 INFO - 'PAGER': '/bin/cat', 15:53:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:21 INFO - 'PWD': '/builds/slave/test', 15:53:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:21 INFO - 'SHELL': '/bin/bash', 15:53:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CarbeBn2lf/Listeners', 15:53:21 INFO - 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/', 15:53:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:21 INFO - 'USER': 'cltbld', 15:53:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:21 INFO - 'XPC_FLAGS': '0x0', 15:53:21 INFO - 'XPC_SERVICE_NAME': '0', 15:53:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:53:21 INFO - Cleaning up... 15:53:21 INFO - Return code: 0 15:53:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:53:21 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')]} 15:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:21 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')]} 15:53:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:21 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 0x101262490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80d0462320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101076d30>, '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 0x100edcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10106eb20>, '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.qzpOBjailN/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.CarbeBn2lf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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 15:53:21 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 15:53:21 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 15:53:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qzpOBjailN/Render', 15:53:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:21 INFO - 'HOME': '/Users/cltbld', 15:53:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:21 INFO - 'LOGNAME': 'cltbld', 15:53:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:21 INFO - 'MOZ_NO_REMOTE': '1', 15:53:21 INFO - 'NO_EM_RESTART': '1', 15:53:21 INFO - 'PAGER': '/bin/cat', 15:53:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:21 INFO - 'PWD': '/builds/slave/test', 15:53:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:21 INFO - 'SHELL': '/bin/bash', 15:53:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CarbeBn2lf/Listeners', 15:53:21 INFO - 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/', 15:53:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:21 INFO - 'USER': 'cltbld', 15:53:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:21 INFO - 'XPC_FLAGS': '0x0', 15:53:21 INFO - 'XPC_SERVICE_NAME': '0', 15:53:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:21 INFO - Downloading/unpacking blobuploader==1.2.4 15:53:21 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 15:53:21 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 15:53:21 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 15:53:21 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 15:53:21 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 15:53:21 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 15:53:24 INFO - Downloading blobuploader-1.2.4.tar.gz 15:53:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:53:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:53:24 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 15:53:24 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 15:53:24 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 15:53:24 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 15:53:24 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 15:53:24 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 15:53:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:53:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:53:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:53:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:53:25 INFO - Downloading docopt-0.6.1.tar.gz 15:53:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:53:25 INFO - Installing collected packages: blobuploader, requests, docopt 15:53:25 INFO - Running setup.py install for blobuploader 15:53:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:53:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:53:25 INFO - Running setup.py install for requests 15:53:26 INFO - Running setup.py install for docopt 15:53:26 INFO - Successfully installed blobuploader requests docopt 15:53:26 INFO - Cleaning up... 15:53:26 INFO - Return code: 0 15:53:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:26 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')]} 15:53:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:26 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')]} 15:53:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:26 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 0x101262490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80d0462320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101076d30>, '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 0x100edcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10106eb20>, '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.qzpOBjailN/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.CarbeBn2lf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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 15:53:26 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 15:53:26 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 15:53:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qzpOBjailN/Render', 15:53:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:26 INFO - 'HOME': '/Users/cltbld', 15:53:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:26 INFO - 'LOGNAME': 'cltbld', 15:53:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:26 INFO - 'MOZ_NO_REMOTE': '1', 15:53:26 INFO - 'NO_EM_RESTART': '1', 15:53:26 INFO - 'PAGER': '/bin/cat', 15:53:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:26 INFO - 'PWD': '/builds/slave/test', 15:53:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:26 INFO - 'SHELL': '/bin/bash', 15:53:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CarbeBn2lf/Listeners', 15:53:26 INFO - 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/', 15:53:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:26 INFO - 'USER': 'cltbld', 15:53:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:26 INFO - 'XPC_FLAGS': '0x0', 15:53:26 INFO - 'XPC_SERVICE_NAME': '0', 15:53:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:53:26 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-Sni978-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:53:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:53:26 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-4gYY_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:53:27 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-T9EfoG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:27 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-N5ihdn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:27 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-IAbzUA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:27 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-mQjIlO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:27 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-plnw5d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:27 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-xbZX3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:27 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-vQ0cwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:27 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-96eM0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:27 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-ZEEKwS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:28 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-vml82e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:28 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-dVSRZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:28 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-64MsFO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:28 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-sF1LU2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:28 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-XAQ4od-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:28 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-8QXrO9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:53:28 INFO - Running setup.py install for manifestparser 15:53:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:53:28 INFO - Running setup.py install for mozcrash 15:53:28 INFO - Running setup.py install for mozdebug 15:53:29 INFO - Running setup.py install for mozdevice 15:53:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:53:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:53:29 INFO - Running setup.py install for mozfile 15:53:29 INFO - Running setup.py install for mozhttpd 15:53:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:53:29 INFO - Running setup.py install for mozinfo 15:53:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:53:29 INFO - Running setup.py install for mozInstall 15:53:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:53:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:53:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:53:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:53:29 INFO - Running setup.py install for mozleak 15:53:29 INFO - Running setup.py install for mozlog 15:53:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:53:30 INFO - Running setup.py install for moznetwork 15:53:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:53:30 INFO - Running setup.py install for mozprocess 15:53:30 INFO - Running setup.py install for mozprofile 15:53:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:53:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:53:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:53:30 INFO - Running setup.py install for mozrunner 15:53:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:53:30 INFO - Running setup.py install for mozscreenshot 15:53:30 INFO - Running setup.py install for moztest 15:53:31 INFO - Running setup.py install for mozversion 15:53:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:53:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:53:31 INFO - Cleaning up... 15:53:31 INFO - Return code: 0 15:53:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:31 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 0x101262490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80d0462320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101076d30>, '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 0x100edcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10106eb20>, '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.qzpOBjailN/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.CarbeBn2lf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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 15:53:31 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 15:53:31 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 15:53:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qzpOBjailN/Render', 15:53:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:31 INFO - 'HOME': '/Users/cltbld', 15:53:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:31 INFO - 'LOGNAME': 'cltbld', 15:53:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:31 INFO - 'MOZ_NO_REMOTE': '1', 15:53:31 INFO - 'NO_EM_RESTART': '1', 15:53:31 INFO - 'PAGER': '/bin/cat', 15:53:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:31 INFO - 'PWD': '/builds/slave/test', 15:53:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:31 INFO - 'SHELL': '/bin/bash', 15:53:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CarbeBn2lf/Listeners', 15:53:31 INFO - 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/', 15:53:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:31 INFO - 'USER': 'cltbld', 15:53:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:31 INFO - 'XPC_FLAGS': '0x0', 15:53:31 INFO - 'XPC_SERVICE_NAME': '0', 15:53:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:53:31 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-lF0rFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:53:31 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)) 15:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:53:31 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-qGKznq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:53:31 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)) 15:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:53:31 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-32Ro5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:53:31 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)) 15:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:53:31 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-lWBjs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:53:31 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)) 15:53:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:53:31 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-B3S7Zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:53:32 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)) 15:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:53:32 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-ND4KPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:53:32 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)) 15:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:53:32 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-jHAnhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:53:32 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)) 15:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:53:32 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-nY_4yh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:53:32 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)) 15:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:53:32 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-cy4SbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:53:32 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)) 15:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:53:32 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-2j7bfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:53:32 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)) 15:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:53:32 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-Bsj5IR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:53:32 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)) 15:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:53:32 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-jvZoM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:53:32 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)) 15:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:53:32 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-uByh48-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:53:32 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)) 15:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:53:32 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-0Qxm77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:53:32 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)) 15:53:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:32 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-o4pobM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:53:33 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)) 15:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:53:33 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-t59TQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:53:33 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:53:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:53:33 INFO - Running setup.py (path:/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/pip-oHWTQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:53:33 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)) 15:53:33 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)) 15:53:33 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)) 15:53:33 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)) 15:53:33 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)) 15:53:33 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)) 15:53:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:53:33 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 15:53:33 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 15:53:33 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 15:53:33 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 15:53:33 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 15:53:33 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 15:53:35 INFO - Downloading blessings-1.6.tar.gz 15:53:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:53:35 INFO - Installing collected packages: blessings 15:53:35 INFO - Running setup.py install for blessings 15:53:36 INFO - Successfully installed blessings 15:53:36 INFO - Cleaning up... 15:53:36 INFO - Return code: 0 15:53:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:53:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:36 INFO - Reading from file tmpfile_stdout 15:53:36 INFO - Current package versions: 15:53:36 INFO - blessings == 1.6 15:53:36 INFO - blobuploader == 1.2.4 15:53:36 INFO - docopt == 0.6.1 15:53:36 INFO - functools32 == 3.2.3-2 15:53:36 INFO - jsonschema == 2.5.1 15:53:36 INFO - manifestparser == 1.1 15:53:36 INFO - mozInstall == 1.12 15:53:36 INFO - mozcrash == 1.0 15:53:36 INFO - mozdebug == 0.1 15:53:36 INFO - mozdevice == 0.48 15:53:36 INFO - mozfile == 1.2 15:53:36 INFO - mozhttpd == 0.7 15:53:36 INFO - mozinfo == 0.9 15:53:36 INFO - mozleak == 0.1 15:53:36 INFO - mozlog == 3.4 15:53:36 INFO - moznetwork == 0.27 15:53:36 INFO - mozprocess == 0.23 15:53:36 INFO - mozprofile == 0.28 15:53:36 INFO - mozrunner == 6.13 15:53:36 INFO - mozscreenshot == 0.1 15:53:36 INFO - mozsystemmonitor == 0.3 15:53:36 INFO - moztest == 0.7 15:53:36 INFO - mozversion == 1.4 15:53:36 INFO - psutil == 3.1.1 15:53:36 INFO - requests == 1.2.3 15:53:36 INFO - wsgiref == 0.1.2 15:53:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:53:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:37 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')]} 15:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:37 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 0x101262490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80d0462320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101076d30>, '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 0x100edcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10106eb20>, '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.qzpOBjailN/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.CarbeBn2lf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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 15:53:37 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 15:53:37 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 15:53:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qzpOBjailN/Render', 15:53:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:37 INFO - 'HOME': '/Users/cltbld', 15:53:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:37 INFO - 'LOGNAME': 'cltbld', 15:53:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:37 INFO - 'MOZ_NO_REMOTE': '1', 15:53:37 INFO - 'NO_EM_RESTART': '1', 15:53:37 INFO - 'PAGER': '/bin/cat', 15:53:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:37 INFO - 'PWD': '/builds/slave/test', 15:53:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:37 INFO - 'SHELL': '/bin/bash', 15:53:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CarbeBn2lf/Listeners', 15:53:37 INFO - 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/', 15:53:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:37 INFO - 'USER': 'cltbld', 15:53:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:37 INFO - 'XPC_FLAGS': '0x0', 15:53:37 INFO - 'XPC_SERVICE_NAME': '0', 15:53:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:37 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)) 15:53:37 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)) 15:53:37 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)) 15:53:37 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)) 15:53:37 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)) 15:53:37 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)) 15:53:37 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)) 15:53:37 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)) 15:53:37 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)) 15:53:37 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)) 15:53:37 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)) 15:53:37 INFO - Cleaning up... 15:53:37 INFO - Return code: 0 15:53:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:53:37 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')]} 15:53:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:53:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:37 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')]} 15:53:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:53:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:53:38 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 0x101262490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1011d8570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f80d0462320>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101076d30>, '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 0x100edcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10106eb20>, '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.qzpOBjailN/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.CarbeBn2lf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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 15:53:38 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 15:53:38 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 15:53:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qzpOBjailN/Render', 15:53:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:53:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:53:38 INFO - 'HOME': '/Users/cltbld', 15:53:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:53:38 INFO - 'LOGNAME': 'cltbld', 15:53:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:53:38 INFO - 'MOZ_NO_REMOTE': '1', 15:53:38 INFO - 'NO_EM_RESTART': '1', 15:53:38 INFO - 'PAGER': '/bin/cat', 15:53:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:53:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:53:38 INFO - 'PWD': '/builds/slave/test', 15:53:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:53:38 INFO - 'SHELL': '/bin/bash', 15:53:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CarbeBn2lf/Listeners', 15:53:38 INFO - 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/', 15:53:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:53:38 INFO - 'USER': 'cltbld', 15:53:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:53:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:53:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:53:38 INFO - 'XPC_FLAGS': '0x0', 15:53:38 INFO - 'XPC_SERVICE_NAME': '0', 15:53:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:53:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:53:38 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:53:38 INFO - Cleaning up... 15:53:38 INFO - Return code: 0 15:53:38 INFO - Running post-action listener: _resource_record_post_action 15:53:38 INFO - Running post-action listener: _start_resource_monitoring 15:53:38 INFO - Starting resource monitoring. 15:53:38 INFO - [mozharness: 2016-11-29 23:53:38.574885Z] Finished create-virtualenv step (success) 15:53:38 INFO - [mozharness: 2016-11-29 23:53:38.575966Z] Running install step. 15:53:38 INFO - Running pre-action listener: _resource_record_pre_action 15:53:38 INFO - Running main action method: install 15:53:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:53:38 INFO - Reading from file tmpfile_stdout 15:53:38 INFO - Detecting whether we're running mozinstall >=1.0... 15:53:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:53:38 INFO - Reading from file tmpfile_stdout 15:53:38 INFO - Output received: 15:53:38 INFO - Usage: mozinstall [options] installer 15:53:38 INFO - Options: 15:53:38 INFO - -h, --help show this help message and exit 15:53:38 INFO - -d DEST, --destination=DEST 15:53:38 INFO - Directory to install application into. [default: 15:53:38 INFO - "/builds/slave/test"] 15:53:38 INFO - --app=APP Application being installed. [default: firefox] 15:53:38 INFO - mkdir: /builds/slave/test/build/application 15:53:38 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:53:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 15:54:09 INFO - Reading from file tmpfile_stdout 15:54:09 INFO - Output received: 15:54:09 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 15:54:09 INFO - Running post-action listener: _resource_record_post_action 15:54:09 INFO - [mozharness: 2016-11-29 23:54:09.569608Z] Finished install step (success) 15:54:09 INFO - [mozharness: 2016-11-29 23:54:09.569753Z] Running run-tests step. 15:54:09 INFO - Running pre-action listener: _resource_record_pre_action 15:54:09 INFO - Running main action method: run_tests 15:54:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:54:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:54:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:54:09 INFO - 2016-11-29 15:54:09.584 screenresolution[1626:7336] starting screenresolution argv=screenresolution get 15:54:09 INFO - 2016-11-29 15:54:09.586 screenresolution[1626:7336] Display 0: 1600x1200x32@60 15:54:09 INFO - 2016-11-29 15:54:09.592 screenresolution[1627:7338] starting screenresolution argv=screenresolution list 15:54:09 INFO - Available Modes on Display 0 15:54:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:54:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:54:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:54:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:54:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:54:09 INFO - Intel Iris: 15:54:09 INFO - Chipset Model: Intel Iris 15:54:09 INFO - Type: GPU 15:54:09 INFO - Bus: Built-In 15:54:09 INFO - VRAM (Dynamic, Max): 1536 MB 15:54:09 INFO - Vendor: Intel (0x8086) 15:54:09 INFO - Device ID: 0x0a2e 15:54:09 INFO - Revision ID: 0x0009 15:54:09 INFO - Displays: 15:54:09 INFO - Display: 15:54:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:54:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:54:09 INFO - Display Serial Number: 1600x1200 60 15:54:09 INFO - Main Display: Yes 15:54:09 INFO - Mirror: Off 15:54:09 INFO - Online: Yes 15:54:09 INFO - Rotation: Supported 15:54:09 INFO - Return code: 0 15:54:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:54:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:54:09 INFO - Python 2.7.3 15:54:09 INFO - Return code: 0 15:54:09 INFO - grabbing minidump binary from tooltool 15:54: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')]} 15:54:09 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 0x101076d30>, '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 0x100edcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10106eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:54:09 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 15:54:09 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 15:54:09 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 15:54:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:54:09 INFO - Return code: 0 15:54:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:54:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:54:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:54:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:54:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:54:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P6Jub1FNQ4u7NnIHMP4W_w/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0323', '--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 15:54:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/P6Jub1FNQ4u7NnIHMP4W_w/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0323 --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 15:54:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.qzpOBjailN/Render', 15:54:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:54:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:54:09 INFO - 'HOME': '/Users/cltbld', 15:54:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:54:09 INFO - 'LOGNAME': 'cltbld', 15:54:09 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:54:09 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:54:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:54:09 INFO - 'MOZ_NO_REMOTE': '1', 15:54:09 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:54:09 INFO - 'NO_EM_RESTART': '1', 15:54:09 INFO - 'PAGER': '/bin/cat', 15:54:09 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:54:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:54:09 INFO - 'PWD': '/builds/slave/test', 15:54:09 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:54:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:54:09 INFO - 'SHELL': '/bin/bash', 15:54:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.CarbeBn2lf/Listeners', 15:54:09 INFO - 'TMPDIR': '/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/', 15:54:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:54:09 INFO - 'USER': 'cltbld', 15:54:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:54:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:54:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:54:09 INFO - 'XPC_FLAGS': '0x0', 15:54:09 INFO - 'XPC_SERVICE_NAME': '0', 15:54:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:54:09 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/P6Jub1FNQ4u7NnIHMP4W_w/artifacts/public/build/firefox-52.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0323', '--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 15:54:10 INFO - mozversion application_buildid: 20161129131427 15:54:10 INFO - mozversion application_changeset: 76cf4e84939e3258e654c7cc756503bcc807ff7e 15:54:10 INFO - mozversion application_display_name: FirefoxDeveloperEdition 15:54:10 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:54:10 INFO - mozversion application_name: Firefox 15:54:10 INFO - mozversion application_remotingname: firefox-dev 15:54:10 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:54:10 INFO - mozversion application_vendor: Mozilla 15:54:10 INFO - mozversion application_version: 52.0a2 15:54:10 INFO - mozversion platform_buildid: 20161129131427 15:54:10 INFO - mozversion platform_changeset: 76cf4e84939e3258e654c7cc756503bcc807ff7e 15:54:10 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 15:54:10 INFO - mozversion platform_version: 52.0a2 15:54:10 INFO - using testdate: 1480463650 15:54:10 INFO - actual date: 1480463650 15:54:10 INFO - starting webserver on 'localhost:49248' 15:54:10 INFO - SUITE-START | Running 2 tests 15:54:10 INFO - TEST-START | dromaeo_css 15:54:10 INFO - operating with platform_type : mac_ 15:54:10 INFO - Initialising browser for dromaeo_css test... 15:54:10 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/tmpEqxA2V/profile http://localhost:49248/getInfo.html) 15:54:12 INFO - PROCESS | 1637 | __metrics Screen width/height:1600/1200 15:54:12 INFO - PROCESS | 1637 | colorDepth:24 15:54:12 INFO - PROCESS | 1637 | Browser inner width/height: 1024/689 15:54:12 INFO - PROCESS | 1637 | __metrics 15:54:12 INFO - PROCESS | 1637 | 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" 15:54:12 INFO - PROCESS | 1637 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:54:13 INFO - TEST-INFO | 1637: exit 0 15:54:13 INFO - Browser initialized. 15:54:13 INFO - Running cycle 1/1 for dromaeo_css test... 15:54:13 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/tmpEqxA2V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:54:26 INFO - PROCESS | 1639 | RSS: Main: 223485952 15:54:26 INFO - PROCESS | 1639 | 15:55:17 INFO - PROCESS | 1639 | 1480463717417 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 15:57:30 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49248/tests/dromaeo/cssquery-ext.html) 15:57:31 INFO - PROCESS | 1639 | RSS: Main: 357625856 15:57:31 INFO - PROCESS | 1639 | 16:00:34 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-ext.html (next: http://localhost:49248/tests/dromaeo/cssquery-jquery.html) 16:00:35 INFO - PROCESS | 1639 | RSS: Main: 348848128 16:00:35 INFO - PROCESS | 1639 | 16:03:37 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49248/tests/dromaeo/cssquery-mootools.html) 16:03:38 INFO - PROCESS | 1639 | RSS: Main: 321499136 16:03:38 INFO - PROCESS | 1639 | 16:06:40 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49248/tests/dromaeo/cssquery-prototype.html) 16:06:41 INFO - PROCESS | 1639 | RSS: Main: 320294912 16:06:41 INFO - PROCESS | 1639 | 16:09:44 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49248/tests/dromaeo/cssquery-yui.html) 16:09:45 INFO - PROCESS | 1639 | RSS: Main: 310153216 16:09:45 INFO - PROCESS | 1639 | 16:12:48 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49248/tests/dromaeo/cssquery-yui.html (next: http://localhost:49248/tests/dromaeo/cssquery-dojo.html) 16:12:48 INFO - PROCESS | 1639 | RSS: Main: 356966400 16:12:48 INFO - PROCESS | 1639 | 16:12:48 INFO - PROCESS | 1639 | __start_tp_report 16:12:48 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 16:12:48 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 16:12:48 INFO - PROCESS | 1639 | |i|pagename|runs| 16:12:48 INFO - PROCESS | 1639 | |0;dojo.html;2644.0349272515527;3027.818330900146;3255.56049933259;3274.9029075259787;3305.8594784799266;5566.471185237406;5568.303962004749;5615.045442274813;5622.381538030813;5651.604387692863;5525.557955363572;5589.664620122796;5591.1054231323;5616.3260408751;5627.971860140694;5083.822066227683;5091.567216786578;5108.719020453874;5172.741362931857;5231.319928409302;5041.1682072458;5096.974515127419;5120.385553733558;5127.384713834345;5155.278261043457;5156.793728250866;5181.145111056671;5197.922031169535;5199.194124910645;5224.138017227153;5180.689158650455;5181.274621552986;5188.481151884819;5196.818111366084;5236.136037553799;5020.071286811952;5042.067217564726;5081.669691470042;5122.795088196468;5125.871853203663;5482.013237617227;5510.090835012258;5528.917066244009;5544.445555444423;5546.223528705985;6030.9747342951805;6032.939670603281;6051.727672254759;6079;6107.389261073901;6146.832101900669;6185.443310102112;6192.8852806494815;6207.658578778165;6209.627422354673;5716.914246286309;5719.142128680648;5725.370209276976;5727.9427205727825;5739.913901291484;6120.569035656853;6214;6226.782062627877;6228.626282423069;6268.529860260499;6006.099085137264;6006.219191505076;6015.30823955242;6021.638701677914;6025.18659980897;6175.84560385985;6183.979643358885;6195.81412557624;6200.100985357098;6210.099535567318;5937.139114828412;5965.612235204698;5975.133605627159;6042.939570604326;6065;6033.18551995475;6103.1455596216565;6114.9754704401175;6126.23422072241;6145.170401995762;4740.573348398591;4815.422149342031;4815.518448155157;4817.325574419584;4839.612830973514;4264.232438161161;4291.678124140702;4346.608805207483;4356.869293921188;4421.314696222091;5555.527780138734;5589.469000444951;5613.7193140342815;5667;5679.148127780866;6204.565680402328;6208.2239720034995;6214.161088253119;6224.906626400608;6231.937680623227;5677.772889084473;5680.460356266148;5690.2887139107615;5704.22992895962;5728.627639203439;5138.845834624967;5246.685198888079;5262.421133675292;5274.050670879278;5318.494742999409;5905.143754155709;6193.566450348432;6227.96886015567;6230.065490176328;6256.280527739368;5180.507851754077;6168.9691551541955;6208.81373558794;6210.844728881814;6211.596246243979;5168.819091331786;6006.755104993566;6185.752569897154;6229;6252.343503932204;6037;6049.062395328731;6082.9695851520455;6127.464420129145;6128.442013631005;6053.515718742402;6075.908861366995;6134.314131579348;6168.9691551541955;6199.256089269316;5798.797042103675;5876.882462350643;5994.67029313392;6030.185924900083;6036.788712395045;5828.5919985602295;5868.383819699041;5912.645241285537;5933.1396947443245;5946.108083787466;5815.680137592473;5815.883682326245;5816.82549523515;5827.184194212899;5831.271091113611;5972.552058595709;6003.909941350796;6007.699615019319;6010.519158467225;6015.608985415934;5503.532199763065;5635.746391412478;5655.604107712421;5658.122990936411;5697.430256974435 16:12:48 INFO - PROCESS | 1639 | |1;ext.html;505.59047171790854;506.0612563694347;509.819014249941;514.1696160700468;516.5170565521238;30080.398392032148;32067;39180.216395672105;40806.59193408065;40989.7950510247;42101.736947891615;42597;42608.7217383479;42632.72101836942;42703;9210.401323913959;9376.203022743075;9386.671466498674;9397.154256116948;9407.670731524398;8583.52790596517;8741.737747867573;10974.945125274362;11222.887771122307;11258;11265.662030139109;11333.603323883666;11356.48895799687;11359.545618175305;11373.772524549504;11030.779384412306;11110.166737494721;11110.666679999613;11120.277181983145;11133.498992545356;11163.218574699775;11179.049780768644;11224.326540407601;11230.213885028052;11236.887631123665;39281;39524.80237598823;39600;39633.20733585312;39634.60365396367;2908.4473949949443;3285.1130194847497;3308.123347312964;3414.709749671281;3895.4351619015083;27837;28380.020720433633;28787;30308.787648494035;30520.38959220803;3204.4071846708434;3211.8394080296125;3260.5272235525954;3334.0497958082074;3354.8658053677823;478723;481690;484531.99999999645;485045;495045;33321.50017749736;59804.40195598076;60109;60258;60447.69776151091;34478.7932422364;35349.646503534634;35390.292194155976;35444;35511;13890.16659000443;14226.430942762381;14356.138631682132;14363.497277595234;14487.275636218146;11108.666739997812;11301;11734.647960561026;11893.40532973348;12092;6743.325667433218;7450.18048014718;7572.924270757332;7584.4311676624475;7855.13593504714;2722.2377734234447;2954.852257387122;3049.8017628854054;3201.295714942709;3235.288236587947;859.6303589456469;926.578406824893;1011.312307630818;1012.6152062216311;1068.8610480637624;29873.805047797843;30081;30285.545716814264;30984.845075774476;31134;1021.1014307409432;1049.6588608702202;1051.232600201857;1068.2255364860569;1085.9728506787394;15189.6202594936;15225.619359515878;15294.464693735667;15435.38258469671;15464.76199990006;671845;673170;677297;677979;678680;57233.71383143058;57625.42374576285;57650.423495765346;57685.711571441876;57955.71022144862;1222.6759908624222;1246.987530124687;1251.6557946564767;1360.571420002696;1393.3451277899371;28358;30553.54169687501;31109.22226944254;31579.684203157674;32196.517052243766;54505.72747136239;55319.72340138435;55337;55356.72321638366;55395.723021384634;554042;554569;556117;556347;567550;26305.73694263033;26413.867930660224;36868.446973295955;37374.626253737115;37513;38130.809345953094;45924;46153;47227;48965.510344896094;38162;38282.788893221164;38807;40089.997750056486;40369;38225;38543.614563854004;38571.614283856805;40100.598994009684;40308;34497.31005379828;35831.82084089563;36251.45622815607;36399;36411.635883640825;32249.35501290008;33892.661073388954;34238.48642270318;34585;34968.776092836626;25491.36271593225;25617.359566011;25678.972841086146;26062;26067.869660651577 16:12:48 INFO - PROCESS | 1639 | |2;jquery.html;334.21959724044353;346.5494856686308;355.1990261959281;360.62314880949396;381.3402813133279;14920.477783277587;15002.924985375072;15442.845571544281;16245.918770406131;20172.495687607818;19452.416427507196;20725.481862953435;20749.481262968395;21410.57178856422;21610.783892161115;6495.642739649317;6798.456123510132;6809.795706128824;6870.553414028072;6967.338102880219;5449.972750136264;6874.896876546856;6906.309369063104;6923.861522769542;6939.826504337381;6494.090827284184;6714.395704386604;6911.7926462206215;6927.099477067999;6932.272111428278;6742.258351581322;6819.624920629363;6824.931750682529;6831.69257383414;6839.0425340452375;6368.808935731936;6613.2064152301555;6620.238672552622;6640.900386494206;6699.598024118569;24083.638745418833;26349.41903485797;27599.862000690067;27728.445431091266;27769.583456248172;2627.5270451318756;2729.6042073899175;2842;2874.425114977013;3282.819444930528;15654;16168.353265869351;16409.83590164107;16419.17904104802;16814.411495597717;1966.803319668036;2017.3342796876996;2038.898055097254;2040.8877511736996;2050.384884534634;112951;121400;130136.34931825375;133473;135754.32122839324;19411.90294048549;20858.687119693215;21218.469538261666;21478.892605537185;21756.78243217579;34036.14909627279;34572.61709531591;34849;34869.302613948086;34881.82559087239;10617.522211500502;10640.574377024986;10642.893571064345;10772.569097236023;10992.670219893416;7352.485326027234;8040.798980025429;8086.989126359205;8772.34207434445;8815.382923195442;7998.800029999296;9486.667966621135;9522.61922021303;9762.90237097634;9815.822101347883;3672.3022625701033;3691.243295124493;3694.6932495416454;3695.815209239527;3801.50580424543;779.3219898688178;898.9146031127033;965.2519297544319;969.9418034917927;978.8399302962409;20225.393238202876;20590;21735.23926662559;21754.782452175594;21773.129074837147;929.8791157149662;942.8255772681939;948.7248697877676;954.8472244440995;1008.7881544875512;10574.577016919391;11395;11395.487203075882;11493.942530287295;11517.021053210403;578061;579256;588664;600979;602848;127361.36319318344;127503.362483187;147181;149000;151856.48143518422;946.2997381937455;984.1536278800369;991.7917237380086;1019.8827134879584;1022.5807418958192;19002.904985474983;19787.505312367306;20027.198912043354;20036.499087522345;20094.095765690286;46207.494345863655;47540.28689569728;47703.28445073257;47779.28331074967;47808;71736.64131679309;79730.20269797227;79777;79855;86920;7004.15950085993;7215.783526494213;7420.998165247623;7500.512466689648;7641.503302285334;8866.911330886609;9664.661736839176;11640.592579259684;12225.877741222474;13076.738465230452;10831.783364332512;10884.238103332691;10958.28771129874;11317.603883864025;11400.258983166068;8513.872291915503;10910.672679819618;10998.230123891251;11176.608818691631;11225.270357426742;11030.669079927615;11119.499622517167;11155.888441115809;11369.31784092957;11582.768344632892;7131.8573628528175;7255.927440725525;7309.853802924018;7533.886991695239;7664.425168112302;9972.850407244043;10623.203259755704;10907.2364934457;10984.395858227874;11077.11383089367 16:12:48 INFO - PROCESS | 1639 | |3;mootools.html;1302.4269321498546;1447.7828325751136;1486.0043770673647;1623.3019801485364;1811.55616873866;7265.854682906339;7643.885341719879;7901.56541390224;8133.024037115554;8140.226678465537;7992.160823113562;8100.473469224511;8101.716439924604;8107.91892081079;8113.391495637836;1773.716205407135;2268.5689718953386;2293.7591552886956;2293.8738369389675;2332.731735850382;2263.230501629446;2301.8158547316175;2308.976910230893;2316.6756654068445;2319.9768002320016;2245.7978781909624;2254.7519772824976;2278.8063014643776;2285.165914441225;2287.3252390544744;2214.2250212425683;2249.7738732390885;2273.295278463673;2279.350385140227;2283.041122728458;2211.4581927427885;2232.8995195216253;2233.6314508106143;2237.362351729749;2242.461809165805;8042.758717238492;8060.516369017878;8157.55133467659;8159.428839981204;8163;4896.975515122402;5080.720560369178;5096.337476128079;5118.436971933084;5132.640715149941;3205.5672484214565;3376.96623033769;3383.9661603383897;3435.587729472454;3435.811030393327;1002.7292630989665;1032.1639472027682;1071.0735214039878;1074.371492676785;1080.6109800471825;10394.688159355232;10441;10511.526981285784;10530.788959269705;10553.577856885715;3753.962460375416;4185.707000509996;4236.6610671146855;4262.50981137167;4340.913181736348;8418.831623367498;8419.494830310201;8419.70531031411;8420.705275315335;8435.156484351515;4847.660663753574;4934.3338649282605;4945;4949.307097006422;4950.950490495049;4165.854195103157;4176.519700234512;4608.055348653518;4653.883652908705;4654.743989080633;3240.7037185126137;3568.91077723059;3578.7494875358475;3581.6955558777277;3661.1213308805695;1100.1693721240413;1103.8730545987153;1107.634480621393;1111.8165502692127;1115.8493603363604;750.572173860894;833.9499630022218;885.287343688337;908.1871724806393;922.6908985489936;5328.387235467893;5595.048841696921;5763.366029736726;5826.970865145647;5955.196048533393;890.8797312362877;923.1444795960034;925.5657620458152;944.0323668240109;954.174638937328;3599.5140656011104;3701.1302343949687;3864.2851072551107;3870.612938706107;3932.5477570079806;9532.760741103752;9740.95129524362;9769.462679552693;9812.852807207897;9816.803663926681;9269.35114541989;9696.418214906987;9699.951500242454;9704.27217958656;9737.756556086013;7507.286807753255;7739.1873853245725;7741.071071471347;7752.767416977387;7766.262205090507;5383.546442460435;5478.260434841245;5525.917111243415;5665.150227465913;5848.035074212878;7625.733099341496;8922.643094276416;9053.59258833341;9174.174324310578;9246.630134794534;9248;9266.907330926873;9334.459814130592;9423.15191632729;9430.575624096795;6461.321561236003;6500.317466666121;6953.930460695328;6991;7126.750563730245;7735.729249476241;7826.256505631955;7841.960790196013;7855.293023627901;7869.409794265339;6946.37482626566;7019.052427922165;7028.683709232994;7049.859002819812;7168;5921.822345329647;6865.450763938973;6906.447484201352;6967.79096627102;6988.965055174692;6466.773662921775;6526.869462610816;6611.570247933869;6622.933770662232;6637.236717777518;4770.284457331428;4791;4810.831620893252;4854.126257273725;4903.264510323337;4761.428628564595;4779.068081724169;4781.13939490895;4944.876378090433;5005.5745261653165 16:12:48 INFO - PROCESS | 1639 | |4;prototype.html;255.28774718535288;286.9153599688092;293.6212286150867;298.7281573767872;303.3160223695566;4435.866923992281;4447;5235.790568377261;5264.262793278219;5301.469853014697;4957.677750946195;4972.955679307341;5005.424376196738;5059.84820455386;5174.249733788598;3888.2223555288983;3949.8420063197436;3978.8806335809973;3997.3204555225534;4020.2712833481737;3385.3060122674915;3835.42468629705;3964.5044369453817;3971.9007024824323;3983.5418926823495;3813.7498875663355;3918.471006414126;3944.441945431567;3945.230680017398;3972.324704800191;3443.94959537341;3893.396523538856;3943.3887747398912;3943.743656662308;3950.2494526040105;2811.325281932342;3416.8633254669785;3441.63862794408;3470.6008808986785;3474.0446377246208;4971.726555039471;5066.138756411419;5066.316047333599;5072.847814565569;5076.746162691888;3723.2634013999686;4005.959940400588;4262.829486820523;4264.957350426487;4509.579482463014;4281.400603915455;5447.5641948644015;5450.972745136289;5454.754536045887;5459.208414779874;3156.842157892096;3273.8199399033283;3794.6584807367194;3837.654611085016;3839.5392552893554;5085.466026067246;5510.666047041523;5645.717714114277;5688.715564221772;5753;3474.8262586870555;3538.840752166159;3708.8145592720257;3823.885283441501;3838.692904567628;3427.3206128996612;3515.6308587598446;3728.0493474164455;3897.1621101462756;3921.137349783043;4247.936280955726;4297.249760153504;4469.709468884512;4475.70907890986;4522.5025247222775;4518.932216016762;5404.513593776579;5431.619786614899;5445.564354851603;5449.482299181651;1103.7902798468265;1249.2254802022803;1267.752788206291;1275;1280.4238092858252;778.4667502760514;825.7687847402736;828.7265202483167;864.3560547392108;879.5821984557284;4629.8842528936375;4848.2002817210705;4925.359703238556;4937.728424936591;4940.283658869444;4847.515248475195;5077.517635824591;5283.894322113536;5419.918701219485;5444.508280668385;4872.0755301655645;4890.315355850184;4913.508649135058;5230.3985041719925;5249;2660.348214687414;2741.232454912628;2780.3744157564793;2815.9859200703863;2816.9859150704115;4827.61379089672;5000.374953130859;5338.492843179892;5496.6701997880255;5607.915881261784;4801.51984801517;5266.131088370453;5469.371022332403;5522.585806064561;5550.972245138829;4821;5569.526590239794;5569.66582005081;5573;5591.748371323219;4859.659823812299;5057.620678449058;5416.0521908666615;5417.6478528895495;5460.918086228789;4888.706677599355;5270.552003079628;5302.023482388209;5325.467453254643;5359.928014397058;5137.126688463045;5396.109641909041;5614.58572813694;5621.381648018796;5672.596442134686;3221.5811944447073;3460.186856088767;3545.858165673344;3598.85604575814;3645.0522864055006;4708.693934894221;5618.803341883015;5633.915451283052;5637.689927054052;5646.520045795989;4604.1252162089095;4691.648126390466;5283.1546952487415;5531.419200983839;5565.972170139124;4752.453467851241;5162.406323272721;5535.474129957647;5539;5560.249366335493;4742.762861856962;5132.358455193101;5348.786048558014;5424.213489044146;5432.429594892479;4930.8767280818265;5033.496650335083;5305.761240744253;5527;5540.584456165884;4607.986243026528;5176.922346164886;5318.361796584435;5345.786168553214;5346.545543628835 16:12:48 INFO - PROCESS | 1639 | |5;yui.html;705.4567982653357;731.1043971135357;740.7444431671073;772.1469865371793;788.306290464392;14177.645558861033;15563.68872622547;16186.919065404685;16193.83806161938;16208.189590520486;14823;14893.478728244514;14910.478133265338;14922.03006804557;14947.327370268336;654.5810681164058;675.5811396933908;817.1746535998655;841.2975165736617;843.7637461510756;675.618275674245;809.6275713171948;824.8762685597148;839.3327304792705;842.4145219072747;882.6469412235125;886.7605746448455;887.9965638828115;888.8533391990346;892.5581836990666;691.3190507350256;714.5676865496404;877.8112705768259;879.5338470610586;880.4585180114248;528.9127293996486;530.1544037260563;530.1702835063153;632.4213344789512;651.9282878883319;14149.787753183711;14192.432302707879;14196.787048194285;14203.928980355033;14223.786643200361;12861.099723019392;12961.611151665466;13006.154599950973;13075.084744067919;13108.672283192996;11792.115591330685;11985.22096063753;12054.939725301318;12166.148369614131;12379.257244565355;3765.6987441004653;4295.2912769393015;4423;4477.9104417911785;4507.549245075499;85903.9928218936;91727.54136229276;91903.54048229783;92209.07790922072;92296.53851730765;9961.800763984824;9998;10218.284720069672;10362.274640775224;10526.947365263124;19507.8049219506;19510.12204450775;19517.90241048814;19548;19561;7461.179270280265;7639.770806875803;7673.961630191925;7762.301392874669;8074;4233.5554766749665;4292.441982542249;4438.844640437569;4460.487043989982;4492.483364413134;3371.359441706117;3467.3065386922717;3488.651134886491;3494.7553671243277;3501.9474707879403;621.5431657731564;624.7719582352408;624.8312955501989;643.723199024424;653.0856800479366;577.8353169346716;582.1093726598311;602.5872277489933;627.2660986645635;638.5817289675177;8387.867637868932;8943.508107054175;9108.59011344491;9250.4912229828;9292.39599426035;559.3120461831969;608.9451949324582;625.3808729357994;663.8174502011985;669.5313280703527;3537.964620353815;4398.120375924827;4416.33754936762;4428.645708343325;4493.977530112394;76543.61728191323;105247.47376263223;108514;111836;112128.87871121184;61545.69227153925;78587.60706196433;87948.5602571983;91231;94552;58352.708236459395;80717;83115;88548;88624;8303.795949587397;8349.290310323691;8937.955310223408;8952.820943581222;9076.909230907606;40505.59494405018;50952.72618184575;54161;56402.153967689694;57606.4239357601;49091;74474.62762686152;76141.61929190319;80360;80456.19543804487;12140.495785721987;12195.207311524722;12382.81425778596;12385.504579817067;12599;12705.745885082431;13284.402201901132;13899.305034748424;14251.714965700836;14675.19286439256;13331.933340333237;13356.131851429625;13684.93157534206;13962.301884905512;13964.022518423613;12496.625101246977;12568.37158142071;13124;13286.269255191057;13375.130616509896;12046.879531204575;12201.69495762613;12635.494580216688;12818.423170957516;13468.393922273717;9531;9565.904340956502;9602.279829012992;9701.514924253617;9926.602935882484;10980.890191097988;11099.506501606118;11258.268212566158;11350.659480215607;11457.255278406878 16:12:48 INFO - PROCESS | 1639 | __end_tp_report 16:12:48 INFO - PROCESS | 1639 | __start_cc_report 16:12:48 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,1548 16:12:48 INFO - PROCESS | 1639 | __end_cc_report 16:12:48 INFO - PROCESS | 1639 | __startTimestamp1480464768919__endTimestamp 16:12:48 INFO - PROCESS | 1639 | 16:12:48 INFO - PROCESS | 1639 | ------- Summary: start ------- 16:12:48 INFO - PROCESS | 1639 | Number of tests: 6 16:12:48 INFO - PROCESS | 1639 | 16:12:48 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5623.92 Median:5798.80 stddev:651.37 (11.2%) stddev-sans-first:609.98 16:12:48 INFO - PROCESS | 1639 | Values: 2644.0 3027.8 3255.6 3274.9 3305.9 5566.5 5568.3 5615.0 5622.4 5651.6 5525.6 5589.7 5591.1 5616.3 5628.0 5083.8 5091.6 5108.7 5172.7 5231.3 5041.2 5097.0 5120.4 5127.4 5155.3 5156.8 5181.1 5197.9 5199.2 5224.1 5180.7 5181.3 5188.5 5196.8 5236.1 5020.1 5042.1 5081.7 5122.8 5125.9 5482.0 5510.1 5528.9 5544.4 5546.2 6031.0 6032.9 6051.7 6079.0 6107.4 6146.8 6185.4 6192.9 6207.7 6209.6 5716.9 5719.1 5725.4 5727.9 5739.9 6120.6 6214.0 6226.8 6228.6 6268.5 6006.1 6006.2 6015.3 6021.6 6025.2 6175.8 6184.0 6195.8 6200.1 6210.1 5937.1 5965.6 5975.1 6042.9 6065.0 6033.2 6103.1 6115.0 6126.2 6145.2 4740.6 4815.4 4815.5 4817.3 4839.6 4264.2 4291.7 4346.6 4356.9 4421.3 5555.5 5589.5 5613.7 5667.0 5679.1 6204.6 6208.2 6214.2 6224.9 6231.9 5677.8 5680.5 5690.3 5704.2 5728.6 5138.8 5246.7 5262.4 5274.1 5318.5 5905.1 6193.6 6228.0 6230.1 6256.3 5180.5 6169.0 6208.8 6210.8 6211.6 5168.8 6006.8 6185.8 6229.0 6252.3 6037.0 6049.1 6083.0 6127.5 6128.4 6053.5 6075.9 6134.3 6169.0 6199.3 5798.8 5876.9 5994.7 6030.2 6036.8 5828.6 5868.4 5912.6 5933.1 5946.1 5815.7 5815.9 5816.8 5827.2 5831.3 5972.6 6003.9 6007.7 6010.5 6015.6 5503.5 5635.7 5655.6 5658.1 5697.4 16:12:48 INFO - PROCESS | 1639 | 16:12:48 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:69385.56 Median:34776.89 stddev:154856.64 (445.3%) stddev-sans-first:155204.70 16:12:48 INFO - PROCESS | 1639 | Values: 505.6 506.1 509.8 514.2 516.5 30080.4 32067.0 39180.2 40806.6 40989.8 42101.7 42597.0 42608.7 42632.7 42703.0 9210.4 9376.2 9386.7 9397.2 9407.7 8583.5 8741.7 10974.9 11222.9 11258.0 11265.7 11333.6 11356.5 11359.5 11373.8 11030.8 11110.2 11110.7 11120.3 11133.5 11163.2 11179.0 11224.3 11230.2 11236.9 39281.0 39524.8 39600.0 39633.2 39634.6 2908.4 3285.1 3308.1 3414.7 3895.4 27837.0 28380.0 28787.0 30308.8 30520.4 3204.4 3211.8 3260.5 3334.0 3354.9 478723.0 481690.0 484532.0 485045.0 495045.0 33321.5 59804.4 60109.0 60258.0 60447.7 34478.8 35349.6 35390.3 35444.0 35511.0 13890.2 14226.4 14356.1 14363.5 14487.3 11108.7 11301.0 11734.6 11893.4 12092.0 6743.3 7450.2 7572.9 7584.4 7855.1 2722.2 2954.9 3049.8 3201.3 3235.3 859.6 926.6 1011.3 1012.6 1068.9 29873.8 30081.0 30285.5 30984.8 31134.0 1021.1 1049.7 1051.2 1068.2 1086.0 15189.6 15225.6 15294.5 15435.4 15464.8 671845.0 673170.0 677297.0 677979.0 678680.0 57233.7 57625.4 57650.4 57685.7 57955.7 1222.7 1247.0 1251.7 1360.6 1393.3 28358.0 30553.5 31109.2 31579.7 32196.5 54505.7 55319.7 55337.0 55356.7 55395.7 554042.0 554569.0 556117.0 556347.0 567550.0 26305.7 26413.9 36868.4 37374.6 37513.0 38130.8 45924.0 46153.0 47227.0 48965.5 38162.0 38282.8 38807.0 40090.0 40369.0 38225.0 38543.6 38571.6 40100.6 40308.0 34497.3 35831.8 36251.5 36399.0 36411.6 32249.4 33892.7 34238.5 34585.0 34968.8 25491.4 25617.4 25679.0 26062.0 26067.9 16:12:48 INFO - PROCESS | 1639 | 16:12:48 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:36540.14 Median:34304.38 stddev:98911.87 (288.3%) stddev-sans-first:99151.99 16:12:48 INFO - PROCESS | 1639 | Values: 334.2 346.5 355.2 360.6 381.3 14920.5 15002.9 15442.8 16245.9 20172.5 19452.4 20725.5 20749.5 21410.6 21610.8 6495.6 6798.5 6809.8 6870.6 6967.3 5450.0 6874.9 6906.3 6923.9 6939.8 6494.1 6714.4 6911.8 6927.1 6932.3 6742.3 6819.6 6824.9 6831.7 6839.0 6368.8 6613.2 6620.2 6640.9 6699.6 24083.6 26349.4 27599.9 27728.4 27769.6 2627.5 2729.6 2842.0 2874.4 3282.8 15654.0 16168.4 16409.8 16419.2 16814.4 1966.8 2017.3 2038.9 2040.9 2050.4 112951.0 121400.0 130136.3 133473.0 135754.3 19411.9 20858.7 21218.5 21478.9 21756.8 34036.1 34572.6 34849.0 34869.3 34881.8 10617.5 10640.6 10642.9 10772.6 10992.7 7352.5 8040.8 8087.0 8772.3 8815.4 7998.8 9486.7 9522.6 9762.9 9815.8 3672.3 3691.2 3694.7 3695.8 3801.5 779.3 898.9 965.3 969.9 978.8 20225.4 20590.0 21735.2 21754.8 21773.1 929.9 942.8 948.7 954.8 1008.8 10574.6 11395.0 11395.5 11493.9 11517.0 578061.0 579256.0 588664.0 600979.0 602848.0 127361.4 127503.4 147181.0 149000.0 151856.5 946.3 984.2 991.8 1019.9 1022.6 19002.9 19787.5 20027.2 20036.5 20094.1 46207.5 47540.3 47703.3 47779.3 47808.0 71736.6 79730.2 79777.0 79855.0 86920.0 7004.2 7215.8 7421.0 7500.5 7641.5 8866.9 9664.7 11640.6 12225.9 13076.7 10831.8 10884.2 10958.3 11317.6 11400.3 8513.9 10910.7 10998.2 11176.6 11225.3 11030.7 11119.5 11155.9 11369.3 11582.8 7131.9 7255.9 7309.9 7533.9 7664.4 9972.9 10623.2 10907.2 10984.4 11077.1 16:12:48 INFO - PROCESS | 1639 | 16:12:48 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5280.13 Median:5355.97 stddev:2870.37 (53.6%) stddev-sans-first:2862.85 16:12:48 INFO - PROCESS | 1639 | Values: 1302.4 1447.8 1486.0 1623.3 1811.6 7265.9 7643.9 7901.6 8133.0 8140.2 7992.2 8100.5 8101.7 8107.9 8113.4 1773.7 2268.6 2293.8 2293.9 2332.7 2263.2 2301.8 2309.0 2316.7 2320.0 2245.8 2254.8 2278.8 2285.2 2287.3 2214.2 2249.8 2273.3 2279.4 2283.0 2211.5 2232.9 2233.6 2237.4 2242.5 8042.8 8060.5 8157.6 8159.4 8163.0 4897.0 5080.7 5096.3 5118.4 5132.6 3205.6 3377.0 3384.0 3435.6 3435.8 1002.7 1032.2 1071.1 1074.4 1080.6 10394.7 10441.0 10511.5 10530.8 10553.6 3754.0 4185.7 4236.7 4262.5 4340.9 8418.8 8419.5 8419.7 8420.7 8435.2 4847.7 4934.3 4945.0 4949.3 4951.0 4165.9 4176.5 4608.1 4653.9 4654.7 3240.7 3568.9 3578.7 3581.7 3661.1 1100.2 1103.9 1107.6 1111.8 1115.8 750.6 833.9 885.3 908.2 922.7 5328.4 5595.0 5763.4 5827.0 5955.2 890.9 923.1 925.6 944.0 954.2 3599.5 3701.1 3864.3 3870.6 3932.5 9532.8 9741.0 9769.5 9812.9 9816.8 9269.4 9696.4 9700.0 9704.3 9737.8 7507.3 7739.2 7741.1 7752.8 7766.3 5383.5 5478.3 5525.9 5665.2 5848.0 7625.7 8922.6 9053.6 9174.2 9246.6 9248.0 9266.9 9334.5 9423.2 9430.6 6461.3 6500.3 6953.9 6991.0 7126.8 7735.7 7826.3 7842.0 7855.3 7869.4 6946.4 7019.1 7028.7 7049.9 7168.0 5921.8 6865.5 6906.4 6967.8 6989.0 6466.8 6526.9 6611.6 6622.9 6637.2 4770.3 4791.0 4810.8 4854.1 4903.3 4761.4 4779.1 4781.1 4944.9 5005.6 16:12:48 INFO - PROCESS | 1639 | 16:12:48 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4350.73 Median:4919.43 stddev:1335.70 (27.2%) stddev-sans-first:1303.60 16:12:48 INFO - PROCESS | 1639 | Values: 255.3 286.9 293.6 298.7 303.3 4435.9 4447.0 5235.8 5264.3 5301.5 4957.7 4973.0 5005.4 5059.8 5174.2 3888.2 3949.8 3978.9 3997.3 4020.3 3385.3 3835.4 3964.5 3971.9 3983.5 3813.7 3918.5 3944.4 3945.2 3972.3 3443.9 3893.4 3943.4 3943.7 3950.2 2811.3 3416.9 3441.6 3470.6 3474.0 4971.7 5066.1 5066.3 5072.8 5076.7 3723.3 4006.0 4262.8 4265.0 4509.6 4281.4 5447.6 5451.0 5454.8 5459.2 3156.8 3273.8 3794.7 3837.7 3839.5 5085.5 5510.7 5645.7 5688.7 5753.0 3474.8 3538.8 3708.8 3823.9 3838.7 3427.3 3515.6 3728.0 3897.2 3921.1 4247.9 4297.2 4469.7 4475.7 4522.5 4518.9 5404.5 5431.6 5445.6 5449.5 1103.8 1249.2 1267.8 1275.0 1280.4 778.5 825.8 828.7 864.4 879.6 4629.9 4848.2 4925.4 4937.7 4940.3 4847.5 5077.5 5283.9 5419.9 5444.5 4872.1 4890.3 4913.5 5230.4 5249.0 2660.3 2741.2 2780.4 2816.0 2817.0 4827.6 5000.4 5338.5 5496.7 5607.9 4801.5 5266.1 5469.4 5522.6 5551.0 4821.0 5569.5 5569.7 5573.0 5591.7 4859.7 5057.6 5416.1 5417.6 5460.9 4888.7 5270.6 5302.0 5325.5 5359.9 5137.1 5396.1 5614.6 5621.4 5672.6 3221.6 3460.2 3545.9 3598.9 3645.1 4708.7 5618.8 5633.9 5637.7 5646.5 4604.1 4691.6 5283.2 5531.4 5566.0 4752.5 5162.4 5535.5 5539.0 5560.2 4742.8 5132.4 5348.8 5424.2 5432.4 4930.9 5033.5 5305.8 5527.0 5540.6 4608.0 5176.9 5318.4 5345.8 5346.5 16:12:48 INFO - PROCESS | 1639 | 16:12:48 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:19846.31 Median:529.53 stddev:28576.80 (5396.6%) stddev-sans-first:28620.82 16:12:48 INFO - PROCESS | 1639 | Values: 705.5 731.1 740.7 772.1 788.3 14177.6 15563.7 16186.9 16193.8 16208.2 14823.0 14893.5 14910.5 14922.0 14947.3 654.6 675.6 817.2 841.3 843.8 675.6 809.6 824.9 839.3 842.4 882.6 886.8 888.0 888.9 892.6 691.3 714.6 877.8 879.5 880.5 528.9 530.2 530.2 632.4 651.9 14149.8 14192.4 14196.8 14203.9 14223.8 12861.1 12961.6 13006.2 13075.1 13108.7 11792.1 11985.2 12054.9 12166.1 12379.3 3765.7 4295.3 4423.0 4477.9 4507.5 85904.0 91727.5 91903.5 92209.1 92296.5 9961.8 9998.0 10218.3 10362.3 10526.9 19507.8 19510.1 19517.9 19548.0 19561.0 7461.2 7639.8 7674.0 7762.3 8074.0 4233.6 4292.4 4438.8 4460.5 4492.5 3371.4 3467.3 3488.7 3494.8 3501.9 621.5 624.8 624.8 643.7 653.1 577.8 582.1 602.6 627.3 638.6 8387.9 8943.5 9108.6 9250.5 9292.4 559.3 608.9 625.4 663.8 669.5 3538.0 4398.1 4416.3 4428.6 4494.0 76543.6 105247.5 108514.0 111836.0 112128.9 61545.7 78587.6 87948.6 91231.0 94552.0 58352.7 80717.0 83115.0 88548.0 88624.0 8303.8 8349.3 8938.0 8952.8 9076.9 40505.6 50952.7 54161.0 56402.2 57606.4 49091.0 74474.6 76141.6 80360.0 80456.2 12140.5 12195.2 12382.8 12385.5 12599.0 12705.7 13284.4 13899.3 14251.7 14675.2 13331.9 13356.1 13684.9 13962.3 13964.0 12496.6 12568.4 13124.0 13286.3 13375.1 12046.9 12201.7 12635.5 12818.4 13468.4 9531.0 9565.9 9602.3 9701.5 9926.6 10980.9 11099.5 11258.3 11350.7 11457.3 16:12:48 INFO - PROCESS | 1639 | -------- Summary: end -------- 16:12:48 INFO - PROCESS | 1639 | 16:12:49 INFO - TEST-INFO | 1639: exit 0 16:12:49 INFO - TEST-OK | dromaeo_css | took 1119498ms 16:12:49 INFO - TEST-START | kraken 16:12:49 INFO - operating with platform_type : mac_ 16:12:49 INFO - Initialising browser for kraken test... 16:12:49 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/tmp_77VkK/profile http://localhost:49248/getInfo.html) 16:12:52 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 16:12:52 INFO - PROCESS | 1649 | colorDepth:24 16:12:52 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 16:12:52 INFO - PROCESS | 1649 | __metrics 16:12:52 INFO - PROCESS | 1649 | 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" 16:12:52 INFO - PROCESS | 1649 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:12:53 INFO - TEST-INFO | 1649: exit 0 16:12:53 INFO - Browser initialized. 16:12:53 INFO - Running cycle 1/1 for kraken test... 16:12:53 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/T/tmp_77VkK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:13:05 INFO - PROCESS | 1650 | RSS: Main: 219410432 16:13:05 INFO - PROCESS | 1650 | 16:13:08 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection) 16:13:08 INFO - PROCESS | 1650 | RSS: Main: 269160448 16:13:08 INFO - PROCESS | 1650 | 16:13:11 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-dft) 16:13:12 INFO - PROCESS | 1650 | RSS: Main: 283250688 16:13:12 INFO - PROCESS | 1650 | 16:13:15 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-fft) 16:13:16 INFO - PROCESS | 1650 | RSS: Main: 380530688 16:13:16 INFO - PROCESS | 1650 | 16:13:18 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator) 16:13:18 INFO - PROCESS | 1650 | RSS: Main: 284483584 16:13:18 INFO - PROCESS | 1650 | 16:13:20 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:13:21 INFO - PROCESS | 1650 | RSS: Main: 285798400 16:13:21 INFO - PROCESS | 1650 | 16:13:24 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom) 16:13:24 INFO - PROCESS | 1650 | RSS: Main: 326828032 16:13:24 INFO - PROCESS | 1650 | 16:13:27 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate) 16:13:28 INFO - PROCESS | 1650 | RSS: Main: 325230592 16:13:28 INFO - PROCESS | 1650 | 16:13:30 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial) 16:13:31 INFO - PROCESS | 1650 | RSS: Main: 322936832 16:13:31 INFO - PROCESS | 1650 | 16:13:33 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:13:33 INFO - PROCESS | 1650 | RSS: Main: 299683840 16:13:33 INFO - PROCESS | 1650 | 16:13:35 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:13:36 INFO - PROCESS | 1650 | RSS: Main: 302903296 16:13:36 INFO - PROCESS | 1650 | 16:13:38 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:13:39 INFO - PROCESS | 1650 | RSS: Main: 305102848 16:13:39 INFO - PROCESS | 1650 | 16:13:42 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:13:43 INFO - PROCESS | 1650 | RSS: Main: 315920384 16:13:43 INFO - PROCESS | 1650 | 16:13:46 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:13:46 INFO - PROCESS | 1650 | RSS: Main: 314937344 16:13:46 INFO - PROCESS | 1650 | 16:13:48 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49248/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49248/tests/kraken/driver.html?testName=ai-astar) 16:13:48 INFO - PROCESS | 1650 | RSS: Main: 359026688 16:13:48 INFO - PROCESS | 1650 | 16:13:48 INFO - PROCESS | 1650 | __start_tp_report 16:13:48 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 16:13:48 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 16:13:48 INFO - PROCESS | 1650 | |i|pagename|runs| 16:13:48 INFO - PROCESS | 1650 | |0;ai-astar;106;114;114;114;114;113;113;115;113;114 16:13:48 INFO - PROCESS | 1650 | |1;audio-beat-detection;163;145;144;148;114;117;117;115;144;115 16:13:48 INFO - PROCESS | 1650 | |2;audio-dft;181;185;184;185;184;184;184;184;185;183 16:13:48 INFO - PROCESS | 1650 | |3;audio-fft;81;59;58;88;61;59;61;58;84;58 16:13:48 INFO - PROCESS | 1650 | |4;audio-oscillator;84;70;95;70;69;67;90;68;68;93 16:13:48 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;94;106;119;130;88;85;88;87;89;84 16:13:48 INFO - PROCESS | 1650 | |6;imaging-darkroom;97;96;97;95;97;97;96;96;97;97 16:13:48 INFO - PROCESS | 1650 | |7;imaging-desaturate;84;88;79;84;83;81;85;85;83;83 16:13:48 INFO - PROCESS | 1650 | |8;json-parse-financial;57;56;58;57;60;60;60;60;59;61 16:13:48 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;72;73;82;76;75;71;76;103;104;92 16:13:48 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;85;83;83;84;85;89;84;85;85;86 16:13:48 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;151;149;159;151;152;151;145;148;244;147 16:13:48 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;170;168;169;169;167;170;175;234;188;168 16:13:48 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;67;68;67;67;67;66;66;69;65;66 16:13:48 INFO - PROCESS | 1650 | __end_tp_report 16:13:48 INFO - PROCESS | 1650 | __start_cc_report 16:13:48 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,2022 16:13:48 INFO - PROCESS | 1650 | __end_cc_report 16:13:48 INFO - PROCESS | 1650 | __startTimestamp1480464828583__endTimestamp 16:13:48 INFO - PROCESS | 1650 | 16:13:48 INFO - PROCESS | 1650 | ------- Summary: start ------- 16:13:48 INFO - PROCESS | 1650 | Number of tests: 14 16:13:48 INFO - PROCESS | 1650 | 16:13:48 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.00 stddev:2.54 (2.2%) stddev-sans-first:0.67 16:13:48 INFO - PROCESS | 1650 | Values: 106.0 114.0 114.0 114.0 114.0 113.0 113.0 115.0 113.0 114.0 16:13:48 INFO - PROCESS | 1650 | 16:13:48 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:132.20 Median:144.00 stddev:18.34 (12.7%) stddev-sans-first:15.70 16:13:48 INFO - PROCESS | 1650 | Values: 163.0 145.0 144.0 148.0 114.0 117.0 117.0 115.0 144.0 115.0 16:13:48 INFO - PROCESS | 1650 | 16:13:48 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:183.90 Median:184.00 stddev:1.20 (0.7%) stddev-sans-first:0.67 16:13:48 INFO - PROCESS | 1650 | Values: 181.0 185.0 184.0 185.0 184.0 184.0 184.0 184.0 185.0 183.0 16:13:48 INFO - PROCESS | 1650 | 16:13:48 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:66.70 Median:61.00 stddev:12.33 (20.2%) stddev-sans-first:11.94 16:13:48 INFO - PROCESS | 1650 | Values: 81.0 59.0 58.0 88.0 61.0 59.0 61.0 58.0 84.0 58.0 16:13:48 INFO - PROCESS | 1650 | 16:13:48 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:77.00 stddev:11.64 (15.1%) stddev-sans-first:12.10 16:13:48 INFO - PROCESS | 1650 | Values: 84.0 70.0 95.0 70.0 69.0 67.0 90.0 68.0 68.0 93.0 16:13:48 INFO - PROCESS | 1650 | 16:13:48 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:97.00 Median:87.50 stddev:15.99 (18.3%) stddev-sans-first:16.93 16:13:48 INFO - PROCESS | 1650 | Values: 94.0 106.0 119.0 130.0 88.0 85.0 88.0 87.0 89.0 84.0 16:13:48 INFO - PROCESS | 1650 | 16:13:48 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:96.50 Median:97.00 stddev:0.71 (0.7%) stddev-sans-first:0.73 16:13:48 INFO - PROCESS | 1650 | Values: 97.0 96.0 97.0 95.0 97.0 97.0 96.0 96.0 97.0 97.0 16:13:48 INFO - PROCESS | 1650 | 16:13:48 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:83.50 Median:84.00 stddev:2.42 (2.9%) stddev-sans-first:2.55 16:13:48 INFO - PROCESS | 1650 | Values: 84.0 88.0 79.0 84.0 83.0 81.0 85.0 85.0 83.0 83.0 16:13:48 INFO - PROCESS | 1650 | 16:13:48 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:58.80 Median:60.00 stddev:1.69 (2.8%) stddev-sans-first:1.66 16:13:48 INFO - PROCESS | 1650 | Values: 57.0 56.0 58.0 57.0 60.0 60.0 60.0 60.0 59.0 61.0 16:13:48 INFO - PROCESS | 1650 | 16:13:48 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:82.40 Median:75.50 stddev:12.68 (16.8%) stddev-sans-first:12.88 16:13:48 INFO - PROCESS | 1650 | Values: 72.0 73.0 82.0 76.0 75.0 71.0 76.0 103.0 104.0 92.0 16:13:48 INFO - PROCESS | 1650 | 16:13:48 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:85.00 stddev:1.73 (2.0%) stddev-sans-first:1.83 16:13:48 INFO - PROCESS | 1650 | Values: 85.0 83.0 83.0 84.0 85.0 89.0 84.0 85.0 85.0 86.0 16:13:48 INFO - PROCESS | 1650 | 16:13:48 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:159.70 Median:151.00 stddev:29.86 (19.8%) stddev-sans-first:31.50 16:13:48 INFO - PROCESS | 1650 | Values: 151.0 149.0 159.0 151.0 152.0 151.0 145.0 148.0 244.0 147.0 16:13:48 INFO - PROCESS | 1650 | 16:13:48 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.80 Median:170.00 stddev:20.70 (12.2%) stddev-sans-first:21.76 16:13:48 INFO - PROCESS | 1650 | Values: 170.0 168.0 169.0 169.0 167.0 170.0 175.0 234.0 188.0 168.0 16:13:48 INFO - PROCESS | 1650 | 16:13:48 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:1.14 (1.7%) stddev-sans-first:1.20 16:13:48 INFO - PROCESS | 1650 | Values: 67.0 68.0 67.0 67.0 67.0 66.0 66.0 69.0 65.0 66.0 16:13:48 INFO - PROCESS | 1650 | -------- Summary: end -------- 16:13:48 INFO - PROCESS | 1650 | 16:13:49 INFO - TEST-INFO | 1650: exit 0 16:13:49 INFO - TEST-OK | kraken | took 59981ms 16:13:49 INFO - SUITE-END | took 1179s 16:13:49 INFO - Completed test suite (00:19:39) 16:13:49 INFO - javascript benchmark 16:13:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2644.0349272515527, 3027.818330900146, 3255.56049933259, 3274.9029075259787, 3305.8594784799266, 5566.471185237406, 5568.303962004749, 5615.045442274813, 5622.381538030813, 5651.604387692863, 5525.557955363572, 5589.664620122796, 5591.1054231323, 5616.3260408751, 5627.971860140694, 5083.822066227683, 5091.567216786578, 5108.719020453874, 5172.741362931857, 5231.319928409302, 5041.1682072458, 5096.974515127419, 5120.385553733558, 5127.384713834345, 5155.278261043457, 5156.793728250866, 5181.145111056671, 5197.922031169535, 5199.194124910645, 5224.138017227153, 5180.689158650455, 5181.274621552986, 5188.481151884819, 5196.818111366084, 5236.136037553799, 5020.071286811952, 5042.067217564726, 5081.669691470042, 5122.795088196468, 5125.871853203663, 5482.013237617227, 5510.090835012258, 5528.917066244009, 5544.445555444423, 5546.223528705985, 6030.9747342951805, 6032.939670603281, 6051.727672254759, 6079.0, 6107.389261073901, 6146.832101900669, 6185.443310102112, 6192.8852806494815, 6207.658578778165, 6209.627422354673, 5716.914246286309, 5719.142128680648, 5725.370209276976, 5727.9427205727825, 5739.913901291484, 6120.569035656853, 6214.0, 6226.782062627877, 6228.626282423069, 6268.529860260499, 6006.099085137264, 6006.219191505076, 6015.30823955242, 6021.638701677914, 6025.18659980897, 6175.84560385985, 6183.979643358885, 6195.81412557624, 6200.100985357098, 6210.099535567318, 5937.139114828412, 5965.612235204698, 5975.133605627159, 6042.939570604326, 6065.0, 6033.18551995475, 6103.1455596216565, 6114.9754704401175, 6126.23422072241, 6145.170401995762, 4740.573348398591, 4815.422149342031, 4815.518448155157, 4817.325574419584, 4839.612830973514, 4264.232438161161, 4291.678124140702, 4346.608805207483, 4356.869293921188, 4421.314696222091, 5555.527780138734, 5589.469000444951, 5613.7193140342815, 5667.0, 5679.148127780866, 6204.565680402328, 6208.2239720034995, 6214.161088253119, 6224.906626400608, 6231.937680623227, 5677.772889084473, 5680.460356266148, 5690.2887139107615, 5704.22992895962, 5728.627639203439, 5138.845834624967, 5246.685198888079, 5262.421133675292, 5274.050670879278, 5318.494742999409, 5905.143754155709, 6193.566450348432, 6227.96886015567, 6230.065490176328, 6256.280527739368, 5180.507851754077, 6168.9691551541955, 6208.81373558794, 6210.844728881814, 6211.596246243979, 5168.819091331786, 6006.755104993566, 6185.752569897154, 6229.0, 6252.343503932204, 6037.0, 6049.062395328731, 6082.9695851520455, 6127.464420129145, 6128.442013631005, 6053.515718742402, 6075.908861366995, 6134.314131579348, 6168.9691551541955, 6199.256089269316, 5798.797042103675, 5876.882462350643, 5994.67029313392, 6030.185924900083, 6036.788712395045, 5828.5919985602295, 5868.383819699041, 5912.645241285537, 5933.1396947443245, 5946.108083787466, 5815.680137592473, 5815.883682326245, 5816.82549523515, 5827.184194212899, 5831.271091113611, 5972.552058595709, 6003.909941350796, 6007.699615019319, 6010.519158467225, 6015.608985415934, 5503.532199763065, 5635.746391412478, 5655.604107712421, 5658.122990936411, 5697.430256974435], "value": 5579.276065630612, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.59047171790854, 506.0612563694347, 509.819014249941, 514.1696160700468, 516.5170565521238, 30080.398392032148, 32067.0, 39180.216395672105, 40806.59193408065, 40989.7950510247, 42101.736947891615, 42597.0, 42608.7217383479, 42632.72101836942, 42703.0, 9210.401323913959, 9376.203022743075, 9386.671466498674, 9397.154256116948, 9407.670731524398, 8583.52790596517, 8741.737747867573, 10974.945125274362, 11222.887771122307, 11258.0, 11265.662030139109, 11333.603323883666, 11356.48895799687, 11359.545618175305, 11373.772524549504, 11030.779384412306, 11110.166737494721, 11110.666679999613, 11120.277181983145, 11133.498992545356, 11163.218574699775, 11179.049780768644, 11224.326540407601, 11230.213885028052, 11236.887631123665, 39281.0, 39524.80237598823, 39600.0, 39633.20733585312, 39634.60365396367, 2908.4473949949443, 3285.1130194847497, 3308.123347312964, 3414.709749671281, 3895.4351619015083, 27837.0, 28380.020720433633, 28787.0, 30308.787648494035, 30520.38959220803, 3204.4071846708434, 3211.8394080296125, 3260.5272235525954, 3334.0497958082074, 3354.8658053677823, 478723.0, 481690.0, 484531.99999999645, 485045.0, 495045.0, 33321.50017749736, 59804.40195598076, 60109.0, 60258.0, 60447.69776151091, 34478.7932422364, 35349.646503534634, 35390.292194155976, 35444.0, 35511.0, 13890.16659000443, 14226.430942762381, 14356.138631682132, 14363.497277595234, 14487.275636218146, 11108.666739997812, 11301.0, 11734.647960561026, 11893.40532973348, 12092.0, 6743.325667433218, 7450.18048014718, 7572.924270757332, 7584.4311676624475, 7855.13593504714, 2722.2377734234447, 2954.852257387122, 3049.8017628854054, 3201.295714942709, 3235.288236587947, 859.6303589456469, 926.578406824893, 1011.312307630818, 1012.6152062216311, 1068.8610480637624, 29873.805047797843, 30081.0, 30285.545716814264, 30984.845075774476, 31134.0, 1021.1014307409432, 1049.6588608702202, 1051.232600201857, 1068.2255364860569, 1085.9728506787394, 15189.6202594936, 15225.619359515878, 15294.464693735667, 15435.38258469671, 15464.76199990006, 671845.0, 673170.0, 677297.0, 677979.0, 678680.0, 57233.71383143058, 57625.42374576285, 57650.423495765346, 57685.711571441876, 57955.71022144862, 1222.6759908624222, 1246.987530124687, 1251.6557946564767, 1360.571420002696, 1393.3451277899371, 28358.0, 30553.54169687501, 31109.22226944254, 31579.684203157674, 32196.517052243766, 54505.72747136239, 55319.72340138435, 55337.0, 55356.72321638366, 55395.723021384634, 554042.0, 554569.0, 556117.0, 556347.0, 567550.0, 26305.73694263033, 26413.867930660224, 36868.446973295955, 37374.626253737115, 37513.0, 38130.809345953094, 45924.0, 46153.0, 47227.0, 48965.510344896094, 38162.0, 38282.788893221164, 38807.0, 40089.997750056486, 40369.0, 38225.0, 38543.614563854004, 38571.614283856805, 40100.598994009684, 40308.0, 34497.31005379828, 35831.82084089563, 36251.45622815607, 36399.0, 36411.635883640825, 32249.35501290008, 33892.661073388954, 34238.48642270318, 34585.0, 34968.776092836626, 25491.36271593225, 25617.359566011, 25678.972841086146, 26062.0, 26067.869660651577], "value": 18829.94584785499, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [334.21959724044353, 346.5494856686308, 355.1990261959281, 360.62314880949396, 381.3402813133279, 14920.477783277587, 15002.924985375072, 15442.845571544281, 16245.918770406131, 20172.495687607818, 19452.416427507196, 20725.481862953435, 20749.481262968395, 21410.57178856422, 21610.783892161115, 6495.642739649317, 6798.456123510132, 6809.795706128824, 6870.553414028072, 6967.338102880219, 5449.972750136264, 6874.896876546856, 6906.309369063104, 6923.861522769542, 6939.826504337381, 6494.090827284184, 6714.395704386604, 6911.7926462206215, 6927.099477067999, 6932.272111428278, 6742.258351581322, 6819.624920629363, 6824.931750682529, 6831.69257383414, 6839.0425340452375, 6368.808935731936, 6613.2064152301555, 6620.238672552622, 6640.900386494206, 6699.598024118569, 24083.638745418833, 26349.41903485797, 27599.862000690067, 27728.445431091266, 27769.583456248172, 2627.5270451318756, 2729.6042073899175, 2842.0, 2874.425114977013, 3282.819444930528, 15654.0, 16168.353265869351, 16409.83590164107, 16419.17904104802, 16814.411495597717, 1966.803319668036, 2017.3342796876996, 2038.898055097254, 2040.8877511736996, 2050.384884534634, 112951.0, 121400.0, 130136.34931825375, 133473.0, 135754.32122839324, 19411.90294048549, 20858.687119693215, 21218.469538261666, 21478.892605537185, 21756.78243217579, 34036.14909627279, 34572.61709531591, 34849.0, 34869.302613948086, 34881.82559087239, 10617.522211500502, 10640.574377024986, 10642.893571064345, 10772.569097236023, 10992.670219893416, 7352.485326027234, 8040.798980025429, 8086.989126359205, 8772.34207434445, 8815.382923195442, 7998.800029999296, 9486.667966621135, 9522.61922021303, 9762.90237097634, 9815.822101347883, 3672.3022625701033, 3691.243295124493, 3694.6932495416454, 3695.815209239527, 3801.50580424543, 779.3219898688178, 898.9146031127033, 965.2519297544319, 969.9418034917927, 978.8399302962409, 20225.393238202876, 20590.0, 21735.23926662559, 21754.782452175594, 21773.129074837147, 929.8791157149662, 942.8255772681939, 948.7248697877676, 954.8472244440995, 1008.7881544875512, 10574.577016919391, 11395.0, 11395.487203075882, 11493.942530287295, 11517.021053210403, 578061.0, 579256.0, 588664.0, 600979.0, 602848.0, 127361.36319318344, 127503.362483187, 147181.0, 149000.0, 151856.48143518422, 946.2997381937455, 984.1536278800369, 991.7917237380086, 1019.8827134879584, 1022.5807418958192, 19002.904985474983, 19787.505312367306, 20027.198912043354, 20036.499087522345, 20094.095765690286, 46207.494345863655, 47540.28689569728, 47703.28445073257, 47779.28331074967, 47808.0, 71736.64131679309, 79730.20269797227, 79777.0, 79855.0, 86920.0, 7004.15950085993, 7215.783526494213, 7420.998165247623, 7500.512466689648, 7641.503302285334, 8866.911330886609, 9664.661736839176, 11640.592579259684, 12225.877741222474, 13076.738465230452, 10831.783364332512, 10884.238103332691, 10958.28771129874, 11317.603883864025, 11400.258983166068, 8513.872291915503, 10910.672679819618, 10998.230123891251, 11176.608818691631, 11225.270357426742, 11030.669079927615, 11119.499622517167, 11155.888441115809, 11369.31784092957, 11582.768344632892, 7131.8573628528175, 7255.927440725525, 7309.853802924018, 7533.886991695239, 7664.425168112302, 9972.850407244043, 10623.203259755704, 10907.2364934457, 10984.395858227874, 11077.11383089367], "value": 10737.973062629859, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1302.4269321498546, 1447.7828325751136, 1486.0043770673647, 1623.3019801485364, 1811.55616873866, 7265.854682906339, 7643.885341719879, 7901.56541390224, 8133.024037115554, 8140.226678465537, 7992.160823113562, 8100.473469224511, 8101.716439924604, 8107.91892081079, 8113.391495637836, 1773.716205407135, 2268.5689718953386, 2293.7591552886956, 2293.8738369389675, 2332.731735850382, 2263.230501629446, 2301.8158547316175, 2308.976910230893, 2316.6756654068445, 2319.9768002320016, 2245.7978781909624, 2254.7519772824976, 2278.8063014643776, 2285.165914441225, 2287.3252390544744, 2214.2250212425683, 2249.7738732390885, 2273.295278463673, 2279.350385140227, 2283.041122728458, 2211.4581927427885, 2232.8995195216253, 2233.6314508106143, 2237.362351729749, 2242.461809165805, 8042.758717238492, 8060.516369017878, 8157.55133467659, 8159.428839981204, 8163.0, 4896.975515122402, 5080.720560369178, 5096.337476128079, 5118.436971933084, 5132.640715149941, 3205.5672484214565, 3376.96623033769, 3383.9661603383897, 3435.587729472454, 3435.811030393327, 1002.7292630989665, 1032.1639472027682, 1071.0735214039878, 1074.371492676785, 1080.6109800471825, 10394.688159355232, 10441.0, 10511.526981285784, 10530.788959269705, 10553.577856885715, 3753.962460375416, 4185.707000509996, 4236.6610671146855, 4262.50981137167, 4340.913181736348, 8418.831623367498, 8419.494830310201, 8419.70531031411, 8420.705275315335, 8435.156484351515, 4847.660663753574, 4934.3338649282605, 4945.0, 4949.307097006422, 4950.950490495049, 4165.854195103157, 4176.519700234512, 4608.055348653518, 4653.883652908705, 4654.743989080633, 3240.7037185126137, 3568.91077723059, 3578.7494875358475, 3581.6955558777277, 3661.1213308805695, 1100.1693721240413, 1103.8730545987153, 1107.634480621393, 1111.8165502692127, 1115.8493603363604, 750.572173860894, 833.9499630022218, 885.287343688337, 908.1871724806393, 922.6908985489936, 5328.387235467893, 5595.048841696921, 5763.366029736726, 5826.970865145647, 5955.196048533393, 890.8797312362877, 923.1444795960034, 925.5657620458152, 944.0323668240109, 954.174638937328, 3599.5140656011104, 3701.1302343949687, 3864.2851072551107, 3870.612938706107, 3932.5477570079806, 9532.760741103752, 9740.95129524362, 9769.462679552693, 9812.852807207897, 9816.803663926681, 9269.35114541989, 9696.418214906987, 9699.951500242454, 9704.27217958656, 9737.756556086013, 7507.286807753255, 7739.1873853245725, 7741.071071471347, 7752.767416977387, 7766.262205090507, 5383.546442460435, 5478.260434841245, 5525.917111243415, 5665.150227465913, 5848.035074212878, 7625.733099341496, 8922.643094276416, 9053.59258833341, 9174.174324310578, 9246.630134794534, 9248.0, 9266.907330926873, 9334.459814130592, 9423.15191632729, 9430.575624096795, 6461.321561236003, 6500.317466666121, 6953.930460695328, 6991.0, 7126.750563730245, 7735.729249476241, 7826.256505631955, 7841.960790196013, 7855.293023627901, 7869.409794265339, 6946.37482626566, 7019.052427922165, 7028.683709232994, 7049.859002819812, 7168.0, 5921.822345329647, 6865.450763938973, 6906.447484201352, 6967.79096627102, 6988.965055174692, 6466.773662921775, 6526.869462610816, 6611.570247933869, 6622.933770662232, 6637.236717777518, 4770.284457331428, 4791.0, 4810.831620893252, 4854.126257273725, 4903.264510323337, 4761.428628564595, 4779.068081724169, 4781.13939490895, 4944.876378090433, 5005.5745261653165], "value": 4286.705520230955, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [255.28774718535288, 286.9153599688092, 293.6212286150867, 298.7281573767872, 303.3160223695566, 4435.866923992281, 4447.0, 5235.790568377261, 5264.262793278219, 5301.469853014697, 4957.677750946195, 4972.955679307341, 5005.424376196738, 5059.84820455386, 5174.249733788598, 3888.2223555288983, 3949.8420063197436, 3978.8806335809973, 3997.3204555225534, 4020.2712833481737, 3385.3060122674915, 3835.42468629705, 3964.5044369453817, 3971.9007024824323, 3983.5418926823495, 3813.7498875663355, 3918.471006414126, 3944.441945431567, 3945.230680017398, 3972.324704800191, 3443.94959537341, 3893.396523538856, 3943.3887747398912, 3943.743656662308, 3950.2494526040105, 2811.325281932342, 3416.8633254669785, 3441.63862794408, 3470.6008808986785, 3474.0446377246208, 4971.726555039471, 5066.138756411419, 5066.316047333599, 5072.847814565569, 5076.746162691888, 3723.2634013999686, 4005.959940400588, 4262.829486820523, 4264.957350426487, 4509.579482463014, 4281.400603915455, 5447.5641948644015, 5450.972745136289, 5454.754536045887, 5459.208414779874, 3156.842157892096, 3273.8199399033283, 3794.6584807367194, 3837.654611085016, 3839.5392552893554, 5085.466026067246, 5510.666047041523, 5645.717714114277, 5688.715564221772, 5753.0, 3474.8262586870555, 3538.840752166159, 3708.8145592720257, 3823.885283441501, 3838.692904567628, 3427.3206128996612, 3515.6308587598446, 3728.0493474164455, 3897.1621101462756, 3921.137349783043, 4247.936280955726, 4297.249760153504, 4469.709468884512, 4475.70907890986, 4522.5025247222775, 4518.932216016762, 5404.513593776579, 5431.619786614899, 5445.564354851603, 5449.482299181651, 1103.7902798468265, 1249.2254802022803, 1267.752788206291, 1275.0, 1280.4238092858252, 778.4667502760514, 825.7687847402736, 828.7265202483167, 864.3560547392108, 879.5821984557284, 4629.8842528936375, 4848.2002817210705, 4925.359703238556, 4937.728424936591, 4940.283658869444, 4847.515248475195, 5077.517635824591, 5283.894322113536, 5419.918701219485, 5444.508280668385, 4872.0755301655645, 4890.315355850184, 4913.508649135058, 5230.3985041719925, 5249.0, 2660.348214687414, 2741.232454912628, 2780.3744157564793, 2815.9859200703863, 2816.9859150704115, 4827.61379089672, 5000.374953130859, 5338.492843179892, 5496.6701997880255, 5607.915881261784, 4801.51984801517, 5266.131088370453, 5469.371022332403, 5522.585806064561, 5550.972245138829, 4821.0, 5569.526590239794, 5569.66582005081, 5573.0, 5591.748371323219, 4859.659823812299, 5057.620678449058, 5416.0521908666615, 5417.6478528895495, 5460.918086228789, 4888.706677599355, 5270.552003079628, 5302.023482388209, 5325.467453254643, 5359.928014397058, 5137.126688463045, 5396.109641909041, 5614.58572813694, 5621.381648018796, 5672.596442134686, 3221.5811944447073, 3460.186856088767, 3545.858165673344, 3598.85604575814, 3645.0522864055006, 4708.693934894221, 5618.803341883015, 5633.915451283052, 5637.689927054052, 5646.520045795989, 4604.1252162089095, 4691.648126390466, 5283.1546952487415, 5531.419200983839, 5565.972170139124, 4752.453467851241, 5162.406323272721, 5535.474129957647, 5539.0, 5560.249366335493, 4742.762861856962, 5132.358455193101, 5348.786048558014, 5424.213489044146, 5432.429594892479, 4930.8767280818265, 5033.496650335083, 5305.761240744253, 5527.0, 5540.584456165884, 4607.986243026528, 5176.922346164886, 5318.361796584435, 5345.786168553214, 5346.545543628835], "value": 3919.1391256280886, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.4567982653357, 731.1043971135357, 740.7444431671073, 772.1469865371793, 788.306290464392, 14177.645558861033, 15563.68872622547, 16186.919065404685, 16193.83806161938, 16208.189590520486, 14823.0, 14893.478728244514, 14910.478133265338, 14922.03006804557, 14947.327370268336, 654.5810681164058, 675.5811396933908, 817.1746535998655, 841.2975165736617, 843.7637461510756, 675.618275674245, 809.6275713171948, 824.8762685597148, 839.3327304792705, 842.4145219072747, 882.6469412235125, 886.7605746448455, 887.9965638828115, 888.8533391990346, 892.5581836990666, 691.3190507350256, 714.5676865496404, 877.8112705768259, 879.5338470610586, 880.4585180114248, 528.9127293996486, 530.1544037260563, 530.1702835063153, 632.4213344789512, 651.9282878883319, 14149.787753183711, 14192.432302707879, 14196.787048194285, 14203.928980355033, 14223.786643200361, 12861.099723019392, 12961.611151665466, 13006.154599950973, 13075.084744067919, 13108.672283192996, 11792.115591330685, 11985.22096063753, 12054.939725301318, 12166.148369614131, 12379.257244565355, 3765.6987441004653, 4295.2912769393015, 4423.0, 4477.9104417911785, 4507.549245075499, 85903.9928218936, 91727.54136229276, 91903.54048229783, 92209.07790922072, 92296.53851730765, 9961.800763984824, 9998.0, 10218.284720069672, 10362.274640775224, 10526.947365263124, 19507.8049219506, 19510.12204450775, 19517.90241048814, 19548.0, 19561.0, 7461.179270280265, 7639.770806875803, 7673.961630191925, 7762.301392874669, 8074.0, 4233.5554766749665, 4292.441982542249, 4438.844640437569, 4460.487043989982, 4492.483364413134, 3371.359441706117, 3467.3065386922717, 3488.651134886491, 3494.7553671243277, 3501.9474707879403, 621.5431657731564, 624.7719582352408, 624.8312955501989, 643.723199024424, 653.0856800479366, 577.8353169346716, 582.1093726598311, 602.5872277489933, 627.2660986645635, 638.5817289675177, 8387.867637868932, 8943.508107054175, 9108.59011344491, 9250.4912229828, 9292.39599426035, 559.3120461831969, 608.9451949324582, 625.3808729357994, 663.8174502011985, 669.5313280703527, 3537.964620353815, 4398.120375924827, 4416.33754936762, 4428.645708343325, 4493.977530112394, 76543.61728191323, 105247.47376263223, 108514.0, 111836.0, 112128.87871121184, 61545.69227153925, 78587.60706196433, 87948.5602571983, 91231.0, 94552.0, 58352.708236459395, 80717.0, 83115.0, 88548.0, 88624.0, 8303.795949587397, 8349.290310323691, 8937.955310223408, 8952.820943581222, 9076.909230907606, 40505.59494405018, 50952.72618184575, 54161.0, 56402.153967689694, 57606.4239357601, 49091.0, 74474.62762686152, 76141.61929190319, 80360.0, 80456.19543804487, 12140.495785721987, 12195.207311524722, 12382.81425778596, 12385.504579817067, 12599.0, 12705.745885082431, 13284.402201901132, 13899.305034748424, 14251.714965700836, 14675.19286439256, 13331.933340333237, 13356.131851429625, 13684.93157534206, 13962.301884905512, 13964.022518423613, 12496.625101246977, 12568.37158142071, 13124.0, 13286.269255191057, 13375.130616509896, 12046.879531204575, 12201.69495762613, 12635.494580216688, 12818.423170957516, 13468.393922273717, 9531.0, 9565.904340956502, 9602.279829012992, 9701.514924253617, 9926.602935882484, 10980.890191097988, 11099.506501606118, 11258.268212566158, 11350.659480215607, 11457.255278406878], "value": 7208.27791190871, "unit": "score"}], "name": "dromaeo_css", "value": 7176.691612969651, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 114.0, 114.0, 114.0, 113.0, 113.0, 115.0, 113.0, 114.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 145.0, 144.0, 148.0, 114.0, 117.0, 117.0, 115.0, 144.0, 115.0], "value": 132.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 185.0, 184.0, 185.0, 184.0, 184.0, 184.0, 184.0, 185.0, 183.0], "value": 183.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 58.0, 88.0, 61.0, 59.0, 61.0, 58.0, 84.0, 58.0], "value": 66.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 95.0, 70.0, 69.0, 67.0, 90.0, 68.0, 68.0, 93.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 106.0, 119.0, 130.0, 88.0, 85.0, 88.0, 87.0, 89.0, 84.0], "value": 97.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 96.0, 97.0, 95.0, 97.0, 97.0, 96.0, 96.0, 97.0, 97.0], "value": 96.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 88.0, 79.0, 84.0, 83.0, 81.0, 85.0, 85.0, 83.0, 83.0], "value": 83.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 58.0, 57.0, 60.0, 60.0, 60.0, 60.0, 59.0, 61.0], "value": 58.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 73.0, 82.0, 76.0, 75.0, 71.0, 76.0, 103.0, 104.0, 92.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 83.0, 84.0, 85.0, 89.0, 84.0, 85.0, 85.0, 86.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 149.0, 159.0, 151.0, 152.0, 151.0, 145.0, 148.0, 244.0, 147.0], "value": 159.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 168.0, 169.0, 169.0, 167.0, 170.0, 175.0, 234.0, 188.0, 168.0], "value": 177.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 66.0, 66.0, 69.0, 65.0, 66.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1480.6, "alertThreshold": 2.0}]} 16:13:49 INFO - Return code: 0 16:13:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:13:49 INFO - # TBPL SUCCESS # 16:13:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:13:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:13:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:13:49 INFO - 2016-11-29 16:13:49.898 screenresolution[1654:9742] starting screenresolution argv=screenresolution get 16:13:49 INFO - 2016-11-29 16:13:49.902 screenresolution[1654:9742] Display 0: 1600x1200x32@60 16:13:49 INFO - 2016-11-29 16:13:49.908 screenresolution[1655:9745] starting screenresolution argv=screenresolution list 16:13:49 INFO - Available Modes on Display 0 16:13:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:13:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:13:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:13:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:13:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:13:50 INFO - Intel Iris: 16:13:50 INFO - Chipset Model: Intel Iris 16:13:50 INFO - Type: GPU 16:13:50 INFO - Bus: Built-In 16:13:50 INFO - VRAM (Dynamic, Max): 1536 MB 16:13:50 INFO - Vendor: Intel (0x8086) 16:13:50 INFO - Device ID: 0x0a2e 16:13:50 INFO - Revision ID: 0x0009 16:13:50 INFO - Displays: 16:13:50 INFO - Display: 16:13:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:13:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:13:50 INFO - Display Serial Number: 1600x1200 60 16:13:50 INFO - Main Display: Yes 16:13:50 INFO - Mirror: Off 16:13:50 INFO - Online: Yes 16:13:50 INFO - Rotation: Supported 16:13:50 INFO - Return code: 0 16:13:50 INFO - Running post-action listener: _resource_record_post_action 16:13:50 INFO - [mozharness: 2016-11-30 00:13:50.148709Z] Finished run-tests step (success) 16:13:50 INFO - Running post-run listener: _resource_record_post_run 16:13:50 INFO - Total resource usage - Wall time: 1211s; CPU: 54.0%; Read bytes: 37663744; Write bytes: 657851904; Read time: 243; Write time: 1906 16:13:50 INFO - TinderboxPrint: CPU usage
53.6% 16:13:50 INFO - TinderboxPrint: I/O read bytes / time
37,663,744 / 243 16:13:50 INFO - TinderboxPrint: I/O write bytes / time
657,851,904 / 1,906 16:13:50 INFO - TinderboxPrint: CPU idle
2,250.2 (46.4%) 16:13:50 INFO - TinderboxPrint: CPU system
973.2 (20.1%) 16:13:50 INFO - TinderboxPrint: CPU user
1,622.4 (33.5%) 16:13:50 INFO - TinderboxPrint: Swap in / out
386,371,584 / 0 16:13:50 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 334133760; Write bytes: 333563392; Read time: 25817; Write time: 692 16:13:50 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 36697088; Write bytes: 306556928; Read time: 228; Write time: 1158 16:13:50 INFO - Running post-run listener: _upload_blobber_files 16:13:50 INFO - Blob upload gear active. 16:13:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:13:50 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 16:13:50 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:13:50 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:13:51 INFO - (blobuploader) - INFO - Open directory for files ... 16:13:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:13:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:13:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:52 INFO - (blobuploader) - INFO - Done attempting. 16:13:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:13:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:13:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:54 INFO - (blobuploader) - INFO - Done attempting. 16:13:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:13:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:13:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:13:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:13:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:13:56 INFO - (blobuploader) - INFO - Done attempting. 16:13:56 INFO - (blobuploader) - INFO - Iteration through files over. 16:13:56 INFO - Return code: 0 16:13:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:13:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:13:56 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/daf4e699b30a5a561d2c25a5534242f17e49c9e8f98eca08aca116f3098943cf42a915204dad0d7c8e1b3abfaabc07067a5f1a618d71a9531c4da7c642c16580", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/86da65bcd5a4f58f680b218f72aeb1954144be2f6091c87bed8364a83bf384f7d23795c215a484bcb1a62eb8411447dec32802a2b23df74cbb2883601476f6f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04fcca6d0e24bd8879f0660534245ba534144244e01dde0d1082848dad0b1309befe27ca5cbcbd07d0b9b37c0fab1732e6caa231bba85d86b4dc136b53f3e97c"} 16:13:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:13:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:13:56 INFO - Contents: 16:13:56 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/daf4e699b30a5a561d2c25a5534242f17e49c9e8f98eca08aca116f3098943cf42a915204dad0d7c8e1b3abfaabc07067a5f1a618d71a9531c4da7c642c16580", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/86da65bcd5a4f58f680b218f72aeb1954144be2f6091c87bed8364a83bf384f7d23795c215a484bcb1a62eb8411447dec32802a2b23df74cbb2883601476f6f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04fcca6d0e24bd8879f0660534245ba534144244e01dde0d1082848dad0b1309befe27ca5cbcbd07d0b9b37c0fab1732e6caa231bba85d86b4dc136b53f3e97c"} 16:13:56 INFO - Running post-run listener: copy_logs_to_upload_dir 16:13:56 INFO - Copying logs to upload dir... 16:13:56 INFO - mkdir: /builds/slave/test/build/upload/logs 16:13:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.138423 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-11-29 16:13:56.658413) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 16:13:56.666429) ========= 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.qzpOBjailN/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.CarbeBn2lf/Listeners TMPDIR=/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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-Aurora/sha512/daf4e699b30a5a561d2c25a5534242f17e49c9e8f98eca08aca116f3098943cf42a915204dad0d7c8e1b3abfaabc07067a5f1a618d71a9531c4da7c642c16580", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/86da65bcd5a4f58f680b218f72aeb1954144be2f6091c87bed8364a83bf384f7d23795c215a484bcb1a62eb8411447dec32802a2b23df74cbb2883601476f6f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04fcca6d0e24bd8879f0660534245ba534144244e01dde0d1082848dad0b1309befe27ca5cbcbd07d0b9b37c0fab1732e6caa231bba85d86b4dc136b53f3e97c"} build_url:https://queue.taskcluster.net/v1/task/P6Jub1FNQ4u7NnIHMP4W_w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011142 build_url: 'https://queue.taskcluster.net/v1/task/P6Jub1FNQ4u7NnIHMP4W_w/artifacts/public/build/firefox-52.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/daf4e699b30a5a561d2c25a5534242f17e49c9e8f98eca08aca116f3098943cf42a915204dad0d7c8e1b3abfaabc07067a5f1a618d71a9531c4da7c642c16580", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/86da65bcd5a4f58f680b218f72aeb1954144be2f6091c87bed8364a83bf384f7d23795c215a484bcb1a62eb8411447dec32802a2b23df74cbb2883601476f6f9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/04fcca6d0e24bd8879f0660534245ba534144244e01dde0d1082848dad0b1309befe27ca5cbcbd07d0b9b37c0fab1732e6caa231bba85d86b4dc136b53f3e97c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-29 16:13:56.708668) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 16:13:56.709080) ========= 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.qzpOBjailN/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.CarbeBn2lf/Listeners TMPDIR=/var/folders/w1/v8762b5s4415f2mkcqd4qsn000000w/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.005287 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-29 16:13:56.761004) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 16:13:56.761345) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-29 16:13:56.761677) ========= ========= Total master_lag: 0.22 =========