builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0003 starttime: 1474636146.03 results: success (0) buildid: 20160923041700 builduid: e244da3a890a41b2998aa2ba10341702 revision: 2e46d0c12db68401969a817832329187da8add06 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 06:09:06.026063) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-23 06:09:06.026887) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 06:09:06.027157) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-23 06:09:06.475888) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 06:09:06.476340) ========= 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.irwfLkIHIW/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.jO5MIrLRTz/Listeners TMPDIR=/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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-09-23 06:09:06-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 15.8M=0.001s 2016-09-23 06:09:06 (15.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.473564 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 06:09:06.976809) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 06:09:06.977138) ========= 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.irwfLkIHIW/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.jO5MIrLRTz/Listeners TMPDIR=/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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.027950 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 06:09:07.025478) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 06:09:07.025876) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 2e46d0c12db68401969a817832329187da8add06 --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 2e46d0c12db68401969a817832329187da8add06 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.irwfLkIHIW/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.jO5MIrLRTz/Listeners TMPDIR=/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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-09-23 06:09:07,112 truncating revision to first 12 chars 2016-09-23 06:09:07,112 Setting DEBUG logging. 2016-09-23 06:09:07,112 attempt 1/10 2016-09-23 06:09:07,112 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/2e46d0c12db6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-23 06:09:08,467 unpacking tar archive at: fx-team-2e46d0c12db6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.636552 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-23 06:09:08.686088) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 06:09:08.686399) ========= script_repo_revision: 2e46d0c12db68401969a817832329187da8add06 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-23 06:09:08.686856) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 06:09:08.687163) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-23 06:09:08.706849) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-09-23 06:09:08.707158) ========= /tools/buildbot/bin/python 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', '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.irwfLkIHIW/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.jO5MIrLRTz/Listeners TMPDIR=/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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 06:09:08 INFO - MultiFileLogger online at 20160923 06:09:08 in /builds/slave/test 06:09:08 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 06:09:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:09:08 INFO - {'append_to_log': False, 06:09:08 INFO - 'base_work_dir': '/builds/slave/test', 06:09:08 INFO - 'blob_upload_branch': 'Fx-Team', 06:09:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:09:08 INFO - 'branch': 'Fx-Team', 06:09:08 INFO - 'buildbot_json_path': 'buildprops.json', 06:09:08 INFO - 'config_files': ('talos/mac_config.py',), 06:09:08 INFO - 'default_actions': ('clobber', 06:09:08 INFO - 'read-buildbot-config', 06:09:08 INFO - 'download-and-extract', 06:09:08 INFO - 'populate-webroot', 06:09:08 INFO - 'create-virtualenv', 06:09:08 INFO - 'install', 06:09:08 INFO - 'run-tests'), 06:09:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:09:08 INFO - 'download_minidump_stackwalk': True, 06:09:08 INFO - 'download_symbols': 'ondemand', 06:09:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:09:08 INFO - 'tooltool.py': '/tools/tooltool.py', 06:09:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:09:08 INFO - '/tools/misc-python/virtualenv.py')}, 06:09:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:09:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:09:08 INFO - 'installer_path': 'installer.exe', 06:09:08 INFO - 'log_level': 'info', 06:09:08 INFO - 'log_name': 'talos', 06:09:08 INFO - 'log_to_console': True, 06:09:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 06:09:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 06:09:08 INFO - 'opt_config_files': (), 06:09:08 INFO - 'pip_index': False, 06:09:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:09:08 INFO - 'cmd': ('bash', 06:09:08 INFO - '-c', 06:09:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:09:08 INFO - 'enabled': True, 06:09:08 INFO - 'halt_on_failure': False, 06:09:08 INFO - 'name': 'check_screen_resolution'},), 06:09:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 06:09:08 INFO - 'cmd': ('bash', 06:09:08 INFO - '-c', 06:09:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 06:09:08 INFO - 'enabled': True, 06:09:08 INFO - 'halt_on_failure': False, 06:09:08 INFO - 'name': 'check_screen_resolution'},), 06:09:08 INFO - 'run_cmd_checks_enabled': True, 06:09:08 INFO - 'sps_profile': False, 06:09:08 INFO - 'sps_profile_interval': 0, 06:09:08 INFO - 'suite': 'dromaeojs', 06:09:08 INFO - 'system_bits': '32', 06:09:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:09:08 INFO - 'title': 't-yosemite-r7-0003', 06:09:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:09:08 INFO - 'use_talos_json': True, 06:09:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:09:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:09:08 INFO - 'work_dir': 'build'} 06:09:08 INFO - [mozharness: 2016-09-23 13:09:08.922665Z] Running clobber step. 06:09:08 INFO - Running pre-action listener: _resource_record_pre_action 06:09:08 INFO - Running main action method: clobber 06:09:08 INFO - rmtree: /builds/slave/test/build 06:09:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:09:11 INFO - Running post-action listener: _resource_record_post_action 06:09:11 INFO - [mozharness: 2016-09-23 13:09:11.222358Z] Finished clobber step (success) 06:09:11 INFO - [mozharness: 2016-09-23 13:09:11.222506Z] Running read-buildbot-config step. 06:09:11 INFO - Running pre-action listener: _resource_record_pre_action 06:09:11 INFO - Running main action method: read_buildbot_config 06:09:11 INFO - Using buildbot properties: 06:09:11 INFO - { 06:09:11 INFO - "project": "", 06:09:11 INFO - "product": "firefox", 06:09:11 INFO - "script_repo_revision": "production", 06:09:11 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 06:09:11 INFO - "repository": "", 06:09:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 06:09:11 INFO - "buildid": "20160923041700", 06:09:11 INFO - "pgo_build": "False", 06:09:11 INFO - "basedir": "/builds/slave/test", 06:09:11 INFO - "buildnumber": 171, 06:09:11 INFO - "slavename": "t-yosemite-r7-0003", 06:09:11 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 06:09:11 INFO - "platform": "yosemite_r7", 06:09:11 INFO - "scheduler": "tests-fx-team-macosx64-talos", 06:09:11 INFO - "branch": "fx-team", 06:09:11 INFO - "repo_path": "integration/fx-team", 06:09:11 INFO - "revision": "2e46d0c12db68401969a817832329187da8add06", 06:09:11 INFO - "stage_platform": "macosx64", 06:09:11 INFO - "builduid": "e244da3a890a41b2998aa2ba10341702", 06:09:11 INFO - "slavebuilddir": "test" 06:09:11 INFO - } 06:09:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 06:09:11 INFO - Running post-action listener: _resource_record_post_action 06:09:11 INFO - [mozharness: 2016-09-23 13:09:11.225571Z] Finished read-buildbot-config step (success) 06:09:11 INFO - [mozharness: 2016-09-23 13:09:11.225677Z] Running download-and-extract step. 06:09:11 INFO - Running pre-action listener: _resource_record_pre_action 06:09:11 INFO - Running main action method: download_and_extract 06:09:11 INFO - mkdir: /builds/slave/test/build/tests 06:09:11 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')]} 06:09:11 INFO - trying https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 06:09:11 INFO - Downloading https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/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 06:09:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/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 06:09:12 INFO - Downloaded 1199 bytes. 06:09:12 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 06:09:12 INFO - Using the following test package requirements: 06:09:12 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:09:12 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:09:12 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 06:09:12 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:09:12 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 06:09:12 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:09:12 INFO - u'jsshell-mac.zip'], 06:09:12 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:09:12 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 06:09:12 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 06:09:12 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:09:12 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 06:09:12 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:09:12 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 06:09:12 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:09:12 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 06:09:12 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 06:09:12 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 06:09:12 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 06:09:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:09:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:09:12 INFO - Fetch https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:09:13 INFO - Expected file size: 16438829 06:09:20 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 06:09:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 06:09:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 06:09:20 INFO - Fetch https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 06:09:20 INFO - Expected file size: 16438829 06:09:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 06:09:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 06:09:27 INFO - Fetch https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 06:09:28 INFO - Expected file size: 14414059 06:09: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')]} 06:09:28 INFO - trying https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:09:28 INFO - Downloading https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 06:09:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/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 06:09:31 INFO - Downloaded 111557890 bytes. 06:09:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:09:31 INFO - mkdir: /builds/slave/test/properties 06:09:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:09:31 INFO - Writing to file /builds/slave/test/properties/build_url 06:09:31 INFO - Contents: 06:09:31 INFO - build_url:https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 06:09:32 INFO - Running post-action listener: _resource_record_post_action 06:09:32 INFO - Running post-action listener: set_extra_try_arguments 06:09:32 INFO - [mozharness: 2016-09-23 13:09:32.332271Z] Finished download-and-extract step (success) 06:09:32 INFO - [mozharness: 2016-09-23 13:09:32.332412Z] Running populate-webroot step. 06:09:32 INFO - Running pre-action listener: _resource_record_pre_action 06:09:32 INFO - Running main action method: populate_webroot 06:09:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:09:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:09:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:09:32 INFO - '--tppagecycles', 06:09:32 INFO - '7'], 06:09:32 INFO - 'tests': ['tsvgm']}}, 06:09:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 06:09:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:09:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 06:09:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 06:09:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 06:09:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 06:09:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:09:32 INFO - 'talos_options': ['--disable-e10s'], 06:09:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:09:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:09:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:09:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:09:32 INFO - 'talos_options': ['--disable-e10s'], 06:09:32 INFO - 'tests': ['damp', 'tps']}, 06:09:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:09:32 INFO - 'tests': ['damp', 'tps']}, 06:09:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 06:09:32 INFO - 'tests': ['dromaeo_dom']}, 06:09:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:09:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 06:09:32 INFO - 'tests': ['basic_compositor_video']}, 06:09:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 06:09:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 06:09:32 INFO - 'tests': ['a11yr', 06:09:32 INFO - 'ts_paint', 06:09:32 INFO - 'tpaint', 06:09:32 INFO - 'sessionrestore', 06:09:32 INFO - 'sessionrestore_no_auto_restore', 06:09:32 INFO - 'tabpaint']}, 06:09:32 INFO - 'other-e10s': {'tests': ['a11yr', 06:09:32 INFO - 'ts_paint', 06:09:32 INFO - 'tpaint', 06:09:32 INFO - 'sessionrestore', 06:09:32 INFO - 'sessionrestore_no_auto_restore', 06:09:32 INFO - 'tabpaint']}, 06:09:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 06:09:32 INFO - 'ts_paint', 06:09:32 INFO - 'tpaint', 06:09:32 INFO - 'sessionrestore', 06:09:32 INFO - 'sessionrestore_no_auto_restore', 06:09:32 INFO - 'tabpaint']}, 06:09:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 06:09:32 INFO - 'ts_paint', 06:09:32 INFO - 'tpaint', 06:09:32 INFO - 'sessionrestore', 06:09:32 INFO - 'sessionrestore_no_auto_restore', 06:09:32 INFO - 'tabpaint']}, 06:09:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 06:09:32 INFO - 'tests': ['a11yr', 06:09:32 INFO - 'ts_paint', 06:09:32 INFO - 'tpaint', 06:09:32 INFO - 'sessionrestore', 06:09:32 INFO - 'sessionrestore_no_auto_restore', 06:09:32 INFO - 'tabpaint']}, 06:09:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 06:09:32 INFO - 'tests': ['a11yr', 06:09:32 INFO - 'ts_paint', 06:09:32 INFO - 'tpaint', 06:09:32 INFO - 'sessionrestore', 06:09:32 INFO - 'sessionrestore_no_auto_restore', 06:09:32 INFO - 'tabpaint']}, 06:09:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 06:09:32 INFO - 'tests': ['tsvgx', 06:09:32 INFO - 'tsvgr_opacity', 06:09:32 INFO - 'tart', 06:09:32 INFO - 'tscrollx', 06:09:32 INFO - 'cart']}, 06:09:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 06:09:32 INFO - 'tsvgr_opacity', 06:09:32 INFO - 'tart', 06:09:32 INFO - 'tscrollx', 06:09:32 INFO - 'cart']}, 06:09:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:09:32 INFO - 'talos_options': ['--disable-e10s'], 06:09:32 INFO - 'tests': ['tp5o']}, 06:09:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:09:32 INFO - 'tests': ['tp5o']}, 06:09:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:09:32 INFO - 'talos_options': ['--disable-e10s', 06:09:32 INFO - '--xperf_path', 06:09:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:09:32 INFO - 'tests': ['tp5n']}, 06:09:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:09:32 INFO - 'talos_options': ['--xperf_path', 06:09:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:09:32 INFO - 'tests': ['tp5n']}}, 06:09:32 INFO - 'talos.zip': {'path': '', 06:09:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:09:32 INFO - Running post-action listener: _resource_record_post_action 06:09:32 INFO - [mozharness: 2016-09-23 13:09:32.351677Z] Finished populate-webroot step (success) 06:09:32 INFO - [mozharness: 2016-09-23 13:09:32.351786Z] Running create-virtualenv step. 06:09:32 INFO - Running pre-action listener: _resource_record_pre_action 06:09:32 INFO - Running main action method: create_virtualenv 06:09:32 INFO - Creating virtualenv /builds/slave/test/build/venv 06:09:32 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 06:09:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:09:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:09:32 INFO - Using real prefix '/tools/python27' 06:09:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:09:33 INFO - Installing distribute.............................................................................................................................................................................................done. 06:09:36 INFO - Installing pip.................done. 06:09:36 INFO - Return code: 0 06:09:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:36 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 0x104558490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81505949b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10436cd30>, '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 0x104192db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104364b20>, '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.irwfLkIHIW/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.jO5MIrLRTz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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 06:09:36 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 06:09:36 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 06:09:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.irwfLkIHIW/Render', 06:09:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:09:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:09:36 INFO - 'HOME': '/Users/cltbld', 06:09:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:09:36 INFO - 'LOGNAME': 'cltbld', 06:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:36 INFO - 'MOZ_NO_REMOTE': '1', 06:09:36 INFO - 'NO_EM_RESTART': '1', 06:09:36 INFO - 'PAGER': '/bin/cat', 06:09:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:36 INFO - 'PWD': '/builds/slave/test', 06:09:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:09:36 INFO - 'SHELL': '/bin/bash', 06:09:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jO5MIrLRTz/Listeners', 06:09:36 INFO - 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/', 06:09:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:09:36 INFO - 'USER': 'cltbld', 06:09:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:09:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:36 INFO - 'XPC_FLAGS': '0x0', 06:09:36 INFO - 'XPC_SERVICE_NAME': '0', 06:09:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:36 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 06:09:36 INFO - Cleaning up... 06:09:36 INFO - Return code: 0 06:09:36 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 06:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:09:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:09:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:36 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 0x104558490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81505949b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10436cd30>, '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 0x104192db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104364b20>, '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.irwfLkIHIW/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.jO5MIrLRTz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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 06:09:36 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 06:09:36 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 06:09:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.irwfLkIHIW/Render', 06:09:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:09:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:09:36 INFO - 'HOME': '/Users/cltbld', 06:09:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:09:36 INFO - 'LOGNAME': 'cltbld', 06:09:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:36 INFO - 'MOZ_NO_REMOTE': '1', 06:09:36 INFO - 'NO_EM_RESTART': '1', 06:09:36 INFO - 'PAGER': '/bin/cat', 06:09:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:09:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:36 INFO - 'PWD': '/builds/slave/test', 06:09:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:09:36 INFO - 'SHELL': '/bin/bash', 06:09:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jO5MIrLRTz/Listeners', 06:09:36 INFO - 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/', 06:09:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:09:36 INFO - 'USER': 'cltbld', 06:09:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:09:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:09:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:36 INFO - 'XPC_FLAGS': '0x0', 06:09:36 INFO - 'XPC_SERVICE_NAME': '0', 06:09:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:36 INFO - Downloading/unpacking psutil>=3.1.1 06:09:36 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 06:09:36 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 06:09:36 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 06:09:36 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 06:09:36 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 06:09:36 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 06:09:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:09:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:09:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:09:40 INFO - Installing collected packages: psutil 06:09:40 INFO - Running setup.py install for psutil 06:09:40 INFO - building 'psutil._psutil_osx' extension 06:09:40 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 06:09:41 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 06:09:41 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 06:09:41 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 06:09:41 INFO - building 'psutil._psutil_posix' extension 06:09:41 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 06:09:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 06:09:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 06:09:41 INFO - ^ 06:09:41 INFO - 1 warning generated. 06:09:41 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 06:09:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:09:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:09:41 INFO - Successfully installed psutil 06:09:41 INFO - Cleaning up... 06:09:41 INFO - Return code: 0 06:09:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 06:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:09:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:09:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:41 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 0x104558490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81505949b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10436cd30>, '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 0x104192db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104364b20>, '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.irwfLkIHIW/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.jO5MIrLRTz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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 06:09:41 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 06:09:41 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 06:09:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.irwfLkIHIW/Render', 06:09:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:09:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:09:41 INFO - 'HOME': '/Users/cltbld', 06:09:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:09:41 INFO - 'LOGNAME': 'cltbld', 06:09:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:41 INFO - 'MOZ_NO_REMOTE': '1', 06:09:41 INFO - 'NO_EM_RESTART': '1', 06:09:41 INFO - 'PAGER': '/bin/cat', 06:09:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:09:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:41 INFO - 'PWD': '/builds/slave/test', 06:09:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:09:41 INFO - 'SHELL': '/bin/bash', 06:09:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jO5MIrLRTz/Listeners', 06:09:41 INFO - 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/', 06:09:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:09:41 INFO - 'USER': 'cltbld', 06:09:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:09:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:09:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:41 INFO - 'XPC_FLAGS': '0x0', 06:09:41 INFO - 'XPC_SERVICE_NAME': '0', 06:09:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:09:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 06:09: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 06:09: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 06:09: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 06:09: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 06:09: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 06:09: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 06:09:44 INFO - Downloading mozsystemmonitor-0.3.tar.gz 06:09:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:09:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 06:09:44 INFO - Installing collected packages: mozsystemmonitor 06:09:44 INFO - Running setup.py install for mozsystemmonitor 06:09:44 INFO - Successfully installed mozsystemmonitor 06:09:44 INFO - Cleaning up... 06:09:44 INFO - Return code: 0 06:09:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 06:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:09:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:44 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 0x104558490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81505949b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10436cd30>, '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 0x104192db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104364b20>, '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.irwfLkIHIW/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.jO5MIrLRTz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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 06:09:44 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 06:09:44 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 06:09:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.irwfLkIHIW/Render', 06:09:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:09:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:09:44 INFO - 'HOME': '/Users/cltbld', 06:09:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:09:44 INFO - 'LOGNAME': 'cltbld', 06:09:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:44 INFO - 'MOZ_NO_REMOTE': '1', 06:09:44 INFO - 'NO_EM_RESTART': '1', 06:09:44 INFO - 'PAGER': '/bin/cat', 06:09:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:09:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:44 INFO - 'PWD': '/builds/slave/test', 06:09:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:09:44 INFO - 'SHELL': '/bin/bash', 06:09:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jO5MIrLRTz/Listeners', 06:09:44 INFO - 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/', 06:09:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:09:44 INFO - 'USER': 'cltbld', 06:09:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:09:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:09:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:44 INFO - 'XPC_FLAGS': '0x0', 06:09:44 INFO - 'XPC_SERVICE_NAME': '0', 06:09:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:09:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:44 INFO - Downloading/unpacking jsonschema==2.5.1 06:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:09:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:09:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:09:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:09:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 06:09:47 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 06:09:47 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 06:09:47 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 06:09:47 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 06:09:47 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 06:09:47 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 06:09:47 INFO - Downloading functools32-3.2.3-2.tar.gz 06:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:09:47 INFO - warning: no files found matching '*.txt' 06:09:47 INFO - no previously-included directories found matching 'build' 06:09:47 INFO - no previously-included directories found matching 'dist' 06:09:47 INFO - no previously-included directories found matching '.git*' 06:09:47 INFO - Installing collected packages: jsonschema, functools32 06:09:47 INFO - Running setup.py install for functools32 06:09:47 INFO - warning: no files found matching '*.txt' 06:09:47 INFO - no previously-included directories found matching 'build' 06:09:47 INFO - no previously-included directories found matching 'dist' 06:09:47 INFO - no previously-included directories found matching '.git*' 06:09:47 INFO - Successfully installed jsonschema functools32 06:09:47 INFO - Cleaning up... 06:09:48 INFO - Return code: 0 06:09:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 06:09:48 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')]} 06:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:48 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')]} 06:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:48 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 0x104558490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81505949b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10436cd30>, '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 0x104192db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104364b20>, '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.irwfLkIHIW/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.jO5MIrLRTz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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 06:09:48 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 06:09:48 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 06:09:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.irwfLkIHIW/Render', 06:09:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:09:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:09:48 INFO - 'HOME': '/Users/cltbld', 06:09:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:09:48 INFO - 'LOGNAME': 'cltbld', 06:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:48 INFO - 'MOZ_NO_REMOTE': '1', 06:09:48 INFO - 'NO_EM_RESTART': '1', 06:09:48 INFO - 'PAGER': '/bin/cat', 06:09:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:48 INFO - 'PWD': '/builds/slave/test', 06:09:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:09:48 INFO - 'SHELL': '/bin/bash', 06:09:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jO5MIrLRTz/Listeners', 06:09:48 INFO - 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/', 06:09:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:09:48 INFO - 'USER': 'cltbld', 06:09:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:09:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:48 INFO - 'XPC_FLAGS': '0x0', 06:09:48 INFO - 'XPC_SERVICE_NAME': '0', 06:09:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 06:09:48 INFO - Cleaning up... 06:09:48 INFO - Return code: 0 06:09:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:09:48 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')]} 06:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:48 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')]} 06:09:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:48 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 0x104558490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81505949b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10436cd30>, '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 0x104192db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104364b20>, '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.irwfLkIHIW/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.jO5MIrLRTz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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 06:09:48 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 06:09:48 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 06:09:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.irwfLkIHIW/Render', 06:09:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:09:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:09:48 INFO - 'HOME': '/Users/cltbld', 06:09:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:09:48 INFO - 'LOGNAME': 'cltbld', 06:09:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:48 INFO - 'MOZ_NO_REMOTE': '1', 06:09:48 INFO - 'NO_EM_RESTART': '1', 06:09:48 INFO - 'PAGER': '/bin/cat', 06:09:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:09:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:48 INFO - 'PWD': '/builds/slave/test', 06:09:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:09:48 INFO - 'SHELL': '/bin/bash', 06:09:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jO5MIrLRTz/Listeners', 06:09:48 INFO - 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/', 06:09:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:09:48 INFO - 'USER': 'cltbld', 06:09:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:09:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:09:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:48 INFO - 'XPC_FLAGS': '0x0', 06:09:48 INFO - 'XPC_SERVICE_NAME': '0', 06:09:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:09:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:48 INFO - Downloading/unpacking blobuploader==1.2.4 06:09:48 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 06:09:48 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 06:09:48 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 06:09:48 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 06:09:48 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 06:09:48 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 06:09:51 INFO - Downloading blobuploader-1.2.4.tar.gz 06:09:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:09:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:09:51 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 06:09:51 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 06:09:51 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 06:09:51 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 06:09:51 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 06:09:51 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 06:09:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:09:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:09:51 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 06:09:51 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 06:09:51 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 06:09:51 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 06:09:51 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 06:09:51 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 06:09:52 INFO - Downloading docopt-0.6.1.tar.gz 06:09:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:09:52 INFO - Installing collected packages: blobuploader, requests, docopt 06:09:52 INFO - Running setup.py install for blobuploader 06:09:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:09:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:09:52 INFO - Running setup.py install for requests 06:09:52 INFO - Running setup.py install for docopt 06:09:53 INFO - Successfully installed blobuploader requests docopt 06:09:53 INFO - Cleaning up... 06:09:53 INFO - Return code: 0 06:09:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:09: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')]} 06:09:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09: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')]} 06:09:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:53 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 0x104558490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81505949b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10436cd30>, '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 0x104192db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104364b20>, '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.irwfLkIHIW/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.jO5MIrLRTz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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 06:09:53 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 06:09:53 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 06:09:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.irwfLkIHIW/Render', 06:09:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:09:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:09:53 INFO - 'HOME': '/Users/cltbld', 06:09:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:09:53 INFO - 'LOGNAME': 'cltbld', 06:09:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:53 INFO - 'MOZ_NO_REMOTE': '1', 06:09:53 INFO - 'NO_EM_RESTART': '1', 06:09:53 INFO - 'PAGER': '/bin/cat', 06:09:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:09:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:53 INFO - 'PWD': '/builds/slave/test', 06:09:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:09:53 INFO - 'SHELL': '/bin/bash', 06:09:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jO5MIrLRTz/Listeners', 06:09:53 INFO - 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/', 06:09:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:09:53 INFO - 'USER': 'cltbld', 06:09:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:09:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:09:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:53 INFO - 'XPC_FLAGS': '0x0', 06:09:53 INFO - 'XPC_SERVICE_NAME': '0', 06:09:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:09:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:09:53 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-mOht5S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:09:53 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-rbrB9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:09:53 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-cj6BH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:09:53 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-BnbUQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:09:53 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-fHVuuw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:09:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:09:53 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-HIWfFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:09:54 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-OXlyrk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:09:54 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-UazrsH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:09:54 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-59PJOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:09:54 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-quH3AY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:09:54 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-Nf1wNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:09:54 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-AUzwKN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:09:54 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-utY62g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:09:54 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-xKvKQC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:09:54 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-SC7imt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:09:54 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-ZNrdOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:09:55 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-YqyWLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:09:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:09:55 INFO - Running setup.py install for manifestparser 06:09:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:09:55 INFO - Running setup.py install for mozcrash 06:09:55 INFO - Running setup.py install for mozdebug 06:09:55 INFO - Running setup.py install for mozdevice 06:09:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:09:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:09:55 INFO - Running setup.py install for mozfile 06:09:55 INFO - Running setup.py install for mozhttpd 06:09:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:09:56 INFO - Running setup.py install for mozinfo 06:09:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:09:56 INFO - Running setup.py install for mozInstall 06:09:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:09:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:09:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:09:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:09:56 INFO - Running setup.py install for mozleak 06:09:56 INFO - Running setup.py install for mozlog 06:09:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:09:56 INFO - Running setup.py install for moznetwork 06:09:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:09:56 INFO - Running setup.py install for mozprocess 06:09:56 INFO - Running setup.py install for mozprofile 06:09:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:09:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:09:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:09:57 INFO - Running setup.py install for mozrunner 06:09:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:09:57 INFO - Running setup.py install for mozscreenshot 06:09:57 INFO - Running setup.py install for moztest 06:09:57 INFO - Running setup.py install for mozversion 06:09:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:09:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:09:57 INFO - Cleaning up... 06:09:57 INFO - Return code: 0 06:09:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:09:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:09:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:09:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:09:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:09:57 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 0x104558490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81505949b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10436cd30>, '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 0x104192db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104364b20>, '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.irwfLkIHIW/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.jO5MIrLRTz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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 06:09:57 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 06:09:57 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 06:09:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.irwfLkIHIW/Render', 06:09:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:09:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:09:57 INFO - 'HOME': '/Users/cltbld', 06:09:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:09:57 INFO - 'LOGNAME': 'cltbld', 06:09:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:09:57 INFO - 'MOZ_NO_REMOTE': '1', 06:09:57 INFO - 'NO_EM_RESTART': '1', 06:09:57 INFO - 'PAGER': '/bin/cat', 06:09:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:09:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:09:57 INFO - 'PWD': '/builds/slave/test', 06:09:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:09:57 INFO - 'SHELL': '/bin/bash', 06:09:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jO5MIrLRTz/Listeners', 06:09:57 INFO - 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/', 06:09:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:09:57 INFO - 'USER': 'cltbld', 06:09:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:09:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:09:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:09:57 INFO - 'XPC_FLAGS': '0x0', 06:09:57 INFO - 'XPC_SERVICE_NAME': '0', 06:09:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:09:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:09:58 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-I17_tw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:09:58 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)) 06:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:09:58 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-10lMEd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:09:58 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)) 06:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:09:58 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-AznD1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:09:58 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)) 06:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:09:58 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-zpjAFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:09:58 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)) 06:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:09:58 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-G2Lyr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:09:58 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)) 06:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:09:58 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-bJhTyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:09:58 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)) 06:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:09:58 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-JUB9L3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:09:58 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)) 06:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:09:58 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-GJRC1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:09:58 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)) 06:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:09:58 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-SXDF63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:09:58 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)) 06:09:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:09:58 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-q3WKA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:09:59 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)) 06:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:09:59 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-YWlDh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:09:59 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)) 06:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:09:59 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-ds8CH8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:09:59 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)) 06:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:09:59 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-CYi2iv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:09:59 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)) 06:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:09:59 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-mwTQQ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:09:59 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)) 06:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:09:59 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-ETNjbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:09:59 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)) 06:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:09:59 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-hqBnqt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:09:59 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)) 06:09:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:09:59 INFO - Running setup.py (path:/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/pip-bnw1IN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:09:59 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)) 06:09:59 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)) 06:09:59 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)) 06:09:59 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)) 06:09:59 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)) 06:09:59 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)) 06:09:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:09:59 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 06:09:59 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 06:09:59 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 06:09:59 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 06:09:59 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 06:09:59 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 06:10:02 INFO - Downloading blessings-1.6.tar.gz 06:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:10:02 INFO - Installing collected packages: blessings 06:10:02 INFO - Running setup.py install for blessings 06:10:02 INFO - Successfully installed blessings 06:10:02 INFO - Cleaning up... 06:10:02 INFO - Return code: 0 06:10:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:10:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:10:02 INFO - Reading from file tmpfile_stdout 06:10:02 INFO - Current package versions: 06:10:02 INFO - blessings == 1.6 06:10:02 INFO - blobuploader == 1.2.4 06:10:02 INFO - docopt == 0.6.1 06:10:02 INFO - functools32 == 3.2.3-2 06:10:02 INFO - jsonschema == 2.5.1 06:10:02 INFO - manifestparser == 1.1 06:10:02 INFO - mozInstall == 1.12 06:10:02 INFO - mozcrash == 0.17 06:10:02 INFO - mozdebug == 0.1 06:10:02 INFO - mozdevice == 0.48 06:10:02 INFO - mozfile == 1.2 06:10:02 INFO - mozhttpd == 0.7 06:10:02 INFO - mozinfo == 0.9 06:10:02 INFO - mozleak == 0.1 06:10:02 INFO - mozlog == 3.4 06:10:02 INFO - moznetwork == 0.27 06:10:02 INFO - mozprocess == 0.23 06:10:02 INFO - mozprofile == 0.28 06:10:02 INFO - mozrunner == 6.12 06:10:02 INFO - mozscreenshot == 0.1 06:10:02 INFO - mozsystemmonitor == 0.3 06:10:02 INFO - moztest == 0.7 06:10:02 INFO - mozversion == 1.4 06:10:02 INFO - psutil == 3.1.1 06:10:02 INFO - requests == 1.2.3 06:10:02 INFO - wsgiref == 0.1.2 06:10:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:03 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 0x104558490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81505949b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10436cd30>, '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 0x104192db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104364b20>, '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.irwfLkIHIW/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.jO5MIrLRTz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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 06:10:03 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 06:10:03 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 06:10:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.irwfLkIHIW/Render', 06:10:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:10:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:10:03 INFO - 'HOME': '/Users/cltbld', 06:10:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:10:03 INFO - 'LOGNAME': 'cltbld', 06:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:03 INFO - 'MOZ_NO_REMOTE': '1', 06:10:03 INFO - 'NO_EM_RESTART': '1', 06:10:03 INFO - 'PAGER': '/bin/cat', 06:10:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:03 INFO - 'PWD': '/builds/slave/test', 06:10:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:10:03 INFO - 'SHELL': '/bin/bash', 06:10:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jO5MIrLRTz/Listeners', 06:10:03 INFO - 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/', 06:10:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:10:03 INFO - 'USER': 'cltbld', 06:10:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:10:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:03 INFO - 'XPC_FLAGS': '0x0', 06:10:03 INFO - 'XPC_SERVICE_NAME': '0', 06:10:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:03 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)) 06:10:03 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)) 06:10:03 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)) 06:10:03 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)) 06:10:03 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)) 06:10:03 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)) 06:10:03 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)) 06:10:03 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)) 06:10:03 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)) 06:10:03 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)) 06:10:03 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)) 06:10:03 INFO - Cleaning up... 06:10:03 INFO - Return code: 0 06:10:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:10:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 06:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:10:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:10:03 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 0x104558490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044ce570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f81505949b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10436cd30>, '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 0x104192db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104364b20>, '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.irwfLkIHIW/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.jO5MIrLRTz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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 06:10:03 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 06:10:03 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 06:10:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.irwfLkIHIW/Render', 06:10:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:10:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:10:03 INFO - 'HOME': '/Users/cltbld', 06:10:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:10:03 INFO - 'LOGNAME': 'cltbld', 06:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:03 INFO - 'MOZ_NO_REMOTE': '1', 06:10:03 INFO - 'NO_EM_RESTART': '1', 06:10:03 INFO - 'PAGER': '/bin/cat', 06:10:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:03 INFO - 'PWD': '/builds/slave/test', 06:10:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:10:03 INFO - 'SHELL': '/bin/bash', 06:10:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jO5MIrLRTz/Listeners', 06:10:03 INFO - 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/', 06:10:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:10:03 INFO - 'USER': 'cltbld', 06:10:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:10:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:03 INFO - 'XPC_FLAGS': '0x0', 06:10:03 INFO - 'XPC_SERVICE_NAME': '0', 06:10:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:10:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 06:10:03 INFO - Cleaning up... 06:10:03 INFO - Return code: 0 06:10:03 INFO - Running post-action listener: _resource_record_post_action 06:10:03 INFO - Running post-action listener: _start_resource_monitoring 06:10:03 INFO - Starting resource monitoring. 06:10:03 INFO - [mozharness: 2016-09-23 13:10:03.567076Z] Finished create-virtualenv step (success) 06:10:03 INFO - [mozharness: 2016-09-23 13:10:03.568108Z] Running install step. 06:10:03 INFO - Running pre-action listener: _resource_record_pre_action 06:10:03 INFO - Running main action method: install 06:10:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:10:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:10:03 INFO - Reading from file tmpfile_stdout 06:10:03 INFO - Detecting whether we're running mozinstall >=1.0... 06:10:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:10:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:10:03 INFO - Reading from file tmpfile_stdout 06:10:03 INFO - Output received: 06:10:03 INFO - Usage: mozinstall [options] installer 06:10:03 INFO - Options: 06:10:03 INFO - -h, --help show this help message and exit 06:10:03 INFO - -d DEST, --destination=DEST 06:10:03 INFO - Directory to install application into. [default: 06:10:03 INFO - "/builds/slave/test"] 06:10:03 INFO - --app=APP Application being installed. [default: firefox] 06:10:03 INFO - mkdir: /builds/slave/test/build/application 06:10:03 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'] 06:10:03 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 06:10:38 INFO - Reading from file tmpfile_stdout 06:10:38 INFO - Output received: 06:10:38 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 06:10:38 INFO - Running post-action listener: _resource_record_post_action 06:10:38 INFO - [mozharness: 2016-09-23 13:10:38.411874Z] Finished install step (success) 06:10:38 INFO - [mozharness: 2016-09-23 13:10:38.412010Z] Running run-tests step. 06:10:38 INFO - Running pre-action listener: _resource_record_pre_action 06:10:38 INFO - Running main action method: run_tests 06:10:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:10:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:10:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:10:38 INFO - 2016-09-23 06:10:38.426 screenresolution[1644:7812] starting screenresolution argv=screenresolution get 06:10:38 INFO - 2016-09-23 06:10:38.429 screenresolution[1644:7812] Display 0: 1600x1200x32@60 06:10:38 INFO - 2016-09-23 06:10:38.435 screenresolution[1645:7814] starting screenresolution argv=screenresolution list 06:10:38 INFO - Available Modes on Display 0 06:10:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:10:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:10:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:10:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:10:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:10:38 INFO - Intel Iris: 06:10:38 INFO - Chipset Model: Intel Iris 06:10:38 INFO - Type: GPU 06:10:38 INFO - Bus: Built-In 06:10:38 INFO - VRAM (Dynamic, Max): 1536 MB 06:10:38 INFO - Vendor: Intel (0x8086) 06:10:38 INFO - Device ID: 0x0a2e 06:10:38 INFO - Revision ID: 0x0009 06:10:38 INFO - Displays: 06:10:38 INFO - Display: 06:10:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:10:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:10:38 INFO - Display Serial Number: 1600x1200 60 06:10:38 INFO - Main Display: Yes 06:10:38 INFO - Mirror: Off 06:10:38 INFO - Online: Yes 06:10:38 INFO - Rotation: Supported 06:10:38 INFO - Return code: 0 06:10:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:10:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:10:38 INFO - Python 2.7.3 06:10:38 INFO - Return code: 0 06:10:38 INFO - grabbing minidump binary from tooltool 06:10: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')]} 06:10:38 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 0x10436cd30>, '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 0x104192db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104364b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:10:38 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 06:10:38 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 06:10:38 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 06:10:38 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:10:38 INFO - Return code: 0 06:10:38 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 06:10:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:10:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:10:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 06:10:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:10:38 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/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0003', '--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 06:10:38 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/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0003 --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 06:10:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.irwfLkIHIW/Render', 06:10:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 06:10:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 06:10:38 INFO - 'HOME': '/Users/cltbld', 06:10:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 06:10:38 INFO - 'LOGNAME': 'cltbld', 06:10:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:10:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 06:10:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:10:38 INFO - 'MOZ_NO_REMOTE': '1', 06:10:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:10:38 INFO - 'NO_EM_RESTART': '1', 06:10:38 INFO - 'PAGER': '/bin/cat', 06:10:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 06:10:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:10:38 INFO - 'PWD': '/builds/slave/test', 06:10:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:10:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 06:10:38 INFO - 'SHELL': '/bin/bash', 06:10:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jO5MIrLRTz/Listeners', 06:10:38 INFO - 'TMPDIR': '/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/', 06:10:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 06:10:38 INFO - 'USER': 'cltbld', 06:10:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 06:10:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 06:10:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:10:38 INFO - 'XPC_FLAGS': '0x0', 06:10:38 INFO - 'XPC_SERVICE_NAME': '0', 06:10:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 06:10:38 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/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0003', '--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 06:10:39 INFO - mozversion application_buildid: 20160923041700 06:10:39 INFO - mozversion application_changeset: 2e46d0c12db68401969a817832329187da8add06 06:10:39 INFO - mozversion application_display_name: Nightly 06:10:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:10:39 INFO - mozversion application_name: Firefox 06:10:39 INFO - mozversion application_remotingname: firefox 06:10:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 06:10:39 INFO - mozversion application_vendor: Mozilla 06:10:39 INFO - mozversion application_version: 52.0a1 06:10:39 INFO - mozversion platform_buildid: 20160923041700 06:10:39 INFO - mozversion platform_changeset: 2e46d0c12db68401969a817832329187da8add06 06:10:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 06:10:39 INFO - mozversion platform_version: 52.0a1 06:10:39 INFO - using testdate: 1474636239 06:10:39 INFO - actual date: 1474636239 06:10:39 INFO - starting webserver on 'localhost:49266' 06:10:39 INFO - SUITE-START | Running 2 tests 06:10:39 INFO - TEST-START | dromaeo_css 06:10:39 INFO - operating with platform_type : mac_ 06:10:39 INFO - Initialising browser for dromaeo_css test... 06:10:39 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/tmpr8e6jB/profile http://localhost:49266/getInfo.html) 06:10:41 INFO - PROCESS | 1655 | __metrics Screen width/height:1600/1200 06:10:41 INFO - PROCESS | 1655 | colorDepth:24 06:10:41 INFO - PROCESS | 1655 | Browser inner width/height: 1024/689 06:10:41 INFO - PROCESS | 1655 | __metrics 06:10:41 INFO - PROCESS | 1655 | 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" 06:10:41 INFO - PROCESS | 1655 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:10:42 INFO - TEST-INFO | 1655: exit 0 06:10:42 INFO - Browser initialized. 06:10:42 INFO - Running cycle 1/1 for dromaeo_css test... 06:10:42 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/tmpr8e6jB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:10:54 INFO - PROCESS | 1657 | RSS: Main: 235626496 06:10:54 INFO - PROCESS | 1657 | 06:11:46 INFO - PROCESS | 1657 | 1474636306337 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] 06:13:57 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49266/tests/dromaeo/cssquery-ext.html) 06:13:59 INFO - PROCESS | 1657 | RSS: Main: 411889664 06:13:59 INFO - PROCESS | 1657 | 06:17:02 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-ext.html (next: http://localhost:49266/tests/dromaeo/cssquery-jquery.html) 06:17:03 INFO - PROCESS | 1657 | RSS: Main: 371441664 06:17:03 INFO - PROCESS | 1657 | 06:20:05 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49266/tests/dromaeo/cssquery-mootools.html) 06:20:06 INFO - PROCESS | 1657 | RSS: Main: 365404160 06:20:06 INFO - PROCESS | 1657 | 06:23:08 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49266/tests/dromaeo/cssquery-prototype.html) 06:23:08 INFO - PROCESS | 1657 | RSS: Main: 356057088 06:23:08 INFO - PROCESS | 1657 | 06:26:12 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49266/tests/dromaeo/cssquery-yui.html) 06:26:12 INFO - PROCESS | 1657 | RSS: Main: 335114240 06:26:12 INFO - PROCESS | 1657 | 06:29:16 INFO - PROCESS | 1657 | Cycle 1(1): loaded http://localhost:49266/tests/dromaeo/cssquery-yui.html (next: http://localhost:49266/tests/dromaeo/cssquery-dojo.html) 06:29:16 INFO - PROCESS | 1657 | RSS: Main: 460193792 06:29:16 INFO - PROCESS | 1657 | 06:29:16 INFO - PROCESS | 1657 | __start_tp_report 06:29:16 INFO - PROCESS | 1657 | _x_x_mozilla_page_load 06:29:16 INFO - PROCESS | 1657 | _x_x_mozilla_page_load_details 06:29:16 INFO - PROCESS | 1657 | |i|pagename|runs| 06:29:16 INFO - PROCESS | 1657 | |0;dojo.html;2866.4267146570687;3301.4222511060566;3312.8840490582834;3334.583177102862;3360.865565377385;5522.171674248864;5581.246531718222;5590.580706447013;5648.491635752782;5674.177244299579;5591.161325801132;5606.35526914405;5686.346070201928;5690.573207009481;5700.458456446631;5080.720560369178;5096.159133742928;5105.5660268877;5110.156824124015;5133;5150.587952963754;5237.8952420951555;5242;5244.449332820056;5288.68267903927;5192.428832828424;5211.114110601206;5226.634135610509;5239.973800131013;5294.047071527124;5066.46802085783;5096.133657278272;5124.564412024945;5129.153689641242;5139.15203991341;5069.670471419346;5081.542661160476;5087.567556757643;5144.305518754995;5187.48125187482;5619.915701264485;5637.661740295595;5638.548916086745;5646.153077038436;5655.830325090254;5965.313988891289;6031.487323577501;6033.849153771147;6123.265208175003;6144;6098.2682078150465;6100.672006988077;6181.284389011517;6183.567150299481;6245.250569931592;5558.527525160326;5617.634853734453;5678.801241956512;5700.629459085146;5712.314522257314;5701.71491425427;6114.785982490592;6187.752489900444;6293.056041593706;6330;5906.675132867734;5929.199558059693;5946.405359464019;5955.702214889238;6053.818385448443;6151.200343955257;6168.660723660242;6176.536759742948;6183.227096612924;6205.782797602153;6050.6369617823075;6075.1191077294425;6092.786752463642;6097.864255374242;6116.244530167495;5969.253843269591;5969.373215812364;5998.850028749316;6097.817065488042;6139.4781443577795;4807.302941073524;4816.903661926742;4823.686460380064;4823.831165909247;4831;4304.870853874389;4323.437953066082;4408.845690400821;4413.514513403523;4421.491528474202;5552.194931734876;5615.2700148980375;5622.887542249132;5629.43705629442;5646.322441307069;6091.587005672113;6098.855844323405;6099.370313949828;6129.205975626751;6135.141080248769;5664.773409063674;5672.347680016768;5680.77276908919;5714.857128571736;5751.798687046017;5231.058409486329;5245.186996015624;5252.894942101137;5262.421133675292;5266.183741520071;6171.043488259327;6243.8126856194385;6316.905246421307;6331.176946996953;6349.746010159542;6104.755809767737;6106.703363853616;6112.929053818819;6121.178620693132;6140.289530736458;6276.4351208389635;6304.905426418516;6312.400321969406;6319.968400158154;6328.525360597881;6084.726187321669;6085.939140608537;6097.237845269341;6111.96944015277;6112.388761123852;6003.099535069775;6007.939920600738;6154.876902462015;6165.260168779775;6173.259208894961;5806.854828629318;5880.647161170344;5882.911756323744;5885.823425297248;5917.526597872074;5891.351951285269;5941.9405805943115;5951.642901425928;5964.463198311999;5992.910106348496;5794.275715535558;5797.710114494174;5797.971010144923;5802.100674395476;5810.4189581041555;5753.3958934311295;5819.359870414336;5821.068629019336;5857.384974577608;5944.8811023780145;5742;5766.048601980794;5850.94149058504;5859.062549992152;5864.824055278348 06:29:16 INFO - PROCESS | 1657 | |1;ext.html;455.876913233427;498.93264409304777;510.27286117282864;528.5982653183581;530.3662123762106;30341.848290758542;40399.59600403995;40487.797561012194;40633.984150396216;42929.57070429302;42411.363829542584;42847.357289640604;42851.571484285145;42956.63738494382;42999.925001874966;9601.327907046509;9792.167665748384;9801.970793066732;9806.607735690599;9814.116729494344;9571.856422153673;9662;9666.999999999965;9667.081627245401;9679.661211857587;9624.566894489764;9658.806823863519;9684.75788105296;9694.854577181313;9707.660231891885;9501.952490237574;9602.711918642382;9637.518124093802;9664.178544823699;9679.322447428684;9522.333436659437;9586.185174260196;9586.808263834684;9590;9602.567884445216;40322.79838600788;40655.7967210162;40734.38898416526;40961.79519102415;40972.79513602413;3393.2195595013286;3544.7341449391397;3597.208614104919;3833.712471564616;3986.142979259473;29870.25324366908;30206;30723.231919201975;31070.223244418845;31459;3191.712745852861;3212.5341825435416;3240.3843269778904;3258.1365938026443;3280.114369120348;439410.9999999968;442685;443691.7815410902;444731;444925;58624.723774859616;58698;58775.41224587785;58933.11600325999;58993.41006589965;34310.14224644354;34571.308573828384;35017.824910875795;62047.6897615509;62450;15433.459828905934;15606.219689015505;15620.218989050729;15657.921710391374;15660.37358505647;9953.900460995443;11858.525658973716;11920.344381059125;11954.342511161796;11996.220245684002;14995.850041499445;18609.53476163107;18668.346607868658;18695.345662902004;18744.25022999065;6247.937520624827;6318.767840271195;7457.552546847207;7608.277213664693;7615.238476152341;886.8980067292215;961.4135377419768;1018.2922868606396;1025.74869157057;1041.682286902502;29087.7091229085;29172.270693232414;29323.774384817654;29557.693830680186;29904.40191196164;888.3337496877342;1049.024407301202;1106.9391183484825;1123.2698745815285;1125.431657013203;14921.477748278758;15250.389984400499;15269.770953435707;15548.22258887051;15707.528774136794;561086;562477;563240;565580;570265;54664.72667636716;55437;55476;55607.16589251164;55610.44389556134;1135.795556799784;1266.5883587833991;1324.5165514586913;1374.3677908162158;1389.4442223110836;24015.51968960646;28973.56539651949;29244.70755292505;29705.85147074337;29961.250968725086;47484.050318994116;48214.27678584894;48220.035599288516;48251.27623085727;48265.7933551664;524089;527837;530413;531019;531640;22853.65719514242;23234.1868034618;25132.246032619052;25725.742742573082;25788;44909.87725306893;45212.54787452083;45410.54589454063;46552.534474656175;47020.7648961753;37579.06052348713;37783.62216377801;37962.810185948896;38399.80800095982;38879.028024299616;37825.86522404332;37958.810205948794;38085.4287185698;38216.61783382131;38628.80685596554;28262.88213047628;31978.52032219472;32862.67137328692;36967.81516092402;37878;32074.518882216318;33312.50031249582;34546.82726586351;34615.653843461245;34661.30677386488;21991.340259792232;24873.751262487145;25132.62301065522;25597.23208303754;25844.870775646003 06:29:16 INFO - PROCESS | 1657 | |2;jquery.html;317.27502656430056;333.204030276808;370.48502581411844;393.1115678566442;400.6914675699711;19564.31524896627;19954.800451995477;20225.696614550758;20245.291414800486;20842.16631334747;20678.282856043537;20752.896235518838;20833.79166208341;20883.164673413085;21405.67891481625;5811.738471768781;5866.6480011199255;6119.541034422414;6143.44708976192;6149.938500614981;3931.8034098295116;6193.876122477548;6221.533384996121;6241.968790156043;6244.157038799772;3867.8066096695193;4102.323116685743;4142.7514349139;4152.792360381984;4184.456020717318;6840.897386539206;6940.618265995368;6946.444284457231;6948.409385202264;6961.721531138748;5868.295804503487;6013.278406591194;6088.238970128734;6100.969495152496;6109.5112391008615;13429.798553021712;13470.25913574753;13481.562201638617;13724.117935233613;13746.037777355588;2160.816330611884;2292.2435596253194;2314.849534780251;2349.189529612298;3031.181580973147;10235.948820255851;10376.94811525945;13746.312684365841;15302.464413745465;16038.358465661477;1804.2422182683304;1872.8314451699412;1899.563100486882;1958.9412317630495;1973.4178417366911;111488;121145;121982.56034879253;123930.38034809858;125522;9464.810703785886;11214.215004949576;11507.539698412138;11627.302361858316;11754.353510557;14720.337584808709;14752.041117327339;14758.40966361355;14772.92613536947;14789.926050369679;8221.506709597443;8511.276541493919;8527.74416767498;8691;8697.608607612547;8327.042390125092;8328.167183281745;8350.248477637042;8514.063453020286;8519.403641745143;3858.7684738915755;4422.049259409242;4549.567791059844;4563.748993805306;4683.484816670163;1667.9166041697868;1873.718942158687;1912.4645099372199;1933.4489670443857;1969.251684359934;853.7566793463833;866.0559989611354;885.2740752582949;886.6985225023523;953.713885834247;17373.913130434266;21217;21296.254631088148;21335.893320533607;21759;927.9860802087974;931.4318265857821;962.2638681408728;1008.7377281906757;1040.38617215843;8266.644006458131;10662.093722033558;10993.285436446606;11288.94355528217;11296.152788540892;568495;570537;577125;592237;593655;120973.39513302554;125475;126250;126299;127982;951.5194826612517;972.6352617768337;976.4434272464626;1038.4963292802984;1041.6874937518714;19238.71141932844;19704.605907881476;19852.70220946658;19864.304749333704;19908.70136947918;54688;54833.30192141807;55462;55488.445115548326;55815.162772559255;75964.62017689877;77140.84288735561;78808.60595696984;81669;82079;6588.472922166311;7981.241782030698;8136.1863813618165;8174.7956301092945;8299.792505187177;10806.135509159405;12648.154165312731;12840.972722182016;13133.146345487512;13225.80161297562;9976.05227503386;10292.816326122293;10879.23845330851;10961.287516311415;11359.829602555803;9416;10222.846657300295;11028.44857757125;11071.612493562687;11367.090632749194;11268.661940141808;11366.772664546497;11527.654170374903;11668.299902005907;11826.82259766087;7870.212978702084;7898.210178982055;8309.501429914224;8309.792255193668;8347.45741526823;8750.69372571957;9792.412455252423;11222.66332010041;11235.831462527905;11423.885761142283 06:29:16 INFO - PROCESS | 1657 | |3;mootools.html;1355.4984655677401;1512.6898985707928;1544.9150296733678;1699.4137022727155;1861.9255229790801;7917.129115797257;8414.621342039607;8581.098984606611;8961.507117108556;8965.103489651032;8833.71911072894;8913.1978121969;8917.152870477294;8930.687425940094;8932.419392739468;2373.8813059347094;2402.7477114902945;2403.230966090852;2404.5311164322966;2405.891734871926;2095.7904209579074;2363.2555744940373;2364.9357788994935;2385.7494963028807;2411.6985376827897;2372.478054827935;2388.080588973249;2390.0917651292484;2411.059686722171;2413.5655581995234;2351.2005917987794;2372.8101751859895;2386.6539351794067;2386.8448550844314;2388.617821148608;2334.1947028275217;2357.587422201108;2358.469344397514;2366.6213405854983;2368.135630494874;8646.351523635753;8739.257163141141;8964.50695211763;8968.372213945026;8975;5201.45384734605;5383.811566595189;5391.110466773017;5394.379646340682;5399.244105825188;3630.6913912317486;3665.486831843544;3719.590845007047;3724.2179142380132;3737.1965027519213;1075.2365820267619;1085.1915323084274;1088.967330980072;1102.8676558812913;1107.385401102388;11655.067594592327;11718.824217636742;11732.17874748768;11833.230839995373;11839;3841.4621952926614;4340.500842403101;4579.22153233951;4597.103564804831;4605.355250264965;9202.447853128833;9207.17135457812;9215.585298661576;9219.631214751469;9240.445573265626;5232.215167724796;5234.502722241381;5235.790568377222;5251.317328747238;5252.527272545489;4138.317177665652;4140.482439695038;4451.577100175478;4521.163584736834;4911.533404326583;3518.7888726676483;3813.4470501777087;3816.2367526494813;3819.5416550014174;3827.8660246891227;1143.5254369436757;1165.7610189911047;1166.2302880099264;1174.277819141222;1176.4470698771563;798.4769975665948;880.9955950220208;911.5305617606938;920.1212841736126;960.870282511852;5568.693721845338;5707.200991861143;5963;5967.343592204854;6001.36985616504;421.1261632113377;424.85342556817847;432.7230572433645;433.3175248982865;445.92196365635886;3086.845657717105;3880.5164694595483;3993.72043956926;4006.5192176938954;4017.7991100445447;10502.527386267637;10766.78466430667;10856.34861908288;10871.619493317696;10882.238243322892;10790.730231744112;10794.73013174677;10799.56801727922;10800.45997700112;10805.945970270099;7929.841403171904;8095.190480951976;8155.184481551797;8267.007959044833;8277.337812974827;5710.086386178192;5813.186153938536;5817.854553636023;5872.0898260769645;5933.495652869555;9941.105300522988;10203.234757393077;10209.234307427121;10210.489475526045;10224.386536807815;9454.669086582211;10099.242556808416;10195.84706229422;10354.5340459678;10421.374717516974;6651.201855777338;6876.656167191721;6979.232284448808;7144.964275178799;7164.785056448315;8230.176982301722;8250.174982501701;8255.917440825515;8324.750257492286;8367.581620918809;7482.625868706434;7538.886916696364;7563.168051514439;7582.469227154046;7585.582792946441;7203.243659415895;7335.481131839907;7383.630818459163;7445;7525.24747525265;6977.406920411822;6978.406835419046;7053.0830991970715;7057.858842823218;7104.076470059066;4250.341197114452;4256.829726810893;4980.352554167935;5062.443131255633;5126.7949282029795;4949.1586430306215;4966.553010229097;5070.771815268248;5098.286239926488;5248.291480650216 06:29:16 INFO - PROCESS | 1657 | |4;prototype.html;249.19758378022766;295.9171431999041;303.8921182980041;309.5233340655391;311.27007168190613;4217.355231459729;4312.547182545834;4600.96478292384;4634.582887540125;5039.899202015962;4780.641451891113;4889.608831293497;5046.318746969158;5104.310918026065;5218.851013444311;3580.820958952055;3854.8650797222103;3908.237893610747;3941.940870886939;3956.2285354355913;3307.5038744188323;3475.4613034979493;4043.6765058795227;4057.8812505307137;4077.4699289092523;3267.722243609296;3767.9434808477895;3949.992751848289;3964.1962906877447;3997.9200415991663;3881.7476864003747;3956.307646161939;3980.1840622672426;3994.7802870842092;4021.6272399284417;2882.135359392195;3179.443597370451;3340.6492318306473;3431.8627254909775;3444.2767018926056;4402.427684401039;4422.535633758441;4987.775550100254;5108.361454818148;5190.480951904817;3779.433085037239;3785.318642644323;4455.665825063101;4499.865004049884;4583.670735486705;4837.153498137812;5315.146518773897;5339.439358867302;5407.675119595724;5417.241586177938;3383.4755612880044;3679.1537946272238;3679.5400574928135;3686.6313368663186;3709.51776269086;5121.052605268;5167.974160129175;5502.614816962814;5583.916241256385;5669.886602267931;3153.385089907492;3763.435484677266;3770.2271034437877;3771.5097037385513;3779.1278628242735;3206.823624700664;3822.292875817927;3843.8078096095082;3851.7496362736333;3855.4409610606303;3980.701447391399;4457.774112119193;4463.8214471421425;4493.932591011072;4506.301523263899;4932.358793356841;4976.004799040206;5442.809501667422;5509.779608815683;5527.640703354269;1292.3279894454831;1311.4491913396396;1314.309987256698;1316.6510874618234;1319.7228581997888;693.4902846407887;736.348331726426;823.8434697407473;851.9190676885686;890.5903284489078;4298.4197133387215;4416.6908316418185;4864.854054378375;5087.465816089331;5143.588512918957;5152.330197074356;5316.9202461963105;5443.482869127427;5556.249906262603;5560.7219639018695;4839.637027222972;5002.274670172877;5023.924641130386;5218.817341393033;5262.947370526323;2818.6758522769733;2842.957355639667;2915.431490859262;2954.2171324599;2959.3131914808782;5622.557340807677;5779.190913272145;5803.65178089316;5844.736986835603;5887.4389640506515;4833.453294945583;4861.562459378673;4939.506049395031;5278.604104692164;5680.829575112671;5177.844664660066;5441.503586513582;5579.80034292629;5713.228714123623;5865.2961644602065;4216.536181020147;4871.58856366101;5130.46042209094;5525.640833345819;5623;5284.524392804666;5473.370562385377;5488.588355873246;5510.862228444321;5533.474319939599;5152.227165925141;5320.334958130234;5447.428020057837;5821.446962538552;5869.8239052828485;3208.2460621754335;3527.553702981765;3757.1734218471893;3789.1285004449683;3816.1795214029116;4771.5705586496;4834.734089625104;5301.54207592915;5472.480114389126;5492.697901615449;5203.869903252449;5390.164524498709;5398.975384230914;5482.533984611353;5524.806631767869;4530.569595888385;5130.333056702605;5334.253204551288;5346.128854900754;5477.287952566141;4340.978295108504;4572.81708731647;5040.823571175138;5089.236614507853;5255.710935898563;4479;4743.905121897612;5042.7897304645885;5319.574434045345;5521.515318106788;4400.73595584266;5298.311219541589;5309.867253318698;5328.467153284795;5341.839744807662 06:29:16 INFO - PROCESS | 1657 | |5;yui.html;605.85560938728;784.3685832904513;788.2590365056847;806.0971711682917;820.7948012996749;15481.922590387047;16237.594060148502;16238.51284461465;16285.999999999985;16632.750508742363;14457.638559036002;14588.124712517256;14594.05138665986;14634.853651463482;14662.266886655678;669.2103318084659;687.7214728035153;825.3397282174267;841.3731769831469;858.3819649852128;857.3398483167988;857.7598272483715;861.840559496492;862.6808081010004;863.404251066765;895.6059333893066;914.4193437167413;916.4226537281537;917.0737555069395;917.179124683408;703.6938931564761;723.819045238693;881.0704706534603;892.9151730585584;912.9954350228272;676.972921083156;677.4174210179242;677.5460441504204;678.3928384096256;679.4971720926479;15404;15422.99750516224;15425.460108896135;15427;15437.922810385988;11345.489452974636;13847.792283115761;13985.860141398558;14086.15483071019;14208.289585520683;12801.679958001032;12824.551140710124;12851.485940562367;13045.73856535866;13095;4488.326750987346;4523.411956445674;4628.8148474061;4729;4738.4550776660435;121087.78912210853;121256.78743212543;122403.38798305951;124614;125619;11032.669019929415;11035.44822758859;11144.911641663668;11200.383978881076;11633.76732465346;22051.00770465333;22053.33839984803;22057.448563786034;22136.446588835086;22146;7858.489198202098;7944.404169687181;7958.562279074707;7991.760247192594;8205.302549283258;4378.365137055109;4402;4436.290193569013;4573.131105090022;4607.723536587815;3446.655334466533;3549.201429678353;3552.3250582389264;3563.964360356415;3571.0715214044535;630.5334052800895;659.6932426421737;679.1578442730978;681.4037716997627;682.9658517074225;526.2317017154996;588.4115884115885;592.4519819167253;603.9581721530325;649.8018104478085;8757.343199260082;8765.956170219108;9147.176754092163;9184.692512033907;9221;578.6817250512202;592.7362323765883;603.4508597176635;606.754264522869;626.1234272019119;4375.387445757597;4522.773861306921;4523.638108951276;4574.851252661543;4660.067986402665;101842.49078754558;111539;132460;167644.16177919033;169698.30301697072;105671.41492877612;107806;112498;139502;144975.55024449833;73384.26615733882;94466.52766736122;102618;103425.93148137146;108157.56188038476;9865.704028879145;9974.3017988743;9985.350952188084;10059.597616095274;10169.33899296573;60094;60336.18991430264;61215;62802.37197627965;63992.680036601385;63016.68491657513;81375;84802.79930017496;92316;93329.5333523328;11241.66275011751;11463.484143213409;11799.764004719686;11861.762764744484;13520.86479135196;12676.809847852106;12858.871411286142;13122.540711075066;13173;15586.9220653896;13483.258420786951;13668.248246346546;14388.784168237695;14544.709105818036;14700.264986750406;13678.658033548843;13729.567608097976;14167;14170.504032358818;14182.503612373517;13092.952563794683;13609;13609.659758506117;13976.161430314214;14111.929440352733;10758.784824303313;11187.70652016351;11293.265937714023;11327.207095503565;11744.823827642422;9633.855492167482;11279.210455268052;11359.54561817518;11562.421878905852;11656.417179141179 06:29:16 INFO - PROCESS | 1657 | __end_tp_report 06:29:16 INFO - PROCESS | 1657 | __start_cc_report 06:29:16 INFO - PROCESS | 1657 | _x_x_mozilla_cycle_collect,1529 06:29:16 INFO - PROCESS | 1657 | __end_cc_report 06:29:16 INFO - PROCESS | 1657 | __startTimestamp1474637356780__endTimestamp 06:29:16 INFO - PROCESS | 1657 | 06:29:16 INFO - PROCESS | 1657 | ------- Summary: start ------- 06:29:16 INFO - PROCESS | 1657 | Number of tests: 6 06:29:16 INFO - PROCESS | 1657 | 06:29:16 INFO - PROCESS | 1657 | [#0] dojo.html Cycles:165 Average:5643.66 Median:5802.10 stddev:627.98 (10.8%) stddev-sans-first:590.90 06:29:16 INFO - PROCESS | 1657 | Values: 2866.4 3301.4 3312.9 3334.6 3360.9 5522.2 5581.2 5590.6 5648.5 5674.2 5591.2 5606.4 5686.3 5690.6 5700.5 5080.7 5096.2 5105.6 5110.2 5133.0 5150.6 5237.9 5242.0 5244.4 5288.7 5192.4 5211.1 5226.6 5240.0 5294.0 5066.5 5096.1 5124.6 5129.2 5139.2 5069.7 5081.5 5087.6 5144.3 5187.5 5619.9 5637.7 5638.5 5646.2 5655.8 5965.3 6031.5 6033.8 6123.3 6144.0 6098.3 6100.7 6181.3 6183.6 6245.3 5558.5 5617.6 5678.8 5700.6 5712.3 5701.7 6114.8 6187.8 6293.1 6330.0 5906.7 5929.2 5946.4 5955.7 6053.8 6151.2 6168.7 6176.5 6183.2 6205.8 6050.6 6075.1 6092.8 6097.9 6116.2 5969.3 5969.4 5998.9 6097.8 6139.5 4807.3 4816.9 4823.7 4823.8 4831.0 4304.9 4323.4 4408.8 4413.5 4421.5 5552.2 5615.3 5622.9 5629.4 5646.3 6091.6 6098.9 6099.4 6129.2 6135.1 5664.8 5672.3 5680.8 5714.9 5751.8 5231.1 5245.2 5252.9 5262.4 5266.2 6171.0 6243.8 6316.9 6331.2 6349.7 6104.8 6106.7 6112.9 6121.2 6140.3 6276.4 6304.9 6312.4 6320.0 6328.5 6084.7 6085.9 6097.2 6112.0 6112.4 6003.1 6007.9 6154.9 6165.3 6173.3 5806.9 5880.6 5882.9 5885.8 5917.5 5891.4 5941.9 5951.6 5964.5 5992.9 5794.3 5797.7 5798.0 5802.1 5810.4 5753.4 5819.4 5821.1 5857.4 5944.9 5742.0 5766.0 5850.9 5859.1 5864.8 06:29:16 INFO - PROCESS | 1657 | 06:29:16 INFO - PROCESS | 1657 | [#1] ext.html Cycles:180 Average:64465.52 Median:40361.20 stddev:137212.59 (340.0%) stddev-sans-first:137513.34 06:29:16 INFO - PROCESS | 1657 | Values: 455.9 498.9 510.3 528.6 530.4 30341.8 40399.6 40487.8 40634.0 42929.6 42411.4 42847.4 42851.6 42956.6 42999.9 9601.3 9792.2 9802.0 9806.6 9814.1 9571.9 9662.0 9667.0 9667.1 9679.7 9624.6 9658.8 9684.8 9694.9 9707.7 9502.0 9602.7 9637.5 9664.2 9679.3 9522.3 9586.2 9586.8 9590.0 9602.6 40322.8 40655.8 40734.4 40961.8 40972.8 3393.2 3544.7 3597.2 3833.7 3986.1 29870.3 30206.0 30723.2 31070.2 31459.0 3191.7 3212.5 3240.4 3258.1 3280.1 439411.0 442685.0 443691.8 444731.0 444925.0 58624.7 58698.0 58775.4 58933.1 58993.4 34310.1 34571.3 35017.8 62047.7 62450.0 15433.5 15606.2 15620.2 15657.9 15660.4 9953.9 11858.5 11920.3 11954.3 11996.2 14995.9 18609.5 18668.3 18695.3 18744.3 6247.9 6318.8 7457.6 7608.3 7615.2 886.9 961.4 1018.3 1025.7 1041.7 29087.7 29172.3 29323.8 29557.7 29904.4 888.3 1049.0 1106.9 1123.3 1125.4 14921.5 15250.4 15269.8 15548.2 15707.5 561086.0 562477.0 563240.0 565580.0 570265.0 54664.7 55437.0 55476.0 55607.2 55610.4 1135.8 1266.6 1324.5 1374.4 1389.4 24015.5 28973.6 29244.7 29705.9 29961.3 47484.1 48214.3 48220.0 48251.3 48265.8 524089.0 527837.0 530413.0 531019.0 531640.0 22853.7 23234.2 25132.2 25725.7 25788.0 44909.9 45212.5 45410.5 46552.5 47020.8 37579.1 37783.6 37962.8 38399.8 38879.0 37825.9 37958.8 38085.4 38216.6 38628.8 28262.9 31978.5 32862.7 36967.8 37878.0 32074.5 33312.5 34546.8 34615.7 34661.3 21991.3 24873.8 25132.6 25597.2 25844.9 06:29:16 INFO - PROCESS | 1657 | 06:29:16 INFO - PROCESS | 1657 | [#2] jquery.html Cycles:180 Average:34359.54 Median:2332.02 stddev:97129.69 (4165.0%) stddev-sans-first:97368.53 06:29:16 INFO - PROCESS | 1657 | Values: 317.3 333.2 370.5 393.1 400.7 19564.3 19954.8 20225.7 20245.3 20842.2 20678.3 20752.9 20833.8 20883.2 21405.7 5811.7 5866.6 6119.5 6143.4 6149.9 3931.8 6193.9 6221.5 6242.0 6244.2 3867.8 4102.3 4142.8 4152.8 4184.5 6840.9 6940.6 6946.4 6948.4 6961.7 5868.3 6013.3 6088.2 6101.0 6109.5 13429.8 13470.3 13481.6 13724.1 13746.0 2160.8 2292.2 2314.8 2349.2 3031.2 10235.9 10376.9 13746.3 15302.5 16038.4 1804.2 1872.8 1899.6 1958.9 1973.4 111488.0 121145.0 121982.6 123930.4 125522.0 9464.8 11214.2 11507.5 11627.3 11754.4 14720.3 14752.0 14758.4 14772.9 14789.9 8221.5 8511.3 8527.7 8691.0 8697.6 8327.0 8328.2 8350.2 8514.1 8519.4 3858.8 4422.0 4549.6 4563.7 4683.5 1667.9 1873.7 1912.5 1933.4 1969.3 853.8 866.1 885.3 886.7 953.7 17373.9 21217.0 21296.3 21335.9 21759.0 928.0 931.4 962.3 1008.7 1040.4 8266.6 10662.1 10993.3 11288.9 11296.2 568495.0 570537.0 577125.0 592237.0 593655.0 120973.4 125475.0 126250.0 126299.0 127982.0 951.5 972.6 976.4 1038.5 1041.7 19238.7 19704.6 19852.7 19864.3 19908.7 54688.0 54833.3 55462.0 55488.4 55815.2 75964.6 77140.8 78808.6 81669.0 82079.0 6588.5 7981.2 8136.2 8174.8 8299.8 10806.1 12648.2 12841.0 13133.1 13225.8 9976.1 10292.8 10879.2 10961.3 11359.8 9416.0 10222.8 11028.4 11071.6 11367.1 11268.7 11366.8 11527.7 11668.3 11826.8 7870.2 7898.2 8309.5 8309.8 8347.5 8750.7 9792.4 11222.7 11235.8 11423.9 06:29:16 INFO - PROCESS | 1657 | 06:29:16 INFO - PROCESS | 1657 | [#3] mootools.html Cycles:180 Average:5657.61 Median:4550.19 stddev:3228.25 (70.9%) stddev-sans-first:3221.12 06:29:16 INFO - PROCESS | 1657 | Values: 1355.5 1512.7 1544.9 1699.4 1861.9 7917.1 8414.6 8581.1 8961.5 8965.1 8833.7 8913.2 8917.2 8930.7 8932.4 2373.9 2402.7 2403.2 2404.5 2405.9 2095.8 2363.3 2364.9 2385.7 2411.7 2372.5 2388.1 2390.1 2411.1 2413.6 2351.2 2372.8 2386.7 2386.8 2388.6 2334.2 2357.6 2358.5 2366.6 2368.1 8646.4 8739.3 8964.5 8968.4 8975.0 5201.5 5383.8 5391.1 5394.4 5399.2 3630.7 3665.5 3719.6 3724.2 3737.2 1075.2 1085.2 1089.0 1102.9 1107.4 11655.1 11718.8 11732.2 11833.2 11839.0 3841.5 4340.5 4579.2 4597.1 4605.4 9202.4 9207.2 9215.6 9219.6 9240.4 5232.2 5234.5 5235.8 5251.3 5252.5 4138.3 4140.5 4451.6 4521.2 4911.5 3518.8 3813.4 3816.2 3819.5 3827.9 1143.5 1165.8 1166.2 1174.3 1176.4 798.5 881.0 911.5 920.1 960.9 5568.7 5707.2 5963.0 5967.3 6001.4 421.1 424.9 432.7 433.3 445.9 3086.8 3880.5 3993.7 4006.5 4017.8 10502.5 10766.8 10856.3 10871.6 10882.2 10790.7 10794.7 10799.6 10800.5 10805.9 7929.8 8095.2 8155.2 8267.0 8277.3 5710.1 5813.2 5817.9 5872.1 5933.5 9941.1 10203.2 10209.2 10210.5 10224.4 9454.7 10099.2 10195.8 10354.5 10421.4 6651.2 6876.7 6979.2 7145.0 7164.8 8230.2 8250.2 8255.9 8324.8 8367.6 7482.6 7538.9 7563.2 7582.5 7585.6 7203.2 7335.5 7383.6 7445.0 7525.2 6977.4 6978.4 7053.1 7057.9 7104.1 4250.3 4256.8 4980.4 5062.4 5126.8 4949.2 4966.6 5070.8 5098.3 5248.3 06:29:16 INFO - PROCESS | 1657 | 06:29:16 INFO - PROCESS | 1657 | [#4] prototype.html Cycles:180 Average:4333.83 Median:4850.60 stddev:1328.91 (27.4%) stddev-sans-first:1296.79 06:29:16 INFO - PROCESS | 1657 | Values: 249.2 295.9 303.9 309.5 311.3 4217.4 4312.5 4601.0 4634.6 5039.9 4780.6 4889.6 5046.3 5104.3 5218.9 3580.8 3854.9 3908.2 3941.9 3956.2 3307.5 3475.5 4043.7 4057.9 4077.5 3267.7 3767.9 3950.0 3964.2 3997.9 3881.7 3956.3 3980.2 3994.8 4021.6 2882.1 3179.4 3340.6 3431.9 3444.3 4402.4 4422.5 4987.8 5108.4 5190.5 3779.4 3785.3 4455.7 4499.9 4583.7 4837.2 5315.1 5339.4 5407.7 5417.2 3383.5 3679.2 3679.5 3686.6 3709.5 5121.1 5168.0 5502.6 5583.9 5669.9 3153.4 3763.4 3770.2 3771.5 3779.1 3206.8 3822.3 3843.8 3851.7 3855.4 3980.7 4457.8 4463.8 4493.9 4506.3 4932.4 4976.0 5442.8 5509.8 5527.6 1292.3 1311.4 1314.3 1316.7 1319.7 693.5 736.3 823.8 851.9 890.6 4298.4 4416.7 4864.9 5087.5 5143.6 5152.3 5316.9 5443.5 5556.2 5560.7 4839.6 5002.3 5023.9 5218.8 5262.9 2818.7 2843.0 2915.4 2954.2 2959.3 5622.6 5779.2 5803.7 5844.7 5887.4 4833.5 4861.6 4939.5 5278.6 5680.8 5177.8 5441.5 5579.8 5713.2 5865.3 4216.5 4871.6 5130.5 5525.6 5623.0 5284.5 5473.4 5488.6 5510.9 5533.5 5152.2 5320.3 5447.4 5821.4 5869.8 3208.2 3527.6 3757.2 3789.1 3816.2 4771.6 4834.7 5301.5 5472.5 5492.7 5203.9 5390.2 5399.0 5482.5 5524.8 4530.6 5130.3 5334.3 5346.1 5477.3 4341.0 4572.8 5040.8 5089.2 5255.7 4479.0 4743.9 5042.8 5319.6 5521.5 4400.7 5298.3 5309.9 5328.5 5341.8 06:29:16 INFO - PROCESS | 1657 | 06:29:16 INFO - PROCESS | 1657 | [#5] yui.html Cycles:180 Average:24144.33 Median:3550.76 stddev:38186.05 (1075.4%) stddev-sans-first:38252.27 06:29:16 INFO - PROCESS | 1657 | Values: 605.9 784.4 788.3 806.1 820.8 15481.9 16237.6 16238.5 16286.0 16632.8 14457.6 14588.1 14594.1 14634.9 14662.3 669.2 687.7 825.3 841.4 858.4 857.3 857.8 861.8 862.7 863.4 895.6 914.4 916.4 917.1 917.2 703.7 723.8 881.1 892.9 913.0 677.0 677.4 677.5 678.4 679.5 15404.0 15423.0 15425.5 15427.0 15437.9 11345.5 13847.8 13985.9 14086.2 14208.3 12801.7 12824.6 12851.5 13045.7 13095.0 4488.3 4523.4 4628.8 4729.0 4738.5 121087.8 121256.8 122403.4 124614.0 125619.0 11032.7 11035.4 11144.9 11200.4 11633.8 22051.0 22053.3 22057.4 22136.4 22146.0 7858.5 7944.4 7958.6 7991.8 8205.3 4378.4 4402.0 4436.3 4573.1 4607.7 3446.7 3549.2 3552.3 3564.0 3571.1 630.5 659.7 679.2 681.4 683.0 526.2 588.4 592.5 604.0 649.8 8757.3 8766.0 9147.2 9184.7 9221.0 578.7 592.7 603.5 606.8 626.1 4375.4 4522.8 4523.6 4574.9 4660.1 101842.5 111539.0 132460.0 167644.2 169698.3 105671.4 107806.0 112498.0 139502.0 144975.6 73384.3 94466.5 102618.0 103425.9 108157.6 9865.7 9974.3 9985.4 10059.6 10169.3 60094.0 60336.2 61215.0 62802.4 63992.7 63016.7 81375.0 84802.8 92316.0 93329.5 11241.7 11463.5 11799.8 11861.8 13520.9 12676.8 12858.9 13122.5 13173.0 15586.9 13483.3 13668.2 14388.8 14544.7 14700.3 13678.7 13729.6 14167.0 14170.5 14182.5 13093.0 13609.0 13609.7 13976.2 14111.9 10758.8 11187.7 11293.3 11327.2 11744.8 9633.9 11279.2 11359.5 11562.4 11656.4 06:29:16 INFO - PROCESS | 1657 | -------- Summary: end -------- 06:29:16 INFO - PROCESS | 1657 | 06:29:17 INFO - TEST-INFO | 1657: exit 0 06:29:17 INFO - TEST-OK | dromaeo_css | took 1118454ms 06:29:17 INFO - TEST-START | kraken 06:29:17 INFO - operating with platform_type : mac_ 06:29:17 INFO - Initialising browser for kraken test... 06:29:17 INFO - TEST-INFO | started process 1664 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/tmp1wSxee/profile http://localhost:49266/getInfo.html) 06:29:19 INFO - PROCESS | 1664 | __metrics Screen width/height:1600/1200 06:29:19 INFO - PROCESS | 1664 | colorDepth:24 06:29:19 INFO - PROCESS | 1664 | Browser inner width/height: 1024/689 06:29:19 INFO - PROCESS | 1664 | __metrics 06:29:19 INFO - PROCESS | 1664 | 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" 06:29:19 INFO - PROCESS | 1664 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:29:20 INFO - TEST-INFO | 1664: exit 0 06:29:20 INFO - Browser initialized. 06:29:20 INFO - Running cycle 1/1 for kraken test... 06:29:20 INFO - TEST-INFO | started process 1665 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/T/tmp1wSxee/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:29:32 INFO - PROCESS | 1665 | RSS: Main: 235143168 06:29:32 INFO - PROCESS | 1665 | 06:29:35 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection) 06:29:36 INFO - PROCESS | 1665 | RSS: Main: 294551552 06:29:36 INFO - PROCESS | 1665 | 06:29:39 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-dft) 06:29:39 INFO - PROCESS | 1665 | RSS: Main: 294248448 06:29:39 INFO - PROCESS | 1665 | 06:29:43 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-fft) 06:29:43 INFO - PROCESS | 1665 | RSS: Main: 382791680 06:29:43 INFO - PROCESS | 1665 | 06:29:46 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator) 06:29:46 INFO - PROCESS | 1665 | RSS: Main: 288112640 06:29:46 INFO - PROCESS | 1665 | 06:29:48 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:29:49 INFO - PROCESS | 1665 | RSS: Main: 291016704 06:29:49 INFO - PROCESS | 1665 | 06:29:52 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom) 06:29:53 INFO - PROCESS | 1665 | RSS: Main: 327548928 06:29:53 INFO - PROCESS | 1665 | 06:29:55 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate) 06:29:56 INFO - PROCESS | 1665 | RSS: Main: 330948608 06:29:56 INFO - PROCESS | 1665 | 06:29:59 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial) 06:29:59 INFO - PROCESS | 1665 | RSS: Main: 327479296 06:29:59 INFO - PROCESS | 1665 | 06:30:01 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:30:02 INFO - PROCESS | 1665 | RSS: Main: 303955968 06:30:02 INFO - PROCESS | 1665 | 06:30:03 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:30:04 INFO - PROCESS | 1665 | RSS: Main: 304832512 06:30:04 INFO - PROCESS | 1665 | 06:30:06 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:30:07 INFO - PROCESS | 1665 | RSS: Main: 307740672 06:30:07 INFO - PROCESS | 1665 | 06:30:10 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:30:11 INFO - PROCESS | 1665 | RSS: Main: 316964864 06:30:11 INFO - PROCESS | 1665 | 06:30:14 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:30:14 INFO - PROCESS | 1665 | RSS: Main: 319201280 06:30:14 INFO - PROCESS | 1665 | 06:30:16 INFO - PROCESS | 1665 | Cycle 1(1): loaded http://localhost:49266/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49266/tests/kraken/driver.html?testName=ai-astar) 06:30:16 INFO - PROCESS | 1665 | RSS: Main: 362008576 06:30:16 INFO - PROCESS | 1665 | 06:30:16 INFO - PROCESS | 1665 | __start_tp_report 06:30:16 INFO - PROCESS | 1665 | _x_x_mozilla_page_load 06:30:16 INFO - PROCESS | 1665 | _x_x_mozilla_page_load_details 06:30:16 INFO - PROCESS | 1665 | |i|pagename|runs| 06:30:16 INFO - PROCESS | 1665 | |0;ai-astar;158;168;142;113;113;112;111;112;114;113 06:30:16 INFO - PROCESS | 1665 | |1;audio-beat-detection;145;109;112;146;114;110;113;133;178;112 06:30:16 INFO - PROCESS | 1665 | |2;audio-dft;184;201;267;184;185;185;187;185;180;184 06:30:16 INFO - PROCESS | 1665 | |3;audio-fft;81;60;60;91;64;80;81;82;92;59 06:30:16 INFO - PROCESS | 1665 | |4;audio-oscillator;87;72;123;100;54;83;120;97;81;90 06:30:16 INFO - PROCESS | 1665 | |5;imaging-gaussian-blur;87;121;75;114;133;102;89;86;87;85 06:30:16 INFO - PROCESS | 1665 | |6;imaging-darkroom;93;93;94;94;94;94;93;94;94;93 06:30:16 INFO - PROCESS | 1665 | |7;imaging-desaturate;84;84;83;85;84;91;83;84;83;84 06:30:16 INFO - PROCESS | 1665 | |8;json-parse-financial;54;53;53;53;54;54;55;54;55;56 06:30:16 INFO - PROCESS | 1665 | |9;json-stringify-tinderbox;64;72;69;76;72;69;69;71;69;74 06:30:16 INFO - PROCESS | 1665 | |10;stanford-crypto-aes;92;104;105;103;85;88;84;88;90;91 06:30:16 INFO - PROCESS | 1665 | |11;stanford-crypto-ccm;141;140;143;160;142;127;124;158;196;146 06:30:16 INFO - PROCESS | 1665 | |12;stanford-crypto-pbkdf2;167;165;170;169;171;170;170;174;169;169 06:30:16 INFO - PROCESS | 1665 | |13;stanford-crypto-sha256-iterative;61;87;91;87;68;71;86;83;83;73 06:30:16 INFO - PROCESS | 1665 | __end_tp_report 06:30:16 INFO - PROCESS | 1665 | __start_cc_report 06:30:16 INFO - PROCESS | 1665 | _x_x_mozilla_cycle_collect,1974 06:30:16 INFO - PROCESS | 1665 | __end_cc_report 06:30:16 INFO - PROCESS | 1665 | __startTimestamp1474637416914__endTimestamp 06:30:16 INFO - PROCESS | 1665 | 06:30:16 INFO - PROCESS | 1665 | ------- Summary: start ------- 06:30:16 INFO - PROCESS | 1665 | Number of tests: 14 06:30:16 INFO - PROCESS | 1665 | 06:30:16 INFO - PROCESS | 1665 | [#0] ai-astar Cycles:10 Average:125.60 Median:113.50 stddev:21.88 (19.3%) stddev-sans-first:19.82 06:30:16 INFO - PROCESS | 1665 | Values: 158.0 168.0 142.0 113.0 113.0 112.0 111.0 112.0 114.0 113.0 06:30:16 INFO - PROCESS | 1665 | 06:30:16 INFO - PROCESS | 1665 | [#1] audio-beat-detection Cycles:10 Average:127.20 Median:123.50 stddev:22.97 (18.6%) stddev-sans-first:23.45 06:30:16 INFO - PROCESS | 1665 | Values: 145.0 109.0 112.0 146.0 114.0 110.0 113.0 133.0 178.0 112.0 06:30:16 INFO - PROCESS | 1665 | 06:30:16 INFO - PROCESS | 1665 | [#2] audio-dft Cycles:10 Average:194.20 Median:185.00 stddev:26.17 (14.1%) stddev-sans-first:27.50 06:30:16 INFO - PROCESS | 1665 | Values: 184.0 201.0 267.0 184.0 185.0 185.0 187.0 185.0 180.0 184.0 06:30:16 INFO - PROCESS | 1665 | 06:30:16 INFO - PROCESS | 1665 | [#3] audio-fft Cycles:10 Average:75.00 Median:81.00 stddev:12.99 (16.0%) stddev-sans-first:13.59 06:30:16 INFO - PROCESS | 1665 | Values: 81.0 60.0 60.0 91.0 64.0 80.0 81.0 82.0 92.0 59.0 06:30:16 INFO - PROCESS | 1665 | 06:30:16 INFO - PROCESS | 1665 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:82.00 stddev:20.80 (25.4%) stddev-sans-first:22.01 06:30:16 INFO - PROCESS | 1665 | Values: 87.0 72.0 123.0 100.0 54.0 83.0 120.0 97.0 81.0 90.0 06:30:16 INFO - PROCESS | 1665 | 06:30:16 INFO - PROCESS | 1665 | [#5] imaging-gaussian-blur Cycles:10 Average:97.90 Median:85.50 stddev:18.83 (22.0%) stddev-sans-first:19.55 06:30:16 INFO - PROCESS | 1665 | Values: 87.0 121.0 75.0 114.0 133.0 102.0 89.0 86.0 87.0 85.0 06:30:16 INFO - PROCESS | 1665 | 06:30:16 INFO - PROCESS | 1665 | [#6] imaging-darkroom Cycles:10 Average:93.60 Median:94.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 06:30:16 INFO - PROCESS | 1665 | Values: 93.0 93.0 94.0 94.0 94.0 94.0 93.0 94.0 94.0 93.0 06:30:16 INFO - PROCESS | 1665 | 06:30:16 INFO - PROCESS | 1665 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:84.00 stddev:2.37 (2.8%) stddev-sans-first:2.51 06:30:16 INFO - PROCESS | 1665 | Values: 84.0 84.0 83.0 85.0 84.0 91.0 83.0 84.0 83.0 84.0 06:30:16 INFO - PROCESS | 1665 | 06:30:16 INFO - PROCESS | 1665 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:0.99 (1.8%) stddev-sans-first:1.05 06:30:16 INFO - PROCESS | 1665 | Values: 54.0 53.0 53.0 53.0 54.0 54.0 55.0 54.0 55.0 56.0 06:30:16 INFO - PROCESS | 1665 | 06:30:16 INFO - PROCESS | 1665 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:71.50 stddev:3.31 (4.6%) stddev-sans-first:2.54 06:30:16 INFO - PROCESS | 1665 | Values: 64.0 72.0 69.0 76.0 72.0 69.0 69.0 71.0 69.0 74.0 06:30:16 INFO - PROCESS | 1665 | 06:30:16 INFO - PROCESS | 1665 | [#10] stanford-crypto-aes Cycles:10 Average:93.00 Median:88.00 stddev:7.99 (9.1%) stddev-sans-first:8.46 06:30:16 INFO - PROCESS | 1665 | Values: 92.0 104.0 105.0 103.0 85.0 88.0 84.0 88.0 90.0 91.0 06:30:16 INFO - PROCESS | 1665 | 06:30:16 INFO - PROCESS | 1665 | [#11] stanford-crypto-ccm Cycles:10 Average:147.70 Median:144.50 stddev:20.39 (14.1%) stddev-sans-first:21.48 06:30:16 INFO - PROCESS | 1665 | Values: 141.0 140.0 143.0 160.0 142.0 127.0 124.0 158.0 196.0 146.0 06:30:16 INFO - PROCESS | 1665 | 06:30:16 INFO - PROCESS | 1665 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.40 Median:170.00 stddev:2.37 (1.4%) stddev-sans-first:2.35 06:30:16 INFO - PROCESS | 1665 | Values: 167.0 165.0 170.0 169.0 171.0 170.0 170.0 174.0 169.0 169.0 06:30:16 INFO - PROCESS | 1665 | 06:30:16 INFO - PROCESS | 1665 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.00 Median:84.50 stddev:9.99 (11.8%) stddev-sans-first:8.20 06:30:16 INFO - PROCESS | 1665 | Values: 61.0 87.0 91.0 87.0 68.0 71.0 86.0 83.0 83.0 73.0 06:30:16 INFO - PROCESS | 1665 | -------- Summary: end -------- 06:30:16 INFO - PROCESS | 1665 | 06:30:17 INFO - TEST-INFO | 1665: exit 0 06:30:17 INFO - TEST-OK | kraken | took 60320ms 06:30:17 INFO - SUITE-END | took 1178s 06:30:18 INFO - Completed test suite (00:19:39) 06:30:18 INFO - javascript benchmark 06:30:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2866.4267146570687, 3301.4222511060566, 3312.8840490582834, 3334.583177102862, 3360.865565377385, 5522.171674248864, 5581.246531718222, 5590.580706447013, 5648.491635752782, 5674.177244299579, 5591.161325801132, 5606.35526914405, 5686.346070201928, 5690.573207009481, 5700.458456446631, 5080.720560369178, 5096.159133742928, 5105.5660268877, 5110.156824124015, 5133.0, 5150.587952963754, 5237.8952420951555, 5242.0, 5244.449332820056, 5288.68267903927, 5192.428832828424, 5211.114110601206, 5226.634135610509, 5239.973800131013, 5294.047071527124, 5066.46802085783, 5096.133657278272, 5124.564412024945, 5129.153689641242, 5139.15203991341, 5069.670471419346, 5081.542661160476, 5087.567556757643, 5144.305518754995, 5187.48125187482, 5619.915701264485, 5637.661740295595, 5638.548916086745, 5646.153077038436, 5655.830325090254, 5965.313988891289, 6031.487323577501, 6033.849153771147, 6123.265208175003, 6144.0, 6098.2682078150465, 6100.672006988077, 6181.284389011517, 6183.567150299481, 6245.250569931592, 5558.527525160326, 5617.634853734453, 5678.801241956512, 5700.629459085146, 5712.314522257314, 5701.71491425427, 6114.785982490592, 6187.752489900444, 6293.056041593706, 6330.0, 5906.675132867734, 5929.199558059693, 5946.405359464019, 5955.702214889238, 6053.818385448443, 6151.200343955257, 6168.660723660242, 6176.536759742948, 6183.227096612924, 6205.782797602153, 6050.6369617823075, 6075.1191077294425, 6092.786752463642, 6097.864255374242, 6116.244530167495, 5969.253843269591, 5969.373215812364, 5998.850028749316, 6097.817065488042, 6139.4781443577795, 4807.302941073524, 4816.903661926742, 4823.686460380064, 4823.831165909247, 4831.0, 4304.870853874389, 4323.437953066082, 4408.845690400821, 4413.514513403523, 4421.491528474202, 5552.194931734876, 5615.2700148980375, 5622.887542249132, 5629.43705629442, 5646.322441307069, 6091.587005672113, 6098.855844323405, 6099.370313949828, 6129.205975626751, 6135.141080248769, 5664.773409063674, 5672.347680016768, 5680.77276908919, 5714.857128571736, 5751.798687046017, 5231.058409486329, 5245.186996015624, 5252.894942101137, 5262.421133675292, 5266.183741520071, 6171.043488259327, 6243.8126856194385, 6316.905246421307, 6331.176946996953, 6349.746010159542, 6104.755809767737, 6106.703363853616, 6112.929053818819, 6121.178620693132, 6140.289530736458, 6276.4351208389635, 6304.905426418516, 6312.400321969406, 6319.968400158154, 6328.525360597881, 6084.726187321669, 6085.939140608537, 6097.237845269341, 6111.96944015277, 6112.388761123852, 6003.099535069775, 6007.939920600738, 6154.876902462015, 6165.260168779775, 6173.259208894961, 5806.854828629318, 5880.647161170344, 5882.911756323744, 5885.823425297248, 5917.526597872074, 5891.351951285269, 5941.9405805943115, 5951.642901425928, 5964.463198311999, 5992.910106348496, 5794.275715535558, 5797.710114494174, 5797.971010144923, 5802.100674395476, 5810.4189581041555, 5753.3958934311295, 5819.359870414336, 5821.068629019336, 5857.384974577608, 5944.8811023780145, 5742.0, 5766.048601980794, 5850.94149058504, 5859.062549992152, 5864.824055278348], "value": 5602.1628807746065, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [455.876913233427, 498.93264409304777, 510.27286117282864, 528.5982653183581, 530.3662123762106, 30341.848290758542, 40399.59600403995, 40487.797561012194, 40633.984150396216, 42929.57070429302, 42411.363829542584, 42847.357289640604, 42851.571484285145, 42956.63738494382, 42999.925001874966, 9601.327907046509, 9792.167665748384, 9801.970793066732, 9806.607735690599, 9814.116729494344, 9571.856422153673, 9662.0, 9666.999999999965, 9667.081627245401, 9679.661211857587, 9624.566894489764, 9658.806823863519, 9684.75788105296, 9694.854577181313, 9707.660231891885, 9501.952490237574, 9602.711918642382, 9637.518124093802, 9664.178544823699, 9679.322447428684, 9522.333436659437, 9586.185174260196, 9586.808263834684, 9590.0, 9602.567884445216, 40322.79838600788, 40655.7967210162, 40734.38898416526, 40961.79519102415, 40972.79513602413, 3393.2195595013286, 3544.7341449391397, 3597.208614104919, 3833.712471564616, 3986.142979259473, 29870.25324366908, 30206.0, 30723.231919201975, 31070.223244418845, 31459.0, 3191.712745852861, 3212.5341825435416, 3240.3843269778904, 3258.1365938026443, 3280.114369120348, 439410.9999999968, 442685.0, 443691.7815410902, 444731.0, 444925.0, 58624.723774859616, 58698.0, 58775.41224587785, 58933.11600325999, 58993.41006589965, 34310.14224644354, 34571.308573828384, 35017.824910875795, 62047.6897615509, 62450.0, 15433.459828905934, 15606.219689015505, 15620.218989050729, 15657.921710391374, 15660.37358505647, 9953.900460995443, 11858.525658973716, 11920.344381059125, 11954.342511161796, 11996.220245684002, 14995.850041499445, 18609.53476163107, 18668.346607868658, 18695.345662902004, 18744.25022999065, 6247.937520624827, 6318.767840271195, 7457.552546847207, 7608.277213664693, 7615.238476152341, 886.8980067292215, 961.4135377419768, 1018.2922868606396, 1025.74869157057, 1041.682286902502, 29087.7091229085, 29172.270693232414, 29323.774384817654, 29557.693830680186, 29904.40191196164, 888.3337496877342, 1049.024407301202, 1106.9391183484825, 1123.2698745815285, 1125.431657013203, 14921.477748278758, 15250.389984400499, 15269.770953435707, 15548.22258887051, 15707.528774136794, 561086.0, 562477.0, 563240.0, 565580.0, 570265.0, 54664.72667636716, 55437.0, 55476.0, 55607.16589251164, 55610.44389556134, 1135.795556799784, 1266.5883587833991, 1324.5165514586913, 1374.3677908162158, 1389.4442223110836, 24015.51968960646, 28973.56539651949, 29244.70755292505, 29705.85147074337, 29961.250968725086, 47484.050318994116, 48214.27678584894, 48220.035599288516, 48251.27623085727, 48265.7933551664, 524089.0, 527837.0, 530413.0, 531019.0, 531640.0, 22853.65719514242, 23234.1868034618, 25132.246032619052, 25725.742742573082, 25788.0, 44909.87725306893, 45212.54787452083, 45410.54589454063, 46552.534474656175, 47020.7648961753, 37579.06052348713, 37783.62216377801, 37962.810185948896, 38399.80800095982, 38879.028024299616, 37825.86522404332, 37958.810205948794, 38085.4287185698, 38216.61783382131, 38628.80685596554, 28262.88213047628, 31978.52032219472, 32862.67137328692, 36967.81516092402, 37878.0, 32074.518882216318, 33312.50031249582, 34546.82726586351, 34615.653843461245, 34661.30677386488, 21991.340259792232, 24873.751262487145, 25132.62301065522, 25597.23208303754, 25844.870775646003], "value": 19271.989365545945, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [317.27502656430056, 333.204030276808, 370.48502581411844, 393.1115678566442, 400.6914675699711, 19564.31524896627, 19954.800451995477, 20225.696614550758, 20245.291414800486, 20842.16631334747, 20678.282856043537, 20752.896235518838, 20833.79166208341, 20883.164673413085, 21405.67891481625, 5811.738471768781, 5866.6480011199255, 6119.541034422414, 6143.44708976192, 6149.938500614981, 3931.8034098295116, 6193.876122477548, 6221.533384996121, 6241.968790156043, 6244.157038799772, 3867.8066096695193, 4102.323116685743, 4142.7514349139, 4152.792360381984, 4184.456020717318, 6840.897386539206, 6940.618265995368, 6946.444284457231, 6948.409385202264, 6961.721531138748, 5868.295804503487, 6013.278406591194, 6088.238970128734, 6100.969495152496, 6109.5112391008615, 13429.798553021712, 13470.25913574753, 13481.562201638617, 13724.117935233613, 13746.037777355588, 2160.816330611884, 2292.2435596253194, 2314.849534780251, 2349.189529612298, 3031.181580973147, 10235.948820255851, 10376.94811525945, 13746.312684365841, 15302.464413745465, 16038.358465661477, 1804.2422182683304, 1872.8314451699412, 1899.563100486882, 1958.9412317630495, 1973.4178417366911, 111488.0, 121145.0, 121982.56034879253, 123930.38034809858, 125522.0, 9464.810703785886, 11214.215004949576, 11507.539698412138, 11627.302361858316, 11754.353510557, 14720.337584808709, 14752.041117327339, 14758.40966361355, 14772.92613536947, 14789.926050369679, 8221.506709597443, 8511.276541493919, 8527.74416767498, 8691.0, 8697.608607612547, 8327.042390125092, 8328.167183281745, 8350.248477637042, 8514.063453020286, 8519.403641745143, 3858.7684738915755, 4422.049259409242, 4549.567791059844, 4563.748993805306, 4683.484816670163, 1667.9166041697868, 1873.718942158687, 1912.4645099372199, 1933.4489670443857, 1969.251684359934, 853.7566793463833, 866.0559989611354, 885.2740752582949, 886.6985225023523, 953.713885834247, 17373.913130434266, 21217.0, 21296.254631088148, 21335.893320533607, 21759.0, 927.9860802087974, 931.4318265857821, 962.2638681408728, 1008.7377281906757, 1040.38617215843, 8266.644006458131, 10662.093722033558, 10993.285436446606, 11288.94355528217, 11296.152788540892, 568495.0, 570537.0, 577125.0, 592237.0, 593655.0, 120973.39513302554, 125475.0, 126250.0, 126299.0, 127982.0, 951.5194826612517, 972.6352617768337, 976.4434272464626, 1038.4963292802984, 1041.6874937518714, 19238.71141932844, 19704.605907881476, 19852.70220946658, 19864.304749333704, 19908.70136947918, 54688.0, 54833.30192141807, 55462.0, 55488.445115548326, 55815.162772559255, 75964.62017689877, 77140.84288735561, 78808.60595696984, 81669.0, 82079.0, 6588.472922166311, 7981.241782030698, 8136.1863813618165, 8174.7956301092945, 8299.792505187177, 10806.135509159405, 12648.154165312731, 12840.972722182016, 13133.146345487512, 13225.80161297562, 9976.05227503386, 10292.816326122293, 10879.23845330851, 10961.287516311415, 11359.829602555803, 9416.0, 10222.846657300295, 11028.44857757125, 11071.612493562687, 11367.090632749194, 11268.661940141808, 11366.772664546497, 11527.654170374903, 11668.299902005907, 11826.82259766087, 7870.212978702084, 7898.210178982055, 8309.501429914224, 8309.792255193668, 8347.45741526823, 8750.69372571957, 9792.412455252423, 11222.66332010041, 11235.831462527905, 11423.885761142283], "value": 9414.100984247028, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.4984655677401, 1512.6898985707928, 1544.9150296733678, 1699.4137022727155, 1861.9255229790801, 7917.129115797257, 8414.621342039607, 8581.098984606611, 8961.507117108556, 8965.103489651032, 8833.71911072894, 8913.1978121969, 8917.152870477294, 8930.687425940094, 8932.419392739468, 2373.8813059347094, 2402.7477114902945, 2403.230966090852, 2404.5311164322966, 2405.891734871926, 2095.7904209579074, 2363.2555744940373, 2364.9357788994935, 2385.7494963028807, 2411.6985376827897, 2372.478054827935, 2388.080588973249, 2390.0917651292484, 2411.059686722171, 2413.5655581995234, 2351.2005917987794, 2372.8101751859895, 2386.6539351794067, 2386.8448550844314, 2388.617821148608, 2334.1947028275217, 2357.587422201108, 2358.469344397514, 2366.6213405854983, 2368.135630494874, 8646.351523635753, 8739.257163141141, 8964.50695211763, 8968.372213945026, 8975.0, 5201.45384734605, 5383.811566595189, 5391.110466773017, 5394.379646340682, 5399.244105825188, 3630.6913912317486, 3665.486831843544, 3719.590845007047, 3724.2179142380132, 3737.1965027519213, 1075.2365820267619, 1085.1915323084274, 1088.967330980072, 1102.8676558812913, 1107.385401102388, 11655.067594592327, 11718.824217636742, 11732.17874748768, 11833.230839995373, 11839.0, 3841.4621952926614, 4340.500842403101, 4579.22153233951, 4597.103564804831, 4605.355250264965, 9202.447853128833, 9207.17135457812, 9215.585298661576, 9219.631214751469, 9240.445573265626, 5232.215167724796, 5234.502722241381, 5235.790568377222, 5251.317328747238, 5252.527272545489, 4138.317177665652, 4140.482439695038, 4451.577100175478, 4521.163584736834, 4911.533404326583, 3518.7888726676483, 3813.4470501777087, 3816.2367526494813, 3819.5416550014174, 3827.8660246891227, 1143.5254369436757, 1165.7610189911047, 1166.2302880099264, 1174.277819141222, 1176.4470698771563, 798.4769975665948, 880.9955950220208, 911.5305617606938, 920.1212841736126, 960.870282511852, 5568.693721845338, 5707.200991861143, 5963.0, 5967.343592204854, 6001.36985616504, 421.1261632113377, 424.85342556817847, 432.7230572433645, 433.3175248982865, 445.92196365635886, 3086.845657717105, 3880.5164694595483, 3993.72043956926, 4006.5192176938954, 4017.7991100445447, 10502.527386267637, 10766.78466430667, 10856.34861908288, 10871.619493317696, 10882.238243322892, 10790.730231744112, 10794.73013174677, 10799.56801727922, 10800.45997700112, 10805.945970270099, 7929.841403171904, 8095.190480951976, 8155.184481551797, 8267.007959044833, 8277.337812974827, 5710.086386178192, 5813.186153938536, 5817.854553636023, 5872.0898260769645, 5933.495652869555, 9941.105300522988, 10203.234757393077, 10209.234307427121, 10210.489475526045, 10224.386536807815, 9454.669086582211, 10099.242556808416, 10195.84706229422, 10354.5340459678, 10421.374717516974, 6651.201855777338, 6876.656167191721, 6979.232284448808, 7144.964275178799, 7164.785056448315, 8230.176982301722, 8250.174982501701, 8255.917440825515, 8324.750257492286, 8367.581620918809, 7482.625868706434, 7538.886916696364, 7563.168051514439, 7582.469227154046, 7585.582792946441, 7203.243659415895, 7335.481131839907, 7383.630818459163, 7445.0, 7525.24747525265, 6977.406920411822, 6978.406835419046, 7053.0830991970715, 7057.858842823218, 7104.076470059066, 4250.341197114452, 4256.829726810893, 4980.352554167935, 5062.443131255633, 5126.7949282029795, 4949.1586430306215, 4966.553010229097, 5070.771815268248, 5098.286239926488, 5248.291480650216], "value": 4452.166250271987, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [249.19758378022766, 295.9171431999041, 303.8921182980041, 309.5233340655391, 311.27007168190613, 4217.355231459729, 4312.547182545834, 4600.96478292384, 4634.582887540125, 5039.899202015962, 4780.641451891113, 4889.608831293497, 5046.318746969158, 5104.310918026065, 5218.851013444311, 3580.820958952055, 3854.8650797222103, 3908.237893610747, 3941.940870886939, 3956.2285354355913, 3307.5038744188323, 3475.4613034979493, 4043.6765058795227, 4057.8812505307137, 4077.4699289092523, 3267.722243609296, 3767.9434808477895, 3949.992751848289, 3964.1962906877447, 3997.9200415991663, 3881.7476864003747, 3956.307646161939, 3980.1840622672426, 3994.7802870842092, 4021.6272399284417, 2882.135359392195, 3179.443597370451, 3340.6492318306473, 3431.8627254909775, 3444.2767018926056, 4402.427684401039, 4422.535633758441, 4987.775550100254, 5108.361454818148, 5190.480951904817, 3779.433085037239, 3785.318642644323, 4455.665825063101, 4499.865004049884, 4583.670735486705, 4837.153498137812, 5315.146518773897, 5339.439358867302, 5407.675119595724, 5417.241586177938, 3383.4755612880044, 3679.1537946272238, 3679.5400574928135, 3686.6313368663186, 3709.51776269086, 5121.052605268, 5167.974160129175, 5502.614816962814, 5583.916241256385, 5669.886602267931, 3153.385089907492, 3763.435484677266, 3770.2271034437877, 3771.5097037385513, 3779.1278628242735, 3206.823624700664, 3822.292875817927, 3843.8078096095082, 3851.7496362736333, 3855.4409610606303, 3980.701447391399, 4457.774112119193, 4463.8214471421425, 4493.932591011072, 4506.301523263899, 4932.358793356841, 4976.004799040206, 5442.809501667422, 5509.779608815683, 5527.640703354269, 1292.3279894454831, 1311.4491913396396, 1314.309987256698, 1316.6510874618234, 1319.7228581997888, 693.4902846407887, 736.348331726426, 823.8434697407473, 851.9190676885686, 890.5903284489078, 4298.4197133387215, 4416.6908316418185, 4864.854054378375, 5087.465816089331, 5143.588512918957, 5152.330197074356, 5316.9202461963105, 5443.482869127427, 5556.249906262603, 5560.7219639018695, 4839.637027222972, 5002.274670172877, 5023.924641130386, 5218.817341393033, 5262.947370526323, 2818.6758522769733, 2842.957355639667, 2915.431490859262, 2954.2171324599, 2959.3131914808782, 5622.557340807677, 5779.190913272145, 5803.65178089316, 5844.736986835603, 5887.4389640506515, 4833.453294945583, 4861.562459378673, 4939.506049395031, 5278.604104692164, 5680.829575112671, 5177.844664660066, 5441.503586513582, 5579.80034292629, 5713.228714123623, 5865.2961644602065, 4216.536181020147, 4871.58856366101, 5130.46042209094, 5525.640833345819, 5623.0, 5284.524392804666, 5473.370562385377, 5488.588355873246, 5510.862228444321, 5533.474319939599, 5152.227165925141, 5320.334958130234, 5447.428020057837, 5821.446962538552, 5869.8239052828485, 3208.2460621754335, 3527.553702981765, 3757.1734218471893, 3789.1285004449683, 3816.1795214029116, 4771.5705586496, 4834.734089625104, 5301.54207592915, 5472.480114389126, 5492.697901615449, 5203.869903252449, 5390.164524498709, 5398.975384230914, 5482.533984611353, 5524.806631767869, 4530.569595888385, 5130.333056702605, 5334.253204551288, 5346.128854900754, 5477.287952566141, 4340.978295108504, 4572.81708731647, 5040.823571175138, 5089.236614507853, 5255.710935898563, 4479.0, 4743.905121897612, 5042.7897304645885, 5319.574434045345, 5521.515318106788, 4400.73595584266, 5298.311219541589, 5309.867253318698, 5328.467153284795, 5341.839744807662], "value": 3909.398107245766, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [605.85560938728, 784.3685832904513, 788.2590365056847, 806.0971711682917, 820.7948012996749, 15481.922590387047, 16237.594060148502, 16238.51284461465, 16285.999999999985, 16632.750508742363, 14457.638559036002, 14588.124712517256, 14594.05138665986, 14634.853651463482, 14662.266886655678, 669.2103318084659, 687.7214728035153, 825.3397282174267, 841.3731769831469, 858.3819649852128, 857.3398483167988, 857.7598272483715, 861.840559496492, 862.6808081010004, 863.404251066765, 895.6059333893066, 914.4193437167413, 916.4226537281537, 917.0737555069395, 917.179124683408, 703.6938931564761, 723.819045238693, 881.0704706534603, 892.9151730585584, 912.9954350228272, 676.972921083156, 677.4174210179242, 677.5460441504204, 678.3928384096256, 679.4971720926479, 15404.0, 15422.99750516224, 15425.460108896135, 15427.0, 15437.922810385988, 11345.489452974636, 13847.792283115761, 13985.860141398558, 14086.15483071019, 14208.289585520683, 12801.679958001032, 12824.551140710124, 12851.485940562367, 13045.73856535866, 13095.0, 4488.326750987346, 4523.411956445674, 4628.8148474061, 4729.0, 4738.4550776660435, 121087.78912210853, 121256.78743212543, 122403.38798305951, 124614.0, 125619.0, 11032.669019929415, 11035.44822758859, 11144.911641663668, 11200.383978881076, 11633.76732465346, 22051.00770465333, 22053.33839984803, 22057.448563786034, 22136.446588835086, 22146.0, 7858.489198202098, 7944.404169687181, 7958.562279074707, 7991.760247192594, 8205.302549283258, 4378.365137055109, 4402.0, 4436.290193569013, 4573.131105090022, 4607.723536587815, 3446.655334466533, 3549.201429678353, 3552.3250582389264, 3563.964360356415, 3571.0715214044535, 630.5334052800895, 659.6932426421737, 679.1578442730978, 681.4037716997627, 682.9658517074225, 526.2317017154996, 588.4115884115885, 592.4519819167253, 603.9581721530325, 649.8018104478085, 8757.343199260082, 8765.956170219108, 9147.176754092163, 9184.692512033907, 9221.0, 578.6817250512202, 592.7362323765883, 603.4508597176635, 606.754264522869, 626.1234272019119, 4375.387445757597, 4522.773861306921, 4523.638108951276, 4574.851252661543, 4660.067986402665, 101842.49078754558, 111539.0, 132460.0, 167644.16177919033, 169698.30301697072, 105671.41492877612, 107806.0, 112498.0, 139502.0, 144975.55024449833, 73384.26615733882, 94466.52766736122, 102618.0, 103425.93148137146, 108157.56188038476, 9865.704028879145, 9974.3017988743, 9985.350952188084, 10059.597616095274, 10169.33899296573, 60094.0, 60336.18991430264, 61215.0, 62802.37197627965, 63992.680036601385, 63016.68491657513, 81375.0, 84802.79930017496, 92316.0, 93329.5333523328, 11241.66275011751, 11463.484143213409, 11799.764004719686, 11861.762764744484, 13520.86479135196, 12676.809847852106, 12858.871411286142, 13122.540711075066, 13173.0, 15586.9220653896, 13483.258420786951, 13668.248246346546, 14388.784168237695, 14544.709105818036, 14700.264986750406, 13678.658033548843, 13729.567608097976, 14167.0, 14170.504032358818, 14182.503612373517, 13092.952563794683, 13609.0, 13609.659758506117, 13976.161430314214, 14111.929440352733, 10758.784824303313, 11187.70652016351, 11293.265937714023, 11327.207095503565, 11744.823827642422, 9633.855492167482, 11279.210455268052, 11359.54561817518, 11562.421878905852, 11656.417179141179], "value": 7798.026890081389, "unit": "score"}], "name": "dromaeo_css", "value": 7188.349588178881, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 168.0, 142.0, 113.0, 113.0, 112.0, 111.0, 112.0, 114.0, 113.0], "value": 125.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 109.0, 112.0, 146.0, 114.0, 110.0, 113.0, 133.0, 178.0, 112.0], "value": 127.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 201.0, 267.0, 184.0, 185.0, 185.0, 187.0, 185.0, 180.0, 184.0], "value": 194.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 60.0, 91.0, 64.0, 80.0, 81.0, 82.0, 92.0, 59.0], "value": 75.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 123.0, 100.0, 54.0, 83.0, 120.0, 97.0, 81.0, 90.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 121.0, 75.0, 114.0, 133.0, 102.0, 89.0, 86.0, 87.0, 85.0], "value": 97.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 93.0], "value": 93.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 83.0, 85.0, 84.0, 91.0, 83.0, 84.0, 83.0, 84.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 53.0, 53.0, 54.0, 54.0, 55.0, 54.0, 55.0, 56.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 72.0, 69.0, 76.0, 72.0, 69.0, 69.0, 71.0, 69.0, 74.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 104.0, 105.0, 103.0, 85.0, 88.0, 84.0, 88.0, 90.0, 91.0], "value": 93.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 140.0, 143.0, 160.0, 142.0, 127.0, 124.0, 158.0, 196.0, 146.0], "value": 147.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 170.0, 169.0, 171.0, 170.0, 170.0, 174.0, 169.0, 169.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 87.0, 91.0, 87.0, 68.0, 71.0, 86.0, 83.0, 83.0, 73.0], "value": 79.0, "unit": "score"}], "name": "kraken", "value": 1502.4000000000003, "alertThreshold": 2.0}]} 06:30:18 INFO - Return code: 0 06:30:18 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:30:18 INFO - # TBPL SUCCESS # 06:30:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:30:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:30:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:30:18 INFO - 2016-09-23 06:30:18.201 screenresolution[1670:10131] starting screenresolution argv=screenresolution get 06:30:18 INFO - 2016-09-23 06:30:18.206 screenresolution[1670:10131] Display 0: 1600x1200x32@60 06:30:18 INFO - 2016-09-23 06:30:18.212 screenresolution[1671:10134] starting screenresolution argv=screenresolution list 06:30:18 INFO - Available Modes on Display 0 06:30:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:30:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:30:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:30:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:30:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:30:18 INFO - Intel Iris: 06:30:18 INFO - Chipset Model: Intel Iris 06:30:18 INFO - Type: GPU 06:30:18 INFO - Bus: Built-In 06:30:18 INFO - VRAM (Dynamic, Max): 1536 MB 06:30:18 INFO - Vendor: Intel (0x8086) 06:30:18 INFO - Device ID: 0x0a2e 06:30:18 INFO - Revision ID: 0x0009 06:30:18 INFO - Displays: 06:30:18 INFO - Display: 06:30:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:30:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:30:18 INFO - Display Serial Number: 1600x1200 60 06:30:18 INFO - Main Display: Yes 06:30:18 INFO - Mirror: Off 06:30:18 INFO - Online: Yes 06:30:18 INFO - Rotation: Supported 06:30:18 INFO - Return code: 0 06:30:18 INFO - Running post-action listener: _resource_record_post_action 06:30:18 INFO - [mozharness: 2016-09-23 13:30:18.448461Z] Finished run-tests step (success) 06:30:18 INFO - Running post-run listener: _resource_record_post_run 06:30:18 INFO - Total resource usage - Wall time: 1214s; CPU: 53.0%; Read bytes: 31616000; Write bytes: 703957504; Read time: 318; Write time: 2025 06:30:18 INFO - TinderboxPrint: CPU usage
53.5% 06:30:18 INFO - TinderboxPrint: I/O read bytes / time
31,616,000 / 318 06:30:18 INFO - TinderboxPrint: I/O write bytes / time
703,957,504 / 2,025 06:30:18 INFO - TinderboxPrint: CPU idle
2,260.7 (46.5%) 06:30:18 INFO - TinderboxPrint: CPU system
969.7 (20.0%) 06:30:18 INFO - TinderboxPrint: CPU user
1,627.3 (33.5%) 06:30:18 INFO - TinderboxPrint: Swap in / out
434,286,592 / 0 06:30:18 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 388737536; Write bytes: 382801408; Read time: 29577; Write time: 737 06:30:18 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 30694400; Write bytes: 294818816; Read time: 305; Write time: 1237 06:30:18 INFO - Running post-run listener: _upload_blobber_files 06:30:18 INFO - Blob upload gear active. 06:30:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:30:18 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 06:30:18 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'] 06:30:18 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 06:30:19 INFO - (blobuploader) - INFO - Open directory for files ... 06:30:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:30:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:30:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:30:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:30:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:30:20 INFO - (blobuploader) - INFO - Done attempting. 06:30:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:30:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:30:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:30:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:30:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:30:21 INFO - (blobuploader) - INFO - Done attempting. 06:30:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:30:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:30:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:30:23 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:30:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:30:23 INFO - (blobuploader) - INFO - Done attempting. 06:30:23 INFO - (blobuploader) - INFO - Iteration through files over. 06:30:23 INFO - Return code: 0 06:30:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:30:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:30:23 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/35bf630aa804fcb6893840b3e35c03aea91f53fe8f07d1bdfdb8b90f6bc43585a121960d87468ee84c68094a48e644118d3ad2bf01a6ffd8385ccc6915cb41ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/725d9c4b0aaf1bf84c8661bfbb411b19d95ad984a4736a3e9974d34f3dfe2099080d60fc82d7787ffd456dc30be94ba694b935674399374291a5e25cb48625cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44ddd13bf517d47b6d597e5b663e3f364601c512f81043d115ec3b6096df96e1f80bda96a35a0794c358e8fec16248e26e33ab2d82ff421e2751277ea7d618aa"} 06:30:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:30:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:30:23 INFO - Contents: 06:30:23 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/35bf630aa804fcb6893840b3e35c03aea91f53fe8f07d1bdfdb8b90f6bc43585a121960d87468ee84c68094a48e644118d3ad2bf01a6ffd8385ccc6915cb41ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/725d9c4b0aaf1bf84c8661bfbb411b19d95ad984a4736a3e9974d34f3dfe2099080d60fc82d7787ffd456dc30be94ba694b935674399374291a5e25cb48625cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44ddd13bf517d47b6d597e5b663e3f364601c512f81043d115ec3b6096df96e1f80bda96a35a0794c358e8fec16248e26e33ab2d82ff421e2751277ea7d618aa"} 06:30:23 INFO - Running post-run listener: copy_logs_to_upload_dir 06:30:23 INFO - Copying logs to upload dir... 06:30:23 INFO - mkdir: /builds/slave/test/build/upload/logs 06:30:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.966850 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-09-23 06:30:23.714139) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 06:30:23.718097) ========= 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.irwfLkIHIW/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.jO5MIrLRTz/Listeners TMPDIR=/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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/35bf630aa804fcb6893840b3e35c03aea91f53fe8f07d1bdfdb8b90f6bc43585a121960d87468ee84c68094a48e644118d3ad2bf01a6ffd8385ccc6915cb41ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/725d9c4b0aaf1bf84c8661bfbb411b19d95ad984a4736a3e9974d34f3dfe2099080d60fc82d7787ffd456dc30be94ba694b935674399374291a5e25cb48625cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44ddd13bf517d47b6d597e5b663e3f364601c512f81043d115ec3b6096df96e1f80bda96a35a0794c358e8fec16248e26e33ab2d82ff421e2751277ea7d618aa"} build_url:https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010963 build_url: 'https://queue.taskcluster.net/v1/task/eUCVpetuT1WCnh5_T_bUow/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/35bf630aa804fcb6893840b3e35c03aea91f53fe8f07d1bdfdb8b90f6bc43585a121960d87468ee84c68094a48e644118d3ad2bf01a6ffd8385ccc6915cb41ce", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/725d9c4b0aaf1bf84c8661bfbb411b19d95ad984a4736a3e9974d34f3dfe2099080d60fc82d7787ffd456dc30be94ba694b935674399374291a5e25cb48625cd", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/44ddd13bf517d47b6d597e5b663e3f364601c512f81043d115ec3b6096df96e1f80bda96a35a0794c358e8fec16248e26e33ab2d82ff421e2751277ea7d618aa"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-23 06:30:23.751189) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 06:30:23.751567) ========= 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.irwfLkIHIW/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.jO5MIrLRTz/Listeners TMPDIR=/var/folders/p1/rk75f7qj4pncvncgdvpj45_h00000w/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.005008 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-23 06:30:23.801482) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 06:30:23.801862) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-23 06:30:23.802339) ========= ========= Total master_lag: 0.18 =========