builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0178 starttime: 1477176957.04 results: success (0) buildid: 20161022140222 builduid: 3f63b372ee0f4e0f87fd04d61af72da9 revision: 60dd82380d43a2b681f50842238f829204486290 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-10-22 15:55:57.044050) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-10-22 15:55:57.044447) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-22 15:55:57.044714) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-10-22 15:55:57.110886) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 15:55:57.111258) ========= 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.4bYSQP9lHk/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.Uil1AQNF7X/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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-22 15:55:57-- 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% 14.7M=0.001s 2016-10-22 15:55:57 (14.7 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.145957 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 15:55:57.279483) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 15:55:57.279794) ========= 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.4bYSQP9lHk/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.Uil1AQNF7X/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.025908 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 15:55:57.328722) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 15:55:57.329122) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 60dd82380d43a2b681f50842238f829204486290 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 60dd82380d43a2b681f50842238f829204486290 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4bYSQP9lHk/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.Uil1AQNF7X/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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-22 15:55:57,404 truncating revision to first 12 chars 2016-10-22 15:55:57,404 Setting DEBUG logging. 2016-10-22 15:55:57,404 attempt 1/10 2016-10-22 15:55:57,404 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/60dd82380d43?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-10-22 15:55:58,051 unpacking tar archive at: fx-team-60dd82380d43/testing/mozharness/ program finished with exit code 0 elapsedTime=0.887477 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 15:55:58.241183) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-22 15:55:58.241508) ========= script_repo_revision: 60dd82380d43a2b681f50842238f829204486290 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-10-22 15:55:58.241879) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-22 15:55:58.242155) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-10-22 15:55:58.260002) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-22 15:55:58.260317) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4bYSQP9lHk/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.Uil1AQNF7X/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 15:55:58 INFO - MultiFileLogger online at 20161022 15:55:58 in /builds/slave/test 15:55:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 15:55:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:55:58 INFO - {'append_to_log': False, 15:55:58 INFO - 'base_work_dir': '/builds/slave/test', 15:55:58 INFO - 'blob_upload_branch': 'Fx-Team', 15:55:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:55:58 INFO - 'branch': 'Fx-Team', 15:55:58 INFO - 'buildbot_json_path': 'buildprops.json', 15:55:58 INFO - 'config_files': ('talos/mac_config.py',), 15:55:58 INFO - 'default_actions': ('clobber', 15:55:58 INFO - 'read-buildbot-config', 15:55:58 INFO - 'download-and-extract', 15:55:58 INFO - 'populate-webroot', 15:55:58 INFO - 'create-virtualenv', 15:55:58 INFO - 'install', 15:55:58 INFO - 'run-tests'), 15:55:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:55:58 INFO - 'download_minidump_stackwalk': True, 15:55:58 INFO - 'download_symbols': 'ondemand', 15:55:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:55:58 INFO - 'tooltool.py': '/tools/tooltool.py', 15:55:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:55:58 INFO - '/tools/misc-python/virtualenv.py')}, 15:55:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:55:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:55:58 INFO - 'installer_path': 'installer.exe', 15:55:58 INFO - 'log_level': 'info', 15:55:58 INFO - 'log_name': 'talos', 15:55:58 INFO - 'log_to_console': True, 15:55:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:55:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:55:58 INFO - 'opt_config_files': (), 15:55:58 INFO - 'pip_index': False, 15:55:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:55:58 INFO - 'cmd': ('bash', 15:55:58 INFO - '-c', 15:55:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:55:58 INFO - 'enabled': True, 15:55:58 INFO - 'halt_on_failure': False, 15:55:58 INFO - 'name': 'check_screen_resolution'},), 15:55:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:55:58 INFO - 'cmd': ('bash', 15:55:58 INFO - '-c', 15:55:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:55:58 INFO - 'enabled': True, 15:55:58 INFO - 'halt_on_failure': False, 15:55:58 INFO - 'name': 'check_screen_resolution'},), 15:55:58 INFO - 'run_cmd_checks_enabled': True, 15:55:58 INFO - 'sps_profile': False, 15:55:58 INFO - 'sps_profile_interval': 0, 15:55:58 INFO - 'suite': 'dromaeojs', 15:55:58 INFO - 'system_bits': '32', 15:55:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:55:58 INFO - 'title': 't-yosemite-r7-0178', 15:55:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:55:58 INFO - 'use_talos_json': True, 15:55:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:55:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:55:58 INFO - 'work_dir': 'build'} 15:55:58 INFO - [mozharness: 2016-10-22 22:55:58.475801Z] Running clobber step. 15:55:58 INFO - Running pre-action listener: _resource_record_pre_action 15:55:58 INFO - Running main action method: clobber 15:55:58 INFO - rmtree: /builds/slave/test/build 15:55:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:56:00 INFO - Running post-action listener: _resource_record_post_action 15:56:00 INFO - [mozharness: 2016-10-22 22:56:00.675152Z] Finished clobber step (success) 15:56:00 INFO - [mozharness: 2016-10-22 22:56:00.675320Z] Running read-buildbot-config step. 15:56:00 INFO - Running pre-action listener: _resource_record_pre_action 15:56:00 INFO - Running main action method: read_buildbot_config 15:56:00 INFO - Using buildbot properties: 15:56:00 INFO - { 15:56:00 INFO - "project": "", 15:56:00 INFO - "product": "firefox", 15:56:00 INFO - "script_repo_revision": "production", 15:56:00 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 15:56:00 INFO - "repository": "", 15:56:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 15:56:00 INFO - "buildid": "20161022140222", 15:56:00 INFO - "pgo_build": "False", 15:56:00 INFO - "basedir": "/builds/slave/test", 15:56:00 INFO - "buildnumber": 190, 15:56:00 INFO - "slavename": "t-yosemite-r7-0178", 15:56:00 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 15:56:00 INFO - "platform": "yosemite_r7", 15:56:00 INFO - "scheduler": "tests-fx-team-macosx64-talos", 15:56:00 INFO - "branch": "fx-team", 15:56:00 INFO - "repo_path": "integration/fx-team", 15:56:00 INFO - "revision": "60dd82380d43a2b681f50842238f829204486290", 15:56:00 INFO - "stage_platform": "macosx64", 15:56:00 INFO - "builduid": "3f63b372ee0f4e0f87fd04d61af72da9", 15:56:00 INFO - "slavebuilddir": "test" 15:56:00 INFO - } 15:56:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/O5GZ3Z7YTlW8SQfj_6JJBA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 15:56:00 INFO - Running post-action listener: _resource_record_post_action 15:56:00 INFO - [mozharness: 2016-10-22 22:56:00.678662Z] Finished read-buildbot-config step (success) 15:56:00 INFO - [mozharness: 2016-10-22 22:56:00.678802Z] Running download-and-extract step. 15:56:00 INFO - Running pre-action listener: _resource_record_pre_action 15:56:00 INFO - Running main action method: download_and_extract 15:56:00 INFO - mkdir: /builds/slave/test/build/tests 15:56:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:00 INFO - trying https://queue.taskcluster.net/v1/task/O5GZ3Z7YTlW8SQfj_6JJBA/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 15:56:00 INFO - Downloading https://queue.taskcluster.net/v1/task/O5GZ3Z7YTlW8SQfj_6JJBA/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 15:56:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O5GZ3Z7YTlW8SQfj_6JJBA/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 15:56:02 INFO - Downloaded 1199 bytes. 15:56:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 15:56:02 INFO - Using the following test package requirements: 15:56:02 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 15:56:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:56:02 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 15:56:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:56:02 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 15:56:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:56:02 INFO - u'jsshell-mac.zip'], 15:56:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:56:02 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 15:56:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 15:56:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:56:02 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 15:56:02 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:56:02 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 15:56:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:56:02 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 15:56:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 15:56:02 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 15:56:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 15:56:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O5GZ3Z7YTlW8SQfj_6JJBA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 15:56:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O5GZ3Z7YTlW8SQfj_6JJBA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:56:02 INFO - Fetch https://queue.taskcluster.net/v1/task/O5GZ3Z7YTlW8SQfj_6JJBA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 15:56:02 INFO - Http code: 200 15:56:02 INFO - via: 1.1 bfc29822e21ecc352f71dce83e06ab74.cloudfront.net (CloudFront) 15:56:02 INFO - x-amz-cf-id: 2_Zz9cZf9ZG8joIpVbAgCOWSeDjKQU3ghGIAwui8jEqOd3PuYtlKTw== 15:56:02 INFO - x-amz-version-id: xiQqwwVepuOO2r7XiG9K6hWfILt1vjmV 15:56:03 INFO - Expected file size: 16420764 15:56:03 INFO - Obtained file size: 16420764 15:56:09 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 15:56:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O5GZ3Z7YTlW8SQfj_6JJBA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 15:56:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O5GZ3Z7YTlW8SQfj_6JJBA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 15:56:09 INFO - Fetch https://queue.taskcluster.net/v1/task/O5GZ3Z7YTlW8SQfj_6JJBA/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 15:56:10 INFO - Http code: 200 15:56:10 INFO - via: 1.1 b9a8ce441329f20cea895e08f19f1ec8.cloudfront.net (CloudFront) 15:56:10 INFO - x-amz-cf-id: ljl0tVWUzVaf4PJl652cL5FVDicA-ik52xEp9x62t18II2TAz-yYTA== 15:56:10 INFO - x-amz-version-id: xiQqwwVepuOO2r7XiG9K6hWfILt1vjmV 15:56:10 INFO - Expected file size: 16420764 15:56:10 INFO - Obtained file size: 16420764 15:56:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/O5GZ3Z7YTlW8SQfj_6JJBA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 15:56:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/O5GZ3Z7YTlW8SQfj_6JJBA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 15:56:16 INFO - Fetch https://queue.taskcluster.net/v1/task/O5GZ3Z7YTlW8SQfj_6JJBA/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 15:56:17 INFO - Http code: 200 15:56:17 INFO - via: 1.1 11dd60d1f68e8258294f92935b53a91f.cloudfront.net (CloudFront) 15:56:17 INFO - x-amz-cf-id: EaFS7llyJR0YSpn8SWDU_3dtbgZyDE0EB8o5IIWNnukNz75JEb2CWQ== 15:56:17 INFO - x-amz-version-id: djpnrHYSrk2ZI6RMai4aK7ITal0MEqm9 15:56:18 INFO - Expected file size: 14409028 15:56:18 INFO - Obtained file size: 14409028 15:56:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:18 INFO - trying https://queue.taskcluster.net/v1/task/O5GZ3Z7YTlW8SQfj_6JJBA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:56:18 INFO - Downloading https://queue.taskcluster.net/v1/task/O5GZ3Z7YTlW8SQfj_6JJBA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 15:56:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/O5GZ3Z7YTlW8SQfj_6JJBA/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 15:56:21 INFO - Downloaded 111313394 bytes. 15:56:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O5GZ3Z7YTlW8SQfj_6JJBA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:56:21 INFO - mkdir: /builds/slave/test/properties 15:56:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:56:21 INFO - Writing to file /builds/slave/test/properties/build_url 15:56:21 INFO - Contents: 15:56:21 INFO - build_url:https://queue.taskcluster.net/v1/task/O5GZ3Z7YTlW8SQfj_6JJBA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 15:56:21 INFO - Running post-action listener: _resource_record_post_action 15:56:21 INFO - Running post-action listener: set_extra_try_arguments 15:56:21 INFO - [mozharness: 2016-10-22 22:56:21.904635Z] Finished download-and-extract step (success) 15:56:21 INFO - [mozharness: 2016-10-22 22:56:21.904798Z] Running populate-webroot step. 15:56:21 INFO - Running pre-action listener: _resource_record_pre_action 15:56:21 INFO - Running main action method: populate_webroot 15:56:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:56:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:56:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:56:21 INFO - '--tppagecycles', 15:56:21 INFO - '7'], 15:56:21 INFO - 'tests': ['tsvgm']}}, 15:56:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:56:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:56:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:56:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:56:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:56:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:56:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:21 INFO - 'talos_options': ['--disable-e10s'], 15:56:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:56:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:56:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:21 INFO - 'talos_options': ['--disable-e10s'], 15:56:21 INFO - 'tests': ['damp', 'tps']}, 15:56:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:21 INFO - 'tests': ['damp', 'tps']}, 15:56:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:56:21 INFO - 'tests': ['dromaeo_dom']}, 15:56:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:56:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:56:21 INFO - 'tests': ['basic_compositor_video']}, 15:56:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:56:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:56:21 INFO - 'tests': ['a11yr', 15:56:21 INFO - 'ts_paint', 15:56:21 INFO - 'tpaint', 15:56:21 INFO - 'sessionrestore', 15:56:21 INFO - 'sessionrestore_no_auto_restore', 15:56:21 INFO - 'tabpaint']}, 15:56:21 INFO - 'other-e10s': {'tests': ['a11yr', 15:56:21 INFO - 'ts_paint', 15:56:21 INFO - 'tpaint', 15:56:21 INFO - 'sessionrestore', 15:56:21 INFO - 'sessionrestore_no_auto_restore', 15:56:21 INFO - 'tabpaint']}, 15:56:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:56:21 INFO - 'ts_paint', 15:56:21 INFO - 'tpaint', 15:56:21 INFO - 'sessionrestore', 15:56:21 INFO - 'sessionrestore_no_auto_restore', 15:56:21 INFO - 'tabpaint']}, 15:56:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:56:21 INFO - 'ts_paint', 15:56:21 INFO - 'tpaint', 15:56:21 INFO - 'sessionrestore', 15:56:21 INFO - 'sessionrestore_no_auto_restore', 15:56:21 INFO - 'tabpaint']}, 15:56:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:56:21 INFO - 'tests': ['a11yr', 15:56:21 INFO - 'ts_paint', 15:56:21 INFO - 'tpaint', 15:56:21 INFO - 'sessionrestore', 15:56:21 INFO - 'sessionrestore_no_auto_restore', 15:56:21 INFO - 'tabpaint']}, 15:56:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:56:21 INFO - 'tests': ['a11yr', 15:56:21 INFO - 'ts_paint', 15:56:21 INFO - 'tpaint', 15:56:21 INFO - 'sessionrestore', 15:56:21 INFO - 'sessionrestore_no_auto_restore', 15:56:21 INFO - 'tabpaint']}, 15:56:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:56:21 INFO - 'tests': ['tsvgx', 15:56:21 INFO - 'tsvgr_opacity', 15:56:21 INFO - 'tart', 15:56:21 INFO - 'tscrollx', 15:56:21 INFO - 'cart']}, 15:56:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:56:21 INFO - 'tsvgr_opacity', 15:56:21 INFO - 'tart', 15:56:21 INFO - 'tscrollx', 15:56:21 INFO - 'cart']}, 15:56:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:21 INFO - 'talos_options': ['--disable-e10s'], 15:56:21 INFO - 'tests': ['tp5o']}, 15:56:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:21 INFO - 'tests': ['tp5o']}, 15:56:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:21 INFO - 'talos_options': ['--disable-e10s', 15:56:21 INFO - '--xperf_path', 15:56:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:56:21 INFO - 'tests': ['tp5n']}, 15:56:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:56:21 INFO - 'talos_options': ['--xperf_path', 15:56:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:56:21 INFO - 'tests': ['tp5n']}}, 15:56:21 INFO - 'talos.zip': {'path': '', 15:56:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:56:21 INFO - Running post-action listener: _resource_record_post_action 15:56:21 INFO - [mozharness: 2016-10-22 22:56:21.923459Z] Finished populate-webroot step (success) 15:56:21 INFO - [mozharness: 2016-10-22 22:56:21.923565Z] Running create-virtualenv step. 15:56:21 INFO - Running pre-action listener: _resource_record_pre_action 15:56:21 INFO - Running main action method: create_virtualenv 15:56:21 INFO - Creating virtualenv /builds/slave/test/build/venv 15:56:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:56:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:56:22 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:56:22 INFO - Using real prefix '/tools/python27' 15:56:22 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:56:22 INFO - Installing distribute.............................................................................................................................................................................................done. 15:56:25 INFO - Installing pip.................done. 15:56:25 INFO - Return code: 0 15:56:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:56:26 INFO - Reading from file tmpfile_stdout 15:56:26 INFO - Output received: 15:56:26 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:56:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:26 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 0x10aead490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb78b49a520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc1d30>, '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 0x10aae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10acb9b20>, '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.4bYSQP9lHk/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.Uil1AQNF7X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:56:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:56:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:56:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4bYSQP9lHk/Render', 15:56:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:26 INFO - 'HOME': '/Users/cltbld', 15:56:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:26 INFO - 'LOGNAME': 'cltbld', 15:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:26 INFO - 'MOZ_NO_REMOTE': '1', 15:56:26 INFO - 'NO_EM_RESTART': '1', 15:56:26 INFO - 'PAGER': '/bin/cat', 15:56:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:26 INFO - 'PWD': '/builds/slave/test', 15:56:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:26 INFO - 'SHELL': '/bin/bash', 15:56:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uil1AQNF7X/Listeners', 15:56:26 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 15:56:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:26 INFO - 'USER': 'cltbld', 15:56:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:26 INFO - 'XPC_FLAGS': '0x0', 15:56:26 INFO - 'XPC_SERVICE_NAME': '0', 15:56:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:56:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:26 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 15:56:26 INFO - Cleaning up... 15:56:26 INFO - Return code: 0 15:56:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:26 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 0x10aead490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb78b49a520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc1d30>, '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 0x10aae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10acb9b20>, '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.4bYSQP9lHk/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.Uil1AQNF7X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:56:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:56:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:56:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4bYSQP9lHk/Render', 15:56:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:26 INFO - 'HOME': '/Users/cltbld', 15:56:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:26 INFO - 'LOGNAME': 'cltbld', 15:56:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:26 INFO - 'MOZ_NO_REMOTE': '1', 15:56:26 INFO - 'NO_EM_RESTART': '1', 15:56:26 INFO - 'PAGER': '/bin/cat', 15:56:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:26 INFO - 'PWD': '/builds/slave/test', 15:56:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:26 INFO - 'SHELL': '/bin/bash', 15:56:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uil1AQNF7X/Listeners', 15:56:26 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 15:56:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:26 INFO - 'USER': 'cltbld', 15:56:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:26 INFO - 'XPC_FLAGS': '0x0', 15:56:26 INFO - 'XPC_SERVICE_NAME': '0', 15:56:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:56:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:26 INFO - Downloading/unpacking psutil>=3.1.1 15:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:56:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:56:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:56:30 INFO - Installing collected packages: psutil 15:56:30 INFO - Running setup.py install for psutil 15:56:30 INFO - building 'psutil._psutil_osx' extension 15:56:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 15:56:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:56:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:56:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 15:56:31 INFO - building 'psutil._psutil_posix' extension 15:56:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 15:56:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:56:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:56:31 INFO - ^ 15:56:31 INFO - 1 warning generated. 15:56:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 15:56:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:56:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:56:31 INFO - Successfully installed psutil 15:56:31 INFO - Cleaning up... 15:56:31 INFO - Return code: 0 15:56:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aead490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb78b49a520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc1d30>, '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 0x10aae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10acb9b20>, '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.4bYSQP9lHk/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.Uil1AQNF7X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:56:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:56:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:56:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4bYSQP9lHk/Render', 15:56:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:31 INFO - 'HOME': '/Users/cltbld', 15:56:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:31 INFO - 'LOGNAME': 'cltbld', 15:56:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:31 INFO - 'MOZ_NO_REMOTE': '1', 15:56:31 INFO - 'NO_EM_RESTART': '1', 15:56:31 INFO - 'PAGER': '/bin/cat', 15:56:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:31 INFO - 'PWD': '/builds/slave/test', 15:56:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:31 INFO - 'SHELL': '/bin/bash', 15:56:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uil1AQNF7X/Listeners', 15:56:31 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 15:56:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:31 INFO - 'USER': 'cltbld', 15:56:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:31 INFO - 'XPC_FLAGS': '0x0', 15:56:31 INFO - 'XPC_SERVICE_NAME': '0', 15:56:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:56:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:56:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:56:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:56:34 INFO - Installing collected packages: mozsystemmonitor 15:56:34 INFO - Running setup.py install for mozsystemmonitor 15:56:34 INFO - Successfully installed mozsystemmonitor 15:56:34 INFO - Cleaning up... 15:56:34 INFO - Return code: 0 15:56:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:56: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')]} 15:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56: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')]} 15:56:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56: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', '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 0x10aead490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb78b49a520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc1d30>, '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 0x10aae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10acb9b20>, '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.4bYSQP9lHk/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.Uil1AQNF7X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:56: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:56: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 jsonschema==2.5.1 15:56:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4bYSQP9lHk/Render', 15:56:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:34 INFO - 'HOME': '/Users/cltbld', 15:56:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:34 INFO - 'LOGNAME': 'cltbld', 15:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:34 INFO - 'MOZ_NO_REMOTE': '1', 15:56:34 INFO - 'NO_EM_RESTART': '1', 15:56:34 INFO - 'PAGER': '/bin/cat', 15:56:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:34 INFO - 'PWD': '/builds/slave/test', 15:56:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:34 INFO - 'SHELL': '/bin/bash', 15:56:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uil1AQNF7X/Listeners', 15:56:34 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 15:56:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:34 INFO - 'USER': 'cltbld', 15:56:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:34 INFO - 'XPC_FLAGS': '0x0', 15:56:34 INFO - 'XPC_SERVICE_NAME': '0', 15:56:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:34 INFO - Downloading/unpacking jsonschema==2.5.1 15:56: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 15:56: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 15:56: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 15:56: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 15:56: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 15:56: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 15:56:37 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:56:37 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:56: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 15:56: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 15:56: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 15:56: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 15:56: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 15:56: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 15:56:37 INFO - Downloading functools32-3.2.3-2.tar.gz 15:56:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:56:37 INFO - warning: no files found matching '*.txt' 15:56:37 INFO - no previously-included directories found matching 'build' 15:56:37 INFO - no previously-included directories found matching 'dist' 15:56:37 INFO - no previously-included directories found matching '.git*' 15:56:37 INFO - Installing collected packages: jsonschema, functools32 15:56:37 INFO - Running setup.py install for functools32 15:56:38 INFO - warning: no files found matching '*.txt' 15:56:38 INFO - no previously-included directories found matching 'build' 15:56:38 INFO - no previously-included directories found matching 'dist' 15:56:38 INFO - no previously-included directories found matching '.git*' 15:56:38 INFO - Successfully installed jsonschema functools32 15:56:38 INFO - Cleaning up... 15:56:38 INFO - Return code: 0 15:56:38 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10aead490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb78b49a520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc1d30>, '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 0x10aae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10acb9b20>, '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.4bYSQP9lHk/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.Uil1AQNF7X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:56:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:56:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4bYSQP9lHk/Render', 15:56:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:38 INFO - 'HOME': '/Users/cltbld', 15:56:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:38 INFO - 'LOGNAME': 'cltbld', 15:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:38 INFO - 'MOZ_NO_REMOTE': '1', 15:56:38 INFO - 'NO_EM_RESTART': '1', 15:56:38 INFO - 'PAGER': '/bin/cat', 15:56:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:38 INFO - 'PWD': '/builds/slave/test', 15:56:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:38 INFO - 'SHELL': '/bin/bash', 15:56:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uil1AQNF7X/Listeners', 15:56:38 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 15:56:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:38 INFO - 'USER': 'cltbld', 15:56:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:38 INFO - 'XPC_FLAGS': '0x0', 15:56:38 INFO - 'XPC_SERVICE_NAME': '0', 15:56:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:38 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:56:38 INFO - Cleaning up... 15:56:38 INFO - Return code: 0 15:56:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10aead490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb78b49a520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc1d30>, '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 0x10aae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10acb9b20>, '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.4bYSQP9lHk/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.Uil1AQNF7X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:56:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:56:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:56:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4bYSQP9lHk/Render', 15:56:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:38 INFO - 'HOME': '/Users/cltbld', 15:56:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:38 INFO - 'LOGNAME': 'cltbld', 15:56:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:38 INFO - 'MOZ_NO_REMOTE': '1', 15:56:38 INFO - 'NO_EM_RESTART': '1', 15:56:38 INFO - 'PAGER': '/bin/cat', 15:56:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:38 INFO - 'PWD': '/builds/slave/test', 15:56:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:38 INFO - 'SHELL': '/bin/bash', 15:56:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uil1AQNF7X/Listeners', 15:56:38 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 15:56:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:38 INFO - 'USER': 'cltbld', 15:56:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:38 INFO - 'XPC_FLAGS': '0x0', 15:56:38 INFO - 'XPC_SERVICE_NAME': '0', 15:56:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:56:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:38 INFO - Downloading/unpacking blobuploader==1.2.4 15:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:41 INFO - Downloading blobuploader-1.2.4.tar.gz 15:56:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:56:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:56: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 15:56: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 15:56: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 15:56: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 15:56: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 15:56: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 15:56:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:56:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:56: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 15:56: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 15:56: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 15:56: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 15:56: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 15:56: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 15:56:42 INFO - Downloading docopt-0.6.1.tar.gz 15:56:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:56:42 INFO - Installing collected packages: blobuploader, requests, docopt 15:56:42 INFO - Running setup.py install for blobuploader 15:56:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:56:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:56:42 INFO - Running setup.py install for requests 15:56:43 INFO - Running setup.py install for docopt 15:56:43 INFO - Successfully installed blobuploader requests docopt 15:56:43 INFO - Cleaning up... 15:56:43 INFO - Return code: 0 15:56:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:43 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 0x10aead490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb78b49a520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc1d30>, '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 0x10aae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10acb9b20>, '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.4bYSQP9lHk/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.Uil1AQNF7X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:56:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:56:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:56:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4bYSQP9lHk/Render', 15:56:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:43 INFO - 'HOME': '/Users/cltbld', 15:56:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:43 INFO - 'LOGNAME': 'cltbld', 15:56:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:43 INFO - 'MOZ_NO_REMOTE': '1', 15:56:43 INFO - 'NO_EM_RESTART': '1', 15:56:43 INFO - 'PAGER': '/bin/cat', 15:56:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:43 INFO - 'PWD': '/builds/slave/test', 15:56:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:43 INFO - 'SHELL': '/bin/bash', 15:56:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uil1AQNF7X/Listeners', 15:56:43 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 15:56:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:43 INFO - 'USER': 'cltbld', 15:56:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:43 INFO - 'XPC_FLAGS': '0x0', 15:56:43 INFO - 'XPC_SERVICE_NAME': '0', 15:56:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:56:43 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-zjhWzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:56:43 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-ffIDRt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:56:43 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-P2TERu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:56:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:56:43 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-jTI2jr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:56:44 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-ltppM3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:56:44 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-oumb4K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:56:44 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-hMplKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:56:44 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-ldi_Nk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:56:44 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-9SfiUE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:56:44 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-v0sp_l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:56:44 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-rlYqgA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:56:44 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-Erilbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:56:44 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-sJZxMy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:56:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:56:44 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-hYCf0x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:45 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-liXKr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:56:45 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-A9zKsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:56:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:56:45 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-zUu26V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:56:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:56:45 INFO - Running setup.py install for manifestparser 15:56:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:56:45 INFO - Running setup.py install for mozcrash 15:56:45 INFO - Running setup.py install for mozdebug 15:56:45 INFO - Running setup.py install for mozdevice 15:56:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:56:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:56:45 INFO - Running setup.py install for mozfile 15:56:46 INFO - Running setup.py install for mozhttpd 15:56:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:56:46 INFO - Running setup.py install for mozinfo 15:56:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:56:46 INFO - Running setup.py install for mozInstall 15:56:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:56:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:56:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:56:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:56:46 INFO - Running setup.py install for mozleak 15:56:46 INFO - Running setup.py install for mozlog 15:56:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:56:46 INFO - Running setup.py install for moznetwork 15:56:46 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:56:47 INFO - Running setup.py install for mozprocess 15:56:47 INFO - Running setup.py install for mozprofile 15:56:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:56:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:56:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:56:47 INFO - Running setup.py install for mozrunner 15:56:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:56:47 INFO - Running setup.py install for mozscreenshot 15:56:47 INFO - Running setup.py install for moztest 15:56:47 INFO - Running setup.py install for mozversion 15:56:47 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:56:47 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:56:47 INFO - Cleaning up... 15:56:47 INFO - Return code: 0 15:56:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:47 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 0x10aead490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb78b49a520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc1d30>, '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 0x10aae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10acb9b20>, '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.4bYSQP9lHk/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.Uil1AQNF7X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:56:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 15:56:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:56:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4bYSQP9lHk/Render', 15:56:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:47 INFO - 'HOME': '/Users/cltbld', 15:56:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:47 INFO - 'LOGNAME': 'cltbld', 15:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:47 INFO - 'MOZ_NO_REMOTE': '1', 15:56:47 INFO - 'NO_EM_RESTART': '1', 15:56:47 INFO - 'PAGER': '/bin/cat', 15:56:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:47 INFO - 'PWD': '/builds/slave/test', 15:56:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:47 INFO - 'SHELL': '/bin/bash', 15:56:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uil1AQNF7X/Listeners', 15:56:47 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 15:56:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:47 INFO - 'USER': 'cltbld', 15:56:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:47 INFO - 'XPC_FLAGS': '0x0', 15:56:47 INFO - 'XPC_SERVICE_NAME': '0', 15:56:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:56:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:56:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-SqF2f8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 15:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:56:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-HomEuK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:56:48 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)) 15:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:56:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-cLzjUx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:56:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-wkkg5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:56:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-ijPIqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 15:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:56:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-lbQZba-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 15:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:56:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-dbeCVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:56:48 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 15:56:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:56:48 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-seQJ1n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 15:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:56:49 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-FQFf15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 15:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:56:49 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-0m8UTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:56:49 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-gLjpsj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 15:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:56:49 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-s_O4g4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:56:49 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-VAk1vR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 15:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:56:49 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-CgJmzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:56:49 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)) 15:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:49 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-jOcvfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 15:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:56:49 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-jqEiXn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:56:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 15:56:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:56:49 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-gE8KUn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:56:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 15:56:50 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)) 15:56:50 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)) 15:56:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 15:56:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:56:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 15:56:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:56:52 INFO - Downloading blessings-1.6.tar.gz 15:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:56:52 INFO - Installing collected packages: blessings 15:56:52 INFO - Running setup.py install for blessings 15:56:52 INFO - Successfully installed blessings 15:56:52 INFO - Cleaning up... 15:56:52 INFO - Return code: 0 15:56:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:56:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:56:53 INFO - Reading from file tmpfile_stdout 15:56:53 INFO - Current package versions: 15:56:53 INFO - blessings == 1.6 15:56:53 INFO - blobuploader == 1.2.4 15:56:53 INFO - docopt == 0.6.1 15:56:53 INFO - functools32 == 3.2.3-2 15:56:53 INFO - jsonschema == 2.5.1 15:56:53 INFO - manifestparser == 1.1 15:56:53 INFO - mozInstall == 1.12 15:56:53 INFO - mozcrash == 0.17 15:56:53 INFO - mozdebug == 0.1 15:56:53 INFO - mozdevice == 0.48 15:56:53 INFO - mozfile == 1.2 15:56:53 INFO - mozhttpd == 0.7 15:56:53 INFO - mozinfo == 0.9 15:56:53 INFO - mozleak == 0.1 15:56:53 INFO - mozlog == 3.4 15:56:53 INFO - moznetwork == 0.27 15:56:53 INFO - mozprocess == 0.23 15:56:53 INFO - mozprofile == 0.28 15:56:53 INFO - mozrunner == 6.12 15:56:53 INFO - mozscreenshot == 0.1 15:56:53 INFO - mozsystemmonitor == 0.3 15:56:53 INFO - moztest == 0.7 15:56:53 INFO - mozversion == 1.4 15:56:53 INFO - psutil == 3.1.1 15:56:53 INFO - requests == 1.2.3 15:56:53 INFO - wsgiref == 0.1.2 15:56:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:53 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 0x10aead490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb78b49a520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc1d30>, '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 0x10aae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10acb9b20>, '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.4bYSQP9lHk/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.Uil1AQNF7X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:56:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 15:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 15:56:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4bYSQP9lHk/Render', 15:56:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:53 INFO - 'HOME': '/Users/cltbld', 15:56:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:53 INFO - 'LOGNAME': 'cltbld', 15:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:53 INFO - 'MOZ_NO_REMOTE': '1', 15:56:53 INFO - 'NO_EM_RESTART': '1', 15:56:53 INFO - 'PAGER': '/bin/cat', 15:56:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:53 INFO - 'PWD': '/builds/slave/test', 15:56:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:53 INFO - 'SHELL': '/bin/bash', 15:56:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uil1AQNF7X/Listeners', 15:56:53 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 15:56:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:53 INFO - 'USER': 'cltbld', 15:56:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:53 INFO - 'XPC_FLAGS': '0x0', 15:56:53 INFO - 'XPC_SERVICE_NAME': '0', 15:56:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 15:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 15:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 15:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 15:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 15:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 15:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 15:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 15:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 15:56:53 INFO - Cleaning up... 15:56:53 INFO - Return code: 0 15:56:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:56:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:56:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:56:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:56:53 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 0x10aead490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae23570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb78b49a520>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10acc1d30>, '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 0x10aae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10acb9b20>, '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.4bYSQP9lHk/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.Uil1AQNF7X/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 15:56:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 15:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 15:56:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4bYSQP9lHk/Render', 15:56:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:56:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:56:53 INFO - 'HOME': '/Users/cltbld', 15:56:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:56:53 INFO - 'LOGNAME': 'cltbld', 15:56:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:56:53 INFO - 'MOZ_NO_REMOTE': '1', 15:56:53 INFO - 'NO_EM_RESTART': '1', 15:56:53 INFO - 'PAGER': '/bin/cat', 15:56:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:56:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:56:53 INFO - 'PWD': '/builds/slave/test', 15:56:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:56:53 INFO - 'SHELL': '/bin/bash', 15:56:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uil1AQNF7X/Listeners', 15:56:53 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 15:56:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:56:53 INFO - 'USER': 'cltbld', 15:56:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:56:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:56:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:56:53 INFO - 'XPC_FLAGS': '0x0', 15:56:53 INFO - 'XPC_SERVICE_NAME': '0', 15:56:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:56:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:56:53 INFO - Cleaning up... 15:56:53 INFO - Return code: 0 15:56:53 INFO - Running post-action listener: _resource_record_post_action 15:56:53 INFO - Running post-action listener: _start_resource_monitoring 15:56:53 INFO - Starting resource monitoring. 15:56:53 INFO - [mozharness: 2016-10-22 22:56:53.749562Z] Finished create-virtualenv step (success) 15:56:53 INFO - [mozharness: 2016-10-22 22:56:53.750530Z] Running install step. 15:56:53 INFO - Running pre-action listener: _resource_record_pre_action 15:56:53 INFO - Running main action method: install 15:56:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:56:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:56:54 INFO - Reading from file tmpfile_stdout 15:56:54 INFO - Detecting whether we're running mozinstall >=1.0... 15:56:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:56:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:56:54 INFO - Reading from file tmpfile_stdout 15:56:54 INFO - Output received: 15:56:54 INFO - Usage: mozinstall [options] installer 15:56:54 INFO - Options: 15:56:54 INFO - -h, --help show this help message and exit 15:56:54 INFO - -d DEST, --destination=DEST 15:56:54 INFO - Directory to install application into. [default: 15:56:54 INFO - "/builds/slave/test"] 15:56:54 INFO - --app=APP Application being installed. [default: firefox] 15:56:54 INFO - mkdir: /builds/slave/test/build/application 15:56:54 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'] 15:56:54 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 15:57:28 INFO - Reading from file tmpfile_stdout 15:57:28 INFO - Output received: 15:57:28 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 15:57:28 INFO - Running post-action listener: _resource_record_post_action 15:57:28 INFO - [mozharness: 2016-10-22 22:57:28.147018Z] Finished install step (success) 15:57:28 INFO - [mozharness: 2016-10-22 22:57:28.147113Z] Running run-tests step. 15:57:28 INFO - Running pre-action listener: _resource_record_pre_action 15:57:28 INFO - Running main action method: run_tests 15:57:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:57:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:57:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:57:28 INFO - 2016-10-22 15:57:28.159 screenresolution[1645:8727] starting screenresolution argv=screenresolution get 15:57:28 INFO - 2016-10-22 15:57:28.162 screenresolution[1645:8727] Display 0: 1600x1200x32@60 15:57:28 INFO - 2016-10-22 15:57:28.167 screenresolution[1646:8729] starting screenresolution argv=screenresolution list 15:57:28 INFO - Available Modes on Display 0 15:57:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:57:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:57:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:57:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:57:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:57:28 INFO - Intel Iris: 15:57:28 INFO - Chipset Model: Intel Iris 15:57:28 INFO - Type: GPU 15:57:28 INFO - Bus: Built-In 15:57:28 INFO - VRAM (Dynamic, Max): 1536 MB 15:57:28 INFO - Vendor: Intel (0x8086) 15:57:28 INFO - Device ID: 0x0a2e 15:57:28 INFO - Revision ID: 0x0009 15:57:28 INFO - Displays: 15:57:28 INFO - Display: 15:57:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:57:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:57:28 INFO - Display Serial Number: 1600x1200 60 15:57:28 INFO - Main Display: Yes 15:57:28 INFO - Mirror: Off 15:57:28 INFO - Online: Yes 15:57:28 INFO - Rotation: Supported 15:57:28 INFO - Return code: 0 15:57:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:57:28 INFO - Python 2.7.3 15:57:28 INFO - Return code: 0 15:57:28 INFO - grabbing minidump binary from tooltool 15:57: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')]} 15:57:28 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 0x10acc1d30>, '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 0x10aae7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10acb9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:57:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 15:57:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 15:57:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 15:57:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:57:28 INFO - Return code: 0 15:57:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:57:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:57:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:57:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:57:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:57:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O5GZ3Z7YTlW8SQfj_6JJBA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0178', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O5GZ3Z7YTlW8SQfj_6JJBA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0178 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:57:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4bYSQP9lHk/Render', 15:57:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:57:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:57:28 INFO - 'HOME': '/Users/cltbld', 15:57:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:57:28 INFO - 'LOGNAME': 'cltbld', 15:57:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:57:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:57:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:57:28 INFO - 'MOZ_NO_REMOTE': '1', 15:57:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:57:28 INFO - 'NO_EM_RESTART': '1', 15:57:28 INFO - 'PAGER': '/bin/cat', 15:57:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:57:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:57:28 INFO - 'PWD': '/builds/slave/test', 15:57:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:57:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:57:28 INFO - 'SHELL': '/bin/bash', 15:57:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Uil1AQNF7X/Listeners', 15:57:28 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 15:57:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:57:28 INFO - 'USER': 'cltbld', 15:57:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:57:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:57:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:57:28 INFO - 'XPC_FLAGS': '0x0', 15:57:28 INFO - 'XPC_SERVICE_NAME': '0', 15:57:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:57:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O5GZ3Z7YTlW8SQfj_6JJBA/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0178', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:57:28 INFO - mozversion application_buildid: 20161022140222 15:57:28 INFO - mozversion application_changeset: 60dd82380d43a2b681f50842238f829204486290 15:57:28 INFO - mozversion application_display_name: Nightly 15:57:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:57:28 INFO - mozversion application_name: Firefox 15:57:28 INFO - mozversion application_remotingname: firefox 15:57:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 15:57:28 INFO - mozversion application_vendor: Mozilla 15:57:28 INFO - mozversion application_version: 52.0a1 15:57:28 INFO - mozversion platform_buildid: 20161022140222 15:57:28 INFO - mozversion platform_changeset: 60dd82380d43a2b681f50842238f829204486290 15:57:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 15:57:28 INFO - mozversion platform_version: 52.0a1 15:57:28 INFO - using testdate: 1477177048 15:57:28 INFO - actual date: 1477177048 15:57:28 INFO - starting webserver on 'localhost:49272' 15:57:28 INFO - SUITE-START | Running 2 tests 15:57:28 INFO - TEST-START | dromaeo_css 15:57:28 INFO - operating with platform_type : mac_ 15:57:28 INFO - Initialising browser for dromaeo_css test... 15:57:28 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpHblvgH/profile http://localhost:49272/getInfo.html) 15:57:31 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 15:57:31 INFO - PROCESS | 1656 | colorDepth:24 15:57:31 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 15:57:31 INFO - PROCESS | 1656 | __metrics 15:57:31 INFO - PROCESS | 1656 | 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" 15:57:31 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:57:31 INFO - TEST-INFO | 1656: exit 0 15:57:31 INFO - Browser initialized. 15:57:31 INFO - Running cycle 1/1 for dromaeo_css test... 15:57:31 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpHblvgH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:57:43 INFO - PROCESS | 1659 | RSS: Main: 238772224 15:57:43 INFO - PROCESS | 1659 | 15:58:35 INFO - PROCESS | 1659 | 1477177115429 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] 16:00:47 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 16:00:49 INFO - PROCESS | 1659 | RSS: Main: 379727872 16:00:49 INFO - PROCESS | 1659 | 16:03:52 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 16:03:53 INFO - PROCESS | 1659 | RSS: Main: 369180672 16:03:53 INFO - PROCESS | 1659 | 16:06:55 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 16:06:55 INFO - PROCESS | 1659 | RSS: Main: 333160448 16:06:55 INFO - PROCESS | 1659 | 16:09:58 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 16:09:58 INFO - PROCESS | 1659 | RSS: Main: 339976192 16:09:58 INFO - PROCESS | 1659 | 16:13:01 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 16:13:02 INFO - PROCESS | 1659 | RSS: Main: 332300288 16:13:02 INFO - PROCESS | 1659 | 16:16:05 INFO - PROCESS | 1659 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 16:16:06 INFO - PROCESS | 1659 | RSS: Main: 436490240 16:16:06 INFO - PROCESS | 1659 | 16:16:06 INFO - PROCESS | 1659 | __start_tp_report 16:16:06 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 16:16:06 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 16:16:06 INFO - PROCESS | 1659 | |i|pagename|runs| 16:16:06 INFO - PROCESS | 1659 | |0;dojo.html;3290.9177270568234;3305.5372247885284;3332.383509050824;3332.7167190788773;3376.679215474531;5441.455854414557;5584.469475399841;5616.6630002199845;5625.1281051437045;5650.434956504348;5575.944240557593;5576.749046292916;5652.463016013482;5666.971665141668;5673.461021202979;5020.778559918579;5099.694018358892;5118.104331741949;5159.200323949775;5184.196449550326;5241.764120614563;5257.684538927658;5267.104592219332;5270.947290527103;5307.363116426015;4299.763513006784;5074.59403247743;5224.76488558012;5264.763085661154;5326.573874090063;5130;5159.484051594848;5164.509371609691;5167.9224811627855;5180.119379705459;5070.569001634865;5098.158803797369;5129.717865517395;5131.666441681279;5135.332406787131;4648.976755116237;5568.331800183963;5582.190582365534;5612.326520817487;5618.971905140489;6133;6143.9385606143815;6149.477294429978;6154.63072215664;6155.938440615581;6090.147379366892;6171.59884607499;6174.259088909314;6185.381461853824;6205.472534834545;5594.664320140804;5606.103023516259;5674.914876276859;5705.828825135252;5712.857178570527;6197.845053873599;6230.470410015108;6271.372862713783;6271.686415679198;6291.213598300213;6062.393760623902;6095.076823467959;6105.419985101408;6116.733149278846;6147.924113280158;6151.692415379213;6167.938320616826;6169.660668663267;6177.227846519185;6181.81454556364;5602.803901863415;5865;5931.40685931412;5942.792002279986;6109.450149486479;6135.509159267248;6166;6168.1056246843955;6173.969130154321;6186.597871138361;4845.127876982177;4860.6111511079025;4860.927086093711;4877.414710234794;4932.038252540792;4336.132773445261;4337.9132417351475;4338.566143385699;4344.4352234209355;4396.340548917688;5613.522850557667;5634.971825140848;5682.204491371212;5688.459596338341;5728.828135155952;5479.232907392969;6204.317525072239;6211.689415529296;6218.440340369298;6230;5307.310049693515;5624.240727501735;5652.265205523256;5652.293463317085;5656;4067.6949228807957;5201.3238279024245;5233.084210263265;5273.736313184326;5286.762095705625;6188.535859810622;6213.068039793977;6236.158118654105;6236.937630623635;6256.624602523863;6172.845678857885;6179.011358182669;6192.040233763774;6196.876062478635;6207.596506227081;6121.0262130506535;6231.2522497300615;6237.002079667232;6237.781677641442;6238.875222495615;6045.969770151121;6095.908561371672;6107.480864126599;6117.979653188298;6125.265974675666;6162.845928851814;6177.227846519185;6177.876442471215;6188.535859810442;6203.348648392034;5764.567657425794;5958.994444666501;5969.462748352669;5970.432808883149;5997.640141591519;5055.191169412877;5830.708464576839;5902.144189092472;5929.822105336847;5951.672658003678;5764.913526297025;5782.595218334676;5794.652320860761;5802.390748971297;5836.416358364129;4864.659473836798;5898.321693005188;5906.852328691817;5907.734151963086;5910.52715782745;5684;5684.8294551163535;5746.195532625519;5751.511121554715;5779.190913272061 16:16:06 INFO - PROCESS | 1659 | |1;ext.html;466.4519189951808;483.3885135303841;499.3608181527641;521.8232884844675;538.7414041260195;20991;31341.84329078357;33644.9906502805;39663;42256;40886.79556602213;41316.79341603295;41916.79041604795;41995.16009679812;42139;9548.665796697116;9590.80818383632;9737.707868763948;9743.171830394425;9753.219742420624;9618.951905240465;9724.465154416504;9728.854067188999;9743.951280243624;9754.561044752967;8249.546274954875;9707.223422126248;9735.56189971453;9770;9783.217342612574;9667.419954802699;9748.31761776676;9748.463834489101;9771.90228097717;9778.364406313567;9484.478353690543;9559.61761529538;9560.043995600454;9570.47362395068;9581.377210481296;39145.60854391448;39529.80235098806;39586;39638.801805990784;39829.60170398288;3383.9171465131167;3411.6417776133644;3424.366492198926;3568.660977207161;3785.6025117362556;28847.56728649072;29321.56017659737;29819;30886;31302.686973130432;3021.471242532548;3158.1630867820045;3171.984140079308;3181.7252708355118;3304.9008529744146;431941;437617.8119109416;437673;438626;441512;60402.0939685905;61000.77998440006;61122.38877611167;61149;61173.38826611766;33366;34213.65786342155;34247;35009;35346;13524;15756;16100.436484722979;16134.435294764628;16158.868879178344;12381.380930953597;12469.501219951282;12496.87503124957;12500.687482813002;12521.56174533887;15688.450904218298;18952.62094758097;18955.431337059912;18983.81016189848;18998.43004709861;7029.713840840815;7712.768616941501;7892.250236227549;8012.197255617556;8113.959430202811;917.9678711245074;972.2707969023232;985.7289245457556;1078.487718333785;1121.6915348279288;29748.702512974593;29866.253343666584;30469.542956855665;30492.23769405738;30660.773569056986;1052;1136.4829002803704;1169.7777422289737;1186.4660902593866;1237.4431505822236;15303.693926121638;15608.687826243411;15612.843871561367;15996.280167392495;16001.599960001093;616531.3468653099;620124;620974;621021;622736;56869.862602747715;57386;57502.424975750546;57538;57551.71224143852;1245;1280.481405030964;1338.7924871644911;1398.9650258743409;1415.7470638485015;22669.546609068057;22936.885315573316;30892.845535773078;31250.87449279458;32259.838700806347;47570;48026.519734802205;48097.519024809306;48183.75908120437;48205.5179448201;464311;465699;468307;468392;468456.20806543215;22767.658485122403;23344;25120.74879251184;25219.621705674064;25746.227613171635;46305.53694463147;46366.07267854556;46428.767856160506;47055.52944470511;47215.055698885146;38044.61955380411;38155;38309.42535861908;38508.614913850506;39768.801155994035;32019.199520012186;37334;37477;38211;39343.80328098341;37045;37838.43242351312;38261;38420.6157938417;39061.41407878827;32250.838745806122;33189.01305857699;33587.824426144965;33699.494507582895;33700.32599348048;24521.509569808146;25011.499770004863;25197.370065748502;25829.483410332065;25893.87053064798 16:16:06 INFO - PROCESS | 1659 | |2;jquery.html;335.84383261783273;370.11542413631423;374.1656106881653;386.06572095528816;396.6237157064985;19719.408417747472;20360.69458958117;20899.68650470244;21309.25417610384;21504.569908601818;11826.467808948597;12010.579629712962;16775;20212.595748085067;20977.37067887962;5121.15500942345;5373.75818088185;5378.2470454136455;5378.731063446812;5385.3268341457315;4692.897169165243;4850.927236091461;5261.973690131544;5366.838994830142;5368.194770784394;5254.054270231357;5262.368515778093;5270.789168433258;5364.034473794715;5364.651297665659;5079.695218286896;5267.209918512254;5305.071612467803;5372.435894231088;5372.985130576034;4320.9135817283795;5108.233764935252;5171.405288391846;5233.162693968985;5238.13570760824;13153.934230328883;13423.463061477529;13604.115732477456;13604.183748974994;13630.318484075757;2015.7177995080701;2055.3011975928257;2099.4121645939163;2173.9021744021557;2465.8767061646845;9496.192823609932;10207.234457415723;10341.689749307458;10372.429516376596;10514.894851051467;1742.311786844202;1835.3484512997827;1838.6598479281377;1894.1476335649013;1921.3947606504046;98135;116195.41902290519;126397.36801316026;130405;135064.32467837696;10776.19178561611;11243.212975091665;11294.830577541343;11348.262362946381;11553.191276610725;14200.431982720576;14531.273436328142;14533.055351402125;14545.200013999332;14594.562163135122;8161.224683655043;8431.662733490715;8452.408331416742;8561;8577.571121443903;8374.232824692328;8387;8402.11777763326;8507.234348908629;8579.785505362292;3680.3375392429084;4394.670399720034;4547.136044151601;4580.106879158532;4675.766211689402;1596.8243493215737;1707.1549582956516;1827.7075667893073;1895.1945423195086;1905.5426697592477;755.4183278875236;925.0564424287189;966.1690945786618;985.8176237396104;1012.5645972232011;19877.701834472493;21224.04491797873;21553.24563640265;21559.35321940344;21652.675209871864;915.1306259053925;930.776613612728;937.3813283233034;938.8826396700413;953.8473844184897;8940.821183576421;9482.146606805421;10535;11391.715207119889;11392.544298227978;377485;381385;383779;530418;534641;89502.55248723846;115962;125702;138657.61342386648;148380;934.5794392523392;935.5836652689488;981.9312648114563;986.3835103060587;986.4032260482448;18739.063046847878;18850.622987540446;19083;19154.138063787443;19325.903370483058;55802.325930222156;55928;56552.434475654714;57439.42560574341;57630;79157;79724;80612;82695;84364.57817711118;7553.848923021619;7777.4166937478785;7938.166492518433;8138.796530086795;8165.265126138676;11861.40692965331;12294.262344259372;12570.1200915935;12617.558385456465;13073.280969546766;10684.679459616224;10910.23628346008;11113.777724445628;11120.833187502032;11205.495752690986;9644.913627639087;10552.99746524079;10818.567257309935;10949.83575246356;11526.538938442369;9860.901390985999;11304.43477826089;11535.596254131066;11648.825267621161;11911.404429778304;6911.654417279216;7237.3486386223385;7260.67326970277;7805.921940780519;8367.205115514016;11016.504257308601;11323.433828308716;11451.969322760991;11546.94226528862;11547.538098476303 16:16:06 INFO - PROCESS | 1659 | |3;mootools.html;1504.2478760619688;1543.328652036364;1751.2032025428432;1884.9717254241198;1932.6134773045394;8545.914540854597;8935.508547029911;8948.28413726902;8964.596593153308;8971.147740964607;7813.453058285922;8086.959565202165;8435.62039708213;8698.217160455557;8709.172628600272;2284.45173158442;2315.0855412112205;2317.7682231776857;2319.698439202901;2321.628539433691;2262.988685056572;2271.375371772759;2299.954000919989;2302.6085565453914;2305;1717.5706073481629;2005.4384772263788;2078.7817279185692;2079.9584008319825;2083.0626218201796;2077.418322869599;2230.4646884747626;2291.1522736587403;2296.5751336002895;2297.023764899911;2249.280230326296;2273.897674604647;2277.544491101786;2281.4296425893526;2296.7358753743365;8831.425957312755;8898.555072246361;8903.55482225886;8910.465372077631;8921.910780892173;5071.923921141186;5210.166373380241;5275.340582427197;5289.709066001368;5293.841184764463;3382.797032178077;3504.2641045380246;3566.4115420955513;3578.9284214315567;3590.6588874056924;1013.2856336282903;1030.8969103089705;1043.4939054558533;1052.9315594486334;1073.983890241647;11480.253783504046;11532;11543.480543375568;11544.480498377594;11545.191836571443;4373.978130109329;4469.307257375112;4688.390509233778;4708.128996135726;4725.173094708481;9854.260930430102;9866.851997220047;9875.802483950281;9876.962918893556;9903.900960990442;4470.485894122217;5266.657667251617;5268.631195816256;5275.815346462932;5278.129108697099;4658.534146585314;4756.7859446325;4803.087413391444;4815.2054910940005;4834.7824347904425;3801.1447424329303;3808.562015368268;3878.166194268246;3896.357101078347;3913.1195481016543;1240.3550153919912;1251.9186252893533;1256.723520825417;1270.3521204185747;1276.8403949506312;566.4477134793543;780.3484090784145;889.9911000890038;902.6389444222232;930.3534043839602;4875.926861097087;5800.9419905800405;5894.115882617556;5940.168376427304;5973.940260597426;934.4533447933036;941.9481928493999;944.5418971798672;962.6341990043738;989.5349185882624;3860.1696602811717;3919.7060220483577;4008.4588580541836;4046.7167298288837;4079.653229475528;10444.73888152787;10673.83989240162;10746;10779.568817247378;10809.405482698527;8922.55387230649;10570.101541368917;10616.416097114732;10722.678319650424;10726.51730672106;7744.3417309528195;7825.530468171928;7965.123836377994;7975.5613441261285;7985.760427187193;5263.894722105613;5778.393268706725;5812.82561523155;5860.179574859609;6015.308239552332;10048.447335396331;10058.798824023625;10061.346012509164;10079.748006299607;10081.445520496443;9548.856767148638;10045.748856278651;10070.647527336509;10166.8474972874;10187.949060254652;7308.378787803096;7502.324790768857;7509.324160825334;7511.3615342696485;7520.811979700551;6946.895796562954;8156.673733050611;8231.670733170606;8301.501909885426;8320.70877519284;7450.8882366763455;7494.362979146834;7574.128975167926;7592.354649854824;7653.693852245848;7135.42916566663;7313.75218829025;7351.338379545653;7440.3675687565;7557.622118894144;6556.541042127005;6807.217170025312;6930.965345173242;6935.167779866449;6951.721931122901;4847.684900481458;4940.827071052496;4978.900421991468;4986.9251961221335;5121.411037730709;4908.141075311734;4959.504049595012;5059.974700126476;5071.2139618359215;5120.974395128001 16:16:06 INFO - PROCESS | 1659 | |4;prototype.html;281.53125046797084;296.3923955890424;297.418546741121;305.44561620658504;311.517148419949;5126.154184559543;5143.3827940647125;5191.676122588739;5223.895522089556;5230.718473973877;4627.791749371278;4843.824124241593;4918.729469879156;5049.772760225789;5136.049830781308;3820.808959552025;4104.199681062194;4106.8562600309;4110.219058378913;4130.772807495587;3804.9619503805025;4042.8989275268204;4119.40268661044;4132.008318003673;4140.917181656365;4023.577524359944;4030.5969403059607;4040.717149799515;4056.7282321899684;4095.0581366285774;3853.6724378427725;4001.339778936472;4009.694425705231;4016.919661606766;4046.413270075852;3462.8614855406004;3474.4961980512685;3479.80861052642;3486.5293185419896;3495;4116.629503344683;4409.4488188976375;5159.509846564571;5184.8963020739375;5218.425973142951;3835.789031603261;3923.881693717277;4352.238358287287;4585.518520555327;4652.464966528859;4129.380592911058;5332.866678333034;5610.971945140289;5621.7751289948765;5664.461876121762;3182.554442378069;3782.678472329855;3784.6972242220554;3829.3872980323013;3839.36650452675;5185.936882938989;5555.30558680165;5912.556558258148;5986.730597123096;5987.970060149715;3532.0640030391965;3768.2275133597545;3831.329517334511;3866.5360156781367;3867.0719027433215;3161.9723589833397;3600.8199590020918;3799.7910114943943;3815.5802861685193;3859.710521710883;3658.853645854136;3847.826847791856;4298.247806633826;4571.428571428572;4616.192166370872;4709.458412282563;4883.560479556857;5463.399026107125;5488.588355873326;5677.630953987978;1218.9085818563642;1232.5870833270956;1250;1324.1525423728822;1336.6190635668981;791.3155120820448;802.430274505108;858.4463021351194;894;898.9505577193187;4620.422447194101;4625.583697467244;4760.880977975578;5243.329669231553;5276.208568714646;4735.679517036628;5665.49010589049;5751.194832723422;5751.741171647286;5790.957627626984;4975.4527002029745;5237.198099017084;5278.630495865253;5312.548433383128;5317.431357749473;2271.7841805028497;2548.789325070614;2555.93928519666;2558.5522533556928;2578.581780020981;4414.627571954779;4434.977825110854;4882.706082888038;5054.82308119214;5072.239164125411;4294.828206871753;4316.913661726748;4377.694840395481;4949.7772600233075;5019.7239151847;3950.683945284428;4836.854894353175;4843.394575677969;4847.4793107583855;4973.651844370859;4035.878923632296;4145.79271036441;4844.539768721966;4856;4866.489018653132;3817.8854634361014;4142.212979533879;4259.74441533509;4520.276311254813;4708.693934894221;4778.307145463818;5054.064997975386;5098.719570423662;5105.7191854448365;5137.8201762938115;3126.717496227812;3221.6778322168534;3561.8753343632848;3649.872254471081;3719.739618226806;4919.852404427873;4977.726225057657;5107.846764597068;5474.644148130359;5809.477147056785;5205.245239440335;5664.742772905678;5691.8861622768145;5696.20253164549;5696.54427645779;4744.4069491313585;5156.9742151289;5281.573975026645;5289.80979279659;5617.775288988395;4785.325136202301;4799.808007679793;5182.818601348935;5503.651605356713;5527.5577953762795;4288.356746488052;5585.357683866245;5590.813236455181;5594.832155035356;5672.829815105553;4604.746738929391;5487.122060470306;5598.720063996702;5607.327120745536;5621.297337832771 16:16:06 INFO - PROCESS | 1659 | |5;yui.html;718.3534818663203;745.8471013442241;781.2383670430575;781.5154604145431;828.6685325869653;15200.847991520082;15950.601234969132;15979;16022.839771602281;16372.263248153831;13985.230812305319;14248.71502569948;14366.425342986295;14515.854841451583;14569.562913112624;701.6877489517167;723.8009547374488;884.6815146547237;886.0961818944705;907.3648446087765;894.0969620683125;895.8924929008529;903.1329923273665;903.661127077346;905.1988989744058;957.5164541906328;960.6589660670467;963.5230560872378;963.8072385522888;963.9277054220927;957.966471173509;958.147248948433;958.7842735384553;959.1607343574373;960.001598337728;544.6949708163402;563.890041441919;679.8708245433352;702.8313204830855;709.6558169287891;15101.32044058009;15135.621609459742;15146.31841567121;15150.31823567942;15186.696266074727;13455.730885382238;13880.791788123086;13963.700964614154;13981.370838312301;14019.228942408163;12188.232706257631;12572.371381430892;12573.93713031429;12640;12994.610161695164;4418.80115394808;4420.400931658488;4535.183666939949;4587.472440669332;4590.242609969351;77290.49456611222;105548;107303;108195.45902270517;109453;8565;10950.780984380268;11068.28056176346;11090.722731931604;11278.887211127783;21728.130874764833;21731.891340543196;21747.23884664029;21762.455938601346;21792.673109903364;7755.185705500954;8028.076771171273;8051.866255442313;8162.469439486415;8173.182681731898;4304.82780688769;4446.355278484666;4540.6821522493765;4593.63250939924;4615.330777037378;3359.6472370401243;3398.1674489749676;3464.6015708193377;3467.09855437588;3472.5138480612736;628.3151365012068;639.0956796133512;642.1074706158444;657.3360905485398;660.5541259649717;517.7721802406929;560.590115858616;597.1729155120103;604.6402390577599;635.3392471829246;7679;8554.957225213833;8758.47449153053;8870.112988701207;8880.911190888137;498.28496108085017;591.5681552466638;604.283923550594;605.794030029792;610.9064774054393;4225.514065882401;4368.650507959355;4378.956210437855;4397.31841564558;4515.616172625364;72713;120827;143073.28463357617;144744.27627862003;147587;112059;116627;117844;119019;120035;98841.50579247202;99332;101087.49456252818;103118.48440757749;104896.42655360328;9493.857592135986;9794.118529332394;9828.31201815866;9961.302708810603;10088.747781305527;50692;59571.70214148902;59735.40264597299;59990.10014849868;63060.36939630545;56359.43640563706;56719.71640141938;60866;75675;80072.39855202747;13235.139715918434;13355.933220334226;13396.531121410704;13761.449542018207;13986.090904091201;14836.62908427298;14884.925575372054;15107.54677359681;15525.922370388076;15911.522654320388;14049.578512644637;14213.289335533389;14640.34118464693;14735.926320368759;14779.630509236926;13718.245496497788;13878.791818122534;14264.286785660883;14272.643183920485;14283.571492855232;13564.660883477598;13572.1856688599;13673.86326136726;13857.03000789935;14498.710025799635;8502.427050995586;9478.526073696425;10224.64213752515;11175.38535380562;11775.17573769862;10081;10612.946935265274;11502.769944601228;11711.472983715923;11792.351420671945 16:16:06 INFO - PROCESS | 1659 | __end_tp_report 16:16:06 INFO - PROCESS | 1659 | __start_cc_report 16:16:06 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,1499 16:16:06 INFO - PROCESS | 1659 | __end_cc_report 16:16:06 INFO - PROCESS | 1659 | __startTimestamp1477178166248__endTimestamp 16:16:06 INFO - PROCESS | 1659 | 16:16:06 INFO - PROCESS | 1659 | ------- Summary: start ------- 16:16:06 INFO - PROCESS | 1659 | Number of tests: 6 16:16:06 INFO - PROCESS | 1659 | 16:16:06 INFO - PROCESS | 1659 | [#0] dojo.html Cycles:165 Average:5622.82 Median:5751.51 stddev:649.33 (11.3%) stddev-sans-first:625.02 16:16:06 INFO - PROCESS | 1659 | Values: 3290.9 3305.5 3332.4 3332.7 3376.7 5441.5 5584.5 5616.7 5625.1 5650.4 5575.9 5576.7 5652.5 5667.0 5673.5 5020.8 5099.7 5118.1 5159.2 5184.2 5241.8 5257.7 5267.1 5270.9 5307.4 4299.8 5074.6 5224.8 5264.8 5326.6 5130.0 5159.5 5164.5 5167.9 5180.1 5070.6 5098.2 5129.7 5131.7 5135.3 4649.0 5568.3 5582.2 5612.3 5619.0 6133.0 6143.9 6149.5 6154.6 6155.9 6090.1 6171.6 6174.3 6185.4 6205.5 5594.7 5606.1 5674.9 5705.8 5712.9 6197.8 6230.5 6271.4 6271.7 6291.2 6062.4 6095.1 6105.4 6116.7 6147.9 6151.7 6167.9 6169.7 6177.2 6181.8 5602.8 5865.0 5931.4 5942.8 6109.5 6135.5 6166.0 6168.1 6174.0 6186.6 4845.1 4860.6 4860.9 4877.4 4932.0 4336.1 4337.9 4338.6 4344.4 4396.3 5613.5 5635.0 5682.2 5688.5 5728.8 5479.2 6204.3 6211.7 6218.4 6230.0 5307.3 5624.2 5652.3 5652.3 5656.0 4067.7 5201.3 5233.1 5273.7 5286.8 6188.5 6213.1 6236.2 6236.9 6256.6 6172.8 6179.0 6192.0 6196.9 6207.6 6121.0 6231.3 6237.0 6237.8 6238.9 6046.0 6095.9 6107.5 6118.0 6125.3 6162.8 6177.2 6177.9 6188.5 6203.3 5764.6 5959.0 5969.5 5970.4 5997.6 5055.2 5830.7 5902.1 5929.8 5951.7 5764.9 5782.6 5794.7 5802.4 5836.4 4864.7 5898.3 5906.9 5907.7 5910.5 5684.0 5684.8 5746.2 5751.5 5779.2 16:16:06 INFO - PROCESS | 1659 | 16:16:06 INFO - PROCESS | 1659 | [#1] ext.html Cycles:180 Average:63902.57 Median:38464.62 stddev:137335.47 (357.0%) stddev-sans-first:137638.14 16:16:06 INFO - PROCESS | 1659 | Values: 466.5 483.4 499.4 521.8 538.7 20991.0 31341.8 33645.0 39663.0 42256.0 40886.8 41316.8 41916.8 41995.2 42139.0 9548.7 9590.8 9737.7 9743.2 9753.2 9619.0 9724.5 9728.9 9744.0 9754.6 8249.5 9707.2 9735.6 9770.0 9783.2 9667.4 9748.3 9748.5 9771.9 9778.4 9484.5 9559.6 9560.0 9570.5 9581.4 39145.6 39529.8 39586.0 39638.8 39829.6 3383.9 3411.6 3424.4 3568.7 3785.6 28847.6 29321.6 29819.0 30886.0 31302.7 3021.5 3158.2 3172.0 3181.7 3304.9 431941.0 437617.8 437673.0 438626.0 441512.0 60402.1 61000.8 61122.4 61149.0 61173.4 33366.0 34213.7 34247.0 35009.0 35346.0 13524.0 15756.0 16100.4 16134.4 16158.9 12381.4 12469.5 12496.9 12500.7 12521.6 15688.5 18952.6 18955.4 18983.8 18998.4 7029.7 7712.8 7892.3 8012.2 8114.0 918.0 972.3 985.7 1078.5 1121.7 29748.7 29866.3 30469.5 30492.2 30660.8 1052.0 1136.5 1169.8 1186.5 1237.4 15303.7 15608.7 15612.8 15996.3 16001.6 616531.3 620124.0 620974.0 621021.0 622736.0 56869.9 57386.0 57502.4 57538.0 57551.7 1245.0 1280.5 1338.8 1399.0 1415.7 22669.5 22936.9 30892.8 31250.9 32259.8 47570.0 48026.5 48097.5 48183.8 48205.5 464311.0 465699.0 468307.0 468392.0 468456.2 22767.7 23344.0 25120.7 25219.6 25746.2 46305.5 46366.1 46428.8 47055.5 47215.1 38044.6 38155.0 38309.4 38508.6 39768.8 32019.2 37334.0 37477.0 38211.0 39343.8 37045.0 37838.4 38261.0 38420.6 39061.4 32250.8 33189.0 33587.8 33699.5 33700.3 24521.5 25011.5 25197.4 25829.5 25893.9 16:16:06 INFO - PROCESS | 1659 | 16:16:06 INFO - PROCESS | 1659 | [#2] jquery.html Cycles:180 Average:30278.04 Median:2025.23 stddev:76810.46 (3792.7%) stddev-sans-first:76993.03 16:16:06 INFO - PROCESS | 1659 | Values: 335.8 370.1 374.2 386.1 396.6 19719.4 20360.7 20899.7 21309.3 21504.6 11826.5 12010.6 16775.0 20212.6 20977.4 5121.2 5373.8 5378.2 5378.7 5385.3 4692.9 4850.9 5262.0 5366.8 5368.2 5254.1 5262.4 5270.8 5364.0 5364.7 5079.7 5267.2 5305.1 5372.4 5373.0 4320.9 5108.2 5171.4 5233.2 5238.1 13153.9 13423.5 13604.1 13604.2 13630.3 2015.7 2055.3 2099.4 2173.9 2465.9 9496.2 10207.2 10341.7 10372.4 10514.9 1742.3 1835.3 1838.7 1894.1 1921.4 98135.0 116195.4 126397.4 130405.0 135064.3 10776.2 11243.2 11294.8 11348.3 11553.2 14200.4 14531.3 14533.1 14545.2 14594.6 8161.2 8431.7 8452.4 8561.0 8577.6 8374.2 8387.0 8402.1 8507.2 8579.8 3680.3 4394.7 4547.1 4580.1 4675.8 1596.8 1707.2 1827.7 1895.2 1905.5 755.4 925.1 966.2 985.8 1012.6 19877.7 21224.0 21553.2 21559.4 21652.7 915.1 930.8 937.4 938.9 953.8 8940.8 9482.1 10535.0 11391.7 11392.5 377485.0 381385.0 383779.0 530418.0 534641.0 89502.6 115962.0 125702.0 138657.6 148380.0 934.6 935.6 981.9 986.4 986.4 18739.1 18850.6 19083.0 19154.1 19325.9 55802.3 55928.0 56552.4 57439.4 57630.0 79157.0 79724.0 80612.0 82695.0 84364.6 7553.8 7777.4 7938.2 8138.8 8165.3 11861.4 12294.3 12570.1 12617.6 13073.3 10684.7 10910.2 11113.8 11120.8 11205.5 9644.9 10553.0 10818.6 10949.8 11526.5 9860.9 11304.4 11535.6 11648.8 11911.4 6911.7 7237.3 7260.7 7805.9 8367.2 11016.5 11323.4 11452.0 11546.9 11547.5 16:16:06 INFO - PROCESS | 1659 | 16:16:06 INFO - PROCESS | 1659 | [#3] mootools.html Cycles:180 Average:5642.21 Median:4892.03 stddev:3186.26 (65.1%) stddev-sans-first:3180.02 16:16:06 INFO - PROCESS | 1659 | Values: 1504.2 1543.3 1751.2 1885.0 1932.6 8545.9 8935.5 8948.3 8964.6 8971.1 7813.5 8087.0 8435.6 8698.2 8709.2 2284.5 2315.1 2317.8 2319.7 2321.6 2263.0 2271.4 2300.0 2302.6 2305.0 1717.6 2005.4 2078.8 2080.0 2083.1 2077.4 2230.5 2291.2 2296.6 2297.0 2249.3 2273.9 2277.5 2281.4 2296.7 8831.4 8898.6 8903.6 8910.5 8921.9 5071.9 5210.2 5275.3 5289.7 5293.8 3382.8 3504.3 3566.4 3578.9 3590.7 1013.3 1030.9 1043.5 1052.9 1074.0 11480.3 11532.0 11543.5 11544.5 11545.2 4374.0 4469.3 4688.4 4708.1 4725.2 9854.3 9866.9 9875.8 9877.0 9903.9 4470.5 5266.7 5268.6 5275.8 5278.1 4658.5 4756.8 4803.1 4815.2 4834.8 3801.1 3808.6 3878.2 3896.4 3913.1 1240.4 1251.9 1256.7 1270.4 1276.8 566.4 780.3 890.0 902.6 930.4 4875.9 5800.9 5894.1 5940.2 5973.9 934.5 941.9 944.5 962.6 989.5 3860.2 3919.7 4008.5 4046.7 4079.7 10444.7 10673.8 10746.0 10779.6 10809.4 8922.6 10570.1 10616.4 10722.7 10726.5 7744.3 7825.5 7965.1 7975.6 7985.8 5263.9 5778.4 5812.8 5860.2 6015.3 10048.4 10058.8 10061.3 10079.7 10081.4 9548.9 10045.7 10070.6 10166.8 10187.9 7308.4 7502.3 7509.3 7511.4 7520.8 6946.9 8156.7 8231.7 8301.5 8320.7 7450.9 7494.4 7574.1 7592.4 7653.7 7135.4 7313.8 7351.3 7440.4 7557.6 6556.5 6807.2 6931.0 6935.2 6951.7 4847.7 4940.8 4978.9 4986.9 5121.4 4908.1 4959.5 5060.0 5071.2 5121.0 16:16:06 INFO - PROCESS | 1659 | 16:16:06 INFO - PROCESS | 1659 | [#4] prototype.html Cycles:180 Average:4285.59 Median:4709.08 stddev:1311.59 (27.9%) stddev-sans-first:1280.38 16:16:06 INFO - PROCESS | 1659 | Values: 281.5 296.4 297.4 305.4 311.5 5126.2 5143.4 5191.7 5223.9 5230.7 4627.8 4843.8 4918.7 5049.8 5136.0 3820.8 4104.2 4106.9 4110.2 4130.8 3805.0 4042.9 4119.4 4132.0 4140.9 4023.6 4030.6 4040.7 4056.7 4095.1 3853.7 4001.3 4009.7 4016.9 4046.4 3462.9 3474.5 3479.8 3486.5 3495.0 4116.6 4409.4 5159.5 5184.9 5218.4 3835.8 3923.9 4352.2 4585.5 4652.5 4129.4 5332.9 5611.0 5621.8 5664.5 3182.6 3782.7 3784.7 3829.4 3839.4 5185.9 5555.3 5912.6 5986.7 5988.0 3532.1 3768.2 3831.3 3866.5 3867.1 3162.0 3600.8 3799.8 3815.6 3859.7 3658.9 3847.8 4298.2 4571.4 4616.2 4709.5 4883.6 5463.4 5488.6 5677.6 1218.9 1232.6 1250.0 1324.2 1336.6 791.3 802.4 858.4 894.0 899.0 4620.4 4625.6 4760.9 5243.3 5276.2 4735.7 5665.5 5751.2 5751.7 5791.0 4975.5 5237.2 5278.6 5312.5 5317.4 2271.8 2548.8 2555.9 2558.6 2578.6 4414.6 4435.0 4882.7 5054.8 5072.2 4294.8 4316.9 4377.7 4949.8 5019.7 3950.7 4836.9 4843.4 4847.5 4973.7 4035.9 4145.8 4844.5 4856.0 4866.5 3817.9 4142.2 4259.7 4520.3 4708.7 4778.3 5054.1 5098.7 5105.7 5137.8 3126.7 3221.7 3561.9 3649.9 3719.7 4919.9 4977.7 5107.8 5474.6 5809.5 5205.2 5664.7 5691.9 5696.2 5696.5 4744.4 5157.0 5281.6 5289.8 5617.8 4785.3 4799.8 5182.8 5503.7 5527.6 4288.4 5585.4 5590.8 5594.8 5672.8 4604.7 5487.1 5598.7 5607.3 5621.3 16:16:06 INFO - PROCESS | 1659 | 16:16:06 INFO - PROCESS | 1659 | [#5] yui.html Cycles:180 Average:22703.42 Median:4336.74 stddev:34910.28 (805.0%) stddev-sans-first:34969.18 16:16:06 INFO - PROCESS | 1659 | Values: 718.4 745.8 781.2 781.5 828.7 15200.8 15950.6 15979.0 16022.8 16372.3 13985.2 14248.7 14366.4 14515.9 14569.6 701.7 723.8 884.7 886.1 907.4 894.1 895.9 903.1 903.7 905.2 957.5 960.7 963.5 963.8 963.9 958.0 958.1 958.8 959.2 960.0 544.7 563.9 679.9 702.8 709.7 15101.3 15135.6 15146.3 15150.3 15186.7 13455.7 13880.8 13963.7 13981.4 14019.2 12188.2 12572.4 12573.9 12640.0 12994.6 4418.8 4420.4 4535.2 4587.5 4590.2 77290.5 105548.0 107303.0 108195.5 109453.0 8565.0 10950.8 11068.3 11090.7 11278.9 21728.1 21731.9 21747.2 21762.5 21792.7 7755.2 8028.1 8051.9 8162.5 8173.2 4304.8 4446.4 4540.7 4593.6 4615.3 3359.6 3398.2 3464.6 3467.1 3472.5 628.3 639.1 642.1 657.3 660.6 517.8 560.6 597.2 604.6 635.3 7679.0 8555.0 8758.5 8870.1 8880.9 498.3 591.6 604.3 605.8 610.9 4225.5 4368.7 4379.0 4397.3 4515.6 72713.0 120827.0 143073.3 144744.3 147587.0 112059.0 116627.0 117844.0 119019.0 120035.0 98841.5 99332.0 101087.5 103118.5 104896.4 9493.9 9794.1 9828.3 9961.3 10088.7 50692.0 59571.7 59735.4 59990.1 63060.4 56359.4 56719.7 60866.0 75675.0 80072.4 13235.1 13355.9 13396.5 13761.4 13986.1 14836.6 14884.9 15107.5 15525.9 15911.5 14049.6 14213.3 14640.3 14735.9 14779.6 13718.2 13878.8 14264.3 14272.6 14283.6 13564.7 13572.2 13673.9 13857.0 14498.7 8502.4 9478.5 10224.6 11175.4 11775.2 10081.0 10612.9 11502.8 11711.5 11792.4 16:16:06 INFO - PROCESS | 1659 | -------- Summary: end -------- 16:16:06 INFO - PROCESS | 1659 | 16:16:06 INFO - TEST-INFO | 1659: exit 0 16:16:07 INFO - TEST-OK | dromaeo_css | took 1118248ms 16:16:07 INFO - TEST-START | kraken 16:16:07 INFO - operating with platform_type : mac_ 16:16:07 INFO - Initialising browser for kraken test... 16:16:07 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpcI8EIY/profile http://localhost:49272/getInfo.html) 16:16:09 INFO - PROCESS | 1665 | __metrics Screen width/height:1600/1200 16:16:09 INFO - PROCESS | 1665 | colorDepth:24 16:16:09 INFO - PROCESS | 1665 | Browser inner width/height: 1024/689 16:16:09 INFO - PROCESS | 1665 | __metrics 16:16:09 INFO - PROCESS | 1665 | 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" 16:16:09 INFO - PROCESS | 1665 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 181: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:16:10 INFO - TEST-INFO | 1665: exit 0 16:16:10 INFO - Browser initialized. 16:16:10 INFO - Running cycle 1/1 for kraken test... 16:16:10 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpcI8EIY/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:16:22 INFO - PROCESS | 1666 | RSS: Main: 230150144 16:16:22 INFO - PROCESS | 1666 | 16:16:24 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 16:16:26 INFO - PROCESS | 1666 | RSS: Main: 289955840 16:16:26 INFO - PROCESS | 1666 | 16:16:28 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 16:16:29 INFO - PROCESS | 1666 | RSS: Main: 291151872 16:16:29 INFO - PROCESS | 1666 | 16:16:32 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 16:16:33 INFO - PROCESS | 1666 | RSS: Main: 384450560 16:16:33 INFO - PROCESS | 1666 | 16:16:35 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 16:16:36 INFO - PROCESS | 1666 | RSS: Main: 286060544 16:16:36 INFO - PROCESS | 1666 | 16:16:37 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:16:38 INFO - PROCESS | 1666 | RSS: Main: 290418688 16:16:38 INFO - PROCESS | 1666 | 16:16:41 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 16:16:41 INFO - PROCESS | 1666 | RSS: Main: 326533120 16:16:41 INFO - PROCESS | 1666 | 16:16:44 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 16:16:45 INFO - PROCESS | 1666 | RSS: Main: 328667136 16:16:45 INFO - PROCESS | 1666 | 16:16:48 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 16:16:48 INFO - PROCESS | 1666 | RSS: Main: 326283264 16:16:48 INFO - PROCESS | 1666 | 16:16:50 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:16:51 INFO - PROCESS | 1666 | RSS: Main: 302522368 16:16:51 INFO - PROCESS | 1666 | 16:16:52 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:16:53 INFO - PROCESS | 1666 | RSS: Main: 306270208 16:16:53 INFO - PROCESS | 1666 | 16:16:55 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:16:56 INFO - PROCESS | 1666 | RSS: Main: 308514816 16:16:56 INFO - PROCESS | 1666 | 16:16:59 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:17:00 INFO - PROCESS | 1666 | RSS: Main: 315916288 16:17:00 INFO - PROCESS | 1666 | 16:17:03 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:17:03 INFO - PROCESS | 1666 | RSS: Main: 315527168 16:17:03 INFO - PROCESS | 1666 | 16:17:05 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 16:17:05 INFO - PROCESS | 1666 | RSS: Main: 359677952 16:17:05 INFO - PROCESS | 1666 | 16:17:05 INFO - PROCESS | 1666 | __start_tp_report 16:17:05 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 16:17:05 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 16:17:05 INFO - PROCESS | 1666 | |i|pagename|runs| 16:17:05 INFO - PROCESS | 1666 | |0;ai-astar;110;113;114;113;114;113;113;113;113;113 16:17:05 INFO - PROCESS | 1666 | |1;audio-beat-detection;143;114;113;149;112;114;113;110;148;139 16:17:05 INFO - PROCESS | 1666 | |2;audio-dft;182;184;190;184;181;184;184;183;179;183 16:17:05 INFO - PROCESS | 1666 | |3;audio-fft;78;58;59;88;67;84;58;50;99;73 16:17:05 INFO - PROCESS | 1666 | |4;audio-oscillator;87;72;89;68;66;67;90;66;67;88 16:17:05 INFO - PROCESS | 1666 | |5;imaging-gaussian-blur;86;83;87;87;134;84;88;84;88;84 16:17:05 INFO - PROCESS | 1666 | |6;imaging-darkroom;95;96;96;95;95;95;95;96;95;101 16:17:05 INFO - PROCESS | 1666 | |7;imaging-desaturate;81;85;82;79;81;81;84;109;123;129 16:17:05 INFO - PROCESS | 1666 | |8;json-parse-financial;56;56;53;53;53;54;54;55;55;55 16:17:05 INFO - PROCESS | 1666 | |9;json-stringify-tinderbox;66;72;72;75;73;70;69;70;71;71 16:17:05 INFO - PROCESS | 1666 | |10;stanford-crypto-aes;87;86;87;87;86;87;87;89;88;86 16:17:05 INFO - PROCESS | 1666 | |11;stanford-crypto-ccm;146;147;148;146;144;147;150;156;214;149 16:17:05 INFO - PROCESS | 1666 | |12;stanford-crypto-pbkdf2;173;174;172;174;237;176;171;175;172;169 16:17:05 INFO - PROCESS | 1666 | |13;stanford-crypto-sha256-iterative;68;67;67;63;69;68;69;69;68;67 16:17:05 INFO - PROCESS | 1666 | __end_tp_report 16:17:05 INFO - PROCESS | 1666 | __start_cc_report 16:17:05 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,2121 16:17:05 INFO - PROCESS | 1666 | __end_cc_report 16:17:05 INFO - PROCESS | 1666 | __startTimestamp1477178225723__endTimestamp 16:17:05 INFO - PROCESS | 1666 | 16:17:05 INFO - PROCESS | 1666 | ------- Summary: start ------- 16:17:05 INFO - PROCESS | 1666 | Number of tests: 14 16:17:05 INFO - PROCESS | 1666 | 16:17:05 INFO - PROCESS | 1666 | [#0] ai-astar Cycles:10 Average:112.90 Median:113.00 stddev:1.10 (1.0%) stddev-sans-first:0.44 16:17:05 INFO - PROCESS | 1666 | Values: 110.0 113.0 114.0 113.0 114.0 113.0 113.0 113.0 113.0 113.0 16:17:05 INFO - PROCESS | 1666 | 16:17:05 INFO - PROCESS | 1666 | [#1] audio-beat-detection Cycles:10 Average:125.50 Median:126.50 stddev:16.82 (13.3%) stddev-sans-first:16.61 16:17:05 INFO - PROCESS | 1666 | Values: 143.0 114.0 113.0 149.0 112.0 114.0 113.0 110.0 148.0 139.0 16:17:05 INFO - PROCESS | 1666 | 16:17:05 INFO - PROCESS | 1666 | [#2] audio-dft Cycles:10 Average:183.40 Median:184.00 stddev:2.84 (1.5%) stddev-sans-first:2.96 16:17:05 INFO - PROCESS | 1666 | Values: 182.0 184.0 190.0 184.0 181.0 184.0 184.0 183.0 179.0 183.0 16:17:05 INFO - PROCESS | 1666 | 16:17:05 INFO - PROCESS | 1666 | [#3] audio-fft Cycles:10 Average:71.40 Median:75.50 stddev:15.75 (20.9%) stddev-sans-first:16.52 16:17:05 INFO - PROCESS | 1666 | Values: 78.0 58.0 59.0 88.0 67.0 84.0 58.0 50.0 99.0 73.0 16:17:05 INFO - PROCESS | 1666 | 16:17:05 INFO - PROCESS | 1666 | [#4] audio-oscillator Cycles:10 Average:76.00 Median:79.50 stddev:10.91 (13.7%) stddev-sans-first:10.83 16:17:05 INFO - PROCESS | 1666 | Values: 87.0 72.0 89.0 68.0 66.0 67.0 90.0 66.0 67.0 88.0 16:17:05 INFO - PROCESS | 1666 | 16:17:05 INFO - PROCESS | 1666 | [#5] imaging-gaussian-blur Cycles:10 Average:90.50 Median:86.50 stddev:15.39 (17.8%) stddev-sans-first:16.24 16:17:05 INFO - PROCESS | 1666 | Values: 86.0 83.0 87.0 87.0 134.0 84.0 88.0 84.0 88.0 84.0 16:17:05 INFO - PROCESS | 1666 | 16:17:05 INFO - PROCESS | 1666 | [#6] imaging-darkroom Cycles:10 Average:95.90 Median:95.00 stddev:1.85 (2.0%) stddev-sans-first:1.94 16:17:05 INFO - PROCESS | 1666 | Values: 95.0 96.0 96.0 95.0 95.0 95.0 95.0 96.0 95.0 101.0 16:17:05 INFO - PROCESS | 1666 | 16:17:05 INFO - PROCESS | 1666 | [#7] imaging-desaturate Cycles:10 Average:93.40 Median:81.00 stddev:19.28 (23.8%) stddev-sans-first:19.92 16:17:05 INFO - PROCESS | 1666 | Values: 81.0 85.0 82.0 79.0 81.0 81.0 84.0 109.0 123.0 129.0 16:17:05 INFO - PROCESS | 1666 | 16:17:05 INFO - PROCESS | 1666 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:1.17 (2.1%) stddev-sans-first:1.09 16:17:05 INFO - PROCESS | 1666 | Values: 56.0 56.0 53.0 53.0 53.0 54.0 54.0 55.0 55.0 55.0 16:17:05 INFO - PROCESS | 1666 | 16:17:05 INFO - PROCESS | 1666 | [#9] json-stringify-tinderbox Cycles:10 Average:70.90 Median:71.50 stddev:2.42 (3.4%) stddev-sans-first:1.81 16:17:05 INFO - PROCESS | 1666 | Values: 66.0 72.0 72.0 75.0 73.0 70.0 69.0 70.0 71.0 71.0 16:17:05 INFO - PROCESS | 1666 | 16:17:05 INFO - PROCESS | 1666 | [#10] stanford-crypto-aes Cycles:10 Average:87.00 Median:87.00 stddev:0.94 (1.1%) stddev-sans-first:1.00 16:17:05 INFO - PROCESS | 1666 | Values: 87.0 86.0 87.0 87.0 86.0 87.0 87.0 89.0 88.0 86.0 16:17:05 INFO - PROCESS | 1666 | 16:17:05 INFO - PROCESS | 1666 | [#11] stanford-crypto-ccm Cycles:10 Average:154.70 Median:148.50 stddev:21.09 (14.2%) stddev-sans-first:22.13 16:17:05 INFO - PROCESS | 1666 | Values: 146.0 147.0 148.0 146.0 144.0 147.0 150.0 156.0 214.0 149.0 16:17:05 INFO - PROCESS | 1666 | 16:17:05 INFO - PROCESS | 1666 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.30 Median:174.00 stddev:20.37 (11.7%) stddev-sans-first:21.48 16:17:05 INFO - PROCESS | 1666 | Values: 173.0 174.0 172.0 174.0 237.0 176.0 171.0 175.0 172.0 169.0 16:17:05 INFO - PROCESS | 1666 | 16:17:05 INFO - PROCESS | 1666 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.78 (2.6%) stddev-sans-first:1.88 16:17:05 INFO - PROCESS | 1666 | Values: 68.0 67.0 67.0 63.0 69.0 68.0 69.0 69.0 68.0 67.0 16:17:05 INFO - PROCESS | 1666 | -------- Summary: end -------- 16:17:05 INFO - PROCESS | 1666 | 16:17:06 INFO - TEST-INFO | 1666: exit 0 16:17:06 INFO - TEST-OK | kraken | took 59604ms 16:17:06 INFO - SUITE-END | took 1177s 16:17:06 INFO - Completed test suite (00:19:38) 16:17:06 INFO - javascript benchmark 16:17:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3290.9177270568234, 3305.5372247885284, 3332.383509050824, 3332.7167190788773, 3376.679215474531, 5441.455854414557, 5584.469475399841, 5616.6630002199845, 5625.1281051437045, 5650.434956504348, 5575.944240557593, 5576.749046292916, 5652.463016013482, 5666.971665141668, 5673.461021202979, 5020.778559918579, 5099.694018358892, 5118.104331741949, 5159.200323949775, 5184.196449550326, 5241.764120614563, 5257.684538927658, 5267.104592219332, 5270.947290527103, 5307.363116426015, 4299.763513006784, 5074.59403247743, 5224.76488558012, 5264.763085661154, 5326.573874090063, 5130.0, 5159.484051594848, 5164.509371609691, 5167.9224811627855, 5180.119379705459, 5070.569001634865, 5098.158803797369, 5129.717865517395, 5131.666441681279, 5135.332406787131, 4648.976755116237, 5568.331800183963, 5582.190582365534, 5612.326520817487, 5618.971905140489, 6133.0, 6143.9385606143815, 6149.477294429978, 6154.63072215664, 6155.938440615581, 6090.147379366892, 6171.59884607499, 6174.259088909314, 6185.381461853824, 6205.472534834545, 5594.664320140804, 5606.103023516259, 5674.914876276859, 5705.828825135252, 5712.857178570527, 6197.845053873599, 6230.470410015108, 6271.372862713783, 6271.686415679198, 6291.213598300213, 6062.393760623902, 6095.076823467959, 6105.419985101408, 6116.733149278846, 6147.924113280158, 6151.692415379213, 6167.938320616826, 6169.660668663267, 6177.227846519185, 6181.81454556364, 5602.803901863415, 5865.0, 5931.40685931412, 5942.792002279986, 6109.450149486479, 6135.509159267248, 6166.0, 6168.1056246843955, 6173.969130154321, 6186.597871138361, 4845.127876982177, 4860.6111511079025, 4860.927086093711, 4877.414710234794, 4932.038252540792, 4336.132773445261, 4337.9132417351475, 4338.566143385699, 4344.4352234209355, 4396.340548917688, 5613.522850557667, 5634.971825140848, 5682.204491371212, 5688.459596338341, 5728.828135155952, 5479.232907392969, 6204.317525072239, 6211.689415529296, 6218.440340369298, 6230.0, 5307.310049693515, 5624.240727501735, 5652.265205523256, 5652.293463317085, 5656.0, 4067.6949228807957, 5201.3238279024245, 5233.084210263265, 5273.736313184326, 5286.762095705625, 6188.535859810622, 6213.068039793977, 6236.158118654105, 6236.937630623635, 6256.624602523863, 6172.845678857885, 6179.011358182669, 6192.040233763774, 6196.876062478635, 6207.596506227081, 6121.0262130506535, 6231.2522497300615, 6237.002079667232, 6237.781677641442, 6238.875222495615, 6045.969770151121, 6095.908561371672, 6107.480864126599, 6117.979653188298, 6125.265974675666, 6162.845928851814, 6177.227846519185, 6177.876442471215, 6188.535859810442, 6203.348648392034, 5764.567657425794, 5958.994444666501, 5969.462748352669, 5970.432808883149, 5997.640141591519, 5055.191169412877, 5830.708464576839, 5902.144189092472, 5929.822105336847, 5951.672658003678, 5764.913526297025, 5782.595218334676, 5794.652320860761, 5802.390748971297, 5836.416358364129, 4864.659473836798, 5898.321693005188, 5906.852328691817, 5907.734151963086, 5910.52715782745, 5684.0, 5684.8294551163535, 5746.195532625519, 5751.511121554715, 5779.190913272061], "value": 5582.058821946921, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.4519189951808, 483.3885135303841, 499.3608181527641, 521.8232884844675, 538.7414041260195, 20991.0, 31341.84329078357, 33644.9906502805, 39663.0, 42256.0, 40886.79556602213, 41316.79341603295, 41916.79041604795, 41995.16009679812, 42139.0, 9548.665796697116, 9590.80818383632, 9737.707868763948, 9743.171830394425, 9753.219742420624, 9618.951905240465, 9724.465154416504, 9728.854067188999, 9743.951280243624, 9754.561044752967, 8249.546274954875, 9707.223422126248, 9735.56189971453, 9770.0, 9783.217342612574, 9667.419954802699, 9748.31761776676, 9748.463834489101, 9771.90228097717, 9778.364406313567, 9484.478353690543, 9559.61761529538, 9560.043995600454, 9570.47362395068, 9581.377210481296, 39145.60854391448, 39529.80235098806, 39586.0, 39638.801805990784, 39829.60170398288, 3383.9171465131167, 3411.6417776133644, 3424.366492198926, 3568.660977207161, 3785.6025117362556, 28847.56728649072, 29321.56017659737, 29819.0, 30886.0, 31302.686973130432, 3021.471242532548, 3158.1630867820045, 3171.984140079308, 3181.7252708355118, 3304.9008529744146, 431941.0, 437617.8119109416, 437673.0, 438626.0, 441512.0, 60402.0939685905, 61000.77998440006, 61122.38877611167, 61149.0, 61173.38826611766, 33366.0, 34213.65786342155, 34247.0, 35009.0, 35346.0, 13524.0, 15756.0, 16100.436484722979, 16134.435294764628, 16158.868879178344, 12381.380930953597, 12469.501219951282, 12496.87503124957, 12500.687482813002, 12521.56174533887, 15688.450904218298, 18952.62094758097, 18955.431337059912, 18983.81016189848, 18998.43004709861, 7029.713840840815, 7712.768616941501, 7892.250236227549, 8012.197255617556, 8113.959430202811, 917.9678711245074, 972.2707969023232, 985.7289245457556, 1078.487718333785, 1121.6915348279288, 29748.702512974593, 29866.253343666584, 30469.542956855665, 30492.23769405738, 30660.773569056986, 1052.0, 1136.4829002803704, 1169.7777422289737, 1186.4660902593866, 1237.4431505822236, 15303.693926121638, 15608.687826243411, 15612.843871561367, 15996.280167392495, 16001.599960001093, 616531.3468653099, 620124.0, 620974.0, 621021.0, 622736.0, 56869.862602747715, 57386.0, 57502.424975750546, 57538.0, 57551.71224143852, 1245.0, 1280.481405030964, 1338.7924871644911, 1398.9650258743409, 1415.7470638485015, 22669.546609068057, 22936.885315573316, 30892.845535773078, 31250.87449279458, 32259.838700806347, 47570.0, 48026.519734802205, 48097.519024809306, 48183.75908120437, 48205.5179448201, 464311.0, 465699.0, 468307.0, 468392.0, 468456.20806543215, 22767.658485122403, 23344.0, 25120.74879251184, 25219.621705674064, 25746.227613171635, 46305.53694463147, 46366.07267854556, 46428.767856160506, 47055.52944470511, 47215.055698885146, 38044.61955380411, 38155.0, 38309.42535861908, 38508.614913850506, 39768.801155994035, 32019.199520012186, 37334.0, 37477.0, 38211.0, 39343.80328098341, 37045.0, 37838.43242351312, 38261.0, 38420.6157938417, 39061.41407878827, 32250.838745806122, 33189.01305857699, 33587.824426144965, 33699.494507582895, 33700.32599348048, 24521.509569808146, 25011.499770004863, 25197.370065748502, 25829.483410332065, 25893.87053064798], "value": 19235.106939214893, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [335.84383261783273, 370.11542413631423, 374.1656106881653, 386.06572095528816, 396.6237157064985, 19719.408417747472, 20360.69458958117, 20899.68650470244, 21309.25417610384, 21504.569908601818, 11826.467808948597, 12010.579629712962, 16775.0, 20212.595748085067, 20977.37067887962, 5121.15500942345, 5373.75818088185, 5378.2470454136455, 5378.731063446812, 5385.3268341457315, 4692.897169165243, 4850.927236091461, 5261.973690131544, 5366.838994830142, 5368.194770784394, 5254.054270231357, 5262.368515778093, 5270.789168433258, 5364.034473794715, 5364.651297665659, 5079.695218286896, 5267.209918512254, 5305.071612467803, 5372.435894231088, 5372.985130576034, 4320.9135817283795, 5108.233764935252, 5171.405288391846, 5233.162693968985, 5238.13570760824, 13153.934230328883, 13423.463061477529, 13604.115732477456, 13604.183748974994, 13630.318484075757, 2015.7177995080701, 2055.3011975928257, 2099.4121645939163, 2173.9021744021557, 2465.8767061646845, 9496.192823609932, 10207.234457415723, 10341.689749307458, 10372.429516376596, 10514.894851051467, 1742.311786844202, 1835.3484512997827, 1838.6598479281377, 1894.1476335649013, 1921.3947606504046, 98135.0, 116195.41902290519, 126397.36801316026, 130405.0, 135064.32467837696, 10776.19178561611, 11243.212975091665, 11294.830577541343, 11348.262362946381, 11553.191276610725, 14200.431982720576, 14531.273436328142, 14533.055351402125, 14545.200013999332, 14594.562163135122, 8161.224683655043, 8431.662733490715, 8452.408331416742, 8561.0, 8577.571121443903, 8374.232824692328, 8387.0, 8402.11777763326, 8507.234348908629, 8579.785505362292, 3680.3375392429084, 4394.670399720034, 4547.136044151601, 4580.106879158532, 4675.766211689402, 1596.8243493215737, 1707.1549582956516, 1827.7075667893073, 1895.1945423195086, 1905.5426697592477, 755.4183278875236, 925.0564424287189, 966.1690945786618, 985.8176237396104, 1012.5645972232011, 19877.701834472493, 21224.04491797873, 21553.24563640265, 21559.35321940344, 21652.675209871864, 915.1306259053925, 930.776613612728, 937.3813283233034, 938.8826396700413, 953.8473844184897, 8940.821183576421, 9482.146606805421, 10535.0, 11391.715207119889, 11392.544298227978, 377485.0, 381385.0, 383779.0, 530418.0, 534641.0, 89502.55248723846, 115962.0, 125702.0, 138657.61342386648, 148380.0, 934.5794392523392, 935.5836652689488, 981.9312648114563, 986.3835103060587, 986.4032260482448, 18739.063046847878, 18850.622987540446, 19083.0, 19154.138063787443, 19325.903370483058, 55802.325930222156, 55928.0, 56552.434475654714, 57439.42560574341, 57630.0, 79157.0, 79724.0, 80612.0, 82695.0, 84364.57817711118, 7553.848923021619, 7777.4166937478785, 7938.166492518433, 8138.796530086795, 8165.265126138676, 11861.40692965331, 12294.262344259372, 12570.1200915935, 12617.558385456465, 13073.280969546766, 10684.679459616224, 10910.23628346008, 11113.777724445628, 11120.833187502032, 11205.495752690986, 9644.913627639087, 10552.99746524079, 10818.567257309935, 10949.83575246356, 11526.538938442369, 9860.901390985999, 11304.43477826089, 11535.596254131066, 11648.825267621161, 11911.404429778304, 6911.654417279216, 7237.3486386223385, 7260.67326970277, 7805.921940780519, 8367.205115514016, 11016.504257308601, 11323.433828308716, 11451.969322760991, 11546.94226528862, 11547.538098476303], "value": 9062.364525613062, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1504.2478760619688, 1543.328652036364, 1751.2032025428432, 1884.9717254241198, 1932.6134773045394, 8545.914540854597, 8935.508547029911, 8948.28413726902, 8964.596593153308, 8971.147740964607, 7813.453058285922, 8086.959565202165, 8435.62039708213, 8698.217160455557, 8709.172628600272, 2284.45173158442, 2315.0855412112205, 2317.7682231776857, 2319.698439202901, 2321.628539433691, 2262.988685056572, 2271.375371772759, 2299.954000919989, 2302.6085565453914, 2305.0, 1717.5706073481629, 2005.4384772263788, 2078.7817279185692, 2079.9584008319825, 2083.0626218201796, 2077.418322869599, 2230.4646884747626, 2291.1522736587403, 2296.5751336002895, 2297.023764899911, 2249.280230326296, 2273.897674604647, 2277.544491101786, 2281.4296425893526, 2296.7358753743365, 8831.425957312755, 8898.555072246361, 8903.55482225886, 8910.465372077631, 8921.910780892173, 5071.923921141186, 5210.166373380241, 5275.340582427197, 5289.709066001368, 5293.841184764463, 3382.797032178077, 3504.2641045380246, 3566.4115420955513, 3578.9284214315567, 3590.6588874056924, 1013.2856336282903, 1030.8969103089705, 1043.4939054558533, 1052.9315594486334, 1073.983890241647, 11480.253783504046, 11532.0, 11543.480543375568, 11544.480498377594, 11545.191836571443, 4373.978130109329, 4469.307257375112, 4688.390509233778, 4708.128996135726, 4725.173094708481, 9854.260930430102, 9866.851997220047, 9875.802483950281, 9876.962918893556, 9903.900960990442, 4470.485894122217, 5266.657667251617, 5268.631195816256, 5275.815346462932, 5278.129108697099, 4658.534146585314, 4756.7859446325, 4803.087413391444, 4815.2054910940005, 4834.7824347904425, 3801.1447424329303, 3808.562015368268, 3878.166194268246, 3896.357101078347, 3913.1195481016543, 1240.3550153919912, 1251.9186252893533, 1256.723520825417, 1270.3521204185747, 1276.8403949506312, 566.4477134793543, 780.3484090784145, 889.9911000890038, 902.6389444222232, 930.3534043839602, 4875.926861097087, 5800.9419905800405, 5894.115882617556, 5940.168376427304, 5973.940260597426, 934.4533447933036, 941.9481928493999, 944.5418971798672, 962.6341990043738, 989.5349185882624, 3860.1696602811717, 3919.7060220483577, 4008.4588580541836, 4046.7167298288837, 4079.653229475528, 10444.73888152787, 10673.83989240162, 10746.0, 10779.568817247378, 10809.405482698527, 8922.55387230649, 10570.101541368917, 10616.416097114732, 10722.678319650424, 10726.51730672106, 7744.3417309528195, 7825.530468171928, 7965.123836377994, 7975.5613441261285, 7985.760427187193, 5263.894722105613, 5778.393268706725, 5812.82561523155, 5860.179574859609, 6015.308239552332, 10048.447335396331, 10058.798824023625, 10061.346012509164, 10079.748006299607, 10081.445520496443, 9548.856767148638, 10045.748856278651, 10070.647527336509, 10166.8474972874, 10187.949060254652, 7308.378787803096, 7502.324790768857, 7509.324160825334, 7511.3615342696485, 7520.811979700551, 6946.895796562954, 8156.673733050611, 8231.670733170606, 8301.501909885426, 8320.70877519284, 7450.8882366763455, 7494.362979146834, 7574.128975167926, 7592.354649854824, 7653.693852245848, 7135.42916566663, 7313.75218829025, 7351.338379545653, 7440.3675687565, 7557.622118894144, 6556.541042127005, 6807.217170025312, 6930.965345173242, 6935.167779866449, 6951.721931122901, 4847.684900481458, 4940.827071052496, 4978.900421991468, 4986.9251961221335, 5121.411037730709, 4908.141075311734, 4959.504049595012, 5059.974700126476, 5071.2139618359215, 5120.974395128001], "value": 4514.207501093576, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [281.53125046797084, 296.3923955890424, 297.418546741121, 305.44561620658504, 311.517148419949, 5126.154184559543, 5143.3827940647125, 5191.676122588739, 5223.895522089556, 5230.718473973877, 4627.791749371278, 4843.824124241593, 4918.729469879156, 5049.772760225789, 5136.049830781308, 3820.808959552025, 4104.199681062194, 4106.8562600309, 4110.219058378913, 4130.772807495587, 3804.9619503805025, 4042.8989275268204, 4119.40268661044, 4132.008318003673, 4140.917181656365, 4023.577524359944, 4030.5969403059607, 4040.717149799515, 4056.7282321899684, 4095.0581366285774, 3853.6724378427725, 4001.339778936472, 4009.694425705231, 4016.919661606766, 4046.413270075852, 3462.8614855406004, 3474.4961980512685, 3479.80861052642, 3486.5293185419896, 3495.0, 4116.629503344683, 4409.4488188976375, 5159.509846564571, 5184.8963020739375, 5218.425973142951, 3835.789031603261, 3923.881693717277, 4352.238358287287, 4585.518520555327, 4652.464966528859, 4129.380592911058, 5332.866678333034, 5610.971945140289, 5621.7751289948765, 5664.461876121762, 3182.554442378069, 3782.678472329855, 3784.6972242220554, 3829.3872980323013, 3839.36650452675, 5185.936882938989, 5555.30558680165, 5912.556558258148, 5986.730597123096, 5987.970060149715, 3532.0640030391965, 3768.2275133597545, 3831.329517334511, 3866.5360156781367, 3867.0719027433215, 3161.9723589833397, 3600.8199590020918, 3799.7910114943943, 3815.5802861685193, 3859.710521710883, 3658.853645854136, 3847.826847791856, 4298.247806633826, 4571.428571428572, 4616.192166370872, 4709.458412282563, 4883.560479556857, 5463.399026107125, 5488.588355873326, 5677.630953987978, 1218.9085818563642, 1232.5870833270956, 1250.0, 1324.1525423728822, 1336.6190635668981, 791.3155120820448, 802.430274505108, 858.4463021351194, 894.0, 898.9505577193187, 4620.422447194101, 4625.583697467244, 4760.880977975578, 5243.329669231553, 5276.208568714646, 4735.679517036628, 5665.49010589049, 5751.194832723422, 5751.741171647286, 5790.957627626984, 4975.4527002029745, 5237.198099017084, 5278.630495865253, 5312.548433383128, 5317.431357749473, 2271.7841805028497, 2548.789325070614, 2555.93928519666, 2558.5522533556928, 2578.581780020981, 4414.627571954779, 4434.977825110854, 4882.706082888038, 5054.82308119214, 5072.239164125411, 4294.828206871753, 4316.913661726748, 4377.694840395481, 4949.7772600233075, 5019.7239151847, 3950.683945284428, 4836.854894353175, 4843.394575677969, 4847.4793107583855, 4973.651844370859, 4035.878923632296, 4145.79271036441, 4844.539768721966, 4856.0, 4866.489018653132, 3817.8854634361014, 4142.212979533879, 4259.74441533509, 4520.276311254813, 4708.693934894221, 4778.307145463818, 5054.064997975386, 5098.719570423662, 5105.7191854448365, 5137.8201762938115, 3126.717496227812, 3221.6778322168534, 3561.8753343632848, 3649.872254471081, 3719.739618226806, 4919.852404427873, 4977.726225057657, 5107.846764597068, 5474.644148130359, 5809.477147056785, 5205.245239440335, 5664.742772905678, 5691.8861622768145, 5696.20253164549, 5696.54427645779, 4744.4069491313585, 5156.9742151289, 5281.573975026645, 5289.80979279659, 5617.775288988395, 4785.325136202301, 4799.808007679793, 5182.818601348935, 5503.651605356713, 5527.5577953762795, 4288.356746488052, 5585.357683866245, 5590.813236455181, 5594.832155035356, 5672.829815105553, 4604.746738929391, 5487.122060470306, 5598.720063996702, 5607.327120745536, 5621.297337832771], "value": 3873.7029675127887, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.3534818663203, 745.8471013442241, 781.2383670430575, 781.5154604145431, 828.6685325869653, 15200.847991520082, 15950.601234969132, 15979.0, 16022.839771602281, 16372.263248153831, 13985.230812305319, 14248.71502569948, 14366.425342986295, 14515.854841451583, 14569.562913112624, 701.6877489517167, 723.8009547374488, 884.6815146547237, 886.0961818944705, 907.3648446087765, 894.0969620683125, 895.8924929008529, 903.1329923273665, 903.661127077346, 905.1988989744058, 957.5164541906328, 960.6589660670467, 963.5230560872378, 963.8072385522888, 963.9277054220927, 957.966471173509, 958.147248948433, 958.7842735384553, 959.1607343574373, 960.001598337728, 544.6949708163402, 563.890041441919, 679.8708245433352, 702.8313204830855, 709.6558169287891, 15101.32044058009, 15135.621609459742, 15146.31841567121, 15150.31823567942, 15186.696266074727, 13455.730885382238, 13880.791788123086, 13963.700964614154, 13981.370838312301, 14019.228942408163, 12188.232706257631, 12572.371381430892, 12573.93713031429, 12640.0, 12994.610161695164, 4418.80115394808, 4420.400931658488, 4535.183666939949, 4587.472440669332, 4590.242609969351, 77290.49456611222, 105548.0, 107303.0, 108195.45902270517, 109453.0, 8565.0, 10950.780984380268, 11068.28056176346, 11090.722731931604, 11278.887211127783, 21728.130874764833, 21731.891340543196, 21747.23884664029, 21762.455938601346, 21792.673109903364, 7755.185705500954, 8028.076771171273, 8051.866255442313, 8162.469439486415, 8173.182681731898, 4304.82780688769, 4446.355278484666, 4540.6821522493765, 4593.63250939924, 4615.330777037378, 3359.6472370401243, 3398.1674489749676, 3464.6015708193377, 3467.09855437588, 3472.5138480612736, 628.3151365012068, 639.0956796133512, 642.1074706158444, 657.3360905485398, 660.5541259649717, 517.7721802406929, 560.590115858616, 597.1729155120103, 604.6402390577599, 635.3392471829246, 7679.0, 8554.957225213833, 8758.47449153053, 8870.112988701207, 8880.911190888137, 498.28496108085017, 591.5681552466638, 604.283923550594, 605.794030029792, 610.9064774054393, 4225.514065882401, 4368.650507959355, 4378.956210437855, 4397.31841564558, 4515.616172625364, 72713.0, 120827.0, 143073.28463357617, 144744.27627862003, 147587.0, 112059.0, 116627.0, 117844.0, 119019.0, 120035.0, 98841.50579247202, 99332.0, 101087.49456252818, 103118.48440757749, 104896.42655360328, 9493.857592135986, 9794.118529332394, 9828.31201815866, 9961.302708810603, 10088.747781305527, 50692.0, 59571.70214148902, 59735.40264597299, 59990.10014849868, 63060.36939630545, 56359.43640563706, 56719.71640141938, 60866.0, 75675.0, 80072.39855202747, 13235.139715918434, 13355.933220334226, 13396.531121410704, 13761.449542018207, 13986.090904091201, 14836.62908427298, 14884.925575372054, 15107.54677359681, 15525.922370388076, 15911.522654320388, 14049.578512644637, 14213.289335533389, 14640.34118464693, 14735.926320368759, 14779.630509236926, 13718.245496497788, 13878.791818122534, 14264.286785660883, 14272.643183920485, 14283.571492855232, 13564.660883477598, 13572.1856688599, 13673.86326136726, 13857.03000789935, 14498.710025799635, 8502.427050995586, 9478.526073696425, 10224.64213752515, 11175.38535380562, 11775.17573769862, 10081.0, 10612.946935265274, 11502.769944601228, 11711.472983715923, 11792.351420671945], "value": 7702.734138436689, "unit": "score"}], "name": "dromaeo_css", "value": 7127.24647873943, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 114.0, 113.0, 114.0, 113.0, 113.0, 113.0, 113.0, 113.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 114.0, 113.0, 149.0, 112.0, 114.0, 113.0, 110.0, 148.0, 139.0], "value": 125.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 190.0, 184.0, 181.0, 184.0, 184.0, 183.0, 179.0, 183.0], "value": 183.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 58.0, 59.0, 88.0, 67.0, 84.0, 58.0, 50.0, 99.0, 73.0], "value": 71.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 89.0, 68.0, 66.0, 67.0, 90.0, 66.0, 67.0, 88.0], "value": 76.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 83.0, 87.0, 87.0, 134.0, 84.0, 88.0, 84.0, 88.0, 84.0], "value": 90.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 101.0], "value": 95.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 85.0, 82.0, 79.0, 81.0, 81.0, 84.0, 109.0, 123.0, 129.0], "value": 93.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 56.0, 53.0, 53.0, 53.0, 54.0, 54.0, 55.0, 55.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 72.0, 72.0, 75.0, 73.0, 70.0, 69.0, 70.0, 71.0, 71.0], "value": 70.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 87.0, 87.0, 86.0, 87.0, 87.0, 89.0, 88.0, 86.0], "value": 87.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 148.0, 146.0, 144.0, 147.0, 150.0, 156.0, 214.0, 149.0], "value": 154.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 174.0, 172.0, 174.0, 237.0, 176.0, 171.0, 175.0, 172.0, 169.0], "value": 179.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 63.0, 69.0, 68.0, 69.0, 69.0, 68.0, 67.0], "value": 67.5, "unit": "score"}], "name": "kraken", "value": 1462.8, "alertThreshold": 2.0}]} 16:17:06 INFO - Return code: 0 16:17:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:17:06 INFO - # TBPL SUCCESS # 16:17:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:17:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:17:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:17:07 INFO - 2016-10-22 16:17:07.014 screenresolution[1670:10933] starting screenresolution argv=screenresolution get 16:17:07 INFO - 2016-10-22 16:17:07.016 screenresolution[1670:10933] Display 0: 1600x1200x32@60 16:17:07 INFO - 2016-10-22 16:17:07.022 screenresolution[1671:10936] starting screenresolution argv=screenresolution list 16:17:07 INFO - Available Modes on Display 0 16:17:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:17:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:17:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:17:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:17:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:17:07 INFO - Intel Iris: 16:17:07 INFO - Chipset Model: Intel Iris 16:17:07 INFO - Type: GPU 16:17:07 INFO - Bus: Built-In 16:17:07 INFO - VRAM (Dynamic, Max): 1536 MB 16:17:07 INFO - Vendor: Intel (0x8086) 16:17:07 INFO - Device ID: 0x0a2e 16:17:07 INFO - Revision ID: 0x0009 16:17:07 INFO - Displays: 16:17:07 INFO - Display: 16:17:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:17:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:17:07 INFO - Display Serial Number: 1600x1200 60 16:17:07 INFO - Main Display: Yes 16:17:07 INFO - Mirror: Off 16:17:07 INFO - Online: Yes 16:17:07 INFO - Rotation: Supported 16:17:07 INFO - Return code: 0 16:17:07 INFO - Running post-action listener: _resource_record_post_action 16:17:07 INFO - [mozharness: 2016-10-22 23:17:07.263441Z] Finished run-tests step (success) 16:17:07 INFO - Running post-run listener: _resource_record_post_run 16:17:07 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 33205248; Write bytes: 708171776; Read time: 353; Write time: 2511 16:17:07 INFO - TinderboxPrint: CPU usage
53.6% 16:17:07 INFO - TinderboxPrint: I/O read bytes / time
33,205,248 / 353 16:17:07 INFO - TinderboxPrint: I/O write bytes / time
708,171,776 / 2,511 16:17:07 INFO - TinderboxPrint: CPU idle
2,253.6 (46.4%) 16:17:07 INFO - TinderboxPrint: CPU system
969.5 (20.0%) 16:17:07 INFO - TinderboxPrint: CPU user
1,630.5 (33.6%) 16:17:07 INFO - TinderboxPrint: Swap in / out
434,597,888 / 0 16:17:07 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 397996544; Write bytes: 391980544; Read time: 29827; Write time: 759 16:17:07 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 31136768; Write bytes: 299741696; Read time: 331; Write time: 1714 16:17:07 INFO - Running post-run listener: _upload_blobber_files 16:17:07 INFO - Blob upload gear active. 16:17:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:17:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:17:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:17:08 INFO - (blobuploader) - INFO - Open directory for files ... 16:17:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:17:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:17:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:17:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:17:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:17:08 INFO - (blobuploader) - INFO - Done attempting. 16:17:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:17:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:17:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:17:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:17:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:17:10 INFO - (blobuploader) - INFO - Done attempting. 16:17:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:17:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:17:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:17:12 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:17:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:17:12 INFO - (blobuploader) - INFO - Done attempting. 16:17:12 INFO - (blobuploader) - INFO - Iteration through files over. 16:17:12 INFO - Return code: 0 16:17:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:17:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:17:12 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77fbcf88e6eb0162bf2cf8d5d867b18dd93f005f6b2aa336559018049b1ebb884a645792d0423ed084d00693e40ba33c8034456705d02fad92ecb3cfa6202b27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4710e439a637590f2fcca051db63e55daa831b24ba8f5ddd43943e559ed4b794370812ab3165643f11722a24fee50a2af8a121bb71ec4e6741ee823153f5801", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c3053dab634c3a4952ffec80b1db00ba06a4bc0810458fa841699f2950eaa438d2581bd26cb124a95ba3c206dbad204c282108c3ee0e1a4decd2b8f650193f3"} 16:17:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:17:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:17:12 INFO - Contents: 16:17:12 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77fbcf88e6eb0162bf2cf8d5d867b18dd93f005f6b2aa336559018049b1ebb884a645792d0423ed084d00693e40ba33c8034456705d02fad92ecb3cfa6202b27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4710e439a637590f2fcca051db63e55daa831b24ba8f5ddd43943e559ed4b794370812ab3165643f11722a24fee50a2af8a121bb71ec4e6741ee823153f5801", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c3053dab634c3a4952ffec80b1db00ba06a4bc0810458fa841699f2950eaa438d2581bd26cb124a95ba3c206dbad204c282108c3ee0e1a4decd2b8f650193f3"} 16:17:12 INFO - Running post-run listener: copy_logs_to_upload_dir 16:17:12 INFO - Copying logs to upload dir... 16:17:12 INFO - mkdir: /builds/slave/test/build/upload/logs 16:17:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.064925 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2016-10-22 16:17:12.382541) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-22 16:17:12.387357) ========= 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.4bYSQP9lHk/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.Uil1AQNF7X/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77fbcf88e6eb0162bf2cf8d5d867b18dd93f005f6b2aa336559018049b1ebb884a645792d0423ed084d00693e40ba33c8034456705d02fad92ecb3cfa6202b27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4710e439a637590f2fcca051db63e55daa831b24ba8f5ddd43943e559ed4b794370812ab3165643f11722a24fee50a2af8a121bb71ec4e6741ee823153f5801", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c3053dab634c3a4952ffec80b1db00ba06a4bc0810458fa841699f2950eaa438d2581bd26cb124a95ba3c206dbad204c282108c3ee0e1a4decd2b8f650193f3"} build_url:https://queue.taskcluster.net/v1/task/O5GZ3Z7YTlW8SQfj_6JJBA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010066 build_url: 'https://queue.taskcluster.net/v1/task/O5GZ3Z7YTlW8SQfj_6JJBA/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/77fbcf88e6eb0162bf2cf8d5d867b18dd93f005f6b2aa336559018049b1ebb884a645792d0423ed084d00693e40ba33c8034456705d02fad92ecb3cfa6202b27", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e4710e439a637590f2fcca051db63e55daa831b24ba8f5ddd43943e559ed4b794370812ab3165643f11722a24fee50a2af8a121bb71ec4e6741ee823153f5801", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8c3053dab634c3a4952ffec80b1db00ba06a4bc0810458fa841699f2950eaa438d2581bd26cb124a95ba3c206dbad204c282108c3ee0e1a4decd2b8f650193f3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-10-22 16:17:12.416812) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 16:17:12.420141) ========= 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.4bYSQP9lHk/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.Uil1AQNF7X/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.004220 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-10-22 16:17:12.467624) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-22 16:17:12.467917) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-10-22 16:17:12.468241) ========= ========= Total master_lag: 0.19 =========