builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0295 starttime: 1476274618.39 results: success (0) buildid: 20161012030146 builduid: 218056a61d7349029419562c9d163dc7 revision: 500baee3ce9f1b701ace9d38489cbc112d076c72 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 05:16:58.389634) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-12 05:16:58.390086) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 05:16:58.390370) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-12 05:16:58.415165) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 05:16:58.415543) ========= 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.Z4Wh0mFPG1/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.MioDz3Lk2l/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-10-12 05:16:58-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.9M=0.001s 2016-10-12 05:16:58 (18.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.112390 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 05:16:58.550228) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 05:16:58.550600) ========= 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.Z4Wh0mFPG1/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.MioDz3Lk2l/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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.025767 ========= master_lag: 1.55 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 05:17:00.128033) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 05:17:00.128476) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 500baee3ce9f1b701ace9d38489cbc112d076c72 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 500baee3ce9f1b701ace9d38489cbc112d076c72 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Z4Wh0mFPG1/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.MioDz3Lk2l/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-10-12 05:17:00,212 truncating revision to first 12 chars 2016-10-12 05:17:00,212 Setting DEBUG logging. 2016-10-12 05:17:00,212 attempt 1/10 2016-10-12 05:17:00,212 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/500baee3ce9f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-12 05:17:01,279 unpacking tar archive at: mozilla-central-500baee3ce9f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.327062 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-10-12 05:17:01.481916) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 05:17:01.482246) ========= script_repo_revision: 500baee3ce9f1b701ace9d38489cbc112d076c72 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-12 05:17:01.482652) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 05:17:01.482925) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-12 05:17:01.501130) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-12 05:17:01.501563) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Z4Wh0mFPG1/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.MioDz3Lk2l/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 05:17:01 INFO - MultiFileLogger online at 20161012 05:17:01 in /builds/slave/test 05:17:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:17:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:17:01 INFO - {'append_to_log': False, 05:17:01 INFO - 'base_work_dir': '/builds/slave/test', 05:17:01 INFO - 'blob_upload_branch': 'Firefox', 05:17:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:17:01 INFO - 'branch': 'Firefox', 05:17:01 INFO - 'buildbot_json_path': 'buildprops.json', 05:17:01 INFO - 'config_files': ('talos/mac_config.py',), 05:17:01 INFO - 'default_actions': ('clobber', 05:17:01 INFO - 'read-buildbot-config', 05:17:01 INFO - 'download-and-extract', 05:17:01 INFO - 'populate-webroot', 05:17:01 INFO - 'create-virtualenv', 05:17:01 INFO - 'install', 05:17:01 INFO - 'run-tests'), 05:17:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:17:01 INFO - 'download_minidump_stackwalk': True, 05:17:01 INFO - 'download_symbols': 'ondemand', 05:17:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:17:01 INFO - 'tooltool.py': '/tools/tooltool.py', 05:17:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:17:01 INFO - '/tools/misc-python/virtualenv.py')}, 05:17:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:17:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:17:01 INFO - 'installer_path': 'installer.exe', 05:17:01 INFO - 'log_level': 'info', 05:17:01 INFO - 'log_name': 'talos', 05:17:01 INFO - 'log_to_console': True, 05:17:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:17:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:17:01 INFO - 'opt_config_files': (), 05:17:01 INFO - 'pip_index': False, 05:17:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:17:01 INFO - 'cmd': ('bash', 05:17:01 INFO - '-c', 05:17:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:17:01 INFO - 'enabled': True, 05:17:01 INFO - 'halt_on_failure': False, 05:17:01 INFO - 'name': 'check_screen_resolution'},), 05:17:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:17:01 INFO - 'cmd': ('bash', 05:17:01 INFO - '-c', 05:17:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:17:01 INFO - 'enabled': True, 05:17:01 INFO - 'halt_on_failure': False, 05:17:01 INFO - 'name': 'check_screen_resolution'},), 05:17:01 INFO - 'run_cmd_checks_enabled': True, 05:17:01 INFO - 'sps_profile': False, 05:17:01 INFO - 'sps_profile_interval': 0, 05:17:01 INFO - 'suite': 'dromaeojs', 05:17:01 INFO - 'system_bits': '32', 05:17:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:17:01 INFO - 'title': 't-yosemite-r7-0295', 05:17:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:17:01 INFO - 'use_talos_json': True, 05:17:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:17:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:17:01 INFO - 'work_dir': 'build'} 05:17:01 INFO - [mozharness: 2016-10-12 12:17:01.700927Z] Running clobber step. 05:17:01 INFO - Running pre-action listener: _resource_record_pre_action 05:17:01 INFO - Running main action method: clobber 05:17:01 INFO - rmtree: /builds/slave/test/build 05:17:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:17:03 INFO - Running post-action listener: _resource_record_post_action 05:17:03 INFO - [mozharness: 2016-10-12 12:17:03.797939Z] Finished clobber step (success) 05:17:03 INFO - [mozharness: 2016-10-12 12:17:03.798137Z] Running read-buildbot-config step. 05:17:03 INFO - Running pre-action listener: _resource_record_pre_action 05:17:03 INFO - Running main action method: read_buildbot_config 05:17:03 INFO - Using buildbot properties: 05:17:03 INFO - { 05:17:03 INFO - "project": "", 05:17:03 INFO - "product": "firefox", 05:17:03 INFO - "script_repo_revision": "production", 05:17:03 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:17:03 INFO - "repository": "", 05:17:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:17:03 INFO - "buildid": "20161012030146", 05:17:03 INFO - "pgo_build": "False", 05:17:03 INFO - "basedir": "/builds/slave/test", 05:17:03 INFO - "buildnumber": 7, 05:17:03 INFO - "slavename": "t-yosemite-r7-0295", 05:17:03 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:17:03 INFO - "platform": "yosemite_r7", 05:17:03 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:17:03 INFO - "branch": "mozilla-central", 05:17:03 INFO - "repo_path": "mozilla-central", 05:17:03 INFO - "revision": "500baee3ce9f1b701ace9d38489cbc112d076c72", 05:17:03 INFO - "stage_platform": "macosx64", 05:17:03 INFO - "builduid": "218056a61d7349029419562c9d163dc7", 05:17:03 INFO - "slavebuilddir": "test" 05:17:03 INFO - } 05:17:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/DLq_r_MsRqWNlVprypqr6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:17:03 INFO - Running post-action listener: _resource_record_post_action 05:17:03 INFO - [mozharness: 2016-10-12 12:17:03.803540Z] Finished read-buildbot-config step (success) 05:17:03 INFO - [mozharness: 2016-10-12 12:17:03.803712Z] Running download-and-extract step. 05:17:03 INFO - Running pre-action listener: _resource_record_pre_action 05:17:03 INFO - Running main action method: download_and_extract 05:17:03 INFO - mkdir: /builds/slave/test/build/tests 05:17:03 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')]} 05:17:03 INFO - trying https://queue.taskcluster.net/v1/task/DLq_r_MsRqWNlVprypqr6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:17:03 INFO - Downloading https://queue.taskcluster.net/v1/task/DLq_r_MsRqWNlVprypqr6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:17:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DLq_r_MsRqWNlVprypqr6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 05:17:04 INFO - Downloaded 1199 bytes. 05:17:04 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:17:04 INFO - Using the following test package requirements: 05:17:04 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:17:04 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:17:04 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:17:04 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:17:04 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:17:04 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:17:04 INFO - u'jsshell-mac.zip'], 05:17:04 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:17:04 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:17:04 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:17:04 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:17:04 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:17:04 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:17:04 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:17:04 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:17:04 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:17:04 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:17:04 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:17:04 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:17:04 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DLq_r_MsRqWNlVprypqr6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:17:04 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DLq_r_MsRqWNlVprypqr6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:17:04 INFO - Fetch https://queue.taskcluster.net/v1/task/DLq_r_MsRqWNlVprypqr6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:17:05 INFO - Http code: 200 05:17:05 INFO - via: 1.1 e30ae5b3d9f6779a9b8bc992faad0b09.cloudfront.net (CloudFront) 05:17:05 INFO - x-amz-cf-id: J6HAJgplTr8E8qjcuT3tNgeFqVYyR-8hqlAMh10axOxs-q6S5FafWA== 05:17:05 INFO - x-amz-version-id: 60owCznH5PC7v5a_IGSrEcAEyAyb6Tsj 05:17:05 INFO - Expected file size: 16508569 05:17:05 INFO - Obtained file size: 16508569 05:17:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:17:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DLq_r_MsRqWNlVprypqr6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:17:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DLq_r_MsRqWNlVprypqr6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:17:12 INFO - Fetch https://queue.taskcluster.net/v1/task/DLq_r_MsRqWNlVprypqr6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:17:12 INFO - Http code: 200 05:17:12 INFO - via: 1.1 455cf6ccbccc261c46d02110de1c0237.cloudfront.net (CloudFront) 05:17:12 INFO - x-amz-cf-id: IJi-BRrtr-j47_5MYrwcxXR4CKaBUPzO7ef0T7nhpRSjL8KgLmpjYg== 05:17:12 INFO - x-amz-version-id: 60owCznH5PC7v5a_IGSrEcAEyAyb6Tsj 05:17:13 INFO - Expected file size: 16508569 05:17:13 INFO - Obtained file size: 16508569 05:17:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DLq_r_MsRqWNlVprypqr6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:17:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DLq_r_MsRqWNlVprypqr6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:17:19 INFO - Fetch https://queue.taskcluster.net/v1/task/DLq_r_MsRqWNlVprypqr6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:17:20 INFO - Http code: 200 05:17:20 INFO - via: 1.1 6eaa7f856e226a0db7cef6201d3b8393.cloudfront.net (CloudFront) 05:17:20 INFO - x-amz-cf-id: mPyMoB9rgEKoAC30V_1fFXAK1ar_7irTUihytez6sTwR3jsiRjoXXQ== 05:17:20 INFO - x-amz-version-id: PYjgOZ8ubZl1j_iG9L14cRziC66xKNH0 05:17:21 INFO - Expected file size: 14409006 05:17:21 INFO - Obtained file size: 14409006 05:17: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')]} 05:17:21 INFO - trying https://queue.taskcluster.net/v1/task/DLq_r_MsRqWNlVprypqr6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:17:21 INFO - Downloading https://queue.taskcluster.net/v1/task/DLq_r_MsRqWNlVprypqr6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:17:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DLq_r_MsRqWNlVprypqr6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 05:17:24 INFO - Downloaded 111696066 bytes. 05:17:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DLq_r_MsRqWNlVprypqr6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:17:24 INFO - mkdir: /builds/slave/test/properties 05:17:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:17:24 INFO - Writing to file /builds/slave/test/properties/build_url 05:17:24 INFO - Contents: 05:17:24 INFO - build_url:https://queue.taskcluster.net/v1/task/DLq_r_MsRqWNlVprypqr6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:17:24 INFO - Running post-action listener: _resource_record_post_action 05:17:24 INFO - Running post-action listener: set_extra_try_arguments 05:17:24 INFO - [mozharness: 2016-10-12 12:17:24.882627Z] Finished download-and-extract step (success) 05:17:24 INFO - [mozharness: 2016-10-12 12:17:24.882805Z] Running populate-webroot step. 05:17:24 INFO - Running pre-action listener: _resource_record_pre_action 05:17:24 INFO - Running main action method: populate_webroot 05:17:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:17:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:17:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:17:24 INFO - '--tppagecycles', 05:17:24 INFO - '7'], 05:17:24 INFO - 'tests': ['tsvgm']}}, 05:17:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:17:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:17:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:17:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:17:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:17:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:17:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:24 INFO - 'talos_options': ['--disable-e10s'], 05:17:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:17:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:17:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:24 INFO - 'talos_options': ['--disable-e10s'], 05:17:24 INFO - 'tests': ['damp', 'tps']}, 05:17:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:24 INFO - 'tests': ['damp', 'tps']}, 05:17:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:17:24 INFO - 'tests': ['dromaeo_dom']}, 05:17:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:17:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:17:24 INFO - 'tests': ['basic_compositor_video']}, 05:17:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:17:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:17:24 INFO - 'tests': ['a11yr', 05:17:24 INFO - 'ts_paint', 05:17:24 INFO - 'tpaint', 05:17:24 INFO - 'sessionrestore', 05:17:24 INFO - 'sessionrestore_no_auto_restore', 05:17:24 INFO - 'tabpaint']}, 05:17:24 INFO - 'other-e10s': {'tests': ['a11yr', 05:17:24 INFO - 'ts_paint', 05:17:24 INFO - 'tpaint', 05:17:24 INFO - 'sessionrestore', 05:17:24 INFO - 'sessionrestore_no_auto_restore', 05:17:24 INFO - 'tabpaint']}, 05:17:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:17:24 INFO - 'ts_paint', 05:17:24 INFO - 'tpaint', 05:17:24 INFO - 'sessionrestore', 05:17:24 INFO - 'sessionrestore_no_auto_restore', 05:17:24 INFO - 'tabpaint']}, 05:17:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:17:24 INFO - 'ts_paint', 05:17:24 INFO - 'tpaint', 05:17:24 INFO - 'sessionrestore', 05:17:24 INFO - 'sessionrestore_no_auto_restore', 05:17:24 INFO - 'tabpaint']}, 05:17:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:17:24 INFO - 'tests': ['a11yr', 05:17:24 INFO - 'ts_paint', 05:17:24 INFO - 'tpaint', 05:17:24 INFO - 'sessionrestore', 05:17:24 INFO - 'sessionrestore_no_auto_restore', 05:17:24 INFO - 'tabpaint']}, 05:17:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:17:24 INFO - 'tests': ['a11yr', 05:17:24 INFO - 'ts_paint', 05:17:24 INFO - 'tpaint', 05:17:24 INFO - 'sessionrestore', 05:17:24 INFO - 'sessionrestore_no_auto_restore', 05:17:24 INFO - 'tabpaint']}, 05:17:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:17:24 INFO - 'tests': ['tsvgx', 05:17:24 INFO - 'tsvgr_opacity', 05:17:24 INFO - 'tart', 05:17:24 INFO - 'tscrollx', 05:17:24 INFO - 'cart']}, 05:17:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:17:24 INFO - 'tsvgr_opacity', 05:17:24 INFO - 'tart', 05:17:24 INFO - 'tscrollx', 05:17:24 INFO - 'cart']}, 05:17:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:24 INFO - 'talos_options': ['--disable-e10s'], 05:17:24 INFO - 'tests': ['tp5o']}, 05:17:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:24 INFO - 'tests': ['tp5o']}, 05:17:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:24 INFO - 'talos_options': ['--disable-e10s', 05:17:24 INFO - '--xperf_path', 05:17:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:17:24 INFO - 'tests': ['tp5n']}, 05:17:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:17:24 INFO - 'talos_options': ['--xperf_path', 05:17:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:17:24 INFO - 'tests': ['tp5n']}}, 05:17:24 INFO - 'talos.zip': {'path': '', 05:17:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:17:24 INFO - Running post-action listener: _resource_record_post_action 05:17:24 INFO - [mozharness: 2016-10-12 12:17:24.902074Z] Finished populate-webroot step (success) 05:17:24 INFO - [mozharness: 2016-10-12 12:17:24.902177Z] Running create-virtualenv step. 05:17:24 INFO - Running pre-action listener: _resource_record_pre_action 05:17:24 INFO - Running main action method: create_virtualenv 05:17:24 INFO - Creating virtualenv /builds/slave/test/build/venv 05:17:24 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 05:17:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:17:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:17:25 INFO - Using real prefix '/tools/python27' 05:17:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:17:25 INFO - Installing distribute.............................................................................................................................................................................................done. 05:17:28 INFO - Installing pip.................done. 05:17:28 INFO - Return code: 0 05:17:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:17:28 INFO - Reading from file tmpfile_stdout 05:17:28 INFO - Output received: 05:17:28 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) 05:17:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f164490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0da570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7c2c9a060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef78d30>, '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 0x10ed9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef70b20>, '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.Z4Wh0mFPG1/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.MioDz3Lk2l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 05:17:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:17:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4Wh0mFPG1/Render', 05:17:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:28 INFO - 'HOME': '/Users/cltbld', 05:17:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:28 INFO - 'LOGNAME': 'cltbld', 05:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:28 INFO - 'MOZ_NO_REMOTE': '1', 05:17:28 INFO - 'NO_EM_RESTART': '1', 05:17:28 INFO - 'PAGER': '/bin/cat', 05:17:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:28 INFO - 'PWD': '/builds/slave/test', 05:17:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:28 INFO - 'SHELL': '/bin/bash', 05:17:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MioDz3Lk2l/Listeners', 05:17:28 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 05:17:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:28 INFO - 'USER': 'cltbld', 05:17:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:28 INFO - 'XPC_FLAGS': '0x0', 05:17:28 INFO - 'XPC_SERVICE_NAME': '0', 05:17:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:29 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 05:17:29 INFO - Cleaning up... 05:17:29 INFO - Return code: 0 05:17:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:17:29 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')]} 05:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:29 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')]} 05:17:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:29 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 0x10f164490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0da570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7c2c9a060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef78d30>, '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 0x10ed9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef70b20>, '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.Z4Wh0mFPG1/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.MioDz3Lk2l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 05:17:29 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 05:17:29 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 05:17:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4Wh0mFPG1/Render', 05:17:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:29 INFO - 'HOME': '/Users/cltbld', 05:17:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:29 INFO - 'LOGNAME': 'cltbld', 05:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:29 INFO - 'MOZ_NO_REMOTE': '1', 05:17:29 INFO - 'NO_EM_RESTART': '1', 05:17:29 INFO - 'PAGER': '/bin/cat', 05:17:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:29 INFO - 'PWD': '/builds/slave/test', 05:17:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:29 INFO - 'SHELL': '/bin/bash', 05:17:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MioDz3Lk2l/Listeners', 05:17:29 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 05:17:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:29 INFO - 'USER': 'cltbld', 05:17:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:29 INFO - 'XPC_FLAGS': '0x0', 05:17:29 INFO - 'XPC_SERVICE_NAME': '0', 05:17:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:29 INFO - Downloading/unpacking psutil>=3.1.1 05:17:29 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 05:17:29 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 05:17:29 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 05:17:29 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 05:17:29 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 05:17:29 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 05:17:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:17:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:32 INFO - Installing collected packages: psutil 05:17:32 INFO - Running setup.py install for psutil 05:17:32 INFO - building 'psutil._psutil_osx' extension 05:17:32 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 05:17:33 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 05:17:33 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 05:17:33 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 05:17:33 INFO - building 'psutil._psutil_posix' extension 05:17:33 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 05:17:33 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:17:33 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:17:33 INFO - ^ 05:17:33 INFO - 1 warning generated. 05:17:33 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 05:17:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:17:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:17:33 INFO - Successfully installed psutil 05:17:33 INFO - Cleaning up... 05:17:34 INFO - Return code: 0 05:17:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:17:34 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')]} 05:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:34 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')]} 05:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:34 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 0x10f164490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0da570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7c2c9a060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef78d30>, '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 0x10ed9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef70b20>, '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.Z4Wh0mFPG1/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.MioDz3Lk2l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 05:17:34 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 05:17:34 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 05:17:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4Wh0mFPG1/Render', 05:17:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:34 INFO - 'HOME': '/Users/cltbld', 05:17:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:34 INFO - 'LOGNAME': 'cltbld', 05:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:34 INFO - 'MOZ_NO_REMOTE': '1', 05:17:34 INFO - 'NO_EM_RESTART': '1', 05:17:34 INFO - 'PAGER': '/bin/cat', 05:17:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:34 INFO - 'PWD': '/builds/slave/test', 05:17:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:34 INFO - 'SHELL': '/bin/bash', 05:17:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MioDz3Lk2l/Listeners', 05:17:34 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 05:17:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:34 INFO - 'USER': 'cltbld', 05:17:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:34 INFO - 'XPC_FLAGS': '0x0', 05:17:34 INFO - 'XPC_SERVICE_NAME': '0', 05:17:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:17:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:17:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:17:36 INFO - Installing collected packages: mozsystemmonitor 05:17:36 INFO - Running setup.py install for mozsystemmonitor 05:17:37 INFO - Successfully installed mozsystemmonitor 05:17:37 INFO - Cleaning up... 05:17:37 INFO - Return code: 0 05:17:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:17: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')]} 05:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17: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')]} 05:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:37 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 0x10f164490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0da570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7c2c9a060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef78d30>, '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 0x10ed9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef70b20>, '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.Z4Wh0mFPG1/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.MioDz3Lk2l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 05:17:37 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 05:17:37 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 05:17:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4Wh0mFPG1/Render', 05:17:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:37 INFO - 'HOME': '/Users/cltbld', 05:17:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:37 INFO - 'LOGNAME': 'cltbld', 05:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:37 INFO - 'MOZ_NO_REMOTE': '1', 05:17:37 INFO - 'NO_EM_RESTART': '1', 05:17:37 INFO - 'PAGER': '/bin/cat', 05:17:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:37 INFO - 'PWD': '/builds/slave/test', 05:17:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:37 INFO - 'SHELL': '/bin/bash', 05:17:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MioDz3Lk2l/Listeners', 05:17:37 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 05:17:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:37 INFO - 'USER': 'cltbld', 05:17:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:37 INFO - 'XPC_FLAGS': '0x0', 05:17:37 INFO - 'XPC_SERVICE_NAME': '0', 05:17:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:37 INFO - Downloading/unpacking jsonschema==2.5.1 05:17:37 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 05:17:37 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 05:17:37 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 05:17:37 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 05:17:37 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 05:17:37 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 05:17:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:17:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:17:39 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 05:17:39 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 05:17:39 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 05:17:39 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 05:17:39 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 05:17:39 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 05:17:40 INFO - Downloading functools32-3.2.3-2.tar.gz 05:17:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:17:40 INFO - warning: no files found matching '*.txt' 05:17:40 INFO - no previously-included directories found matching 'build' 05:17:40 INFO - no previously-included directories found matching 'dist' 05:17:40 INFO - no previously-included directories found matching '.git*' 05:17:40 INFO - Installing collected packages: jsonschema, functools32 05:17:40 INFO - Running setup.py install for functools32 05:17:40 INFO - warning: no files found matching '*.txt' 05:17:40 INFO - no previously-included directories found matching 'build' 05:17:40 INFO - no previously-included directories found matching 'dist' 05:17:40 INFO - no previously-included directories found matching '.git*' 05:17:40 INFO - Successfully installed jsonschema functools32 05:17:40 INFO - Cleaning up... 05:17:40 INFO - Return code: 0 05:17:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:17:40 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')]} 05:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:40 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')]} 05:17:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:40 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 0x10f164490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0da570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7c2c9a060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef78d30>, '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 0x10ed9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef70b20>, '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.Z4Wh0mFPG1/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.MioDz3Lk2l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 05:17:40 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 05:17:40 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 05:17:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4Wh0mFPG1/Render', 05:17:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:40 INFO - 'HOME': '/Users/cltbld', 05:17:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:40 INFO - 'LOGNAME': 'cltbld', 05:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:40 INFO - 'MOZ_NO_REMOTE': '1', 05:17:40 INFO - 'NO_EM_RESTART': '1', 05:17:40 INFO - 'PAGER': '/bin/cat', 05:17:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:40 INFO - 'PWD': '/builds/slave/test', 05:17:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:40 INFO - 'SHELL': '/bin/bash', 05:17:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MioDz3Lk2l/Listeners', 05:17:40 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 05:17:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:40 INFO - 'USER': 'cltbld', 05:17:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:40 INFO - 'XPC_FLAGS': '0x0', 05:17:40 INFO - 'XPC_SERVICE_NAME': '0', 05:17:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:17:40 INFO - Cleaning up... 05:17:40 INFO - Return code: 0 05:17:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:17:40 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')]} 05:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:40 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')]} 05:17:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:40 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 0x10f164490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0da570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7c2c9a060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef78d30>, '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 0x10ed9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef70b20>, '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.Z4Wh0mFPG1/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.MioDz3Lk2l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 05:17:40 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 05:17:40 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 05:17:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4Wh0mFPG1/Render', 05:17:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:40 INFO - 'HOME': '/Users/cltbld', 05:17:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:40 INFO - 'LOGNAME': 'cltbld', 05:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:40 INFO - 'MOZ_NO_REMOTE': '1', 05:17:40 INFO - 'NO_EM_RESTART': '1', 05:17:40 INFO - 'PAGER': '/bin/cat', 05:17:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:40 INFO - 'PWD': '/builds/slave/test', 05:17:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:40 INFO - 'SHELL': '/bin/bash', 05:17:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MioDz3Lk2l/Listeners', 05:17:40 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 05:17:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:40 INFO - 'USER': 'cltbld', 05:17:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:40 INFO - 'XPC_FLAGS': '0x0', 05:17:40 INFO - 'XPC_SERVICE_NAME': '0', 05:17:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:41 INFO - Downloading/unpacking blobuploader==1.2.4 05:17:41 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 05:17:41 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 05:17:41 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 05:17:41 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 05:17:41 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 05:17:41 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 05:17:43 INFO - Downloading blobuploader-1.2.4.tar.gz 05:17:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:17:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:17:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:17:44 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 05:17:44 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 05:17:44 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 05:17:44 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 05:17:44 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 05:17:44 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 05:17:44 INFO - Downloading docopt-0.6.1.tar.gz 05:17:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:17:44 INFO - Installing collected packages: blobuploader, requests, docopt 05:17:44 INFO - Running setup.py install for blobuploader 05:17:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:17:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:17:45 INFO - Running setup.py install for requests 05:17:45 INFO - Running setup.py install for docopt 05:17:45 INFO - Successfully installed blobuploader requests docopt 05:17:45 INFO - Cleaning up... 05:17:45 INFO - Return code: 0 05:17:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:45 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 0x10f164490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0da570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7c2c9a060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef78d30>, '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 0x10ed9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef70b20>, '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.Z4Wh0mFPG1/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.MioDz3Lk2l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 05:17:45 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 05:17:45 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 05:17:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4Wh0mFPG1/Render', 05:17:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:45 INFO - 'HOME': '/Users/cltbld', 05:17:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:45 INFO - 'LOGNAME': 'cltbld', 05:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:45 INFO - 'MOZ_NO_REMOTE': '1', 05:17:45 INFO - 'NO_EM_RESTART': '1', 05:17:45 INFO - 'PAGER': '/bin/cat', 05:17:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:45 INFO - 'PWD': '/builds/slave/test', 05:17:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:45 INFO - 'SHELL': '/bin/bash', 05:17:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MioDz3Lk2l/Listeners', 05:17:45 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 05:17:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:45 INFO - 'USER': 'cltbld', 05:17:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:45 INFO - 'XPC_FLAGS': '0x0', 05:17:45 INFO - 'XPC_SERVICE_NAME': '0', 05:17:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:46 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-u2_Kjd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:46 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-6IKq1A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:46 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-nsxnNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:46 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-YMz1qP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:46 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-k9wy42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:46 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-iAaEBG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:46 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-a5clKx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:46 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-kAF0RJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:46 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-xeKlm5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:46 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-4hwjFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:47 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-7NN9Os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:47 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-t7Ot4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:47 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-hkOb8T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:47 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-msSKcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:47 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-epSVzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:47 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-5yP7ZV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:47 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-gFD5e7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:17:47 INFO - Running setup.py install for manifestparser 05:17:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:17:47 INFO - Running setup.py install for mozcrash 05:17:48 INFO - Running setup.py install for mozdebug 05:17:48 INFO - Running setup.py install for mozdevice 05:17:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:17:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:17:48 INFO - Running setup.py install for mozfile 05:17:48 INFO - Running setup.py install for mozhttpd 05:17:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:17:48 INFO - Running setup.py install for mozinfo 05:17:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:17:48 INFO - Running setup.py install for mozInstall 05:17:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:17:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:17:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:17:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:17:48 INFO - Running setup.py install for mozleak 05:17:49 INFO - Running setup.py install for mozlog 05:17:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:17:49 INFO - Running setup.py install for moznetwork 05:17:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:17:49 INFO - Running setup.py install for mozprocess 05:17:49 INFO - Running setup.py install for mozprofile 05:17:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:17:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:17:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:17:49 INFO - Running setup.py install for mozrunner 05:17:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:17:49 INFO - Running setup.py install for mozscreenshot 05:17:50 INFO - Running setup.py install for moztest 05:17:50 INFO - Running setup.py install for mozversion 05:17:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:17:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:17:50 INFO - Cleaning up... 05:17:50 INFO - Return code: 0 05:17:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:50 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')]} 05:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:50 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')]} 05:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:50 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 0x10f164490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0da570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7c2c9a060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef78d30>, '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 0x10ed9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef70b20>, '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.Z4Wh0mFPG1/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.MioDz3Lk2l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 05:17:50 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 05:17:50 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 05:17:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4Wh0mFPG1/Render', 05:17:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:50 INFO - 'HOME': '/Users/cltbld', 05:17:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:50 INFO - 'LOGNAME': 'cltbld', 05:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:50 INFO - 'MOZ_NO_REMOTE': '1', 05:17:50 INFO - 'NO_EM_RESTART': '1', 05:17:50 INFO - 'PAGER': '/bin/cat', 05:17:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:50 INFO - 'PWD': '/builds/slave/test', 05:17:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:50 INFO - 'SHELL': '/bin/bash', 05:17:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MioDz3Lk2l/Listeners', 05:17:50 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 05:17:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:50 INFO - 'USER': 'cltbld', 05:17:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:50 INFO - 'XPC_FLAGS': '0x0', 05:17:50 INFO - 'XPC_SERVICE_NAME': '0', 05:17:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:17:50 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-7_qJuT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:17:50 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)) 05:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:17:50 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-PaFBtc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:17:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:17:50 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-ITjUNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:17:50 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)) 05:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:17:50 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-RpQ2ds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:17:51 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)) 05:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:17:51 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-xj5uIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:17:51 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)) 05:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:17:51 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-QrLPUz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:17:51 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)) 05:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:17:51 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-4q2SuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:17:51 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)) 05:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:17:51 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-sP_Vqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:17:51 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)) 05:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:17:51 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-sH1Zez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:17:51 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)) 05:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:17:51 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-rocHFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:17:51 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)) 05:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:17:51 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-lg2bsN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:17:51 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)) 05:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:17:51 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-tm5LdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:17:51 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)) 05:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:17:51 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-M7NKIH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:17:52 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)) 05:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:17:52 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-bjl45E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:52 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-GuseCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:17:52 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)) 05:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:17:52 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-u4v8iE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:17:52 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)) 05:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:17:52 INFO - Running setup.py (path:/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/pip-FRamYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:17:52 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)) 05:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:17:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:17:52 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)) 05:17:52 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)) 05:17:52 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)) 05:17:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:17:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:17:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:17:54 INFO - Downloading blessings-1.6.tar.gz 05:17:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:17:55 INFO - Installing collected packages: blessings 05:17:55 INFO - Running setup.py install for blessings 05:17:55 INFO - Successfully installed blessings 05:17:55 INFO - Cleaning up... 05:17:55 INFO - Return code: 0 05:17:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:17:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:55 INFO - Reading from file tmpfile_stdout 05:17:55 INFO - Current package versions: 05:17:55 INFO - blessings == 1.6 05:17:55 INFO - blobuploader == 1.2.4 05:17:55 INFO - docopt == 0.6.1 05:17:55 INFO - functools32 == 3.2.3-2 05:17:55 INFO - jsonschema == 2.5.1 05:17:55 INFO - manifestparser == 1.1 05:17:55 INFO - mozInstall == 1.12 05:17:55 INFO - mozcrash == 0.17 05:17:55 INFO - mozdebug == 0.1 05:17:55 INFO - mozdevice == 0.48 05:17:55 INFO - mozfile == 1.2 05:17:55 INFO - mozhttpd == 0.7 05:17:55 INFO - mozinfo == 0.9 05:17:55 INFO - mozleak == 0.1 05:17:55 INFO - mozlog == 3.4 05:17:55 INFO - moznetwork == 0.27 05:17:55 INFO - mozprocess == 0.23 05:17:55 INFO - mozprofile == 0.28 05:17:55 INFO - mozrunner == 6.12 05:17:55 INFO - mozscreenshot == 0.1 05:17:55 INFO - mozsystemmonitor == 0.3 05:17:55 INFO - moztest == 0.7 05:17:55 INFO - mozversion == 1.4 05:17:55 INFO - psutil == 3.1.1 05:17:55 INFO - requests == 1.2.3 05:17:55 INFO - wsgiref == 0.1.2 05:17:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:17:55 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')]} 05:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:55 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')]} 05:17:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:56 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 0x10f164490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0da570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7c2c9a060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef78d30>, '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 0x10ed9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef70b20>, '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.Z4Wh0mFPG1/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.MioDz3Lk2l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 05:17:56 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 05:17:56 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 05:17:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4Wh0mFPG1/Render', 05:17:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:56 INFO - 'HOME': '/Users/cltbld', 05:17:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:56 INFO - 'LOGNAME': 'cltbld', 05:17:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:56 INFO - 'MOZ_NO_REMOTE': '1', 05:17:56 INFO - 'NO_EM_RESTART': '1', 05:17:56 INFO - 'PAGER': '/bin/cat', 05:17:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:56 INFO - 'PWD': '/builds/slave/test', 05:17:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:56 INFO - 'SHELL': '/bin/bash', 05:17:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MioDz3Lk2l/Listeners', 05:17:56 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 05:17:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:56 INFO - 'USER': 'cltbld', 05:17:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:56 INFO - 'XPC_FLAGS': '0x0', 05:17:56 INFO - 'XPC_SERVICE_NAME': '0', 05:17:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:56 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)) 05:17:56 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)) 05:17:56 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)) 05:17:56 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)) 05:17:56 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)) 05:17:56 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)) 05:17:56 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)) 05:17:56 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)) 05:17:56 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)) 05:17:56 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)) 05:17:56 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)) 05:17:56 INFO - Cleaning up... 05:17:56 INFO - Return code: 0 05:17:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:17:56 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')]} 05:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:17:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:56 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')]} 05:17:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:17:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:17:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f164490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0da570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe7c2c9a060>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef78d30>, '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 0x10ed9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef70b20>, '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.Z4Wh0mFPG1/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.MioDz3Lk2l/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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 05:17:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:17:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4Wh0mFPG1/Render', 05:17:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:57 INFO - 'HOME': '/Users/cltbld', 05:17:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:57 INFO - 'LOGNAME': 'cltbld', 05:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:57 INFO - 'MOZ_NO_REMOTE': '1', 05:17:57 INFO - 'NO_EM_RESTART': '1', 05:17:57 INFO - 'PAGER': '/bin/cat', 05:17:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:57 INFO - 'PWD': '/builds/slave/test', 05:17:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:57 INFO - 'SHELL': '/bin/bash', 05:17:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MioDz3Lk2l/Listeners', 05:17:57 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 05:17:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:57 INFO - 'USER': 'cltbld', 05:17:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:57 INFO - 'XPC_FLAGS': '0x0', 05:17:57 INFO - 'XPC_SERVICE_NAME': '0', 05:17:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:17:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:17:57 INFO - Cleaning up... 05:17:57 INFO - Return code: 0 05:17:57 INFO - Running post-action listener: _resource_record_post_action 05:17:57 INFO - Running post-action listener: _start_resource_monitoring 05:17:57 INFO - Starting resource monitoring. 05:17:57 INFO - [mozharness: 2016-10-12 12:17:57.317203Z] Finished create-virtualenv step (success) 05:17:57 INFO - [mozharness: 2016-10-12 12:17:57.318203Z] Running install step. 05:17:57 INFO - Running pre-action listener: _resource_record_pre_action 05:17:57 INFO - Running main action method: install 05:17:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:17:57 INFO - Reading from file tmpfile_stdout 05:17:57 INFO - Detecting whether we're running mozinstall >=1.0... 05:17:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:17:57 INFO - Reading from file tmpfile_stdout 05:17:57 INFO - Output received: 05:17:57 INFO - Usage: mozinstall [options] installer 05:17:57 INFO - Options: 05:17:57 INFO - -h, --help show this help message and exit 05:17:57 INFO - -d DEST, --destination=DEST 05:17:57 INFO - Directory to install application into. [default: 05:17:57 INFO - "/builds/slave/test"] 05:17:57 INFO - --app=APP Application being installed. [default: firefox] 05:17:57 INFO - mkdir: /builds/slave/test/build/application 05:17:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:18:32 INFO - Reading from file tmpfile_stdout 05:18:32 INFO - Output received: 05:18:32 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:18:32 INFO - Running post-action listener: _resource_record_post_action 05:18:32 INFO - [mozharness: 2016-10-12 12:18:32.210932Z] Finished install step (success) 05:18:32 INFO - [mozharness: 2016-10-12 12:18:32.211052Z] Running run-tests step. 05:18:32 INFO - Running pre-action listener: _resource_record_pre_action 05:18:32 INFO - Running main action method: run_tests 05:18:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:18:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:18:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:18:32 INFO - 2016-10-12 05:18:32.225 screenresolution[1650:7612] starting screenresolution argv=screenresolution get 05:18:32 INFO - 2016-10-12 05:18:32.228 screenresolution[1650:7612] Display 0: 1600x1200x32@60 05:18:32 INFO - 2016-10-12 05:18:32.234 screenresolution[1651:7614] starting screenresolution argv=screenresolution list 05:18:32 INFO - Available Modes on Display 0 05:18:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:18:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:18:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:18:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:18:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:18:32 INFO - Intel Iris: 05:18:32 INFO - Chipset Model: Intel Iris 05:18:32 INFO - Type: GPU 05:18:32 INFO - Bus: Built-In 05:18:32 INFO - VRAM (Dynamic, Max): 1536 MB 05:18:32 INFO - Vendor: Intel (0x8086) 05:18:32 INFO - Device ID: 0x0a2e 05:18:32 INFO - Revision ID: 0x0009 05:18:32 INFO - Displays: 05:18:32 INFO - Display: 05:18:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:18:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:18:32 INFO - Display Serial Number: 1600x1200 60 05:18:32 INFO - Main Display: Yes 05:18:32 INFO - Mirror: Off 05:18:32 INFO - Online: Yes 05:18:32 INFO - Rotation: Supported 05:18:32 INFO - Return code: 0 05:18:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:18:32 INFO - Python 2.7.3 05:18:32 INFO - Return code: 0 05:18:32 INFO - grabbing minidump binary from tooltool 05:18:32 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')]} 05:18:32 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 0x10ef78d30>, '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 0x10ed9edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef70b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:18:32 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 05:18:32 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 05:18:32 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 05:18:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:18:32 INFO - Return code: 0 05:18:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:18:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:18:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:18:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:18:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:18:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DLq_r_MsRqWNlVprypqr6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0295', '--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 05:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DLq_r_MsRqWNlVprypqr6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0295 --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 05:18:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Z4Wh0mFPG1/Render', 05:18:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:18:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:18:32 INFO - 'HOME': '/Users/cltbld', 05:18:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:18:32 INFO - 'LOGNAME': 'cltbld', 05:18:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:18:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:18:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:18:32 INFO - 'MOZ_NO_REMOTE': '1', 05:18:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:18:32 INFO - 'NO_EM_RESTART': '1', 05:18:32 INFO - 'PAGER': '/bin/cat', 05:18:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:18:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:18:32 INFO - 'PWD': '/builds/slave/test', 05:18:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:18:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:18:32 INFO - 'SHELL': '/bin/bash', 05:18:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MioDz3Lk2l/Listeners', 05:18:32 INFO - 'TMPDIR': '/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/', 05:18:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:18:32 INFO - 'USER': 'cltbld', 05:18:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:18:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:18:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:18:32 INFO - 'XPC_FLAGS': '0x0', 05:18:32 INFO - 'XPC_SERVICE_NAME': '0', 05:18:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:18:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DLq_r_MsRqWNlVprypqr6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0295', '--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 05:18:32 INFO - mozversion application_buildid: 20161012030146 05:18:32 INFO - mozversion application_changeset: 500baee3ce9f1b701ace9d38489cbc112d076c72 05:18:32 INFO - mozversion application_display_name: Nightly 05:18:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:18:32 INFO - mozversion application_name: Firefox 05:18:32 INFO - mozversion application_remotingname: firefox 05:18:32 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:18:32 INFO - mozversion application_vendor: Mozilla 05:18:32 INFO - mozversion application_version: 52.0a1 05:18:32 INFO - mozversion platform_buildid: 20161012030146 05:18:32 INFO - mozversion platform_changeset: 500baee3ce9f1b701ace9d38489cbc112d076c72 05:18:32 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:18:32 INFO - mozversion platform_version: 52.0a1 05:18:32 INFO - using testdate: 1476274712 05:18:32 INFO - actual date: 1476274712 05:18:32 INFO - starting webserver on 'localhost:49276' 05:18:32 INFO - SUITE-START | Running 2 tests 05:18:32 INFO - TEST-START | dromaeo_css 05:18:32 INFO - operating with platform_type : mac_ 05:18:32 INFO - Initialising browser for dromaeo_css test... 05:18:32 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmpcVu9UK/profile http://localhost:49276/getInfo.html) 05:18:35 INFO - PROCESS | 1661 | __metrics Screen width/height:1600/1200 05:18:35 INFO - PROCESS | 1661 | colorDepth:24 05:18:35 INFO - PROCESS | 1661 | Browser inner width/height: 1024/689 05:18:35 INFO - PROCESS | 1661 | __metrics 05:18:35 INFO - PROCESS | 1661 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:18:35 INFO - PROCESS | 1661 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:18:36 INFO - TEST-INFO | 1661: exit 0 05:18:36 INFO - Browser initialized. 05:18:36 INFO - Running cycle 1/1 for dromaeo_css test... 05:18:36 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmpcVu9UK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:18:48 INFO - PROCESS | 1663 | RSS: Main: 234856448 05:18:48 INFO - PROCESS | 1663 | 05:19:39 INFO - PROCESS | 1663 | 1476274779422 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] 05:21:51 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 05:21:54 INFO - PROCESS | 1663 | RSS: Main: 470867968 05:21:54 INFO - PROCESS | 1663 | 05:24:57 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 05:24:58 INFO - PROCESS | 1663 | RSS: Main: 372412416 05:24:58 INFO - PROCESS | 1663 | 05:28:00 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 05:28:01 INFO - PROCESS | 1663 | RSS: Main: 351981568 05:28:01 INFO - PROCESS | 1663 | 05:31:03 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 05:31:04 INFO - PROCESS | 1663 | RSS: Main: 340164608 05:31:04 INFO - PROCESS | 1663 | 05:34:07 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 05:34:08 INFO - PROCESS | 1663 | RSS: Main: 333684736 05:34:08 INFO - PROCESS | 1663 | 05:37:11 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 05:37:11 INFO - PROCESS | 1663 | RSS: Main: 466391040 05:37:11 INFO - PROCESS | 1663 | 05:37:11 INFO - PROCESS | 1663 | __start_tp_report 05:37:11 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 05:37:11 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 05:37:11 INFO - PROCESS | 1663 | |i|pagename|runs| 05:37:11 INFO - PROCESS | 1663 | |0;dojo.html;2766.792490563207;3216.7587430942676;3242.756793240506;3282.9343413131724;3305.6694330566947;4536.659750518707;5443.156310771837;5545.417731138223;5554.805581804638;5599.412061733516;5519.917201241975;5521.834344969648;5549.639273447223;5556.388797232301;5564.998300305943;5051.343325367697;5078.822241221558;5083.694978301295;5112.8977420451565;5163;5088.898222035576;5156.329677141966;5167.069927413064;5178.585713142958;5178.974105129469;5106.234064890259;5132.692038477703;5159.251908473269;5170.586353091744;5180.3265575475325;5193.68837869729;5195.402528709209;5205.063088644042;5213.4004589472315;5223.660462069954;5004.674696144775;5006.724630145341;5056.393232812049;5133.178691409394;5137.152369858969;5512.972435137839;5533.861653458655;5566.248556444869;5591.077472217079;5618.522425593829;6072.787452439144;6075.119107729399;6080.9391906081255;6087.026075827846;6093.329733729286;5981.371955944606;6040.395960403968;6085.756569737206;6176.104464852616;6182.319944806068;5596.832095037155;5620.325560932714;5648.661080335193;5650.208970744099;5701.71491425427;6244.843878902973;6272.686365681698;6277.780277690259;6280.152179455807;6292.716827742763;5746.655200687972;5855;5923.200367950271;5942.851428714231;5960.225170727865;5907.084401917709;6056.727447264883;6081.209442772411;6093.11649810775;6153.907691384633;6094.240526104309;6101.139495047328;6132.846678833065;6133.539984501181;6137.048757442603;6098.298695650057;6103.05402662588;6107.053406721965;6111.96944015277;6114.144019837227;4706.505816889246;4796.232602783538;4797.328374027639;4825.710457372569;4826.8069277228515;4330.826766929351;4355.433793606874;4401.559844015573;4404.669649776216;4406.647468202536;5499.285092937893;5534.723263836792;5558.249636299048;5561.4716601923565;5563.499285064364;6103.908441373383;6109.450149486479;6120.602160859619;6121.265448146162;6132.908006379907;5555.833325000256;5569.637973531708;5573.693446860461;5575.749091290902;5588.888222235532;5247.317848679723;5262.736863156827;5267.736613169326;5268.2097685346735;5272.499112584298;5001.424836143818;6205.968970155211;6235.971064774352;6251.374862513712;6291.087792270187;6176.567640265138;6177.6911154441195;6182.443580077635;6182.876342473035;6198.442140207403;6112.351504965139;6164.845878852885;6190.0714892764645;6286.277078136073;6300.59046161998;5815.709214539172;5963.493103086286;5978.461938425563;5979.402059793986;5982.7008649568215;5005.6996580205305;5996.970015149896;6065.272167339771;6069.180660610761;6074.058520929263;5854.209681692917;5904.852378690395;5926.911096333472;5959.731812068554;6010.699465026643;5884.9705751470965;5908.202392676933;5915.911261330997;5916.911246331395;5936.28764548257;5642.915356269577;5796.855078623068;5806.158107074535;5809.186713860147;5812.099124635688;5726.312842458931;5754.424557544212;5768.2501274834;5795.768169273182;5843.853903652443;4716.457607375196;5649.604527683023;5663.603547751783;5693.032184528557;5694.430556944272 05:37:11 INFO - PROCESS | 1663 | |1;ext.html;449.21163358306165;505.0807530294863;512.9970906877056;523.8376103407944;537.7792411226516;28266.293342666417;31336.21659458512;34167.658323416756;38414.463421463144;39550.20899582007;33604.99185024447;40289.597104029024;40592.79703601478;40631.39052914209;40676.79661601695;9383.624655013808;9544.95227523865;9560.091791279852;9571.473568953705;9573.569189386495;8527.95736021319;8735.082816304292;9225.21585665216;11346.262492937974;11618.825717614243;9516.80966380672;11453.083753299716;11455;11507.367094809782;11535.711607209803;11373;11440.084793216523;11455.713607159805;11465.484053217626;11467.426628668616;8419.158084191531;8629.093945135734;9269.582868770922;11255.66233013011;11511.539538418454;39106.413403798964;39340;39461.40807887884;39491.40762888559;39501;3346.2136397946465;3347;3367.5117108019444;3374.561307030095;3672.9632703672887;25459.363515912064;28783.42433151325;29856;29950.101496955125;30414.239644008856;3193.3772914281726;3216.5818443602416;3223.580934478503;3237.3833626215737;3323.5180898769786;484419;485004;485155;485367;488918.32980042265;51475.97048059018;52086.47913520816;52266.95466090733;52367;52443.73778131085;48481.5151848484;50636.49363506392;50819.23771143436;50878;54806.45193548014;13680.521181758591;15036.173010484528;15392.923035384976;15394.15332156742;15771.605709857346;11839.763204735857;11913.285202887855;11927.821082683766;11936.701582460508;11954.342511161969;13320.400581973834;13355.198688078552;13428.19430834153;14919;15062.623434414227;6197.25632924052;6323.588966717149;6358.1416508771645;6360;6392.26488953767;807.3339494916718;860.9827803444022;894.6490798893587;908.0374802709149;1092.8743194532572;24732.752672473045;29174.270643233664;29335.85332073326;29597;30032.54951175734;892.2415946445469;939.0797018921359;970.8592254123113;1000.6797824696027;1058.0530425269342;12810.231386116677;15049.623759406102;15119.16844573537;15253.923730381277;15531.378744850306;621592.8920355369;632010;633542;634146;635451;54386.728066359414;54649.45350546523;54650;54675.45324546703;54769;1206.5716670581992;1247.158168236455;1310.8099325597734;1333.8732820382047;1351.6215459671307;25880.482390352463;29508.114756557337;30197;30857.919972800843;30977.69022309748;50326.24510632417;50930.49069509406;50957;50968.235476468624;51077;570023;573221;573286;574050;574730;20060.799392005894;24183.63724544098;24610.630840537047;31831.408429578893;37511.6248837519;43287.783561082;43474.56525434705;43748.34377484277;44027.13823601456;44195;36192.81903590465;36628.45057324089;36650.8167459161;37373.81313093417;37451;36268.45597316095;36681.71613993497;37095;37136.25727485489;37942.81028594839;35186.296274073866;35846.103847404025;36279.45580816237;36429.63570364263;36450.45324320084;31207.063788086394;32531;32554.186145346557;32603.67396326101;32755.508667370486;23967.56194628328;24441.51116977615;24593.63109553394;24746.381340466633;25341.98632054771 05:37:11 INFO - PROCESS | 1663 | |2;jquery.html;347.92171761353717;369.8243334416154;376.1499012232355;383.79466985162924;402.7120608764733;14652.340644670989;14764.852351476482;15409.971157807995;20479.795202047975;20586.588268234627;18391;18831;19128.33050843221;19444.611107777837;20211.191552337925;5818.2145410369585;6124.081387791823;6128.540359473035;6128.938710612903;6131.7240724167295;5662.943370566303;6023.608465449754;6081.908771368433;6090.5736598438125;6091.543134264925;5797.188393624875;6036.637801731888;6041.486473649745;6042.456178943894;6044.184035155264;5900.557458190631;6038.939610603926;6041.577089603729;6044.486218671418;6057.485113765335;5013.1227035268685;5200.713960732158;5219.817306394296;5227.817026404057;5275.366955965271;25768.09811656583;25814.483710325687;25835.09577164809;25886.835092420886;25995.870020649774;2205.9889700551553;2227.6324406472913;2622.895084196649;3101.65881753007;3205.9198520036953;14714.926425367912;15539.378424862993;15855.841441585668;15967.281472333772;16121.83878161215;1748.1259370314842;1802.2971041293774;1813.1296977450897;1918.8944608046552;1930.8938008409532;109415;112944;113350.43324783324;113447;114236;10443.84334234987;10596.947015264874;10682.839757403644;10978.804239152201;11175.552977880956;13764.31178441074;13787.310634468236;13789.034767566374;13801.861981380258;13808.723825523433;8176.182381761895;8448.408611397143;8455.069942306342;8597.699080532151;8651.48091114535;8375.371847111492;8389.286910612665;8416.284615807603;8556.27271681914;8562.871556926651;5404.243405923174;5784.161296611967;6446.871062578723;6550.737970481127;6572.539922205399;1742.6340468501503;1839.9080045997914;1846.2153584726439;1848.3253612431636;1856.4152292028239;880.7093659092484;967.5500892085073;969.3214749675255;981.3375971219398;1046.0899017854515;20886.791132088485;22154;22178;22201;22227.888605569657;906.8095699903095;921.3734660430837;934.4441504894274;945.8061097475002;962.4898803634085;11222.55109795599;11615.651530453932;11828.52685892572;11895;11899.524019039314;551140;552216;592515;615962;617027;95502;115819;118605;121509.39245303717;123139.3843030797;841.7054031089192;972.8443449048118;1009.6769033909079;1011.0647650923014;1013.1287093099928;19375.90312048431;19689.409317720492;19779.307724229584;19790.307339243056;20311.4922126948;51819.740901295256;52084;52597;52774.73612631912;53807.6548086301;57413.13880291716;60858.39141608527;69509;74523;84589;7857.9214207857185;8000.319972802377;8196.467229630054;8266.710665126691;8375.62309696053;10789.946050269698;13047.086703930634;13298.069135160833;13586.86413135856;13669.863301366859;10970.506327215135;11347.148963827582;11480.770384592428;11641.53433862636;11664.708382290512;9331.813363732823;11201.327920324806;11524;11584.768304634028;11631.418429078682;10372;11325.830112548483;11560.710982225512;11915.344656044;12015.75968480643;7062.4703147263135;7945.0863150738405;7983.04203495561;8019.5990200490905;8208.630611622611;5151.7166555839785;8263.545504997282;11565.595204167814;11597.82603260935;11630.825537616773 05:37:11 INFO - PROCESS | 1663 | |3;mootools.html;1355.430719097979;1360.7074478987029;1517.6644552793541;1695.7456381542768;1895.2608482691744;7819.648115834787;8286.751397458085;8297.253247207742;8299.377546683992;8313.459625124371;8101.311388531967;8551.957240213806;8755.562221888897;8771.56142192891;8869.20177184055;2344.15610380263;2381.880905954704;2383.2492764779126;2384.546936082139;2388.0447820871705;2329.3827135809024;2363.161077817376;2373.1489438238114;2374.8575085494926;2377.3224630980176;2331.40549159964;2350.1304517328613;2354.3290162303747;2365.3613524348416;2365.73976862545;2314.7685231476885;2333.3000099970027;2342.0631747301045;2342.5783358995373;2351.835371523994;2302.7236731592147;2333.43997440613;2335.66132910727;2336.7663233676494;2338.018032426385;8705.738827835175;8789.56052197394;8840.823183536357;8845;8847.77880552985;4976.979719157564;5179.818706345298;5364.436734142898;5370.838874833761;5374.5700343972385;3185.5221716742676;3646.562412510489;3745.007572993159;3755.5681096673684;3768.208676178006;1079.1798233342638;1086.0605576176629;1112.1380929779405;1112.471576001401;1116.810142275807;11769.41152942358;11886.524539018515;11891.108166887518;11896.22674526153;11899.524019039314;4452.506596306079;4456.732596044248;4589.954100458953;4663.253879379283;4665.906681866344;9072.682456114004;9092.090790920987;9220.400673956172;9301.581428835718;9305.720828375159;5261.421243663194;5289.761960711778;5291.126964050965;5293.179557168645;5295.126304159848;4121.733819403353;4372.40972468719;4514.909701805946;4893.192623217201;4929.482404347492;3470.2018535736415;3496.0560648625237;3716.479692843004;3802.821125451119;3811.809409529568;1138.800709875785;1149.5114576305036;1158.1487606609135;1160.2284480820329;1160.512584714422;797.2426195114664;813.8657121574993;835.7265653724894;888.2316795971439;951.167728237792;5157.484251574812;5455.345358556999;5702.201691763156;5744.942550574524;6058.363871793398;899.8290324838259;955.2358113509304;959.7648576098901;975.2344409638541;986.9161121304626;3716.7955762433326;3873.8837834865;3931.253061918226;3972.781497017692;4009.278329900646;10506.579736810441;10947.781044379068;10964.616238431616;10967.067799236995;10969.451527423596;9927.702168934944;10358.44623306495;10390.844137337946;10898.836517452244;10918;7999.520028798291;8217.34261259098;8229.629666664894;8232.794180145544;8236.794080148044;5884.823455296348;5950.583459157991;5990.161377407254;6137.84655383619;6173.32093469727;8251;8695.39132260761;10012.949935250568;10162.441065741159;10196.796064078528;9936.155426788804;10142;10270;10361.378317300987;10410.791784164123;6758.7296508139125;7286.234945330876;7325.267473252632;7616.7334143304715;7640.923590764243;8323.12607176262;8474.703385381483;8523.445976011539;8530.10433904456;8532.23209911111;7422.294881986203;7496.512726672749;7534.962325188339;7586.848263034819;7661.233876612294;7153.678084486315;7170.42636589082;7227.241139680258;7250.673719682733;7274.199838017919;6153.969230153821;6867.862642747217;6989.287624532022;7016.719331226694;7047.753328633473;4915.287283343967;4937.938343256217;4959.330490383752;4984.975075124601;5096.847094587169;4628.907421851612;4997.425296090996;5025.949740502694;5073.518015788494;5104.3619547556555 05:37:11 INFO - PROCESS | 1663 | |4;prototype.html;259.4551441971859;284.0512687623338;299.61798706649006;306.98311592862393;313.2435169066704;4424.491183513893;4439.24532829419;4973.676711013786;5082.720450375228;5232.476752324766;4828.855134345967;5251.763670634821;5257.31765834933;5292.259083728281;5316.6544174628625;3323.667633236681;3885.9028524286978;3956.2987915196454;3994.0229586354794;4018.4482853388017;3318.850651720666;3482.733651277178;3686.8525258989607;3805.5243094613174;4014.1570270243283;3964.5638979712353;3968.444417781513;3968.702347323948;3973.2450834341385;3986.900327491807;3955.8219880105466;3972.940405893914;3982.7012974026775;3983.541892682335;4010.177913527749;3470.132466883279;3475.2180759329203;3477.3566890125408;3480.1821571930827;3491.8603255869734;4176.874693759192;4834.709917404932;5100.642954993152;5173.3016042834115;5195.818146364897;3802.6007269236607;3937.0551067743536;4063.7358571692744;4454.398656181406;4611.939253971572;4677.801433326331;4790.5448982346625;5453.454654534555;5525.861853453655;5555.416681248451;3174.3175217328385;3706.629337066299;3891.610838916114;3913.6086391360923;3944.2900277949957;5115.693058416507;5476;5576.191452239443;5759.2512973313205;5791.333996590404;3528.2767032758225;3864.9806750966063;4019;4033.858814941463;4052.2908491014546;3924.9215015700097;4054.790139374048;4069.212589376287;4083.4283200351974;4094.733842300241;4328;4520.593146616755;4524.457065152203;4526.864194074183;4706.129366067288;5450.264214331094;5455.5908306876345;5478.58910581708;5481.725913704299;5485.025390859288;1329.3419757220045;1337.25782190885;1375.2573610250554;1378.8896888248917;1389.8262717160355;795.8288967871936;923.3029063057483;928.5542939389131;958.5542722633869;959.7571145366767;4884.584810291165;5019.573336266385;5146.588272938156;5180.766865490987;5184.7926082956255;4752.714837109785;4799.328094066834;5691.544676425876;5713.628729104985;5729.48434640876;4537.523560026216;4915.705057696549;5155.97422012895;5253.632245742761;5259.263703081571;2050.974512743628;2107.599556084339;2285;2409.6024455666375;2470.5300346293925;4081.5102187737066;4274.764887931132;4844.055409195244;4914;4974.850754477371;4218.8523401681405;4236.15727158687;4397.648188144941;4485.775711214426;4743.383360163157;4211.567572428461;4599.448066232074;4737.478877323423;4881.218355300361;4911.607071434277;4370.453693288339;4374.693771435969;4394.912101758011;4428.092241090504;4775.087196810013;3710.9404280623435;3866.6853269888375;4222.641075508616;4358.520562738159;4736.242201247784;4192.96010392463;4812.639052071038;4890.828820991391;4976.427710813303;4984.850454486371;2934.8532573370817;3252.5118284511896;3440.3979303621268;3470.427379482458;3501.8249087546033;3943.6647884928952;4013.7557357219357;4252.469780480609;4577.404937358122;4819.59033482158;4152.480939882515;4853.39332583427;4861.392325959255;5079.8570321677325;5482.451754824645;5418.729063546728;5493.23094766741;5495.2856128703015;5504.779808807763;5556.38864729224;5110.805746408495;5347.491988261109;5431.185322201702;5480.068388373907;5548.805791797267;4643.698159619614;4901.852944411673;5154.433012368711;5365.114756065205;5579.995600791896;4323.378732975134;5511.145772405283;5523.459208764014;5529.843361089259;5566.860828479321 05:37:11 INFO - PROCESS | 1663 | |5;yui.html;602.9638221706698;709.4182770128493;746.4028776978416;803.1687203744126;815.2825513548079;14281.642958926031;15850.365985360586;15866.36534538617;15887.126208058538;15909.602259943507;12730.490780368797;14282.500112496065;14385.208813515279;14403.135811851296;14425;815.5799763121997;836.2056046755577;842.2546046748641;844.1010324004915;844.6368061733452;683.2006552333781;696.8014115976947;819.6024927909959;834.8038211020436;848.9193526614993;894.6332003878412;895.2614093372961;895.5477483870636;897.9820403591924;898.0121865947439;886.1935638568935;887.7558671365362;887.7780554861284;887.786931136529;893.2362829780542;659.7031335898864;659.7064306383661;660.451824985261;663.9170103737033;665.6638397609224;14854.70290594193;14898.925505372512;14899;14899.53014095767;14910.62723431912;14285.428582856674;14341.354639041268;14369.425222991067;14381.856181438156;14618.342174602169;11705.70735731605;11779.941100294529;11861.347625880573;11949.64151075469;12328.81506777399;3756.793376364299;3811.3901775715754;3825.674817640504;3840.481534992768;3893.1629699614437;68253.72247169128;88298.5585072077;88441;122676.38661806723;124153.37923310326;10831.235507624062;11158.274712143848;11174.736421326203;11479.483423245974;11661.475233614508;21867.671984920238;22030.779692203192;22177.223797167022;22207.77792222057;22207.777922220896;7952.483088599222;8011.639476223584;8022.518648881086;8102.351811855037;8256.876146857801;4162.646175075152;4200.936985945214;4309.267424537836;4324.956750432455;4351.477822661238;3565.4117070683565;3671.6695497404826;3680.6687398133763;3723.497327860704;3726.6832319253167;670.5071772247394;674.9730010799611;678.9015592739025;683.7265093962454;688.6315821035822;528.3000024966857;621.4624349937271;671.8051764988098;680.1022650101818;692.9930700693029;9192.356535042616;9372.5313734313;9378.67174648884;9481.718369029146;9521.619135234652;581.3692144023697;628.6479571440008;666.5634009723639;670.3129292475252;671.4762485261504;4118.19695159447;4326.632236259953;4337.9132417351475;4447.755373454491;4584.083183363341;150049;155643;156994;158741;159179;123231;138932;140719;142285;148041;93762;94045;99280;106770.46614767032;109005.90994090117;9147.405418647766;9253.861192082259;9615.798025246844;9721.805563888824;9863.449158303149;50152.749236253585;63426.04860927182;65204;65717.67141164263;66878.32804179934;67133.66433167802;73271;94363.52818235866;94975.52512237395;99167.50416247873;12762.29807360604;13003.869961300266;13087.869121308666;13564;13743.037987340791;14500.129992200502;14603.561893143222;14748.115113093249;14762.557123286319;14783.186924719244;12080.697982550506;12967.481300747864;13469.528566500125;13562;13625.591232262652;13965.860341396863;13999.580012599637;14009.229492378017;14123.576292711236;14294.642633934234;13487.393067311797;13560.321983900569;13632;13765.862341376458;13789.655258618615;9541.618335266789;11058.391788451712;11302.265352752045;11435.313881167156;11621.709457263636;11091;11306.773864522827;11392.373419462008;11462.4268786562;11702.35637039971 05:37:11 INFO - PROCESS | 1663 | __end_tp_report 05:37:11 INFO - PROCESS | 1663 | __start_cc_report 05:37:11 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,2898 05:37:11 INFO - PROCESS | 1663 | __end_cc_report 05:37:11 INFO - PROCESS | 1663 | __startTimestamp1476275831435__endTimestamp 05:37:11 INFO - PROCESS | 1663 | 05:37:11 INFO - PROCESS | 1663 | ------- Summary: start ------- 05:37:11 INFO - PROCESS | 1663 | Number of tests: 6 05:37:11 INFO - PROCESS | 1663 | 05:37:11 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5583.89 Median:5701.71 stddev:642.32 (11.3%) stddev-sans-first:605.09 05:37:11 INFO - PROCESS | 1663 | Values: 2766.8 3216.8 3242.8 3282.9 3305.7 4536.7 5443.2 5545.4 5554.8 5599.4 5519.9 5521.8 5549.6 5556.4 5565.0 5051.3 5078.8 5083.7 5112.9 5163.0 5088.9 5156.3 5167.1 5178.6 5179.0 5106.2 5132.7 5159.3 5170.6 5180.3 5193.7 5195.4 5205.1 5213.4 5223.7 5004.7 5006.7 5056.4 5133.2 5137.2 5513.0 5533.9 5566.2 5591.1 5618.5 6072.8 6075.1 6080.9 6087.0 6093.3 5981.4 6040.4 6085.8 6176.1 6182.3 5596.8 5620.3 5648.7 5650.2 5701.7 6244.8 6272.7 6277.8 6280.2 6292.7 5746.7 5855.0 5923.2 5942.9 5960.2 5907.1 6056.7 6081.2 6093.1 6153.9 6094.2 6101.1 6132.8 6133.5 6137.0 6098.3 6103.1 6107.1 6112.0 6114.1 4706.5 4796.2 4797.3 4825.7 4826.8 4330.8 4355.4 4401.6 4404.7 4406.6 5499.3 5534.7 5558.2 5561.5 5563.5 6103.9 6109.5 6120.6 6121.3 6132.9 5555.8 5569.6 5573.7 5575.7 5588.9 5247.3 5262.7 5267.7 5268.2 5272.5 5001.4 6206.0 6236.0 6251.4 6291.1 6176.6 6177.7 6182.4 6182.9 6198.4 6112.4 6164.8 6190.1 6286.3 6300.6 5815.7 5963.5 5978.5 5979.4 5982.7 5005.7 5997.0 6065.3 6069.2 6074.1 5854.2 5904.9 5926.9 5959.7 6010.7 5885.0 5908.2 5915.9 5916.9 5936.3 5642.9 5796.9 5806.2 5809.2 5812.1 5726.3 5754.4 5768.3 5795.8 5843.9 4716.5 5649.6 5663.6 5693.0 5694.4 05:37:11 INFO - PROCESS | 1663 | 05:37:11 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:68366.21 Median:36639.63 stddev:151552.64 (413.6%) stddev-sans-first:151891.99 05:37:11 INFO - PROCESS | 1663 | Values: 449.2 505.1 513.0 523.8 537.8 28266.3 31336.2 34167.7 38414.5 39550.2 33605.0 40289.6 40592.8 40631.4 40676.8 9383.6 9545.0 9560.1 9571.5 9573.6 8528.0 8735.1 9225.2 11346.3 11618.8 9516.8 11453.1 11455.0 11507.4 11535.7 11373.0 11440.1 11455.7 11465.5 11467.4 8419.2 8629.1 9269.6 11255.7 11511.5 39106.4 39340.0 39461.4 39491.4 39501.0 3346.2 3347.0 3367.5 3374.6 3673.0 25459.4 28783.4 29856.0 29950.1 30414.2 3193.4 3216.6 3223.6 3237.4 3323.5 484419.0 485004.0 485155.0 485367.0 488918.3 51476.0 52086.5 52267.0 52367.0 52443.7 48481.5 50636.5 50819.2 50878.0 54806.5 13680.5 15036.2 15392.9 15394.2 15771.6 11839.8 11913.3 11927.8 11936.7 11954.3 13320.4 13355.2 13428.2 14919.0 15062.6 6197.3 6323.6 6358.1 6360.0 6392.3 807.3 861.0 894.6 908.0 1092.9 24732.8 29174.3 29335.9 29597.0 30032.5 892.2 939.1 970.9 1000.7 1058.1 12810.2 15049.6 15119.2 15253.9 15531.4 621592.9 632010.0 633542.0 634146.0 635451.0 54386.7 54649.5 54650.0 54675.5 54769.0 1206.6 1247.2 1310.8 1333.9 1351.6 25880.5 29508.1 30197.0 30857.9 30977.7 50326.2 50930.5 50957.0 50968.2 51077.0 570023.0 573221.0 573286.0 574050.0 574730.0 20060.8 24183.6 24610.6 31831.4 37511.6 43287.8 43474.6 43748.3 44027.1 44195.0 36192.8 36628.5 36650.8 37373.8 37451.0 36268.5 36681.7 37095.0 37136.3 37942.8 35186.3 35846.1 36279.5 36429.6 36450.5 31207.1 32531.0 32554.2 32603.7 32755.5 23967.6 24441.5 24593.6 24746.4 25342.0 05:37:11 INFO - PROCESS | 1663 | 05:37:11 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:34043.22 Median:25941.35 stddev:97452.44 (375.7%) stddev-sans-first:97692.98 05:37:11 INFO - PROCESS | 1663 | Values: 347.9 369.8 376.1 383.8 402.7 14652.3 14764.9 15410.0 20479.8 20586.6 18391.0 18831.0 19128.3 19444.6 20211.2 5818.2 6124.1 6128.5 6128.9 6131.7 5662.9 6023.6 6081.9 6090.6 6091.5 5797.2 6036.6 6041.5 6042.5 6044.2 5900.6 6038.9 6041.6 6044.5 6057.5 5013.1 5200.7 5219.8 5227.8 5275.4 25768.1 25814.5 25835.1 25886.8 25995.9 2206.0 2227.6 2622.9 3101.7 3205.9 14714.9 15539.4 15855.8 15967.3 16121.8 1748.1 1802.3 1813.1 1918.9 1930.9 109415.0 112944.0 113350.4 113447.0 114236.0 10443.8 10596.9 10682.8 10978.8 11175.6 13764.3 13787.3 13789.0 13801.9 13808.7 8176.2 8448.4 8455.1 8597.7 8651.5 8375.4 8389.3 8416.3 8556.3 8562.9 5404.2 5784.2 6446.9 6550.7 6572.5 1742.6 1839.9 1846.2 1848.3 1856.4 880.7 967.6 969.3 981.3 1046.1 20886.8 22154.0 22178.0 22201.0 22227.9 906.8 921.4 934.4 945.8 962.5 11222.6 11615.7 11828.5 11895.0 11899.5 551140.0 552216.0 592515.0 615962.0 617027.0 95502.0 115819.0 118605.0 121509.4 123139.4 841.7 972.8 1009.7 1011.1 1013.1 19375.9 19689.4 19779.3 19790.3 20311.5 51819.7 52084.0 52597.0 52774.7 53807.7 57413.1 60858.4 69509.0 74523.0 84589.0 7857.9 8000.3 8196.5 8266.7 8375.6 10789.9 13047.1 13298.1 13586.9 13669.9 10970.5 11347.1 11480.8 11641.5 11664.7 9331.8 11201.3 11524.0 11584.8 11631.4 10372.0 11325.8 11560.7 11915.3 12015.8 7062.5 7945.1 7983.0 8019.6 8208.6 5151.7 8263.5 11565.6 11597.8 11630.8 05:37:11 INFO - PROCESS | 1663 | 05:37:11 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:5642.77 Median:4980.98 stddev:3174.67 (63.7%) stddev-sans-first:3167.22 05:37:11 INFO - PROCESS | 1663 | Values: 1355.4 1360.7 1517.7 1695.7 1895.3 7819.6 8286.8 8297.3 8299.4 8313.5 8101.3 8552.0 8755.6 8771.6 8869.2 2344.2 2381.9 2383.2 2384.5 2388.0 2329.4 2363.2 2373.1 2374.9 2377.3 2331.4 2350.1 2354.3 2365.4 2365.7 2314.8 2333.3 2342.1 2342.6 2351.8 2302.7 2333.4 2335.7 2336.8 2338.0 8705.7 8789.6 8840.8 8845.0 8847.8 4977.0 5179.8 5364.4 5370.8 5374.6 3185.5 3646.6 3745.0 3755.6 3768.2 1079.2 1086.1 1112.1 1112.5 1116.8 11769.4 11886.5 11891.1 11896.2 11899.5 4452.5 4456.7 4590.0 4663.3 4665.9 9072.7 9092.1 9220.4 9301.6 9305.7 5261.4 5289.8 5291.1 5293.2 5295.1 4121.7 4372.4 4514.9 4893.2 4929.5 3470.2 3496.1 3716.5 3802.8 3811.8 1138.8 1149.5 1158.1 1160.2 1160.5 797.2 813.9 835.7 888.2 951.2 5157.5 5455.3 5702.2 5744.9 6058.4 899.8 955.2 959.8 975.2 986.9 3716.8 3873.9 3931.3 3972.8 4009.3 10506.6 10947.8 10964.6 10967.1 10969.5 9927.7 10358.4 10390.8 10898.8 10918.0 7999.5 8217.3 8229.6 8232.8 8236.8 5884.8 5950.6 5990.2 6137.8 6173.3 8251.0 8695.4 10012.9 10162.4 10196.8 9936.2 10142.0 10270.0 10361.4 10410.8 6758.7 7286.2 7325.3 7616.7 7640.9 8323.1 8474.7 8523.4 8530.1 8532.2 7422.3 7496.5 7535.0 7586.8 7661.2 7153.7 7170.4 7227.2 7250.7 7274.2 6154.0 6867.9 6989.3 7016.7 7047.8 4915.3 4937.9 4959.3 4985.0 5096.8 4628.9 4997.4 5025.9 5073.5 5104.4 05:37:11 INFO - PROCESS | 1663 | 05:37:11 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:4212.52 Median:4525.66 stddev:1272.75 (28.1%) stddev-sans-first:1241.25 05:37:11 INFO - PROCESS | 1663 | Values: 259.5 284.1 299.6 307.0 313.2 4424.5 4439.2 4973.7 5082.7 5232.5 4828.9 5251.8 5257.3 5292.3 5316.7 3323.7 3885.9 3956.3 3994.0 4018.4 3318.9 3482.7 3686.9 3805.5 4014.2 3964.6 3968.4 3968.7 3973.2 3986.9 3955.8 3972.9 3982.7 3983.5 4010.2 3470.1 3475.2 3477.4 3480.2 3491.9 4176.9 4834.7 5100.6 5173.3 5195.8 3802.6 3937.1 4063.7 4454.4 4611.9 4677.8 4790.5 5453.5 5525.9 5555.4 3174.3 3706.6 3891.6 3913.6 3944.3 5115.7 5476.0 5576.2 5759.3 5791.3 3528.3 3865.0 4019.0 4033.9 4052.3 3924.9 4054.8 4069.2 4083.4 4094.7 4328.0 4520.6 4524.5 4526.9 4706.1 5450.3 5455.6 5478.6 5481.7 5485.0 1329.3 1337.3 1375.3 1378.9 1389.8 795.8 923.3 928.6 958.6 959.8 4884.6 5019.6 5146.6 5180.8 5184.8 4752.7 4799.3 5691.5 5713.6 5729.5 4537.5 4915.7 5156.0 5253.6 5259.3 2051.0 2107.6 2285.0 2409.6 2470.5 4081.5 4274.8 4844.1 4914.0 4974.9 4218.9 4236.2 4397.6 4485.8 4743.4 4211.6 4599.4 4737.5 4881.2 4911.6 4370.5 4374.7 4394.9 4428.1 4775.1 3710.9 3866.7 4222.6 4358.5 4736.2 4193.0 4812.6 4890.8 4976.4 4984.9 2934.9 3252.5 3440.4 3470.4 3501.8 3943.7 4013.8 4252.5 4577.4 4819.6 4152.5 4853.4 4861.4 5079.9 5482.5 5418.7 5493.2 5495.3 5504.8 5556.4 5110.8 5347.5 5431.2 5480.1 5548.8 4643.7 4901.9 5154.4 5365.1 5580.0 4323.4 5511.1 5523.5 5529.8 5566.9 05:37:11 INFO - PROCESS | 1663 | 05:37:11 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:24638.00 Median:3833.08 stddev:39800.04 (1038.3%) stddev-sans-first:39870.78 05:37:11 INFO - PROCESS | 1663 | Values: 603.0 709.4 746.4 803.2 815.3 14281.6 15850.4 15866.4 15887.1 15909.6 12730.5 14282.5 14385.2 14403.1 14425.0 815.6 836.2 842.3 844.1 844.6 683.2 696.8 819.6 834.8 848.9 894.6 895.3 895.5 898.0 898.0 886.2 887.8 887.8 887.8 893.2 659.7 659.7 660.5 663.9 665.7 14854.7 14898.9 14899.0 14899.5 14910.6 14285.4 14341.4 14369.4 14381.9 14618.3 11705.7 11779.9 11861.3 11949.6 12328.8 3756.8 3811.4 3825.7 3840.5 3893.2 68253.7 88298.6 88441.0 122676.4 124153.4 10831.2 11158.3 11174.7 11479.5 11661.5 21867.7 22030.8 22177.2 22207.8 22207.8 7952.5 8011.6 8022.5 8102.4 8256.9 4162.6 4200.9 4309.3 4325.0 4351.5 3565.4 3671.7 3680.7 3723.5 3726.7 670.5 675.0 678.9 683.7 688.6 528.3 621.5 671.8 680.1 693.0 9192.4 9372.5 9378.7 9481.7 9521.6 581.4 628.6 666.6 670.3 671.5 4118.2 4326.6 4337.9 4447.8 4584.1 150049.0 155643.0 156994.0 158741.0 159179.0 123231.0 138932.0 140719.0 142285.0 148041.0 93762.0 94045.0 99280.0 106770.5 109005.9 9147.4 9253.9 9615.8 9721.8 9863.4 50152.7 63426.0 65204.0 65717.7 66878.3 67133.7 73271.0 94363.5 94975.5 99167.5 12762.3 13003.9 13087.9 13564.0 13743.0 14500.1 14603.6 14748.1 14762.6 14783.2 12080.7 12967.5 13469.5 13562.0 13625.6 13965.9 13999.6 14009.2 14123.6 14294.6 13487.4 13560.3 13632.0 13765.9 13789.7 9541.6 11058.4 11302.3 11435.3 11621.7 11091.0 11306.8 11392.4 11462.4 11702.4 05:37:11 INFO - PROCESS | 1663 | -------- Summary: end -------- 05:37:11 INFO - PROCESS | 1663 | 05:37:12 INFO - TEST-INFO | 1663: exit 0 05:37:12 INFO - TEST-OK | dromaeo_css | took 1119254ms 05:37:12 INFO - TEST-START | kraken 05:37:12 INFO - operating with platform_type : mac_ 05:37:12 INFO - Initialising browser for kraken test... 05:37:12 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmpl8gVXU/profile http://localhost:49276/getInfo.html) 05:37:14 INFO - PROCESS | 1670 | __metrics Screen width/height:1600/1200 05:37:14 INFO - PROCESS | 1670 | colorDepth:24 05:37:14 INFO - PROCESS | 1670 | Browser inner width/height: 1024/689 05:37:14 INFO - PROCESS | 1670 | __metrics 05:37:14 INFO - PROCESS | 1670 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:37:14 INFO - PROCESS | 1670 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:37:15 INFO - TEST-INFO | 1670: exit 0 05:37:15 INFO - Browser initialized. 05:37:15 INFO - Running cycle 1/1 for kraken test... 05:37:15 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/T/tmpl8gVXU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:37:27 INFO - PROCESS | 1671 | RSS: Main: 234688512 05:37:27 INFO - PROCESS | 1671 | 05:37:29 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 05:37:30 INFO - PROCESS | 1671 | RSS: Main: 293867520 05:37:30 INFO - PROCESS | 1671 | 05:37:33 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 05:37:34 INFO - PROCESS | 1671 | RSS: Main: 293662720 05:37:34 INFO - PROCESS | 1671 | 05:37:37 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 05:37:38 INFO - PROCESS | 1671 | RSS: Main: 383234048 05:37:38 INFO - PROCESS | 1671 | 05:37:40 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 05:37:40 INFO - PROCESS | 1671 | RSS: Main: 287055872 05:37:40 INFO - PROCESS | 1671 | 05:37:42 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:37:43 INFO - PROCESS | 1671 | RSS: Main: 289648640 05:37:43 INFO - PROCESS | 1671 | 05:37:46 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 05:37:46 INFO - PROCESS | 1671 | RSS: Main: 328204288 05:37:46 INFO - PROCESS | 1671 | 05:37:49 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 05:37:50 INFO - PROCESS | 1671 | RSS: Main: 327495680 05:37:50 INFO - PROCESS | 1671 | 05:37:53 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 05:37:53 INFO - PROCESS | 1671 | RSS: Main: 327856128 05:37:53 INFO - PROCESS | 1671 | 05:37:55 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:37:55 INFO - PROCESS | 1671 | RSS: Main: 300568576 05:37:55 INFO - PROCESS | 1671 | 05:37:57 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:37:58 INFO - PROCESS | 1671 | RSS: Main: 305385472 05:37:58 INFO - PROCESS | 1671 | 05:38:00 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:38:01 INFO - PROCESS | 1671 | RSS: Main: 307761152 05:38:01 INFO - PROCESS | 1671 | 05:38:04 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:38:05 INFO - PROCESS | 1671 | RSS: Main: 318099456 05:38:05 INFO - PROCESS | 1671 | 05:38:08 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:38:08 INFO - PROCESS | 1671 | RSS: Main: 317321216 05:38:08 INFO - PROCESS | 1671 | 05:38:10 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 05:38:10 INFO - PROCESS | 1671 | RSS: Main: 361205760 05:38:10 INFO - PROCESS | 1671 | 05:38:10 INFO - PROCESS | 1671 | __start_tp_report 05:38:10 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 05:38:10 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 05:38:10 INFO - PROCESS | 1671 | |i|pagename|runs| 05:38:10 INFO - PROCESS | 1671 | |0;ai-astar;113;113;113;112;113;113;110;113;113;113 05:38:10 INFO - PROCESS | 1671 | |1;audio-beat-detection;146;111;115;150;113;114;123;138;158;113 05:38:10 INFO - PROCESS | 1671 | |2;audio-dft;181;184;182;182;183;182;178;182;182;182 05:38:10 INFO - PROCESS | 1671 | |3;audio-fft;82;58;59;86;60;60;59;57;83;58 05:38:10 INFO - PROCESS | 1671 | |4;audio-oscillator;86;70;93;71;68;69;92;68;68;91 05:38:10 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;89;84;88;86;86;85;89;85;88;85 05:38:10 INFO - PROCESS | 1671 | |6;imaging-darkroom;95;97;96;96;97;96;97;95;95;96 05:38:10 INFO - PROCESS | 1671 | |7;imaging-desaturate;84;91;144;140;86;94;140;88;88;86 05:38:10 INFO - PROCESS | 1671 | |8;json-parse-financial;55;54;56;53;53;54;53;53;54;53 05:38:10 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;66;77;70;75;103;102;107;69;70;71 05:38:10 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;88;87;86;90;91;87;85;86;86;87 05:38:10 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;151;155;163;163;161;141;146;143;217;159 05:38:10 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;168;185;150;234;235;168;170;171;205;162 05:38:10 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;70;70;69;68;67;68;68;69;68;67 05:38:10 INFO - PROCESS | 1671 | __end_tp_report 05:38:10 INFO - PROCESS | 1671 | __start_cc_report 05:38:10 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,2025 05:38:10 INFO - PROCESS | 1671 | __end_cc_report 05:38:10 INFO - PROCESS | 1671 | __startTimestamp1476275890861__endTimestamp 05:38:10 INFO - PROCESS | 1671 | 05:38:10 INFO - PROCESS | 1671 | ------- Summary: start ------- 05:38:10 INFO - PROCESS | 1671 | Number of tests: 14 05:38:10 INFO - PROCESS | 1671 | 05:38:10 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.00 stddev:0.97 (0.9%) stddev-sans-first:1.01 05:38:10 INFO - PROCESS | 1671 | Values: 113.0 113.0 113.0 112.0 113.0 113.0 110.0 113.0 113.0 113.0 05:38:10 INFO - PROCESS | 1671 | 05:38:10 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:128.10 Median:130.50 stddev:18.06 (13.8%) stddev-sans-first:17.96 05:38:10 INFO - PROCESS | 1671 | Values: 146.0 111.0 115.0 150.0 113.0 114.0 123.0 138.0 158.0 113.0 05:38:10 INFO - PROCESS | 1671 | 05:38:10 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:181.80 Median:182.00 stddev:1.55 (0.9%) stddev-sans-first:1.62 05:38:10 INFO - PROCESS | 1671 | Values: 181.0 184.0 182.0 182.0 183.0 182.0 178.0 182.0 182.0 182.0 05:38:10 INFO - PROCESS | 1671 | 05:38:10 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:66.20 Median:60.00 stddev:12.13 (20.2%) stddev-sans-first:11.44 05:38:10 INFO - PROCESS | 1671 | Values: 82.0 58.0 59.0 86.0 60.0 60.0 59.0 57.0 83.0 58.0 05:38:10 INFO - PROCESS | 1671 | 05:38:10 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:77.60 Median:78.50 stddev:11.29 (14.4%) stddev-sans-first:11.55 05:38:10 INFO - PROCESS | 1671 | Values: 86.0 70.0 93.0 71.0 68.0 69.0 92.0 68.0 68.0 91.0 05:38:10 INFO - PROCESS | 1671 | 05:38:10 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:86.50 Median:87.00 stddev:1.84 (2.1%) stddev-sans-first:1.72 05:38:10 INFO - PROCESS | 1671 | Values: 89.0 84.0 88.0 86.0 86.0 85.0 89.0 85.0 88.0 85.0 05:38:10 INFO - PROCESS | 1671 | 05:38:10 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.78 05:38:10 INFO - PROCESS | 1671 | Values: 95.0 97.0 96.0 96.0 97.0 96.0 97.0 95.0 95.0 96.0 05:38:10 INFO - PROCESS | 1671 | 05:38:10 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:104.10 Median:87.00 stddev:25.86 (29.7%) stddev-sans-first:26.39 05:38:10 INFO - PROCESS | 1671 | Values: 84.0 91.0 144.0 140.0 86.0 94.0 140.0 88.0 88.0 86.0 05:38:10 INFO - PROCESS | 1671 | 05:38:10 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:54.00 stddev:1.03 (1.9%) stddev-sans-first:1.00 05:38:10 INFO - PROCESS | 1671 | Values: 55.0 54.0 56.0 53.0 53.0 54.0 53.0 53.0 54.0 53.0 05:38:10 INFO - PROCESS | 1671 | 05:38:10 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:81.00 Median:70.00 stddev:16.21 (23.2%) stddev-sans-first:16.26 05:38:10 INFO - PROCESS | 1671 | Values: 66.0 77.0 70.0 75.0 103.0 102.0 107.0 69.0 70.0 71.0 05:38:10 INFO - PROCESS | 1671 | 05:38:10 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:87.00 stddev:1.89 (2.2%) stddev-sans-first:1.99 05:38:10 INFO - PROCESS | 1671 | Values: 88.0 87.0 86.0 90.0 91.0 87.0 85.0 86.0 86.0 87.0 05:38:10 INFO - PROCESS | 1671 | 05:38:10 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:159.90 Median:160.00 stddev:21.66 (13.5%) stddev-sans-first:22.73 05:38:10 INFO - PROCESS | 1671 | Values: 151.0 155.0 163.0 163.0 161.0 141.0 146.0 143.0 217.0 159.0 05:38:10 INFO - PROCESS | 1671 | 05:38:10 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.80 Median:178.00 stddev:29.91 (16.8%) stddev-sans-first:31.10 05:38:10 INFO - PROCESS | 1671 | Values: 168.0 185.0 150.0 234.0 235.0 168.0 170.0 171.0 205.0 162.0 05:38:10 INFO - PROCESS | 1671 | 05:38:10 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.07 (1.6%) stddev-sans-first:0.97 05:38:10 INFO - PROCESS | 1671 | Values: 70.0 70.0 69.0 68.0 67.0 68.0 68.0 69.0 68.0 67.0 05:38:10 INFO - PROCESS | 1671 | -------- Summary: end -------- 05:38:10 INFO - PROCESS | 1671 | 05:38:11 INFO - TEST-INFO | 1671: exit 0 05:38:11 INFO - TEST-OK | kraken | took 59652ms 05:38:11 INFO - SUITE-END | took 1178s 05:38:12 INFO - Completed test suite (00:19:39) 05:38:12 INFO - javascript benchmark 05:38:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2766.792490563207, 3216.7587430942676, 3242.756793240506, 3282.9343413131724, 3305.6694330566947, 4536.659750518707, 5443.156310771837, 5545.417731138223, 5554.805581804638, 5599.412061733516, 5519.917201241975, 5521.834344969648, 5549.639273447223, 5556.388797232301, 5564.998300305943, 5051.343325367697, 5078.822241221558, 5083.694978301295, 5112.8977420451565, 5163.0, 5088.898222035576, 5156.329677141966, 5167.069927413064, 5178.585713142958, 5178.974105129469, 5106.234064890259, 5132.692038477703, 5159.251908473269, 5170.586353091744, 5180.3265575475325, 5193.68837869729, 5195.402528709209, 5205.063088644042, 5213.4004589472315, 5223.660462069954, 5004.674696144775, 5006.724630145341, 5056.393232812049, 5133.178691409394, 5137.152369858969, 5512.972435137839, 5533.861653458655, 5566.248556444869, 5591.077472217079, 5618.522425593829, 6072.787452439144, 6075.119107729399, 6080.9391906081255, 6087.026075827846, 6093.329733729286, 5981.371955944606, 6040.395960403968, 6085.756569737206, 6176.104464852616, 6182.319944806068, 5596.832095037155, 5620.325560932714, 5648.661080335193, 5650.208970744099, 5701.71491425427, 6244.843878902973, 6272.686365681698, 6277.780277690259, 6280.152179455807, 6292.716827742763, 5746.655200687972, 5855.0, 5923.200367950271, 5942.851428714231, 5960.225170727865, 5907.084401917709, 6056.727447264883, 6081.209442772411, 6093.11649810775, 6153.907691384633, 6094.240526104309, 6101.139495047328, 6132.846678833065, 6133.539984501181, 6137.048757442603, 6098.298695650057, 6103.05402662588, 6107.053406721965, 6111.96944015277, 6114.144019837227, 4706.505816889246, 4796.232602783538, 4797.328374027639, 4825.710457372569, 4826.8069277228515, 4330.826766929351, 4355.433793606874, 4401.559844015573, 4404.669649776216, 4406.647468202536, 5499.285092937893, 5534.723263836792, 5558.249636299048, 5561.4716601923565, 5563.499285064364, 6103.908441373383, 6109.450149486479, 6120.602160859619, 6121.265448146162, 6132.908006379907, 5555.833325000256, 5569.637973531708, 5573.693446860461, 5575.749091290902, 5588.888222235532, 5247.317848679723, 5262.736863156827, 5267.736613169326, 5268.2097685346735, 5272.499112584298, 5001.424836143818, 6205.968970155211, 6235.971064774352, 6251.374862513712, 6291.087792270187, 6176.567640265138, 6177.6911154441195, 6182.443580077635, 6182.876342473035, 6198.442140207403, 6112.351504965139, 6164.845878852885, 6190.0714892764645, 6286.277078136073, 6300.59046161998, 5815.709214539172, 5963.493103086286, 5978.461938425563, 5979.402059793986, 5982.7008649568215, 5005.6996580205305, 5996.970015149896, 6065.272167339771, 6069.180660610761, 6074.058520929263, 5854.209681692917, 5904.852378690395, 5926.911096333472, 5959.731812068554, 6010.699465026643, 5884.9705751470965, 5908.202392676933, 5915.911261330997, 5916.911246331395, 5936.28764548257, 5642.915356269577, 5796.855078623068, 5806.158107074535, 5809.186713860147, 5812.099124635688, 5726.312842458931, 5754.424557544212, 5768.2501274834, 5795.768169273182, 5843.853903652443, 4716.457607375196, 5649.604527683023, 5663.603547751783, 5693.032184528557, 5694.430556944272], "value": 5542.193710241255, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [449.21163358306165, 505.0807530294863, 512.9970906877056, 523.8376103407944, 537.7792411226516, 28266.293342666417, 31336.21659458512, 34167.658323416756, 38414.463421463144, 39550.20899582007, 33604.99185024447, 40289.597104029024, 40592.79703601478, 40631.39052914209, 40676.79661601695, 9383.624655013808, 9544.95227523865, 9560.091791279852, 9571.473568953705, 9573.569189386495, 8527.95736021319, 8735.082816304292, 9225.21585665216, 11346.262492937974, 11618.825717614243, 9516.80966380672, 11453.083753299716, 11455.0, 11507.367094809782, 11535.711607209803, 11373.0, 11440.084793216523, 11455.713607159805, 11465.484053217626, 11467.426628668616, 8419.158084191531, 8629.093945135734, 9269.582868770922, 11255.66233013011, 11511.539538418454, 39106.413403798964, 39340.0, 39461.40807887884, 39491.40762888559, 39501.0, 3346.2136397946465, 3347.0, 3367.5117108019444, 3374.561307030095, 3672.9632703672887, 25459.363515912064, 28783.42433151325, 29856.0, 29950.101496955125, 30414.239644008856, 3193.3772914281726, 3216.5818443602416, 3223.580934478503, 3237.3833626215737, 3323.5180898769786, 484419.0, 485004.0, 485155.0, 485367.0, 488918.32980042265, 51475.97048059018, 52086.47913520816, 52266.95466090733, 52367.0, 52443.73778131085, 48481.5151848484, 50636.49363506392, 50819.23771143436, 50878.0, 54806.45193548014, 13680.521181758591, 15036.173010484528, 15392.923035384976, 15394.15332156742, 15771.605709857346, 11839.763204735857, 11913.285202887855, 11927.821082683766, 11936.701582460508, 11954.342511161969, 13320.400581973834, 13355.198688078552, 13428.19430834153, 14919.0, 15062.623434414227, 6197.25632924052, 6323.588966717149, 6358.1416508771645, 6360.0, 6392.26488953767, 807.3339494916718, 860.9827803444022, 894.6490798893587, 908.0374802709149, 1092.8743194532572, 24732.752672473045, 29174.270643233664, 29335.85332073326, 29597.0, 30032.54951175734, 892.2415946445469, 939.0797018921359, 970.8592254123113, 1000.6797824696027, 1058.0530425269342, 12810.231386116677, 15049.623759406102, 15119.16844573537, 15253.923730381277, 15531.378744850306, 621592.8920355369, 632010.0, 633542.0, 634146.0, 635451.0, 54386.728066359414, 54649.45350546523, 54650.0, 54675.45324546703, 54769.0, 1206.5716670581992, 1247.158168236455, 1310.8099325597734, 1333.8732820382047, 1351.6215459671307, 25880.482390352463, 29508.114756557337, 30197.0, 30857.919972800843, 30977.69022309748, 50326.24510632417, 50930.49069509406, 50957.0, 50968.235476468624, 51077.0, 570023.0, 573221.0, 573286.0, 574050.0, 574730.0, 20060.799392005894, 24183.63724544098, 24610.630840537047, 31831.408429578893, 37511.6248837519, 43287.783561082, 43474.56525434705, 43748.34377484277, 44027.13823601456, 44195.0, 36192.81903590465, 36628.45057324089, 36650.8167459161, 37373.81313093417, 37451.0, 36268.45597316095, 36681.71613993497, 37095.0, 37136.25727485489, 37942.81028594839, 35186.296274073866, 35846.103847404025, 36279.45580816237, 36429.63570364263, 36450.45324320084, 31207.063788086394, 32531.0, 32554.186145346557, 32603.67396326101, 32755.508667370486, 23967.56194628328, 24441.51116977615, 24593.63109553394, 24746.381340466633, 25341.98632054771], "value": 19139.349263442553, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.92171761353717, 369.8243334416154, 376.1499012232355, 383.79466985162924, 402.7120608764733, 14652.340644670989, 14764.852351476482, 15409.971157807995, 20479.795202047975, 20586.588268234627, 18391.0, 18831.0, 19128.33050843221, 19444.611107777837, 20211.191552337925, 5818.2145410369585, 6124.081387791823, 6128.540359473035, 6128.938710612903, 6131.7240724167295, 5662.943370566303, 6023.608465449754, 6081.908771368433, 6090.5736598438125, 6091.543134264925, 5797.188393624875, 6036.637801731888, 6041.486473649745, 6042.456178943894, 6044.184035155264, 5900.557458190631, 6038.939610603926, 6041.577089603729, 6044.486218671418, 6057.485113765335, 5013.1227035268685, 5200.713960732158, 5219.817306394296, 5227.817026404057, 5275.366955965271, 25768.09811656583, 25814.483710325687, 25835.09577164809, 25886.835092420886, 25995.870020649774, 2205.9889700551553, 2227.6324406472913, 2622.895084196649, 3101.65881753007, 3205.9198520036953, 14714.926425367912, 15539.378424862993, 15855.841441585668, 15967.281472333772, 16121.83878161215, 1748.1259370314842, 1802.2971041293774, 1813.1296977450897, 1918.8944608046552, 1930.8938008409532, 109415.0, 112944.0, 113350.43324783324, 113447.0, 114236.0, 10443.84334234987, 10596.947015264874, 10682.839757403644, 10978.804239152201, 11175.552977880956, 13764.31178441074, 13787.310634468236, 13789.034767566374, 13801.861981380258, 13808.723825523433, 8176.182381761895, 8448.408611397143, 8455.069942306342, 8597.699080532151, 8651.48091114535, 8375.371847111492, 8389.286910612665, 8416.284615807603, 8556.27271681914, 8562.871556926651, 5404.243405923174, 5784.161296611967, 6446.871062578723, 6550.737970481127, 6572.539922205399, 1742.6340468501503, 1839.9080045997914, 1846.2153584726439, 1848.3253612431636, 1856.4152292028239, 880.7093659092484, 967.5500892085073, 969.3214749675255, 981.3375971219398, 1046.0899017854515, 20886.791132088485, 22154.0, 22178.0, 22201.0, 22227.888605569657, 906.8095699903095, 921.3734660430837, 934.4441504894274, 945.8061097475002, 962.4898803634085, 11222.55109795599, 11615.651530453932, 11828.52685892572, 11895.0, 11899.524019039314, 551140.0, 552216.0, 592515.0, 615962.0, 617027.0, 95502.0, 115819.0, 118605.0, 121509.39245303717, 123139.3843030797, 841.7054031089192, 972.8443449048118, 1009.6769033909079, 1011.0647650923014, 1013.1287093099928, 19375.90312048431, 19689.409317720492, 19779.307724229584, 19790.307339243056, 20311.4922126948, 51819.740901295256, 52084.0, 52597.0, 52774.73612631912, 53807.6548086301, 57413.13880291716, 60858.39141608527, 69509.0, 74523.0, 84589.0, 7857.9214207857185, 8000.319972802377, 8196.467229630054, 8266.710665126691, 8375.62309696053, 10789.946050269698, 13047.086703930634, 13298.069135160833, 13586.86413135856, 13669.863301366859, 10970.506327215135, 11347.148963827582, 11480.770384592428, 11641.53433862636, 11664.708382290512, 9331.813363732823, 11201.327920324806, 11524.0, 11584.768304634028, 11631.418429078682, 10372.0, 11325.830112548483, 11560.710982225512, 11915.344656044, 12015.75968480643, 7062.4703147263135, 7945.0863150738405, 7983.04203495561, 8019.5990200490905, 8208.630611622611, 5151.7166555839785, 8263.545504997282, 11565.595204167814, 11597.82603260935, 11630.825537616773], "value": 9657.587434740359, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.430719097979, 1360.7074478987029, 1517.6644552793541, 1695.7456381542768, 1895.2608482691744, 7819.648115834787, 8286.751397458085, 8297.253247207742, 8299.377546683992, 8313.459625124371, 8101.311388531967, 8551.957240213806, 8755.562221888897, 8771.56142192891, 8869.20177184055, 2344.15610380263, 2381.880905954704, 2383.2492764779126, 2384.546936082139, 2388.0447820871705, 2329.3827135809024, 2363.161077817376, 2373.1489438238114, 2374.8575085494926, 2377.3224630980176, 2331.40549159964, 2350.1304517328613, 2354.3290162303747, 2365.3613524348416, 2365.73976862545, 2314.7685231476885, 2333.3000099970027, 2342.0631747301045, 2342.5783358995373, 2351.835371523994, 2302.7236731592147, 2333.43997440613, 2335.66132910727, 2336.7663233676494, 2338.018032426385, 8705.738827835175, 8789.56052197394, 8840.823183536357, 8845.0, 8847.77880552985, 4976.979719157564, 5179.818706345298, 5364.436734142898, 5370.838874833761, 5374.5700343972385, 3185.5221716742676, 3646.562412510489, 3745.007572993159, 3755.5681096673684, 3768.208676178006, 1079.1798233342638, 1086.0605576176629, 1112.1380929779405, 1112.471576001401, 1116.810142275807, 11769.41152942358, 11886.524539018515, 11891.108166887518, 11896.22674526153, 11899.524019039314, 4452.506596306079, 4456.732596044248, 4589.954100458953, 4663.253879379283, 4665.906681866344, 9072.682456114004, 9092.090790920987, 9220.400673956172, 9301.581428835718, 9305.720828375159, 5261.421243663194, 5289.761960711778, 5291.126964050965, 5293.179557168645, 5295.126304159848, 4121.733819403353, 4372.40972468719, 4514.909701805946, 4893.192623217201, 4929.482404347492, 3470.2018535736415, 3496.0560648625237, 3716.479692843004, 3802.821125451119, 3811.809409529568, 1138.800709875785, 1149.5114576305036, 1158.1487606609135, 1160.2284480820329, 1160.512584714422, 797.2426195114664, 813.8657121574993, 835.7265653724894, 888.2316795971439, 951.167728237792, 5157.484251574812, 5455.345358556999, 5702.201691763156, 5744.942550574524, 6058.363871793398, 899.8290324838259, 955.2358113509304, 959.7648576098901, 975.2344409638541, 986.9161121304626, 3716.7955762433326, 3873.8837834865, 3931.253061918226, 3972.781497017692, 4009.278329900646, 10506.579736810441, 10947.781044379068, 10964.616238431616, 10967.067799236995, 10969.451527423596, 9927.702168934944, 10358.44623306495, 10390.844137337946, 10898.836517452244, 10918.0, 7999.520028798291, 8217.34261259098, 8229.629666664894, 8232.794180145544, 8236.794080148044, 5884.823455296348, 5950.583459157991, 5990.161377407254, 6137.84655383619, 6173.32093469727, 8251.0, 8695.39132260761, 10012.949935250568, 10162.441065741159, 10196.796064078528, 9936.155426788804, 10142.0, 10270.0, 10361.378317300987, 10410.791784164123, 6758.7296508139125, 7286.234945330876, 7325.267473252632, 7616.7334143304715, 7640.923590764243, 8323.12607176262, 8474.703385381483, 8523.445976011539, 8530.10433904456, 8532.23209911111, 7422.294881986203, 7496.512726672749, 7534.962325188339, 7586.848263034819, 7661.233876612294, 7153.678084486315, 7170.42636589082, 7227.241139680258, 7250.673719682733, 7274.199838017919, 6153.969230153821, 6867.862642747217, 6989.287624532022, 7016.719331226694, 7047.753328633473, 4915.287283343967, 4937.938343256217, 4959.330490383752, 4984.975075124601, 5096.847094587169, 4628.907421851612, 4997.425296090996, 5025.949740502694, 5073.518015788494, 5104.3619547556555], "value": 4529.940285699549, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [259.4551441971859, 284.0512687623338, 299.61798706649006, 306.98311592862393, 313.2435169066704, 4424.491183513893, 4439.24532829419, 4973.676711013786, 5082.720450375228, 5232.476752324766, 4828.855134345967, 5251.763670634821, 5257.31765834933, 5292.259083728281, 5316.6544174628625, 3323.667633236681, 3885.9028524286978, 3956.2987915196454, 3994.0229586354794, 4018.4482853388017, 3318.850651720666, 3482.733651277178, 3686.8525258989607, 3805.5243094613174, 4014.1570270243283, 3964.5638979712353, 3968.444417781513, 3968.702347323948, 3973.2450834341385, 3986.900327491807, 3955.8219880105466, 3972.940405893914, 3982.7012974026775, 3983.541892682335, 4010.177913527749, 3470.132466883279, 3475.2180759329203, 3477.3566890125408, 3480.1821571930827, 3491.8603255869734, 4176.874693759192, 4834.709917404932, 5100.642954993152, 5173.3016042834115, 5195.818146364897, 3802.6007269236607, 3937.0551067743536, 4063.7358571692744, 4454.398656181406, 4611.939253971572, 4677.801433326331, 4790.5448982346625, 5453.454654534555, 5525.861853453655, 5555.416681248451, 3174.3175217328385, 3706.629337066299, 3891.610838916114, 3913.6086391360923, 3944.2900277949957, 5115.693058416507, 5476.0, 5576.191452239443, 5759.2512973313205, 5791.333996590404, 3528.2767032758225, 3864.9806750966063, 4019.0, 4033.858814941463, 4052.2908491014546, 3924.9215015700097, 4054.790139374048, 4069.212589376287, 4083.4283200351974, 4094.733842300241, 4328.0, 4520.593146616755, 4524.457065152203, 4526.864194074183, 4706.129366067288, 5450.264214331094, 5455.5908306876345, 5478.58910581708, 5481.725913704299, 5485.025390859288, 1329.3419757220045, 1337.25782190885, 1375.2573610250554, 1378.8896888248917, 1389.8262717160355, 795.8288967871936, 923.3029063057483, 928.5542939389131, 958.5542722633869, 959.7571145366767, 4884.584810291165, 5019.573336266385, 5146.588272938156, 5180.766865490987, 5184.7926082956255, 4752.714837109785, 4799.328094066834, 5691.544676425876, 5713.628729104985, 5729.48434640876, 4537.523560026216, 4915.705057696549, 5155.97422012895, 5253.632245742761, 5259.263703081571, 2050.974512743628, 2107.599556084339, 2285.0, 2409.6024455666375, 2470.5300346293925, 4081.5102187737066, 4274.764887931132, 4844.055409195244, 4914.0, 4974.850754477371, 4218.8523401681405, 4236.15727158687, 4397.648188144941, 4485.775711214426, 4743.383360163157, 4211.567572428461, 4599.448066232074, 4737.478877323423, 4881.218355300361, 4911.607071434277, 4370.453693288339, 4374.693771435969, 4394.912101758011, 4428.092241090504, 4775.087196810013, 3710.9404280623435, 3866.6853269888375, 4222.641075508616, 4358.520562738159, 4736.242201247784, 4192.96010392463, 4812.639052071038, 4890.828820991391, 4976.427710813303, 4984.850454486371, 2934.8532573370817, 3252.5118284511896, 3440.3979303621268, 3470.427379482458, 3501.8249087546033, 3943.6647884928952, 4013.7557357219357, 4252.469780480609, 4577.404937358122, 4819.59033482158, 4152.480939882515, 4853.39332583427, 4861.392325959255, 5079.8570321677325, 5482.451754824645, 5418.729063546728, 5493.23094766741, 5495.2856128703015, 5504.779808807763, 5556.38864729224, 5110.805746408495, 5347.491988261109, 5431.185322201702, 5480.068388373907, 5548.805791797267, 4643.698159619614, 4901.852944411673, 5154.433012368711, 5365.114756065205, 5579.995600791896, 4323.378732975134, 5511.145772405283, 5523.459208764014, 5529.843361089259, 5566.860828479321], "value": 3819.166046263038, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [602.9638221706698, 709.4182770128493, 746.4028776978416, 803.1687203744126, 815.2825513548079, 14281.642958926031, 15850.365985360586, 15866.36534538617, 15887.126208058538, 15909.602259943507, 12730.490780368797, 14282.500112496065, 14385.208813515279, 14403.135811851296, 14425.0, 815.5799763121997, 836.2056046755577, 842.2546046748641, 844.1010324004915, 844.6368061733452, 683.2006552333781, 696.8014115976947, 819.6024927909959, 834.8038211020436, 848.9193526614993, 894.6332003878412, 895.2614093372961, 895.5477483870636, 897.9820403591924, 898.0121865947439, 886.1935638568935, 887.7558671365362, 887.7780554861284, 887.786931136529, 893.2362829780542, 659.7031335898864, 659.7064306383661, 660.451824985261, 663.9170103737033, 665.6638397609224, 14854.70290594193, 14898.925505372512, 14899.0, 14899.53014095767, 14910.62723431912, 14285.428582856674, 14341.354639041268, 14369.425222991067, 14381.856181438156, 14618.342174602169, 11705.70735731605, 11779.941100294529, 11861.347625880573, 11949.64151075469, 12328.81506777399, 3756.793376364299, 3811.3901775715754, 3825.674817640504, 3840.481534992768, 3893.1629699614437, 68253.72247169128, 88298.5585072077, 88441.0, 122676.38661806723, 124153.37923310326, 10831.235507624062, 11158.274712143848, 11174.736421326203, 11479.483423245974, 11661.475233614508, 21867.671984920238, 22030.779692203192, 22177.223797167022, 22207.77792222057, 22207.777922220896, 7952.483088599222, 8011.639476223584, 8022.518648881086, 8102.351811855037, 8256.876146857801, 4162.646175075152, 4200.936985945214, 4309.267424537836, 4324.956750432455, 4351.477822661238, 3565.4117070683565, 3671.6695497404826, 3680.6687398133763, 3723.497327860704, 3726.6832319253167, 670.5071772247394, 674.9730010799611, 678.9015592739025, 683.7265093962454, 688.6315821035822, 528.3000024966857, 621.4624349937271, 671.8051764988098, 680.1022650101818, 692.9930700693029, 9192.356535042616, 9372.5313734313, 9378.67174648884, 9481.718369029146, 9521.619135234652, 581.3692144023697, 628.6479571440008, 666.5634009723639, 670.3129292475252, 671.4762485261504, 4118.19695159447, 4326.632236259953, 4337.9132417351475, 4447.755373454491, 4584.083183363341, 150049.0, 155643.0, 156994.0, 158741.0, 159179.0, 123231.0, 138932.0, 140719.0, 142285.0, 148041.0, 93762.0, 94045.0, 99280.0, 106770.46614767032, 109005.90994090117, 9147.405418647766, 9253.861192082259, 9615.798025246844, 9721.805563888824, 9863.449158303149, 50152.749236253585, 63426.04860927182, 65204.0, 65717.67141164263, 66878.32804179934, 67133.66433167802, 73271.0, 94363.52818235866, 94975.52512237395, 99167.50416247873, 12762.29807360604, 13003.869961300266, 13087.869121308666, 13564.0, 13743.037987340791, 14500.129992200502, 14603.561893143222, 14748.115113093249, 14762.557123286319, 14783.186924719244, 12080.697982550506, 12967.481300747864, 13469.528566500125, 13562.0, 13625.591232262652, 13965.860341396863, 13999.580012599637, 14009.229492378017, 14123.576292711236, 14294.642633934234, 13487.393067311797, 13560.321983900569, 13632.0, 13765.862341376458, 13789.655258618615, 9541.618335266789, 11058.391788451712, 11302.265352752045, 11435.313881167156, 11621.709457263636, 11091.0, 11306.773864522827, 11392.373419462008, 11462.4268786562, 11702.35637039971], "value": 7801.121852074223, "unit": "score"}], "name": "dromaeo_css", "value": 7191.024190822928, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 113.0, 112.0, 113.0, 113.0, 110.0, 113.0, 113.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 111.0, 115.0, 150.0, 113.0, 114.0, 123.0, 138.0, 158.0, 113.0], "value": 128.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 184.0, 182.0, 182.0, 183.0, 182.0, 178.0, 182.0, 182.0, 182.0], "value": 181.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 59.0, 86.0, 60.0, 60.0, 59.0, 57.0, 83.0, 58.0], "value": 66.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 93.0, 71.0, 68.0, 69.0, 92.0, 68.0, 68.0, 91.0], "value": 77.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 84.0, 88.0, 86.0, 86.0, 85.0, 89.0, 85.0, 88.0, 85.0], "value": 86.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 97.0, 96.0, 96.0, 97.0, 96.0, 97.0, 95.0, 95.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 91.0, 144.0, 140.0, 86.0, 94.0, 140.0, 88.0, 88.0, 86.0], "value": 104.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 54.0, 56.0, 53.0, 53.0, 54.0, 53.0, 53.0, 54.0, 53.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 77.0, 70.0, 75.0, 103.0, 102.0, 107.0, 69.0, 70.0, 71.0], "value": 81.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 86.0, 90.0, 91.0, 87.0, 85.0, 86.0, 86.0, 87.0], "value": 87.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 155.0, 163.0, 163.0, 161.0, 141.0, 146.0, 143.0, 217.0, 159.0], "value": 159.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 185.0, 150.0, 234.0, 235.0, 168.0, 170.0, 171.0, 205.0, 162.0], "value": 184.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 68.0, 67.0, 68.0, 68.0, 69.0, 68.0, 67.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1488.1000000000001, "alertThreshold": 2.0}]} 05:38:12 INFO - Return code: 0 05:38:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:38:12 INFO - # TBPL SUCCESS # 05:38:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:38:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:38:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:38:12 INFO - 2016-10-12 05:38:12.204 screenresolution[1675:9855] starting screenresolution argv=screenresolution get 05:38:12 INFO - 2016-10-12 05:38:12.207 screenresolution[1675:9855] Display 0: 1600x1200x32@60 05:38:12 INFO - 2016-10-12 05:38:12.213 screenresolution[1676:9858] starting screenresolution argv=screenresolution list 05:38:12 INFO - Available Modes on Display 0 05:38:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:38:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:38:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:38:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:38:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:38:12 INFO - Intel Iris: 05:38:12 INFO - Chipset Model: Intel Iris 05:38:12 INFO - Type: GPU 05:38:12 INFO - Bus: Built-In 05:38:12 INFO - VRAM (Dynamic, Max): 1536 MB 05:38:12 INFO - Vendor: Intel (0x8086) 05:38:12 INFO - Device ID: 0x0a2e 05:38:12 INFO - Revision ID: 0x0009 05:38:12 INFO - Displays: 05:38:12 INFO - Display: 05:38:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:38:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:38:12 INFO - Display Serial Number: 1600x1200 60 05:38:12 INFO - Main Display: Yes 05:38:12 INFO - Mirror: Off 05:38:12 INFO - Online: Yes 05:38:12 INFO - Rotation: Supported 05:38:12 INFO - Return code: 0 05:38:12 INFO - Running post-action listener: _resource_record_post_action 05:38:12 INFO - [mozharness: 2016-10-12 12:38:12.446857Z] Finished run-tests step (success) 05:38:12 INFO - Running post-run listener: _resource_record_post_run 05:38:12 INFO - Total resource usage - Wall time: 1214s; CPU: 54.0%; Read bytes: 37258240; Write bytes: 707830784; Read time: 242; Write time: 1995 05:38:12 INFO - TinderboxPrint: CPU usage
53.6% 05:38:12 INFO - TinderboxPrint: I/O read bytes / time
37,258,240 / 242 05:38:12 INFO - TinderboxPrint: I/O write bytes / time
707,830,784 / 1,995 05:38:12 INFO - TinderboxPrint: CPU idle
2,254.1 (46.4%) 05:38:12 INFO - TinderboxPrint: CPU system
970.7 (20.0%) 05:38:12 INFO - TinderboxPrint: CPU user
1,633.0 (33.6%) 05:38:12 INFO - TinderboxPrint: Swap in / out
444,276,736 / 0 05:38:12 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 394371584; Write bytes: 383354880; Read time: 29518; Write time: 816 05:38:12 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 30989312; Write bytes: 295634432; Read time: 184; Write time: 1108 05:38:12 INFO - Running post-run listener: _upload_blobber_files 05:38:12 INFO - Blob upload gear active. 05:38:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:38:12 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 05:38:12 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:38:12 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:38:13 INFO - (blobuploader) - INFO - Open directory for files ... 05:38:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:38:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:38:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:14 INFO - (blobuploader) - INFO - Done attempting. 05:38:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:38:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:38:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:15 INFO - (blobuploader) - INFO - Done attempting. 05:38:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:38:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:38:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:38:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:38:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:38:17 INFO - (blobuploader) - INFO - Done attempting. 05:38:17 INFO - (blobuploader) - INFO - Iteration through files over. 05:38:17 INFO - Return code: 0 05:38:17 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:38:17 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:38:17 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72569e6e8d984a42270673a19ab0123b8f36e25299d5164b6bec04bba3b4da49c1305b4f8509fc7a8d0a8345b4a886b7361089d86cc30213721c1a18611fc16b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9533ceebe0f10b9e3d76e6846348a771298a21b1f4bedae9cd6d37ee7c37741fb5938e0e0ab605d68d108ac4b85f128f1c9f6253f4822f27330ee655c0257bdd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bb553402c934b9f74954dce346ddc3a65a1f0a362156eb0e317f2f55b902fbcc49577787d3492e403cf5df49d93ebdab294c5544b1d645b47372efdb8b2e0e0"} 05:38:17 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:38:17 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:38:17 INFO - Contents: 05:38:17 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72569e6e8d984a42270673a19ab0123b8f36e25299d5164b6bec04bba3b4da49c1305b4f8509fc7a8d0a8345b4a886b7361089d86cc30213721c1a18611fc16b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9533ceebe0f10b9e3d76e6846348a771298a21b1f4bedae9cd6d37ee7c37741fb5938e0e0ab605d68d108ac4b85f128f1c9f6253f4822f27330ee655c0257bdd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bb553402c934b9f74954dce346ddc3a65a1f0a362156eb0e317f2f55b902fbcc49577787d3492e403cf5df49d93ebdab294c5544b1d645b47372efdb8b2e0e0"} 05:38:17 INFO - Running post-run listener: copy_logs_to_upload_dir 05:38:17 INFO - Copying logs to upload dir... 05:38:17 INFO - mkdir: /builds/slave/test/build/upload/logs 05:38:17 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1275.867870 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-10-12 05:38:17.404896) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 05:38:17.408890) ========= 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.Z4Wh0mFPG1/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.MioDz3Lk2l/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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/Firefox/sha512/72569e6e8d984a42270673a19ab0123b8f36e25299d5164b6bec04bba3b4da49c1305b4f8509fc7a8d0a8345b4a886b7361089d86cc30213721c1a18611fc16b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9533ceebe0f10b9e3d76e6846348a771298a21b1f4bedae9cd6d37ee7c37741fb5938e0e0ab605d68d108ac4b85f128f1c9f6253f4822f27330ee655c0257bdd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bb553402c934b9f74954dce346ddc3a65a1f0a362156eb0e317f2f55b902fbcc49577787d3492e403cf5df49d93ebdab294c5544b1d645b47372efdb8b2e0e0"} build_url:https://queue.taskcluster.net/v1/task/DLq_r_MsRqWNlVprypqr6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010980 build_url: 'https://queue.taskcluster.net/v1/task/DLq_r_MsRqWNlVprypqr6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/72569e6e8d984a42270673a19ab0123b8f36e25299d5164b6bec04bba3b4da49c1305b4f8509fc7a8d0a8345b4a886b7361089d86cc30213721c1a18611fc16b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9533ceebe0f10b9e3d76e6846348a771298a21b1f4bedae9cd6d37ee7c37741fb5938e0e0ab605d68d108ac4b85f128f1c9f6253f4822f27330ee655c0257bdd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2bb553402c934b9f74954dce346ddc3a65a1f0a362156eb0e317f2f55b902fbcc49577787d3492e403cf5df49d93ebdab294c5544b1d645b47372efdb8b2e0e0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-12 05:38:17.440629) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 05:38:17.440948) ========= 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.Z4Wh0mFPG1/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.MioDz3Lk2l/Listeners TMPDIR=/var/folders/x8/51gh5t9x18561frvys_qxbhw00000w/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.005358 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-12 05:38:17.489287) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 05:38:17.489647) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-12 05:38:17.489966) ========= ========= Total master_lag: 1.70 =========