builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0093 starttime: 1490271932.15 results: success (0) buildid: 20170323035458 builduid: 0a82eed6b0bf44d2843339ecc1b2c889 revision: 2f76881b7ba245bb4cfaa4e2c63fa2a040ccce46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 05:25:32.146564) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-23 05:25:32.147011) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 05:25:32.147284) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-23 05:25:32.172569) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 05:25:32.172988) ========= 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.vg0HDeY8Kz/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.aCr4i2kKoH/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-23 05:25:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.98M=0.001s 2017-03-23 05:25:32 (7.98 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.135748 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 05:25:32.332133) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 05:25:32.332444) ========= 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.vg0HDeY8Kz/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.aCr4i2kKoH/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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.022703 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 05:25:32.381424) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 05:25:32.381875) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2f76881b7ba245bb4cfaa4e2c63fa2a040ccce46 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 2f76881b7ba245bb4cfaa4e2c63fa2a040ccce46 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vg0HDeY8Kz/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.aCr4i2kKoH/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-23 05:25:32,462 truncating revision to first 12 chars 2017-03-23 05:25:32,462 Setting DEBUG logging. 2017-03-23 05:25:32,462 attempt 1/10 2017-03-23 05:25:32,462 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/2f76881b7ba2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-23 05:25:33,352 unpacking tar archive at: mozilla-beta-2f76881b7ba2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.146700 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-23 05:25:33.552050) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 05:25:33.552358) ========= script_repo_revision: 2f76881b7ba245bb4cfaa4e2c63fa2a040ccce46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-23 05:25:33.552811) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 05:25:33.553080) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-23 05:25:33.573046) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-03-23 05:25:33.573474) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.vg0HDeY8Kz/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.aCr4i2kKoH/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:25:33 INFO - MultiFileLogger online at 20170323 05:25:33 in /builds/slave/test 05:25:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 05:25:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:25:33 INFO - {'append_to_log': False, 05:25:33 INFO - 'base_work_dir': '/builds/slave/test', 05:25:33 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:25:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:25:33 INFO - 'branch': 'Mozilla-Beta', 05:25:33 INFO - 'buildbot_json_path': 'buildprops.json', 05:25:33 INFO - 'config_files': ('talos/mac_config.py',), 05:25:33 INFO - 'default_actions': ('clobber', 05:25:33 INFO - 'read-buildbot-config', 05:25:33 INFO - 'download-and-extract', 05:25:33 INFO - 'populate-webroot', 05:25:33 INFO - 'create-virtualenv', 05:25:33 INFO - 'install', 05:25:33 INFO - 'run-tests'), 05:25:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:25:33 INFO - 'download_minidump_stackwalk': True, 05:25:33 INFO - 'download_symbols': 'ondemand', 05:25:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:25:33 INFO - 'tooltool.py': '/tools/tooltool.py', 05:25:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:25:33 INFO - '/tools/misc-python/virtualenv.py')}, 05:25:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:25:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:25:33 INFO - 'installer_path': 'installer.exe', 05:25:33 INFO - 'log_level': 'info', 05:25:33 INFO - 'log_name': 'talos', 05:25:33 INFO - 'log_to_console': True, 05:25:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:25:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:25:33 INFO - 'opt_config_files': (), 05:25:33 INFO - 'pip_index': False, 05:25:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:25:33 INFO - 'cmd': ('bash', 05:25:33 INFO - '-c', 05:25:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:25:33 INFO - 'enabled': True, 05:25:33 INFO - 'halt_on_failure': False, 05:25:33 INFO - 'name': 'check_screen_resolution'},), 05:25:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:25:33 INFO - 'cmd': ('bash', 05:25:33 INFO - '-c', 05:25:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:25:33 INFO - 'enabled': True, 05:25:33 INFO - 'halt_on_failure': False, 05:25:33 INFO - 'name': 'check_screen_resolution'},), 05:25:33 INFO - 'run_cmd_checks_enabled': True, 05:25:33 INFO - 'sps_profile': False, 05:25:33 INFO - 'sps_profile_interval': 0, 05:25:33 INFO - 'suite': 'dromaeojs', 05:25:33 INFO - 'system_bits': '32', 05:25:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:25:33 INFO - 'title': 't-yosemite-r7-0093', 05:25:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:25:33 INFO - 'use_talos_json': True, 05:25:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:25:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:25:33 INFO - 'work_dir': 'build'} 05:25:33 INFO - [mozharness: 2017-03-23 12:25:33.780211Z] Running clobber step. 05:25:33 INFO - Running pre-action listener: _resource_record_pre_action 05:25:33 INFO - Running main action method: clobber 05:25:33 INFO - rmtree: /builds/slave/test/build 05:25:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:25:34 INFO - Running post-action listener: _resource_record_post_action 05:25:34 INFO - [mozharness: 2017-03-23 12:25:34.238146Z] Finished clobber step (success) 05:25:34 INFO - [mozharness: 2017-03-23 12:25:34.238310Z] Running read-buildbot-config step. 05:25:34 INFO - Running pre-action listener: _resource_record_pre_action 05:25:34 INFO - Running main action method: read_buildbot_config 05:25:34 INFO - Using buildbot properties: 05:25:34 INFO - { 05:25:34 INFO - "project": "", 05:25:34 INFO - "product": "firefox", 05:25:34 INFO - "script_repo_revision": "production", 05:25:34 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 05:25:34 INFO - "repository": "", 05:25:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 05:25:34 INFO - "buildid": "20170323035458", 05:25:34 INFO - "pgo_build": "False", 05:25:34 INFO - "basedir": "/builds/slave/test", 05:25:34 INFO - "buildnumber": 14, 05:25:34 INFO - "slavename": "t-yosemite-r7-0093", 05:25:34 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 05:25:34 INFO - "platform": "yosemite_r7", 05:25:34 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 05:25:34 INFO - "branch": "mozilla-beta", 05:25:34 INFO - "repo_path": "releases/mozilla-beta", 05:25:34 INFO - "revision": "2f76881b7ba245bb4cfaa4e2c63fa2a040ccce46", 05:25:34 INFO - "stage_platform": "macosx64", 05:25:34 INFO - "builduid": "0a82eed6b0bf44d2843339ecc1b2c889", 05:25:34 INFO - "slavebuilddir": "test" 05:25:34 INFO - } 05:25:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/GUpN3vp_R466G4S1iEulyg/artifacts/public/build/firefox-53.0.en-US.mac.dmg. 05:25:34 INFO - Running post-action listener: _resource_record_post_action 05:25:34 INFO - [mozharness: 2017-03-23 12:25:34.241655Z] Finished read-buildbot-config step (success) 05:25:34 INFO - [mozharness: 2017-03-23 12:25:34.241787Z] Running download-and-extract step. 05:25:34 INFO - Running pre-action listener: _resource_record_pre_action 05:25:34 INFO - Running main action method: download_and_extract 05:25:34 INFO - mkdir: /builds/slave/test/build/tests 05:25:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:34 INFO - trying https://queue.taskcluster.net/v1/task/GUpN3vp_R466G4S1iEulyg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json 05:25:34 INFO - Downloading https://queue.taskcluster.net/v1/task/GUpN3vp_R466G4S1iEulyg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 05:25:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GUpN3vp_R466G4S1iEulyg/artifacts/public/build/firefox-53.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json'}, attempt #1 05:25:35 INFO - Downloaded 1165 bytes. 05:25:35 INFO - Reading from file /builds/slave/test/build/firefox-53.0.en-US.mac.test_packages.json 05:25:35 INFO - Using the following test package requirements: 05:25:35 INFO - {u'common': [u'firefox-53.0.en-US.mac.common.tests.zip'], 05:25:35 INFO - u'cppunittest': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:25:35 INFO - u'firefox-53.0.en-US.mac.cppunittest.tests.zip'], 05:25:35 INFO - u'gtest': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:25:35 INFO - u'firefox-53.0.en-US.mac.gtest.tests.zip'], 05:25:35 INFO - u'jittest': [u'firefox-53.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 05:25:35 INFO - u'mochitest': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:25:35 INFO - u'firefox-53.0.en-US.mac.mochitest.tests.zip'], 05:25:35 INFO - u'mozbase': [u'firefox-53.0.en-US.mac.common.tests.zip'], 05:25:35 INFO - u'reftest': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:25:35 INFO - u'firefox-53.0.en-US.mac.reftest.tests.zip'], 05:25:35 INFO - u'talos': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:25:35 INFO - u'firefox-53.0.en-US.mac.talos.tests.zip'], 05:25:35 INFO - u'web-platform': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:25:35 INFO - u'firefox-53.0.en-US.mac.web-platform.tests.zip'], 05:25:35 INFO - u'xpcshell': [u'firefox-53.0.en-US.mac.common.tests.zip', 05:25:35 INFO - u'firefox-53.0.en-US.mac.xpcshell.tests.zip']} 05:25:35 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip'] for test suite category: common 05:25:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GUpN3vp_R466G4S1iEulyg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 05:25:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GUpN3vp_R466G4S1iEulyg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 05:25:35 INFO - Fetch https://queue.taskcluster.net/v1/task/GUpN3vp_R466G4S1iEulyg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 05:25:36 INFO - Expected file size: 16108254 05:25:36 INFO - Obtained file size: 16108254 05:25:43 INFO - Downloading packages: [u'firefox-53.0.en-US.mac.common.tests.zip', u'firefox-53.0.en-US.mac.talos.tests.zip'] for test suite category: talos 05:25:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GUpN3vp_R466G4S1iEulyg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip 05:25:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GUpN3vp_R466G4S1iEulyg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip'}, attempt #1 05:25:43 INFO - Fetch https://queue.taskcluster.net/v1/task/GUpN3vp_R466G4S1iEulyg/artifacts/public/build/firefox-53.0.en-US.mac.common.tests.zip into memory 05:25:44 INFO - Expected file size: 16108254 05:25:44 INFO - Obtained file size: 16108254 05:25:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GUpN3vp_R466G4S1iEulyg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip 05:25:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GUpN3vp_R466G4S1iEulyg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip'}, attempt #1 05:25:50 INFO - Fetch https://queue.taskcluster.net/v1/task/GUpN3vp_R466G4S1iEulyg/artifacts/public/build/firefox-53.0.en-US.mac.talos.tests.zip into memory 05:25:51 INFO - Expected file size: 14403663 05:25:51 INFO - Obtained file size: 14403663 05:25:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:51 INFO - trying https://queue.taskcluster.net/v1/task/GUpN3vp_R466G4S1iEulyg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 05:25:51 INFO - Downloading https://queue.taskcluster.net/v1/task/GUpN3vp_R466G4S1iEulyg/artifacts/public/build/firefox-53.0.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0.en-US.mac.dmg 05:25:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GUpN3vp_R466G4S1iEulyg/artifacts/public/build/firefox-53.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg'}, attempt #1 05:25:53 INFO - Downloaded 58762507 bytes. 05:25:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GUpN3vp_R466G4S1iEulyg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 05:25:53 INFO - mkdir: /builds/slave/test/properties 05:25:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:25:53 INFO - Writing to file /builds/slave/test/properties/build_url 05:25:53 INFO - Contents: 05:25:53 INFO - build_url:https://queue.taskcluster.net/v1/task/GUpN3vp_R466G4S1iEulyg/artifacts/public/build/firefox-53.0.en-US.mac.dmg 05:25:53 INFO - Running post-action listener: _resource_record_post_action 05:25:53 INFO - Running post-action listener: set_extra_try_arguments 05:25:53 INFO - [mozharness: 2017-03-23 12:25:53.915345Z] Finished download-and-extract step (success) 05:25:53 INFO - [mozharness: 2017-03-23 12:25:53.915487Z] Running populate-webroot step. 05:25:53 INFO - Running pre-action listener: _resource_record_pre_action 05:25:53 INFO - Running main action method: populate_webroot 05:25:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:25:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:25:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:25:53 INFO - '--tppagecycles', 05:25:53 INFO - '7'], 05:25:53 INFO - 'tests': ['tsvgm']}}, 05:25:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:25:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:25:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:25:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:25:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:25:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:25:53 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:25:53 INFO - 'talos_options': ['--disable-e10s'], 05:25:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:25:53 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:25:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:25:53 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:25:53 INFO - 'talos_options': ['--disable-e10s'], 05:25:53 INFO - 'tests': ['damp', 'tps']}, 05:25:53 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:25:53 INFO - 'tests': ['damp', 'tps']}, 05:25:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:25:53 INFO - 'tests': ['dromaeo_dom']}, 05:25:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:25:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:25:53 INFO - 'tests': ['basic_compositor_video']}, 05:25:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:25:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:25:53 INFO - 'tests': ['a11yr', 05:25:53 INFO - 'ts_paint', 05:25:53 INFO - 'tpaint', 05:25:53 INFO - 'sessionrestore', 05:25:53 INFO - 'sessionrestore_no_auto_restore', 05:25:53 INFO - 'tabpaint']}, 05:25:53 INFO - 'other-e10s': {'tests': ['a11yr', 05:25:53 INFO - 'ts_paint', 05:25:53 INFO - 'tpaint', 05:25:53 INFO - 'sessionrestore', 05:25:53 INFO - 'sessionrestore_no_auto_restore', 05:25:53 INFO - 'tabpaint']}, 05:25:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:25:53 INFO - 'ts_paint', 05:25:53 INFO - 'tpaint', 05:25:53 INFO - 'sessionrestore', 05:25:53 INFO - 'sessionrestore_no_auto_restore', 05:25:53 INFO - 'tabpaint']}, 05:25:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:25:53 INFO - 'ts_paint', 05:25:53 INFO - 'tpaint', 05:25:53 INFO - 'sessionrestore', 05:25:53 INFO - 'sessionrestore_no_auto_restore', 05:25:53 INFO - 'tabpaint']}, 05:25:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:25:53 INFO - 'tests': ['a11yr', 05:25:53 INFO - 'ts_paint', 05:25:53 INFO - 'tpaint', 05:25:53 INFO - 'sessionrestore', 05:25:53 INFO - 'sessionrestore_no_auto_restore', 05:25:53 INFO - 'tabpaint']}, 05:25:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:25:53 INFO - 'tests': ['a11yr', 05:25:53 INFO - 'ts_paint', 05:25:53 INFO - 'tpaint', 05:25:53 INFO - 'sessionrestore', 05:25:53 INFO - 'sessionrestore_no_auto_restore', 05:25:53 INFO - 'tabpaint']}, 05:25:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:25:53 INFO - 'tests': ['tsvgx', 05:25:53 INFO - 'tsvgr_opacity', 05:25:53 INFO - 'tart', 05:25:53 INFO - 'tscrollx', 05:25:53 INFO - 'cart', 05:25:53 INFO - 'tsvg_static']}, 05:25:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:25:53 INFO - 'tsvgr_opacity', 05:25:53 INFO - 'tart', 05:25:53 INFO - 'tscrollx', 05:25:53 INFO - 'cart', 05:25:53 INFO - 'tsvg_static']}, 05:25:53 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:25:53 INFO - 'talos_options': ['--disable-e10s'], 05:25:53 INFO - 'tests': ['tp5o']}, 05:25:53 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:25:53 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:25:53 INFO - 'talos_options': ['--disable-e10s', 05:25:53 INFO - '--xperf_path', 05:25:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:25:53 INFO - 'tests': ['tp5n']}, 05:25:53 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:25:53 INFO - 'talos_options': ['--xperf_path', 05:25:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:25:53 INFO - 'tests': ['tp5n']}}, 05:25:53 INFO - 'talos.zip': {'path': '', 05:25:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:25:53 INFO - Running post-action listener: _resource_record_post_action 05:25:53 INFO - [mozharness: 2017-03-23 12:25:53.933894Z] Finished populate-webroot step (success) 05:25:53 INFO - [mozharness: 2017-03-23 12:25:53.934025Z] Running create-virtualenv step. 05:25:53 INFO - Running pre-action listener: _resource_record_pre_action 05:25:53 INFO - Running main action method: create_virtualenv 05:25:53 INFO - Creating virtualenv /builds/slave/test/build/venv 05:25:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:25:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:25:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:25:54 INFO - Using real prefix '/tools/python27' 05:25:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:25:54 INFO - Installing distribute.............................................................................................................................................................................................done. 05:25:57 INFO - Installing pip.................done. 05:25:57 INFO - Return code: 0 05:25:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:25:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:25:58 INFO - Reading from file tmpfile_stdout 05:25:58 INFO - Output received: 05:25:58 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:25:58 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:58 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 0x10aa5eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa61768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1cbda3950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a83cd30>, '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 0x10a763db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a831be8>, '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.vg0HDeY8Kz/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.aCr4i2kKoH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:25:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:25:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vg0HDeY8Kz/Render', 05:25:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:58 INFO - 'HOME': '/Users/cltbld', 05:25:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:58 INFO - 'LOGNAME': 'cltbld', 05:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:58 INFO - 'MOZ_NO_REMOTE': '1', 05:25:58 INFO - 'NO_EM_RESTART': '1', 05:25:58 INFO - 'PAGER': '/bin/cat', 05:25:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:58 INFO - 'PWD': '/builds/slave/test', 05:25:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:58 INFO - 'SHELL': '/bin/bash', 05:25:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCr4i2kKoH/Listeners', 05:25:58 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 05:25:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:58 INFO - 'USER': 'cltbld', 05:25:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:58 INFO - 'XPC_FLAGS': '0x0', 05:25:58 INFO - 'XPC_SERVICE_NAME': '0', 05:25:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:58 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:25:58 INFO - Cleaning up... 05:25:58 INFO - Return code: 0 05:25:58 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:25:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:25:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:25:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:25:58 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 0x10aa5eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa61768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1cbda3950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a83cd30>, '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 0x10a763db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a831be8>, '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.vg0HDeY8Kz/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.aCr4i2kKoH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:25:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:25:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:25:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vg0HDeY8Kz/Render', 05:25:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:25:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:25:58 INFO - 'HOME': '/Users/cltbld', 05:25:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:25:58 INFO - 'LOGNAME': 'cltbld', 05:25:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:25:58 INFO - 'MOZ_NO_REMOTE': '1', 05:25:58 INFO - 'NO_EM_RESTART': '1', 05:25:58 INFO - 'PAGER': '/bin/cat', 05:25:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:25:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:25:58 INFO - 'PWD': '/builds/slave/test', 05:25:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:25:58 INFO - 'SHELL': '/bin/bash', 05:25:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCr4i2kKoH/Listeners', 05:25:58 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 05:25:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:25:58 INFO - 'USER': 'cltbld', 05:25:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:25:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:25:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:25:58 INFO - 'XPC_FLAGS': '0x0', 05:25:58 INFO - 'XPC_SERVICE_NAME': '0', 05:25:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:25:58 INFO - Downloading/unpacking psutil>=3.1.1 05:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:25:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:25:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:25:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:26:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:26:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:26:02 INFO - Installing collected packages: psutil 05:26:02 INFO - Running setup.py install for psutil 05:26:02 INFO - building 'psutil._psutil_osx' extension 05:26:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:26:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:26:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:26:02 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:26:02 INFO - building 'psutil._psutil_posix' extension 05:26:02 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:26:02 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:26:02 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:26:02 INFO - ^ 05:26:02 INFO - 1 warning generated. 05:26:02 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:26:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:26:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:26:03 INFO - Successfully installed psutil 05:26:03 INFO - Cleaning up... 05:26:03 INFO - Return code: 0 05:26:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10aa5eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa61768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1cbda3950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a83cd30>, '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 0x10a763db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a831be8>, '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.vg0HDeY8Kz/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.aCr4i2kKoH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:26: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:26: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 mozsystemmonitor==0.3 05:26:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vg0HDeY8Kz/Render', 05:26:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:03 INFO - 'HOME': '/Users/cltbld', 05:26:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:03 INFO - 'LOGNAME': 'cltbld', 05:26:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:03 INFO - 'MOZ_NO_REMOTE': '1', 05:26:03 INFO - 'NO_EM_RESTART': '1', 05:26:03 INFO - 'PAGER': '/bin/cat', 05:26:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:03 INFO - 'PWD': '/builds/slave/test', 05:26:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:03 INFO - 'SHELL': '/bin/bash', 05:26:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCr4i2kKoH/Listeners', 05:26:03 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 05:26:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:03 INFO - 'USER': 'cltbld', 05:26:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:03 INFO - 'XPC_FLAGS': '0x0', 05:26:03 INFO - 'XPC_SERVICE_NAME': '0', 05:26:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:26:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:26:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:26:06 INFO - Installing collected packages: mozsystemmonitor 05:26:06 INFO - Running setup.py install for mozsystemmonitor 05:26:06 INFO - Successfully installed mozsystemmonitor 05:26:06 INFO - Cleaning up... 05:26:06 INFO - Return code: 0 05:26:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:06 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 0x10aa5eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa61768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1cbda3950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a83cd30>, '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 0x10a763db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a831be8>, '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.vg0HDeY8Kz/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.aCr4i2kKoH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:26:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:26:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:26:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vg0HDeY8Kz/Render', 05:26:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:06 INFO - 'HOME': '/Users/cltbld', 05:26:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:06 INFO - 'LOGNAME': 'cltbld', 05:26:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:06 INFO - 'MOZ_NO_REMOTE': '1', 05:26:06 INFO - 'NO_EM_RESTART': '1', 05:26:06 INFO - 'PAGER': '/bin/cat', 05:26:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:06 INFO - 'PWD': '/builds/slave/test', 05:26:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:06 INFO - 'SHELL': '/bin/bash', 05:26:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCr4i2kKoH/Listeners', 05:26:06 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 05:26:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:06 INFO - 'USER': 'cltbld', 05:26:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:06 INFO - 'XPC_FLAGS': '0x0', 05:26:06 INFO - 'XPC_SERVICE_NAME': '0', 05:26:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:06 INFO - Downloading/unpacking jsonschema==2.5.1 05:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:26:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:09 INFO - Downloading functools32-3.2.3-2.tar.gz 05:26:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:26:09 INFO - warning: no files found matching '*.txt' 05:26:09 INFO - no previously-included directories found matching 'build' 05:26:09 INFO - no previously-included directories found matching 'dist' 05:26:09 INFO - no previously-included directories found matching '.git*' 05:26:09 INFO - Installing collected packages: jsonschema, functools32 05:26:09 INFO - Running setup.py install for functools32 05:26:09 INFO - warning: no files found matching '*.txt' 05:26:09 INFO - no previously-included directories found matching 'build' 05:26:09 INFO - no previously-included directories found matching 'dist' 05:26:09 INFO - no previously-included directories found matching '.git*' 05:26:09 INFO - Successfully installed jsonschema functools32 05:26:09 INFO - Cleaning up... 05:26:10 INFO - Return code: 0 05:26:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:10 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 0x10aa5eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa61768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1cbda3950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a83cd30>, '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 0x10a763db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a831be8>, '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.vg0HDeY8Kz/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.aCr4i2kKoH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:26:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:26:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vg0HDeY8Kz/Render', 05:26:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:10 INFO - 'HOME': '/Users/cltbld', 05:26:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:10 INFO - 'LOGNAME': 'cltbld', 05:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:10 INFO - 'MOZ_NO_REMOTE': '1', 05:26:10 INFO - 'NO_EM_RESTART': '1', 05:26:10 INFO - 'PAGER': '/bin/cat', 05:26:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:10 INFO - 'PWD': '/builds/slave/test', 05:26:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:10 INFO - 'SHELL': '/bin/bash', 05:26:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCr4i2kKoH/Listeners', 05:26:10 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 05:26:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:10 INFO - 'USER': 'cltbld', 05:26:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:10 INFO - 'XPC_FLAGS': '0x0', 05:26:10 INFO - 'XPC_SERVICE_NAME': '0', 05:26:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:26:10 INFO - Cleaning up... 05:26:10 INFO - Return code: 0 05:26:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:10 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 0x10aa5eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa61768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1cbda3950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a83cd30>, '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 0x10a763db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a831be8>, '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.vg0HDeY8Kz/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.aCr4i2kKoH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:26:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:26:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:26:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vg0HDeY8Kz/Render', 05:26:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:10 INFO - 'HOME': '/Users/cltbld', 05:26:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:10 INFO - 'LOGNAME': 'cltbld', 05:26:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:10 INFO - 'MOZ_NO_REMOTE': '1', 05:26:10 INFO - 'NO_EM_RESTART': '1', 05:26:10 INFO - 'PAGER': '/bin/cat', 05:26:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:10 INFO - 'PWD': '/builds/slave/test', 05:26:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:10 INFO - 'SHELL': '/bin/bash', 05:26:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCr4i2kKoH/Listeners', 05:26:10 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 05:26:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:10 INFO - 'USER': 'cltbld', 05:26:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:10 INFO - 'XPC_FLAGS': '0x0', 05:26:10 INFO - 'XPC_SERVICE_NAME': '0', 05:26:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:10 INFO - Downloading/unpacking blobuploader==1.2.4 05:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:13 INFO - Downloading blobuploader-1.2.4.tar.gz 05:26:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:26:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:26:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:14 INFO - Downloading docopt-0.6.1.tar.gz 05:26:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:26:14 INFO - Installing collected packages: blobuploader, requests, docopt 05:26:14 INFO - Running setup.py install for blobuploader 05:26:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:26:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:26:14 INFO - Running setup.py install for requests 05:26:15 INFO - Running setup.py install for docopt 05:26:15 INFO - Successfully installed blobuploader requests docopt 05:26:15 INFO - Cleaning up... 05:26:15 INFO - Return code: 0 05:26:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:15 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 0x10aa5eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa61768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1cbda3950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a83cd30>, '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 0x10a763db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a831be8>, '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.vg0HDeY8Kz/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.aCr4i2kKoH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:26:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:26:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:26:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vg0HDeY8Kz/Render', 05:26:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:15 INFO - 'HOME': '/Users/cltbld', 05:26:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:15 INFO - 'LOGNAME': 'cltbld', 05:26:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:15 INFO - 'MOZ_NO_REMOTE': '1', 05:26:15 INFO - 'NO_EM_RESTART': '1', 05:26:15 INFO - 'PAGER': '/bin/cat', 05:26:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:15 INFO - 'PWD': '/builds/slave/test', 05:26:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:15 INFO - 'SHELL': '/bin/bash', 05:26:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCr4i2kKoH/Listeners', 05:26:15 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 05:26:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:15 INFO - 'USER': 'cltbld', 05:26:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:15 INFO - 'XPC_FLAGS': '0x0', 05:26:15 INFO - 'XPC_SERVICE_NAME': '0', 05:26:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:26:15 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-tEU7Br-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:26:15 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-pjLZ9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:26:15 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-MLxtTH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:26:15 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-LUP_5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:26:16 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-Zx4EpA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:26:16 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-0_x9nv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:26:16 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-uzPzlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:26:16 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-z7NvUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:26:16 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-bt7F1V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:26:16 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-AV5fhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:26:16 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-FxPwT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:26:16 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-oULDWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:26:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:26:16 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-_tDxPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:26:17 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-X2Dkgz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:17 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-DGFnNp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:26:17 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-BxLWzI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:26:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:26:17 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-RwwSDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:26:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:26:17 INFO - Running setup.py install for manifestparser 05:26:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:26:17 INFO - Running setup.py install for mozcrash 05:26:17 INFO - Running setup.py install for mozdebug 05:26:17 INFO - Running setup.py install for mozdevice 05:26:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:26:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:26:18 INFO - Running setup.py install for mozfile 05:26:18 INFO - Running setup.py install for mozhttpd 05:26:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:26:18 INFO - Running setup.py install for mozinfo 05:26:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:26:18 INFO - Running setup.py install for mozInstall 05:26:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:26:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:26:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:26:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:26:18 INFO - Running setup.py install for mozleak 05:26:18 INFO - Running setup.py install for mozlog 05:26:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:26:18 INFO - Running setup.py install for moznetwork 05:26:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:26:19 INFO - Running setup.py install for mozprocess 05:26:19 INFO - Running setup.py install for mozprofile 05:26:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:26:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:26:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:26:19 INFO - Running setup.py install for mozrunner 05:26:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:26:19 INFO - Running setup.py install for mozscreenshot 05:26:19 INFO - Running setup.py install for moztest 05:26:19 INFO - Running setup.py install for mozversion 05:26:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:26:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:26:20 INFO - Cleaning up... 05:26:20 INFO - Return code: 0 05:26:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:20 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 0x10aa5eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa61768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1cbda3950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a83cd30>, '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 0x10a763db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a831be8>, '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.vg0HDeY8Kz/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.aCr4i2kKoH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:26:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:26:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:26:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vg0HDeY8Kz/Render', 05:26:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:20 INFO - 'HOME': '/Users/cltbld', 05:26:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:20 INFO - 'LOGNAME': 'cltbld', 05:26:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:20 INFO - 'MOZ_NO_REMOTE': '1', 05:26:20 INFO - 'NO_EM_RESTART': '1', 05:26:20 INFO - 'PAGER': '/bin/cat', 05:26:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:20 INFO - 'PWD': '/builds/slave/test', 05:26:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:20 INFO - 'SHELL': '/bin/bash', 05:26:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCr4i2kKoH/Listeners', 05:26:20 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 05:26:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:20 INFO - 'USER': 'cltbld', 05:26:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:20 INFO - 'XPC_FLAGS': '0x0', 05:26:20 INFO - 'XPC_SERVICE_NAME': '0', 05:26:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:26:20 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-kioZAq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:26:20 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-IUx4mH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:26:20 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-bjitHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:26:20 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-NFiarZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:26:20 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-SX5R_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:26:20 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-uhuC4I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:26:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:26:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:26:20 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-LVSSjP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:26:21 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-lH1IGL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:26:21 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-dQdguM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:26:21 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-FqbdZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:26:21 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-BVFfBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:26:21 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-gae8n6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:26:21 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-VC2YRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:26:21 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-3VPhu_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:21 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-wE1MB4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:26:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:26:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:26:21 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-aViNhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:26:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:26:22 INFO - Running setup.py (path:/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/pip-Wx1KIL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:26:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:26:22 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:26:22 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:26:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:26:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:26:24 INFO - Downloading blessings-1.6.tar.gz 05:26:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:26:24 INFO - Installing collected packages: blessings 05:26:24 INFO - Running setup.py install for blessings 05:26:24 INFO - Successfully installed blessings 05:26:24 INFO - Cleaning up... 05:26:25 INFO - Return code: 0 05:26:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:26:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:26:25 INFO - Reading from file tmpfile_stdout 05:26:25 INFO - Current package versions: 05:26:25 INFO - blessings == 1.6 05:26:25 INFO - blobuploader == 1.2.4 05:26:25 INFO - docopt == 0.6.1 05:26:25 INFO - functools32 == 3.2.3-2 05:26:25 INFO - jsonschema == 2.5.1 05:26:25 INFO - manifestparser == 1.1 05:26:25 INFO - mozInstall == 1.12 05:26:25 INFO - mozcrash == 1.0 05:26:25 INFO - mozdebug == 0.1 05:26:25 INFO - mozdevice == 0.49 05:26:25 INFO - mozfile == 1.2 05:26:25 INFO - mozhttpd == 0.7 05:26:25 INFO - mozinfo == 0.9 05:26:25 INFO - mozleak == 0.1 05:26:25 INFO - mozlog == 3.4 05:26:25 INFO - moznetwork == 0.27 05:26:25 INFO - mozprocess == 0.24 05:26:25 INFO - mozprofile == 0.28 05:26:25 INFO - mozrunner == 6.13 05:26:25 INFO - mozscreenshot == 0.1 05:26:25 INFO - mozsystemmonitor == 0.3 05:26:25 INFO - moztest == 0.8 05:26:25 INFO - mozversion == 1.4 05:26:25 INFO - psutil == 3.1.1 05:26:25 INFO - requests == 1.2.3 05:26:25 INFO - wsgiref == 0.1.2 05:26:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:25 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 0x10aa5eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa61768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1cbda3950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a83cd30>, '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 0x10a763db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a831be8>, '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.vg0HDeY8Kz/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.aCr4i2kKoH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:26:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:26:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vg0HDeY8Kz/Render', 05:26:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:25 INFO - 'HOME': '/Users/cltbld', 05:26:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:25 INFO - 'LOGNAME': 'cltbld', 05:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:25 INFO - 'MOZ_NO_REMOTE': '1', 05:26:25 INFO - 'NO_EM_RESTART': '1', 05:26:25 INFO - 'PAGER': '/bin/cat', 05:26:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:25 INFO - 'PWD': '/builds/slave/test', 05:26:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:25 INFO - 'SHELL': '/bin/bash', 05:26:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCr4i2kKoH/Listeners', 05:26:25 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 05:26:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:25 INFO - 'USER': 'cltbld', 05:26:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:25 INFO - 'XPC_FLAGS': '0x0', 05:26:25 INFO - 'XPC_SERVICE_NAME': '0', 05:26:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:26:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:26:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:26:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:26:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:26:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:26:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:26:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:26:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:26:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:26:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:26:25 INFO - Cleaning up... 05:26:25 INFO - Return code: 0 05:26:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:26:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:26:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:26:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:26:25 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 0x10aa5eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10aa61768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa1cbda3950>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a83cd30>, '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 0x10a763db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a831be8>, '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.vg0HDeY8Kz/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.aCr4i2kKoH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:26:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:26:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vg0HDeY8Kz/Render', 05:26:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:25 INFO - 'HOME': '/Users/cltbld', 05:26:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:25 INFO - 'LOGNAME': 'cltbld', 05:26:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:25 INFO - 'MOZ_NO_REMOTE': '1', 05:26:25 INFO - 'NO_EM_RESTART': '1', 05:26:25 INFO - 'PAGER': '/bin/cat', 05:26:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:25 INFO - 'PWD': '/builds/slave/test', 05:26:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:25 INFO - 'SHELL': '/bin/bash', 05:26:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCr4i2kKoH/Listeners', 05:26:25 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 05:26:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:25 INFO - 'USER': 'cltbld', 05:26:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:25 INFO - 'XPC_FLAGS': '0x0', 05:26:25 INFO - 'XPC_SERVICE_NAME': '0', 05:26:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:26:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:26:25 INFO - Cleaning up... 05:26:25 INFO - Return code: 0 05:26:25 INFO - Running post-action listener: _resource_record_post_action 05:26:25 INFO - Running post-action listener: _start_resource_monitoring 05:26:25 INFO - Starting resource monitoring. 05:26:25 INFO - [mozharness: 2017-03-23 12:26:25.883707Z] Finished create-virtualenv step (success) 05:26:25 INFO - [mozharness: 2017-03-23 12:26:25.884703Z] Running install step. 05:26:25 INFO - Running pre-action listener: _resource_record_pre_action 05:26:25 INFO - Running main action method: install 05:26:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:26:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:26:26 INFO - Reading from file tmpfile_stdout 05:26:26 INFO - Detecting whether we're running mozinstall >=1.0... 05:26:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:26:26 INFO - Reading from file tmpfile_stdout 05:26:26 INFO - Output received: 05:26:26 INFO - Usage: mozinstall [options] installer 05:26:26 INFO - Options: 05:26:26 INFO - -h, --help show this help message and exit 05:26:26 INFO - -d DEST, --destination=DEST 05:26:26 INFO - Directory to install application into. [default: 05:26:26 INFO - "/builds/slave/test"] 05:26:26 INFO - --app=APP Application being installed. [default: firefox] 05:26:26 INFO - mkdir: /builds/slave/test/build/application 05:26:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0.en-US.mac.dmg --destination /builds/slave/test/build/application 05:26:40 INFO - Reading from file tmpfile_stdout 05:26:40 INFO - Output received: 05:26:40 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 05:26:40 INFO - Running post-action listener: _resource_record_post_action 05:26:40 INFO - [mozharness: 2017-03-23 12:26:40.787221Z] Finished install step (success) 05:26:40 INFO - [mozharness: 2017-03-23 12:26:40.787388Z] Running run-tests step. 05:26:40 INFO - Running pre-action listener: _resource_record_pre_action 05:26:40 INFO - Running main action method: run_tests 05:26:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:26:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:26:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:26:40 INFO - 2017-03-23 05:26:40.801 screenresolution[2292:24338] starting screenresolution argv=screenresolution get 05:26:40 INFO - 2017-03-23 05:26:40.804 screenresolution[2292:24338] Display 0: 1600x1200x32@60 05:26:40 INFO - 2017-03-23 05:26:40.810 screenresolution[2293:24340] starting screenresolution argv=screenresolution list 05:26:40 INFO - Available Modes on Display 0 05:26:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:26:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:26:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:26:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:26:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:26:41 INFO - Intel Iris: 05:26:41 INFO - Chipset Model: Intel Iris 05:26:41 INFO - Type: GPU 05:26:41 INFO - Bus: Built-In 05:26:41 INFO - VRAM (Dynamic, Max): 1536 MB 05:26:41 INFO - Vendor: Intel (0x8086) 05:26:41 INFO - Device ID: 0x0a2e 05:26:41 INFO - Revision ID: 0x0009 05:26:41 INFO - Displays: 05:26:41 INFO - Display: 05:26:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:26:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:26:41 INFO - Display Serial Number: 1600x1200 60 05:26:41 INFO - Main Display: Yes 05:26:41 INFO - Mirror: Off 05:26:41 INFO - Online: Yes 05:26:41 INFO - Rotation: Supported 05:26:41 INFO - Return code: 0 05:26:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:26:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:26:41 INFO - Python 2.7.3 05:26:41 INFO - Return code: 0 05:26:41 INFO - grabbing minidump binary from tooltool 05:26: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')]} 05:26:41 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 0x10a83cd30>, '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 0x10a763db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a831be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:26:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:26:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:26:41 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:26:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:26:41 INFO - Return code: 0 05:26:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:26:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:26:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:26:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:26:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:26:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GUpN3vp_R466G4S1iEulyg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0093', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:26:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GUpN3vp_R466G4S1iEulyg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0093 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:26:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.vg0HDeY8Kz/Render', 05:26:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:26:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:26:41 INFO - 'HOME': '/Users/cltbld', 05:26:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:26:41 INFO - 'LOGNAME': 'cltbld', 05:26:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:26:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:26:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:26:41 INFO - 'MOZ_NO_REMOTE': '1', 05:26:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:26:41 INFO - 'NO_EM_RESTART': '1', 05:26:41 INFO - 'PAGER': '/bin/cat', 05:26:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:26:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:26:41 INFO - 'PWD': '/builds/slave/test', 05:26:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:26:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:26:41 INFO - 'SHELL': '/bin/bash', 05:26:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.aCr4i2kKoH/Listeners', 05:26:41 INFO - 'TMPDIR': '/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/', 05:26:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:26:41 INFO - 'USER': 'cltbld', 05:26:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:26:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:26:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:26:41 INFO - 'XPC_FLAGS': '0x0', 05:26:41 INFO - 'XPC_SERVICE_NAME': '0', 05:26:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:26:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GUpN3vp_R466G4S1iEulyg/artifacts/public/build/firefox-53.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0093', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:26:41 INFO - mozversion application_buildid: 20170323035458 05:26:41 INFO - mozversion application_changeset: 2f76881b7ba245bb4cfaa4e2c63fa2a040ccce46 05:26:41 INFO - mozversion application_display_name: Firefox 05:26:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:26:41 INFO - mozversion application_name: Firefox 05:26:41 INFO - mozversion application_remotingname: firefox 05:26:41 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:26:41 INFO - mozversion application_vendor: Mozilla 05:26:41 INFO - mozversion application_version: 53.0 05:26:41 INFO - mozversion platform_buildid: 20170323035458 05:26:41 INFO - mozversion platform_changeset: 2f76881b7ba245bb4cfaa4e2c63fa2a040ccce46 05:26:41 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:26:41 INFO - mozversion platform_version: 53.0 05:26:41 INFO - using testdate: 1490272001 05:26:41 INFO - actual date: 1490272001 05:26:41 INFO - starting webserver on 'localhost:50082' 05:26:41 INFO - SUITE-START | Running 2 tests 05:26:41 INFO - TEST-START | dromaeo_css 05:26:41 INFO - operating with platform_type : mac_ 05:26:41 INFO - Initialising browser for dromaeo_css test... 05:26:41 INFO - TEST-INFO | started process 2303 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/tmpVR2yU_/profile http://localhost:50082/getInfo.html) 05:26:43 INFO - PROCESS | 2303 | __metrics Screen width/height:1600/1200 05:26:43 INFO - PROCESS | 2303 | colorDepth:24 05:26:43 INFO - PROCESS | 2303 | Browser inner width/height: 1024/689 05:26:43 INFO - PROCESS | 2303 | __metrics 05:26:43 INFO - PROCESS | 2303 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:26:43 INFO - PROCESS | 2303 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:26:44 INFO - TEST-INFO | 2303: exit 0 05:26:44 INFO - Browser initialized. 05:26:44 INFO - Running cycle 1/1 for dromaeo_css test... 05:26:44 INFO - TEST-INFO | started process 2306 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/tmpVR2yU_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:26:56 INFO - PROCESS | 2306 | RSS: Main: 163794944 05:26:56 INFO - PROCESS | 2306 | 05:29:59 INFO - PROCESS | 2306 | Cycle 1(1): loaded http://localhost:50082/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50082/tests/dromaeo/cssquery-ext.html) 05:30:00 INFO - PROCESS | 2306 | RSS: Main: 297652224 05:30:00 INFO - PROCESS | 2306 | 05:33:03 INFO - PROCESS | 2306 | Cycle 1(1): loaded http://localhost:50082/tests/dromaeo/cssquery-ext.html (next: http://localhost:50082/tests/dromaeo/cssquery-jquery.html) 05:33:03 INFO - PROCESS | 2306 | RSS: Main: 326283264 05:33:03 INFO - PROCESS | 2306 | 05:36:06 INFO - PROCESS | 2306 | Cycle 1(1): loaded http://localhost:50082/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50082/tests/dromaeo/cssquery-mootools.html) 05:36:07 INFO - PROCESS | 2306 | RSS: Main: 280608768 05:36:07 INFO - PROCESS | 2306 | 05:39:09 INFO - PROCESS | 2306 | Cycle 1(1): loaded http://localhost:50082/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50082/tests/dromaeo/cssquery-prototype.html) 05:39:10 INFO - PROCESS | 2306 | RSS: Main: 275402752 05:39:10 INFO - PROCESS | 2306 | 05:42:13 INFO - PROCESS | 2306 | Cycle 1(1): loaded http://localhost:50082/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50082/tests/dromaeo/cssquery-yui.html) 05:42:14 INFO - PROCESS | 2306 | RSS: Main: 268103680 05:42:14 INFO - PROCESS | 2306 | 05:45:17 INFO - PROCESS | 2306 | Cycle 1(1): loaded http://localhost:50082/tests/dromaeo/cssquery-yui.html (next: http://localhost:50082/tests/dromaeo/cssquery-dojo.html) 05:45:17 INFO - PROCESS | 2306 | RSS: Main: 367325184 05:45:17 INFO - PROCESS | 2306 | 05:45:17 INFO - PROCESS | 2306 | __start_tp_report 05:45:17 INFO - PROCESS | 2306 | _x_x_mozilla_page_load 05:45:17 INFO - PROCESS | 2306 | _x_x_mozilla_page_load_details 05:45:17 INFO - PROCESS | 2306 | |i|pagename|runs| 05:45:17 INFO - PROCESS | 2306 | |0;dojo.html;3438.4154693702067;3439.3121375724854;3448.6896179343853;3473.9652603473955;3502.9649703502955;5908.615939963899;5918.970405147968;5939.970300148504;5946.286445626525;5966.46301832835;5942.168096466498;6007.429294217042;6015.157877897098;6016.789412370568;6029.969850150754;5343.118385466393;5357.651752636066;5390.568754499631;5457.399686034533;5522.144067669517;5316.9202461963105;5319.760610772505;5327.706976116312;5343.1985202219785;5463.262459567947;5452.100403433429;5456.563474922016;5458.5087342139195;5474.507294343508;5506.862328441781;5455.372632147314;5456;5467.890642187134;5471.23402723619;5482.122860342366;5241.187615919539;5333.706646134461;5381.461853814626;5399.892002159974;5454.645448045904;5771.595988280822;5818.8254352369495;5875.41245875409;5878.353381128072;5880.411958804086;6240.968795156041;6247.125402443661;6283.874322513524;6298.968505157445;6317.526185536103;6289.433950944392;6322.146510221153;6328.272248691414;6336.556441049129;6355.713992870285;5985.790497332572;6043.607165534227;6056.15213870063;6091.786787462417;6096.664683442365;6274.560780745304;6336.556441049082;6372.36276372359;6423.100765892778;6435.871282574322;6328.082428047907;6342.746290148435;6348.301686814447;6365.108884756138;6368.490520758328;6309.463695585835;6355.3009168991375;6360.9045864312075;6391.96804015977;6395.968020159869;6219.595726277777;6250.093736408196;6255.374462553799;6258.968705156445;6277.780277690259;6251.9687401562705;6270;6270.749170033238;6280.497560195174;6284.842878928063;5104.234364845229;5104.821331253388;5115.258287548285;5117.232415137759;5142.845714628567;4467.441569803775;4505.986153115588;4541.364209010741;4569.840055598104;4594.19601569724;6058.242719660043;6125.387461253928;6137.662428566472;6141.017437210025;6158.568900176944;6331.0819931110655;6394.904076438857;6397;6405.135306733531;6418.550701450947;5498.202760599691;5864.09106588471;5864.44287792659;6117.694115294217;6138.754449821957;5509.531689806411;5556.666600003932;5577.9163312550345;5590.552755779528;5591.440855914376;6304.117423560797;6434.292227854932;6437.163168788027;6440.194975628046;6446.774362897276;6249.093881387083;6255.343188965093;6277.403646653561;6283.434490895841;6293.874122517615;6463.547551671526;6464.159659244268;6469.417752402306;6482.060101285381;6485.935140648722;6152.261728592597;6284.465820405317;6305.180326557518;6314.242290925118;6317.368263173646;6190.938090619036;6214.223222097238;6242.1261023455845;6276.215473065867;6348.396902294275;6301.054841773771;6320.241571011508;6324.873502530016;6334.556581039283;6336;6298.464630506458;6298.496120310272;6302.275238347649;6310.5898116622275;6319.557630965788;6101.267847858286;6118.80192544137;6141.608749743955;6187.690615469299;6190;6294;6301.936980630318;6314.368563143833;6315.936840631535;6323.430891219812;6059.606125601822;6201.193844800147;6241.21984751906;6246;6249.7187626557825 05:45:17 INFO - PROCESS | 2306 | |1;ext.html;468.26248658363085;485.94411642661106;507.6700144905811;547.54280176053;558.4555058817654;32797.67202327976;38365.84902452924;42393.36409953849;44438.555614443845;44763.55236447639;46826;47249.81875453115;47299.8175045624;47335.28997065038;47380;9598.712038638834;9780.364276322052;9806.705798826011;9815.362001469917;9827.754306142333;8863.601137948808;9109.544522773867;9126.634934602642;9179.127982841619;11785.705357366092;11879.881201187964;12007.159498835084;12012.759744805098;12017.639470815846;12077.758444831097;11861.9917307029;11930.105242106876;11938.28370297785;11939.522419103225;11948.223365481259;11797.351145686984;11881.40592970348;11882.702932426671;11884.465199065977;11917.523299068114;43446.56553434457;43694.344584831255;43700;43776;43798.562014379764;4031.314676504972;4054.959450405517;4065.8780236592947;4081.673466122703;4099.672026237894;29783.10650680483;31419.685803141903;31827.681723182704;31949.520757188428;32181.356372872644;3027.8940237091597;3180.761442891769;3319.668033196685;3405.3700065487715;3406.233597440556;527515;529997;532100;532225;533255;60252.698736506034;60744;60854.39145608576;60878.39121608816;60907.39092609106;65566.67216663886;65587;65634;65672;65756.6712166436;17006.404775832787;17326;17363.47909562715;17371;17390.913045434943;13208.33958302081;13295.601131966056;13306.73386532264;13308.800367994489;13330.73338533224;16799.58001049959;17101.04028331109;17213.311467541407;17289.394871179447;19146.617067658848;7106.502544821813;7942.324902383362;8396.958015209884;8880.955595221982;8902.972989183709;799.2686691677167;859.3726579596929;888.4624801994829;894.1014280648037;898.3262553085186;30449.238769030508;31170.532442013387;31493.8425307872;31906.36187276288;32261.51607725886;1058.539535302146;1074.752806854428;1078.735709751116;1118.972025699364;1121.2319561100671;12954.80567791484;16392.75410868838;16587.253573589216;16618.00291982485;16915.577110572332;690038;693853;695177;697419.5129024322;697570;55652.72173639106;57283;64622.353776461634;65779;66265;1465.7434948884115;1497.3636204612778;1501.369424841569;1508.615303097703;1511.8110236220693;31305.8434707825;32818.34363312768;32964.34071318608;33087;33649.83175084109;56091.71954140203;56720;56796.716016421306;56803;56816.431835682764;585122;595296;636052;642913;644574;27444.45111097727;27614.861925690242;27733;27753.44493110086;27757.889684412396;46960.7651961738;48122.79693007703;48866;49782;49850.25224621561;38152.236955261294;39290.80354598209;40765.592344076176;41534.79232603818;41645.16709665729;38085.4287185698;39186.60813391829;39644.40533392059;40071.599284007956;40229.51196248806;38214.67433159588;38901.41647875341;39246.803765980985;39249.80375098106;39325.41011884767;30337.24156896007;32886.506702399005;34907.47638785471;35405.82297088498;36004;20021.6996745046;21447.078734143015;25499.74500255048;25742.485150296514;25933.870330648228 05:45:17 INFO - PROCESS | 2306 | |2;jquery.html;358.83736693114315;390.62109753539056;399.9340108882035;402.50692901196027;433.744090986318;19021.429357119276;20989.580208395822;21464.785352146475;22279.665805012937;22354.441138971513;19926.60146797063;20070;21339.759325270858;21542.030608622612;21678.783212167873;5929.762809487626;6231.844203894893;6255.15555400022;6268.592541484812;6272.278687950876;6104.847378815521;6179.721912513925;6234.8441288967915;7564.319211270985;7893.921060789376;7819.296263336299;7927.801804954865;7945.12603613602;8053.838923221532;8108.310793582553;7981.920180798175;8039;8060.032796064451;8072.273495385414;8097.716579919675;7573.848523029508;7779.688812447495;7915.722949696733;7954.363650907913;7956;30251;31562.842185788923;31754.206144846332;32213.35573288521;32658.673413265802;2805.6072149899032;2878.53943369062;2895.6235689360246;2930.355321829194;3325.7717329389366;16892.239849206693;17205.053722045282;17564.736528952075;18326.90836545822;18612.162452689525;1916.1568909679697;2013.4161093283076;2026.199651137807;2026.4629873083645;2133.4986278224605;81941;112442;115243;127650.99999999907;159576;20655.58688826215;22343.32970010902;23361.41596460068;24525.141620043214;24850.875745621157;42366.78816605897;42477.362839557434;43379.56620433818;43800.12399751987;43917.560824391345;10109.848352274721;11369.204155709022;11500.88499115015;11771.941140294244;11967;9366.484843333683;9383.765405864908;9455.952720236492;9470.715878523655;9608.222478841437;9380.437173769596;11172;11180.826013268652;11262.155338349656;11384.37385943781;4096.795160241976;4120.484939382577;4171.436856024458;4171.893193937103;4188.979055104766;1038.8857225705167;1063.3407287481812;1066.0831684751108;1074.5594306334365;1112.671761830262;21562.892185539287;21817.67273490899;21905.671414928787;21960.45098872541;21997.780022199895;1083.9078678312273;1093.8577984861918;1097.91765617579;1102.3330884814573;1117.4803716271972;10210.723659542557;10594.629187978384;11507.964283214551;11538.88461115378;11723.531058757555;780282.0985895034;806243;812380;821933;822941.8852905697;145913;151639;153858.230708848;154246.22876885545;156336;1018.3686114608842;1100.5377741348652;1101.0255923507593;1107.3023994883333;1165.580391059218;19709.60580788405;20121;20375.388738337875;20899;20960.790392095885;62365;64221.03668445071;65521.01718474322;66134.66932665306;66280.34299142368;90302;92836.07163928275;94417.52791236274;95318;97264.51367743115;7740.729074482366;8349.916500834914;8421.578921054046;8426.410151289596;8620.094890036708;11342.149338799789;12803.871961280269;12887.613371598867;12889.935550322189;13370.866291336963;9317.767055823388;11043.779124417628;11504.82742758876;11653.941730291293;11707.941460292644;11238.494267758135;11251.943740281245;11299.830502542633;11306.83039754388;11638.53445862156;11418.657440276806;11518.82721759191;11603.303801771921;11632.418379081182;11942.283462992249;8308.626111825104;8315.792105197419;8346.666133354598;8621.439606425562;8648.308135349283;8328.708495202882;9676.9032309676;11116.61091861781;11139.053180479426;11526.94236528812 05:45:17 INFO - PROCESS | 2306 | |3;mootools.html;1301.5639760680172;1376.098655380726;1474.9926250368746;1505.3677455468696;1507.2689745473447;7607.885881711779;7982.960085199573;8234.711785087517;8416;8417.747467575982;8322;8400.285975692073;8425.747227583168;8433.156684331563;8434.283085937703;2355.9411014724596;2400.0399840063938;2400.50789588134;2403.7476065013184;2404.038384646138;2131.5417185305155;2207.4812419081504;2208.149862303017;2210.1932794530044;2213.170061227032;2321.1759825262043;2407.9518409631796;2409.0725070847675;2413.095089341497;2414.1912459326145;2364.4679947011955;2387.4747555537756;2403.663487111806;2405.9037638494437;2409.9759002410015;1937.0314842578712;2369.845960012594;2380.4405964598304;2427.1868923910333;2428.5021570577987;8529.914700852974;8574;8576.914230857736;8596.78508037304;8603.139686031409;5097.388313402415;5260;5260.079486089919;5261.710605916673;5265.973670131663;3478.565179352581;3481.0427132538753;3514.7539672222956;3545.4327307630656;3565.2512972275854;1244.9066320025943;1249.3378509390038;1253.0414233111676;1301.1087405127519;1301.5704817410233;11046.889531104747;11062.612808551743;11075.16936229778;11089.611863584736;11090.445477726082;4006.6193711597352;4119.608637179464;4735.786889589976;4816.590589799836;4816.903661926742;8312.459690120122;9586.95206523963;9638.228941684649;9638.228941684649;9649.469279189572;5369.7583608737705;5383.192521121863;5387.865303367369;5392.703401312965;5409.6213265071065;4681.742504162304;4840.782164802592;4899.755012249445;4965.826196083192;4975.253711943165;3761.3041587306434;3858.980705096513;3986.940195897064;4001.91996160081;4088.386741988666;1305;1305.5691621764795;1308.130093487839;1313.750387426386;1323.0672375974914;806.8023334283138;821.322409012567;825.3974598543098;832.0193575898219;837.6984285657159;5633.155026745939;5745.88508229833;5889.411058894077;5910.261217347832;6070.939290607126;917.5274733512113;988.9752756181153;1005.9497025148713;1008.6671398438498;1019.6329321444274;3794.2032173243374;3888.844446222176;3908.1988192420486;3955.3078211312904;4005.5193376794386;8376.916230837736;10170.745731356776;10176.338537995007;10193.796124077477;10202.38785672862;10041.949790251001;10089.848652270222;10106.646267380607;10112.393256404492;10125.59497620087;7521.398288136936;7861.371090312761;7880.921190788134;7931.127575966639;8020.278174964281;5815.534757219497;5868.765249390148;5925.496332811759;5933.05071188625;6045.6070355426755;9068.319876009458;9329.393589416666;9342.626294948126;9430.481323526998;9444.433333999981;7746.92253077462;9214.401063930824;9557.808843823224;9575.904240957501;9586.472743999147;7084.220735718964;7297.160826504807;7322.743703970335;7361.30067643573;7426.14599321085;7375.926240737524;7629.2370762923265;7848.646810893638;8093.676252949816;8178.754637360888;7222.927770722225;7280.963595182202;7299.8540029200185;7307.707691692272;7321.487495875451;6532.248791388861;6946.756863509753;7113.679884405111;7136.536125152056;7225.277472252733;6489.870202595827;6547.247066587213;6605.339466053356;6607.174103237096;6608.5374023819795;4975.477574854588;5105.744712764421;5125.308083408692;5183.5593974512585;5250.847390434001;5054.418741844588;5055.494450554915;5167.302414174038;5204.8178313758835;5322.068637988259 05:45:17 INFO - PROCESS | 2306 | |4;prototype.html;356.71997481976643;364.34236203652404;370.7515964303916;383.38466760848854;384.76337052712574;4931.827386041489;5349.170878513827;5387.4343193964605;5433.565314774818;5459.208414779854;4526.6378689704825;5034.622403319757;5164.483551644834;5196.58427325814;5304.602154838383;4159.376093585956;4186.79066046698;4199.7690127043;4247.362895565659;4290.721103128287;3420.2304481491715;3672.797996110213;4200.222958752625;4209.452771139748;4225.323948168294;4065.715399922007;4142.896427589304;4175.0397408596045;4199.68502362324;4207.326827707568;3321.9501707474287;3538;4161.56303588125;4182.351735481006;4235.428217190671;3128.452520808872;3394.6605339466105;3699.9260014799825;3709.069834830481;3740.3267411865854;4983.252512123175;5255.1329030709885;5274.734063824692;5284.524392804666;5287.4976877196605;4538.319252112176;4612.446506419251;4670.579647831678;4792.880177995578;4832.395950506187;4635.629149668019;5507.0637991541535;5587.910357480293;5589.441055894378;5604.8038318659055;4087.591240875918;4089.8568550100604;4090.2820815257364;4094.3858421236755;4116;4951.851444456672;5394;5507.889842203133;5589.071770239261;5622.381538030813;3524.6827785499427;3827.8468861245237;3947.585503522146;3947.8618248361167;3954.7429417088374;3625.927481450356;3886.9222615547533;4003.2994226010915;4005.319095753729;4036.6770658347264;3977.7867750336427;4334.523202447728;4341.544137865541;4577.8168873244695;4587.52273772166;5429.782808687608;5693;5700.059490184156;5724.599278050497;5724.685142317129;1292.6057552446407;1293.2951541409766;1293.430890408236;1309.7511472820133;1312.4618906248584;768.2125821033374;816.7753867686433;849.3035710717276;860.7288704058202;871.3203701113142;4969.453360130383;5045.495450454925;5048.268001139814;5072.340595722606;5075.56857667095;4774.594159496482;5062.594992400599;5486.506214440719;5681.602287839894;5683.801066962719;4132.628063474242;4430.933535996963;4491.371208030879;4592.7369973256955;4767.356406885096;2311.873076769376;2334.113037045912;2644.505854192375;2868.942621147565;2901.5481917779443;5027.949720502821;5172.353455818023;5266.680652540961;5706.058500347396;5843.474087332161;5522.889542209134;5586;5645.407232240637;5660.773569057274;5954.642721436728;5100.591952643779;6125.264968203844;6135;6145.446909778141;6151.876962460815;5061.822836200715;5502.468864322296;5925.348211696796;5962.598789284428;5990.730417131327;4872.4640289567415;5794.754937235161;5812.709364531672;5824.165387902797;5824.650520968756;4960.544530457447;6137.355577664281;6159.907601385893;6165.5375846810775;6167.5374346925055;3267.7059064684295;3853.3834586466032;3875.748076375027;3940.2316548273957;3944.684425246031;5382.515573598395;5783;5812.94187058141;5823.563232757476;5836.766529338949;4847.551986246923;4855.465898751205;5727.8854422912145;5744.798932037359;5752.842683993503;5266.289050978069;5476.3702174250475;5550.722463876709;5651.858703532444;5686;4750.762461876823;5093.286939828353;5367.114426119647;5398.627112039261;5571.275734154534;4710.905781884411;4995.5004499551205;5241.925405291982;5393.6763794172475;5674.269347848781;5110.872228194325;5218.608604354613;5587.636803607753;5597.972010139923;5611.579131565068 05:45:17 INFO - PROCESS | 2306 | |5;yui.html;755.2372104174783;759.2900637903557;803.0925054688201;862.8274345130972;867.3798234262501;15975.680486390265;16046.679066418665;16082.83917160828;16140.515784526468;16301.918490407546;14720;14829.258537073158;14836.406543738238;14846.628834279149;14851.702965940674;717.2755516927914;739.1647438394607;873.7990262239689;899.6671231644301;919.1497864475367;906.1663269791808;910.7176775199677;911.3666002128523;911.5077857956728;912.8904531456235;961.8509131084693;976.3458482816494;978.7455261631956;979.1872745621117;983.1741337276686;969.5685419988108;973.3770386952356;975.7024107647201;977.008336538414;979.109010800172;731.9194888562254;732.0044739154745;732.7032551816523;732.9193788683241;738.0626604212673;14646.633834154125;14736.48422305214;16036.75944860828;16245.431409900597;16434.26045827929;14996.175210363426;15229;15456;15546.61133471661;15582.844171558252;10979.725506862313;11668.474918628597;11716.824247636292;11988.820167697491;12054.879451205552;3867.168558759852;3893.1824316893485;3912.726109172359;4045.939310910339;4055.797210139481;101456;106528;107453;107758.46120769424;110710.89289107086;10438.582456701799;11088.279261847954;11321.433928303552;11454.026407755267;12384.071194660437;24737.876310618332;25309.746902531107;25361.74638253631;25363.365915851882;25400.745992540207;7445.813854653568;8153.592320384076;8193.385496087818;8212.917870821335;8491.575421229038;4383.452068491439;4469.530699276529;4523.117991991596;4597.471290801601;4735.076660051257;3125.5936728225183;3719.423489359154;3725.5343082114737;3725.7391982561503;3728.813559322023;645.8320836582523;647.1134545672459;665.3147258323934;685.3900028974217;686.9347411995852;684.3327755438507;693.4521727835055;694.7498900395854;722.0144502753808;734;9235.353525253167;10434.791304173874;10714.839277410845;10756.300840445347;11184.888151118548;662.8806814773387;699.8810202265627;719.1585844561876;725.2063857899282;756.4704706705219;5027.245913113063;5120.155174396183;5135.178371460623;5135.229715542699;5142.6400151989;89213.10786892047;91135.54432227796;106466;110736;111412;91059.08940910506;92053;92313;93221.60167597356;93577.89069277482;73144.63427682934;76316.23683763202;77168.61415692998;78461;79918.60040699875;9822.656207033006;9920.75198120024;9960.053794889474;9973.30186886911;9977.10206081456;52076.47923520716;54864.45135548594;55025.72487137539;55606.44393556013;56156.71921640365;74395.88406173803;74428;74540.62729686317;75758;77552.79577633663;12090.274583525017;12264.632061038183;12282.815757763461;12595.433205505591;12854.742905142031;12211.572594959489;12427.378631068592;12453.128281020605;12743.490260389852;12928.353582321035;12072.3360215189;12194.57318993831;12659.620211393672;12789.232646041268;12950.870491294967;12153.878461215629;12175.634730958085;12194.57318993831;12378.546637096868;13046.478140874258;11888.940555297168;11967.222130561486;12064.819027714415;12175.817362739388;12512.874871251171;9708.85436718464;10045.397276163454;10508.579656813641;10782.092584385944;10787.603779700254;9504.954455009805;10424.061834434937;11205.43972801373;11420.942895285803;11830.935215830272 05:45:17 INFO - PROCESS | 2306 | __end_tp_report 05:45:17 INFO - PROCESS | 2306 | __start_cc_report 05:45:17 INFO - PROCESS | 2306 | _x_x_mozilla_cycle_collect,1325 05:45:17 INFO - PROCESS | 2306 | __end_cc_report 05:45:17 INFO - PROCESS | 2306 | __startTimestamp1490273117680__endTimestamp 05:45:17 INFO - PROCESS | 2306 | 05:45:17 INFO - PROCESS | 2306 | ------- Summary: start ------- 05:45:17 INFO - PROCESS | 2306 | Number of tests: 6 05:45:17 INFO - PROCESS | 2306 | 05:45:17 INFO - PROCESS | 2306 | [#0] dojo.html Cycles:165 Average:5914.44 Median:6190.94 stddev:630.47 (10.2%) stddev-sans-first:601.74 05:45:17 INFO - PROCESS | 2306 | Values: 3438.4 3439.3 3448.7 3474.0 3503.0 5908.6 5919.0 5940.0 5946.3 5966.5 5942.2 6007.4 6015.2 6016.8 6030.0 5343.1 5357.7 5390.6 5457.4 5522.1 5316.9 5319.8 5327.7 5343.2 5463.3 5452.1 5456.6 5458.5 5474.5 5506.9 5455.4 5456.0 5467.9 5471.2 5482.1 5241.2 5333.7 5381.5 5399.9 5454.6 5771.6 5818.8 5875.4 5878.4 5880.4 6241.0 6247.1 6283.9 6299.0 6317.5 6289.4 6322.1 6328.3 6336.6 6355.7 5985.8 6043.6 6056.2 6091.8 6096.7 6274.6 6336.6 6372.4 6423.1 6435.9 6328.1 6342.7 6348.3 6365.1 6368.5 6309.5 6355.3 6360.9 6392.0 6396.0 6219.6 6250.1 6255.4 6259.0 6277.8 6252.0 6270.0 6270.7 6280.5 6284.8 5104.2 5104.8 5115.3 5117.2 5142.8 4467.4 4506.0 4541.4 4569.8 4594.2 6058.2 6125.4 6137.7 6141.0 6158.6 6331.1 6394.9 6397.0 6405.1 6418.6 5498.2 5864.1 5864.4 6117.7 6138.8 5509.5 5556.7 5577.9 5590.6 5591.4 6304.1 6434.3 6437.2 6440.2 6446.8 6249.1 6255.3 6277.4 6283.4 6293.9 6463.5 6464.2 6469.4 6482.1 6485.9 6152.3 6284.5 6305.2 6314.2 6317.4 6190.9 6214.2 6242.1 6276.2 6348.4 6301.1 6320.2 6324.9 6334.6 6336.0 6298.5 6298.5 6302.3 6310.6 6319.6 6101.3 6118.8 6141.6 6187.7 6190.0 6294.0 6301.9 6314.4 6315.9 6323.4 6059.6 6201.2 6241.2 6246.0 6249.7 05:45:17 INFO - PROCESS | 2306 | 05:45:17 INFO - PROCESS | 2306 | [#1] ext.html Cycles:180 Average:75280.46 Median:39308.11 stddev:165620.15 (421.3%) stddev-sans-first:165989.50 05:45:17 INFO - PROCESS | 2306 | Values: 468.3 485.9 507.7 547.5 558.5 32797.7 38365.8 42393.4 44438.6 44763.6 46826.0 47249.8 47299.8 47335.3 47380.0 9598.7 9780.4 9806.7 9815.4 9827.8 8863.6 9109.5 9126.6 9179.1 11785.7 11879.9 12007.2 12012.8 12017.6 12077.8 11862.0 11930.1 11938.3 11939.5 11948.2 11797.4 11881.4 11882.7 11884.5 11917.5 43446.6 43694.3 43700.0 43776.0 43798.6 4031.3 4055.0 4065.9 4081.7 4099.7 29783.1 31419.7 31827.7 31949.5 32181.4 3027.9 3180.8 3319.7 3405.4 3406.2 527515.0 529997.0 532100.0 532225.0 533255.0 60252.7 60744.0 60854.4 60878.4 60907.4 65566.7 65587.0 65634.0 65672.0 65756.7 17006.4 17326.0 17363.5 17371.0 17390.9 13208.3 13295.6 13306.7 13308.8 13330.7 16799.6 17101.0 17213.3 17289.4 19146.6 7106.5 7942.3 8397.0 8881.0 8903.0 799.3 859.4 888.5 894.1 898.3 30449.2 31170.5 31493.8 31906.4 32261.5 1058.5 1074.8 1078.7 1119.0 1121.2 12954.8 16392.8 16587.3 16618.0 16915.6 690038.0 693853.0 695177.0 697419.5 697570.0 55652.7 57283.0 64622.4 65779.0 66265.0 1465.7 1497.4 1501.4 1508.6 1511.8 31305.8 32818.3 32964.3 33087.0 33649.8 56091.7 56720.0 56796.7 56803.0 56816.4 585122.0 595296.0 636052.0 642913.0 644574.0 27444.5 27614.9 27733.0 27753.4 27757.9 46960.8 48122.8 48866.0 49782.0 49850.3 38152.2 39290.8 40765.6 41534.8 41645.2 38085.4 39186.6 39644.4 40071.6 40229.5 38214.7 38901.4 39246.8 39249.8 39325.4 30337.2 32886.5 34907.5 35405.8 36004.0 20021.7 21447.1 25499.7 25742.5 25933.9 05:45:17 INFO - PROCESS | 2306 | 05:45:17 INFO - PROCESS | 2306 | [#2] jquery.html Cycles:180 Average:44606.41 Median:22348.89 stddev:133804.43 (598.7%) stddev-sans-first:134138.54 05:45:17 INFO - PROCESS | 2306 | Values: 358.8 390.6 399.9 402.5 433.7 19021.4 20989.6 21464.8 22279.7 22354.4 19926.6 20070.0 21339.8 21542.0 21678.8 5929.8 6231.8 6255.2 6268.6 6272.3 6104.8 6179.7 6234.8 7564.3 7893.9 7819.3 7927.8 7945.1 8053.8 8108.3 7981.9 8039.0 8060.0 8072.3 8097.7 7573.8 7779.7 7915.7 7954.4 7956.0 30251.0 31562.8 31754.2 32213.4 32658.7 2805.6 2878.5 2895.6 2930.4 3325.8 16892.2 17205.1 17564.7 18326.9 18612.2 1916.2 2013.4 2026.2 2026.5 2133.5 81941.0 112442.0 115243.0 127651.0 159576.0 20655.6 22343.3 23361.4 24525.1 24850.9 42366.8 42477.4 43379.6 43800.1 43917.6 10109.8 11369.2 11500.9 11771.9 11967.0 9366.5 9383.8 9456.0 9470.7 9608.2 9380.4 11172.0 11180.8 11262.2 11384.4 4096.8 4120.5 4171.4 4171.9 4189.0 1038.9 1063.3 1066.1 1074.6 1112.7 21562.9 21817.7 21905.7 21960.5 21997.8 1083.9 1093.9 1097.9 1102.3 1117.5 10210.7 10594.6 11508.0 11538.9 11723.5 780282.1 806243.0 812380.0 821933.0 822941.9 145913.0 151639.0 153858.2 154246.2 156336.0 1018.4 1100.5 1101.0 1107.3 1165.6 19709.6 20121.0 20375.4 20899.0 20960.8 62365.0 64221.0 65521.0 66134.7 66280.3 90302.0 92836.1 94417.5 95318.0 97264.5 7740.7 8349.9 8421.6 8426.4 8620.1 11342.1 12803.9 12887.6 12889.9 13370.9 9317.8 11043.8 11504.8 11653.9 11707.9 11238.5 11251.9 11299.8 11306.8 11638.5 11418.7 11518.8 11603.3 11632.4 11942.3 8308.6 8315.8 8346.7 8621.4 8648.3 8328.7 9676.9 11116.6 11139.1 11526.9 05:45:17 INFO - PROCESS | 2306 | 05:45:17 INFO - PROCESS | 2306 | [#3] mootools.html Cycles:180 Average:5518.51 Median:5227.83 stddev:2971.96 (56.8%) stddev-sans-first:2963.40 05:45:17 INFO - PROCESS | 2306 | Values: 1301.6 1376.1 1475.0 1505.4 1507.3 7607.9 7983.0 8234.7 8416.0 8417.7 8322.0 8400.3 8425.7 8433.2 8434.3 2355.9 2400.0 2400.5 2403.7 2404.0 2131.5 2207.5 2208.1 2210.2 2213.2 2321.2 2408.0 2409.1 2413.1 2414.2 2364.5 2387.5 2403.7 2405.9 2410.0 1937.0 2369.8 2380.4 2427.2 2428.5 8529.9 8574.0 8576.9 8596.8 8603.1 5097.4 5260.0 5260.1 5261.7 5266.0 3478.6 3481.0 3514.8 3545.4 3565.3 1244.9 1249.3 1253.0 1301.1 1301.6 11046.9 11062.6 11075.2 11089.6 11090.4 4006.6 4119.6 4735.8 4816.6 4816.9 8312.5 9587.0 9638.2 9638.2 9649.5 5369.8 5383.2 5387.9 5392.7 5409.6 4681.7 4840.8 4899.8 4965.8 4975.3 3761.3 3859.0 3986.9 4001.9 4088.4 1305.0 1305.6 1308.1 1313.8 1323.1 806.8 821.3 825.4 832.0 837.7 5633.2 5745.9 5889.4 5910.3 6070.9 917.5 989.0 1005.9 1008.7 1019.6 3794.2 3888.8 3908.2 3955.3 4005.5 8376.9 10170.7 10176.3 10193.8 10202.4 10041.9 10089.8 10106.6 10112.4 10125.6 7521.4 7861.4 7880.9 7931.1 8020.3 5815.5 5868.8 5925.5 5933.1 6045.6 9068.3 9329.4 9342.6 9430.5 9444.4 7746.9 9214.4 9557.8 9575.9 9586.5 7084.2 7297.2 7322.7 7361.3 7426.1 7375.9 7629.2 7848.6 8093.7 8178.8 7222.9 7281.0 7299.9 7307.7 7321.5 6532.2 6946.8 7113.7 7136.5 7225.3 6489.9 6547.2 6605.3 6607.2 6608.5 4975.5 5105.7 5125.3 5183.6 5250.8 5054.4 5055.5 5167.3 5204.8 5322.1 05:45:17 INFO - PROCESS | 2306 | 05:45:17 INFO - PROCESS | 2306 | [#4] prototype.html Cycles:180 Average:4532.61 Median:5040.06 stddev:1393.59 (27.7%) stddev-sans-first:1361.80 05:45:17 INFO - PROCESS | 2306 | Values: 356.7 364.3 370.8 383.4 384.8 4931.8 5349.2 5387.4 5433.6 5459.2 4526.6 5034.6 5164.5 5196.6 5304.6 4159.4 4186.8 4199.8 4247.4 4290.7 3420.2 3672.8 4200.2 4209.5 4225.3 4065.7 4142.9 4175.0 4199.7 4207.3 3322.0 3538.0 4161.6 4182.4 4235.4 3128.5 3394.7 3699.9 3709.1 3740.3 4983.3 5255.1 5274.7 5284.5 5287.5 4538.3 4612.4 4670.6 4792.9 4832.4 4635.6 5507.1 5587.9 5589.4 5604.8 4087.6 4089.9 4090.3 4094.4 4116.0 4951.9 5394.0 5507.9 5589.1 5622.4 3524.7 3827.8 3947.6 3947.9 3954.7 3625.9 3886.9 4003.3 4005.3 4036.7 3977.8 4334.5 4341.5 4577.8 4587.5 5429.8 5693.0 5700.1 5724.6 5724.7 1292.6 1293.3 1293.4 1309.8 1312.5 768.2 816.8 849.3 860.7 871.3 4969.5 5045.5 5048.3 5072.3 5075.6 4774.6 5062.6 5486.5 5681.6 5683.8 4132.6 4430.9 4491.4 4592.7 4767.4 2311.9 2334.1 2644.5 2868.9 2901.5 5027.9 5172.4 5266.7 5706.1 5843.5 5522.9 5586.0 5645.4 5660.8 5954.6 5100.6 6125.3 6135.0 6145.4 6151.9 5061.8 5502.5 5925.3 5962.6 5990.7 4872.5 5794.8 5812.7 5824.2 5824.7 4960.5 6137.4 6159.9 6165.5 6167.5 3267.7 3853.4 3875.7 3940.2 3944.7 5382.5 5783.0 5812.9 5823.6 5836.8 4847.6 4855.5 5727.9 5744.8 5752.8 5266.3 5476.4 5550.7 5651.9 5686.0 4750.8 5093.3 5367.1 5398.6 5571.3 4710.9 4995.5 5241.9 5393.7 5674.3 5110.9 5218.6 5587.6 5598.0 5611.6 05:45:17 INFO - PROCESS | 2306 | 05:45:17 INFO - PROCESS | 2306 | [#5] yui.html Cycles:180 Average:20959.75 Median:4426.49 stddev:30094.20 (679.9%) stddev-sans-first:30140.38 05:45:17 INFO - PROCESS | 2306 | Values: 755.2 759.3 803.1 862.8 867.4 15975.7 16046.7 16082.8 16140.5 16301.9 14720.0 14829.3 14836.4 14846.6 14851.7 717.3 739.2 873.8 899.7 919.1 906.2 910.7 911.4 911.5 912.9 961.9 976.3 978.7 979.2 983.2 969.6 973.4 975.7 977.0 979.1 731.9 732.0 732.7 732.9 738.1 14646.6 14736.5 16036.8 16245.4 16434.3 14996.2 15229.0 15456.0 15546.6 15582.8 10979.7 11668.5 11716.8 11988.8 12054.9 3867.2 3893.2 3912.7 4045.9 4055.8 101456.0 106528.0 107453.0 107758.5 110710.9 10438.6 11088.3 11321.4 11454.0 12384.1 24737.9 25309.7 25361.7 25363.4 25400.7 7445.8 8153.6 8193.4 8212.9 8491.6 4383.5 4469.5 4523.1 4597.5 4735.1 3125.6 3719.4 3725.5 3725.7 3728.8 645.8 647.1 665.3 685.4 686.9 684.3 693.5 694.7 722.0 734.0 9235.4 10434.8 10714.8 10756.3 11184.9 662.9 699.9 719.2 725.2 756.5 5027.2 5120.2 5135.2 5135.2 5142.6 89213.1 91135.5 106466.0 110736.0 111412.0 91059.1 92053.0 92313.0 93221.6 93577.9 73144.6 76316.2 77168.6 78461.0 79918.6 9822.7 9920.8 9960.1 9973.3 9977.1 52076.5 54864.5 55025.7 55606.4 56156.7 74395.9 74428.0 74540.6 75758.0 77552.8 12090.3 12264.6 12282.8 12595.4 12854.7 12211.6 12427.4 12453.1 12743.5 12928.4 12072.3 12194.6 12659.6 12789.2 12950.9 12153.9 12175.6 12194.6 12378.5 13046.5 11888.9 11967.2 12064.8 12175.8 12512.9 9708.9 10045.4 10508.6 10782.1 10787.6 9505.0 10424.1 11205.4 11420.9 11830.9 05:45:17 INFO - PROCESS | 2306 | -------- Summary: end -------- 05:45:17 INFO - PROCESS | 2306 | 05:45:18 INFO - TEST-INFO | 2306: exit 0 05:45:18 INFO - TEST-OK | dromaeo_css | took 1116982ms 05:45:18 INFO - TEST-START | kraken 05:45:18 INFO - operating with platform_type : mac_ 05:45:18 INFO - Initialising browser for kraken test... 05:45:18 INFO - TEST-INFO | started process 2310 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/tmpt1Io7J/profile http://localhost:50082/getInfo.html) 05:45:20 INFO - PROCESS | 2310 | __metrics Screen width/height:1600/1200 05:45:20 INFO - PROCESS | 2310 | colorDepth:24 05:45:20 INFO - PROCESS | 2310 | Browser inner width/height: 1024/689 05:45:20 INFO - PROCESS | 2310 | __metrics 05:45:20 INFO - PROCESS | 2310 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:45:20 INFO - PROCESS | 2310 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:45:21 INFO - TEST-INFO | 2310: exit 0 05:45:21 INFO - Browser initialized. 05:45:21 INFO - Running cycle 1/1 for kraken test... 05:45:21 INFO - TEST-INFO | started process 2312 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/tmpt1Io7J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:45:33 INFO - PROCESS | 2312 | RSS: Main: 167653376 05:45:33 INFO - PROCESS | 2312 | 05:45:35 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:50082/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50082/tests/kraken/driver.html?testName=audio-beat-detection) 05:45:36 INFO - PROCESS | 2312 | RSS: Main: 215625728 05:45:36 INFO - PROCESS | 2312 | 05:45:39 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:50082/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50082/tests/kraken/driver.html?testName=audio-dft) 05:45:40 INFO - PROCESS | 2312 | RSS: Main: 231182336 05:45:40 INFO - PROCESS | 2312 | 05:45:43 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:50082/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50082/tests/kraken/driver.html?testName=audio-fft) 05:45:43 INFO - PROCESS | 2312 | RSS: Main: 327819264 05:45:43 INFO - PROCESS | 2312 | 05:45:45 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:50082/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50082/tests/kraken/driver.html?testName=audio-oscillator) 05:45:46 INFO - PROCESS | 2312 | RSS: Main: 228794368 05:45:46 INFO - PROCESS | 2312 | 05:45:48 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:50082/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50082/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:45:49 INFO - PROCESS | 2312 | RSS: Main: 229138432 05:45:49 INFO - PROCESS | 2312 | 05:45:51 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:50082/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50082/tests/kraken/driver.html?testName=imaging-darkroom) 05:45:52 INFO - PROCESS | 2312 | RSS: Main: 267821056 05:45:52 INFO - PROCESS | 2312 | 05:45:55 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:50082/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50082/tests/kraken/driver.html?testName=imaging-desaturate) 05:45:56 INFO - PROCESS | 2312 | RSS: Main: 269201408 05:45:56 INFO - PROCESS | 2312 | 05:45:58 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:50082/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50082/tests/kraken/driver.html?testName=json-parse-financial) 05:45:59 INFO - PROCESS | 2312 | RSS: Main: 268161024 05:45:59 INFO - PROCESS | 2312 | 05:46:01 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:50082/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50082/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:46:01 INFO - PROCESS | 2312 | RSS: Main: 246956032 05:46:01 INFO - PROCESS | 2312 | 05:46:03 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:50082/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50082/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:46:04 INFO - PROCESS | 2312 | RSS: Main: 249053184 05:46:04 INFO - PROCESS | 2312 | 05:46:06 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:50082/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50082/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:46:06 INFO - PROCESS | 2312 | RSS: Main: 257875968 05:46:06 INFO - PROCESS | 2312 | 05:46:09 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:50082/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50082/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:46:10 INFO - PROCESS | 2312 | RSS: Main: 271147008 05:46:10 INFO - PROCESS | 2312 | 05:46:13 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:50082/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50082/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:46:13 INFO - PROCESS | 2312 | RSS: Main: 265461760 05:46:13 INFO - PROCESS | 2312 | 05:46:15 INFO - PROCESS | 2312 | Cycle 1(1): loaded http://localhost:50082/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50082/tests/kraken/driver.html?testName=ai-astar) 05:46:15 INFO - PROCESS | 2312 | RSS: Main: 309796864 05:46:15 INFO - PROCESS | 2312 | 05:46:15 INFO - PROCESS | 2312 | __start_tp_report 05:46:15 INFO - PROCESS | 2312 | _x_x_mozilla_page_load 05:46:15 INFO - PROCESS | 2312 | _x_x_mozilla_page_load_details 05:46:15 INFO - PROCESS | 2312 | |i|pagename|runs| 05:46:15 INFO - PROCESS | 2312 | |0;ai-astar;112;114;114;112;112;113;112;113;113;113 05:46:15 INFO - PROCESS | 2312 | |1;audio-beat-detection;142;109;112;174;139;107;108;108;125;108 05:46:15 INFO - PROCESS | 2312 | |2;audio-dft;184;186;184;186;183;183;183;187;184;182 05:46:15 INFO - PROCESS | 2312 | |3;audio-fft;81;58;58;89;61;59;58;59;73;57 05:46:15 INFO - PROCESS | 2312 | |4;audio-oscillator;84;70;86;70;67;68;101;95;53;101 05:46:15 INFO - PROCESS | 2312 | |5;imaging-gaussian-blur;87;87;90;84;87;82;87;85;90;129 05:46:15 INFO - PROCESS | 2312 | |6;imaging-darkroom;92;93;92;93;101;92;93;91;147;147 05:46:15 INFO - PROCESS | 2312 | |7;imaging-desaturate;85;85;87;86;84;86;86;88;86;84 05:46:15 INFO - PROCESS | 2312 | |8;json-parse-financial;53;49;51;55;54;56;55;55;54;56 05:46:15 INFO - PROCESS | 2312 | |9;json-stringify-tinderbox;64;74;79;73;71;70;68;69;68;67 05:46:15 INFO - PROCESS | 2312 | |10;stanford-crypto-aes;76;83;81;83;83;80;87;87;81;86 05:46:15 INFO - PROCESS | 2312 | |11;stanford-crypto-ccm;133;130;132;133;129;131;132;137;172;142 05:46:15 INFO - PROCESS | 2312 | |12;stanford-crypto-pbkdf2;162;164;160;161;162;164;162;161;158;163 05:46:15 INFO - PROCESS | 2312 | |13;stanford-crypto-sha256-iterative;65;65;64;65;64;64;63;65;62;63 05:46:15 INFO - PROCESS | 2312 | __end_tp_report 05:46:15 INFO - PROCESS | 2312 | __start_cc_report 05:46:15 INFO - PROCESS | 2312 | _x_x_mozilla_cycle_collect,2069 05:46:15 INFO - PROCESS | 2312 | __end_cc_report 05:46:15 INFO - PROCESS | 2312 | __startTimestamp1490273175700__endTimestamp 05:46:15 INFO - PROCESS | 2312 | 05:46:15 INFO - PROCESS | 2312 | ------- Summary: start ------- 05:46:15 INFO - PROCESS | 2312 | Number of tests: 14 05:46:15 INFO - PROCESS | 2312 | 05:46:15 INFO - PROCESS | 2312 | [#0] ai-astar Cycles:10 Average:112.80 Median:113.00 stddev:0.79 (0.7%) stddev-sans-first:0.78 05:46:15 INFO - PROCESS | 2312 | Values: 112.0 114.0 114.0 112.0 112.0 113.0 112.0 113.0 113.0 113.0 05:46:15 INFO - PROCESS | 2312 | 05:46:15 INFO - PROCESS | 2312 | [#1] audio-beat-detection Cycles:10 Average:123.20 Median:118.50 stddev:22.29 (18.8%) stddev-sans-first:22.57 05:46:15 INFO - PROCESS | 2312 | Values: 142.0 109.0 112.0 174.0 139.0 107.0 108.0 108.0 125.0 108.0 05:46:15 INFO - PROCESS | 2312 | 05:46:15 INFO - PROCESS | 2312 | [#2] audio-dft Cycles:10 Average:184.20 Median:184.00 stddev:1.62 (0.9%) stddev-sans-first:1.72 05:46:15 INFO - PROCESS | 2312 | Values: 184.0 186.0 184.0 186.0 183.0 183.0 183.0 187.0 184.0 182.0 05:46:15 INFO - PROCESS | 2312 | 05:46:15 INFO - PROCESS | 2312 | [#3] audio-fft Cycles:10 Average:65.30 Median:60.00 stddev:11.52 (19.2%) stddev-sans-first:10.73 05:46:15 INFO - PROCESS | 2312 | Values: 81.0 58.0 58.0 89.0 61.0 59.0 58.0 59.0 73.0 57.0 05:46:15 INFO - PROCESS | 2312 | 05:46:15 INFO - PROCESS | 2312 | [#4] audio-oscillator Cycles:10 Average:79.50 Median:70.00 stddev:16.32 (23.3%) stddev-sans-first:17.23 05:46:15 INFO - PROCESS | 2312 | Values: 84.0 70.0 86.0 70.0 67.0 68.0 101.0 95.0 53.0 101.0 05:46:15 INFO - PROCESS | 2312 | 05:46:15 INFO - PROCESS | 2312 | [#5] imaging-gaussian-blur Cycles:10 Average:90.80 Median:87.00 stddev:13.64 (15.7%) stddev-sans-first:14.40 05:46:15 INFO - PROCESS | 2312 | Values: 87.0 87.0 90.0 84.0 87.0 82.0 87.0 85.0 90.0 129.0 05:46:15 INFO - PROCESS | 2312 | 05:46:15 INFO - PROCESS | 2312 | [#6] imaging-darkroom Cycles:10 Average:104.10 Median:92.00 stddev:22.78 (24.8%) stddev-sans-first:23.74 05:46:15 INFO - PROCESS | 2312 | Values: 92.0 93.0 92.0 93.0 101.0 92.0 93.0 91.0 147.0 147.0 05:46:15 INFO - PROCESS | 2312 | 05:46:15 INFO - PROCESS | 2312 | [#7] imaging-desaturate Cycles:10 Average:85.70 Median:86.00 stddev:1.25 (1.5%) stddev-sans-first:1.30 05:46:15 INFO - PROCESS | 2312 | Values: 85.0 85.0 87.0 86.0 84.0 86.0 86.0 88.0 86.0 84.0 05:46:15 INFO - PROCESS | 2312 | 05:46:15 INFO - PROCESS | 2312 | [#8] json-parse-financial Cycles:10 Average:53.80 Median:55.00 stddev:2.25 (4.1%) stddev-sans-first:2.37 05:46:15 INFO - PROCESS | 2312 | Values: 53.0 49.0 51.0 55.0 54.0 56.0 55.0 55.0 54.0 56.0 05:46:15 INFO - PROCESS | 2312 | 05:46:15 INFO - PROCESS | 2312 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:70.50 stddev:4.22 (6.0%) stddev-sans-first:3.81 05:46:15 INFO - PROCESS | 2312 | Values: 64.0 74.0 79.0 73.0 71.0 70.0 68.0 69.0 68.0 67.0 05:46:15 INFO - PROCESS | 2312 | 05:46:15 INFO - PROCESS | 2312 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:3.43 (4.1%) stddev-sans-first:2.65 05:46:15 INFO - PROCESS | 2312 | Values: 76.0 83.0 81.0 83.0 83.0 80.0 87.0 87.0 81.0 86.0 05:46:15 INFO - PROCESS | 2312 | 05:46:15 INFO - PROCESS | 2312 | [#11] stanford-crypto-ccm Cycles:10 Average:137.10 Median:133.00 stddev:12.83 (9.6%) stddev-sans-first:13.52 05:46:15 INFO - PROCESS | 2312 | Values: 133.0 130.0 132.0 133.0 129.0 131.0 132.0 137.0 172.0 142.0 05:46:15 INFO - PROCESS | 2312 | 05:46:15 INFO - PROCESS | 2312 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.70 Median:162.00 stddev:1.83 (1.1%) stddev-sans-first:1.94 05:46:15 INFO - PROCESS | 2312 | Values: 162.0 164.0 160.0 161.0 162.0 164.0 162.0 161.0 158.0 163.0 05:46:15 INFO - PROCESS | 2312 | 05:46:15 INFO - PROCESS | 2312 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.00 Median:64.50 stddev:1.05 (1.6%) stddev-sans-first:1.05 05:46:15 INFO - PROCESS | 2312 | Values: 65.0 65.0 64.0 65.0 64.0 64.0 63.0 65.0 62.0 63.0 05:46:15 INFO - PROCESS | 2312 | -------- Summary: end -------- 05:46:15 INFO - PROCESS | 2312 | 05:46:16 INFO - TEST-INFO | 2312: exit 0 05:46:16 INFO - TEST-OK | kraken | took 58161ms 05:46:16 INFO - SUITE-END | took 1175s 05:46:16 INFO - Completed test suite (00:19:35) 05:46:16 INFO - javascript benchmark 05:46:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3438.4154693702067, 3439.3121375724854, 3448.6896179343853, 3473.9652603473955, 3502.9649703502955, 5908.615939963899, 5918.970405147968, 5939.970300148504, 5946.286445626525, 5966.46301832835, 5942.168096466498, 6007.429294217042, 6015.157877897098, 6016.789412370568, 6029.969850150754, 5343.118385466393, 5357.651752636066, 5390.568754499631, 5457.399686034533, 5522.144067669517, 5316.9202461963105, 5319.760610772505, 5327.706976116312, 5343.1985202219785, 5463.262459567947, 5452.100403433429, 5456.563474922016, 5458.5087342139195, 5474.507294343508, 5506.862328441781, 5455.372632147314, 5456.0, 5467.890642187134, 5471.23402723619, 5482.122860342366, 5241.187615919539, 5333.706646134461, 5381.461853814626, 5399.892002159974, 5454.645448045904, 5771.595988280822, 5818.8254352369495, 5875.41245875409, 5878.353381128072, 5880.411958804086, 6240.968795156041, 6247.125402443661, 6283.874322513524, 6298.968505157445, 6317.526185536103, 6289.433950944392, 6322.146510221153, 6328.272248691414, 6336.556441049129, 6355.713992870285, 5985.790497332572, 6043.607165534227, 6056.15213870063, 6091.786787462417, 6096.664683442365, 6274.560780745304, 6336.556441049082, 6372.36276372359, 6423.100765892778, 6435.871282574322, 6328.082428047907, 6342.746290148435, 6348.301686814447, 6365.108884756138, 6368.490520758328, 6309.463695585835, 6355.3009168991375, 6360.9045864312075, 6391.96804015977, 6395.968020159869, 6219.595726277777, 6250.093736408196, 6255.374462553799, 6258.968705156445, 6277.780277690259, 6251.9687401562705, 6270.0, 6270.749170033238, 6280.497560195174, 6284.842878928063, 5104.234364845229, 5104.821331253388, 5115.258287548285, 5117.232415137759, 5142.845714628567, 4467.441569803775, 4505.986153115588, 4541.364209010741, 4569.840055598104, 4594.19601569724, 6058.242719660043, 6125.387461253928, 6137.662428566472, 6141.017437210025, 6158.568900176944, 6331.0819931110655, 6394.904076438857, 6397.0, 6405.135306733531, 6418.550701450947, 5498.202760599691, 5864.09106588471, 5864.44287792659, 6117.694115294217, 6138.754449821957, 5509.531689806411, 5556.666600003932, 5577.9163312550345, 5590.552755779528, 5591.440855914376, 6304.117423560797, 6434.292227854932, 6437.163168788027, 6440.194975628046, 6446.774362897276, 6249.093881387083, 6255.343188965093, 6277.403646653561, 6283.434490895841, 6293.874122517615, 6463.547551671526, 6464.159659244268, 6469.417752402306, 6482.060101285381, 6485.935140648722, 6152.261728592597, 6284.465820405317, 6305.180326557518, 6314.242290925118, 6317.368263173646, 6190.938090619036, 6214.223222097238, 6242.1261023455845, 6276.215473065867, 6348.396902294275, 6301.054841773771, 6320.241571011508, 6324.873502530016, 6334.556581039283, 6336.0, 6298.464630506458, 6298.496120310272, 6302.275238347649, 6310.5898116622275, 6319.557630965788, 6101.267847858286, 6118.80192544137, 6141.608749743955, 6187.690615469299, 6190.0, 6294.0, 6301.936980630318, 6314.368563143833, 6315.936840631535, 6323.430891219812, 6059.606125601822, 6201.193844800147, 6241.21984751906, 6246.0, 6249.7187626557825], "value": 5874.2147078525495, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [468.26248658363085, 485.94411642661106, 507.6700144905811, 547.54280176053, 558.4555058817654, 32797.67202327976, 38365.84902452924, 42393.36409953849, 44438.555614443845, 44763.55236447639, 46826.0, 47249.81875453115, 47299.8175045624, 47335.28997065038, 47380.0, 9598.712038638834, 9780.364276322052, 9806.705798826011, 9815.362001469917, 9827.754306142333, 8863.601137948808, 9109.544522773867, 9126.634934602642, 9179.127982841619, 11785.705357366092, 11879.881201187964, 12007.159498835084, 12012.759744805098, 12017.639470815846, 12077.758444831097, 11861.9917307029, 11930.105242106876, 11938.28370297785, 11939.522419103225, 11948.223365481259, 11797.351145686984, 11881.40592970348, 11882.702932426671, 11884.465199065977, 11917.523299068114, 43446.56553434457, 43694.344584831255, 43700.0, 43776.0, 43798.562014379764, 4031.314676504972, 4054.959450405517, 4065.8780236592947, 4081.673466122703, 4099.672026237894, 29783.10650680483, 31419.685803141903, 31827.681723182704, 31949.520757188428, 32181.356372872644, 3027.8940237091597, 3180.761442891769, 3319.668033196685, 3405.3700065487715, 3406.233597440556, 527515.0, 529997.0, 532100.0, 532225.0, 533255.0, 60252.698736506034, 60744.0, 60854.39145608576, 60878.39121608816, 60907.39092609106, 65566.67216663886, 65587.0, 65634.0, 65672.0, 65756.6712166436, 17006.404775832787, 17326.0, 17363.47909562715, 17371.0, 17390.913045434943, 13208.33958302081, 13295.601131966056, 13306.73386532264, 13308.800367994489, 13330.73338533224, 16799.58001049959, 17101.04028331109, 17213.311467541407, 17289.394871179447, 19146.617067658848, 7106.502544821813, 7942.324902383362, 8396.958015209884, 8880.955595221982, 8902.972989183709, 799.2686691677167, 859.3726579596929, 888.4624801994829, 894.1014280648037, 898.3262553085186, 30449.238769030508, 31170.532442013387, 31493.8425307872, 31906.36187276288, 32261.51607725886, 1058.539535302146, 1074.752806854428, 1078.735709751116, 1118.972025699364, 1121.2319561100671, 12954.80567791484, 16392.75410868838, 16587.253573589216, 16618.00291982485, 16915.577110572332, 690038.0, 693853.0, 695177.0, 697419.5129024322, 697570.0, 55652.72173639106, 57283.0, 64622.353776461634, 65779.0, 66265.0, 1465.7434948884115, 1497.3636204612778, 1501.369424841569, 1508.615303097703, 1511.8110236220693, 31305.8434707825, 32818.34363312768, 32964.34071318608, 33087.0, 33649.83175084109, 56091.71954140203, 56720.0, 56796.716016421306, 56803.0, 56816.431835682764, 585122.0, 595296.0, 636052.0, 642913.0, 644574.0, 27444.45111097727, 27614.861925690242, 27733.0, 27753.44493110086, 27757.889684412396, 46960.7651961738, 48122.79693007703, 48866.0, 49782.0, 49850.25224621561, 38152.236955261294, 39290.80354598209, 40765.592344076176, 41534.79232603818, 41645.16709665729, 38085.4287185698, 39186.60813391829, 39644.40533392059, 40071.599284007956, 40229.51196248806, 38214.67433159588, 38901.41647875341, 39246.803765980985, 39249.80375098106, 39325.41011884767, 30337.24156896007, 32886.506702399005, 34907.47638785471, 35405.82297088498, 36004.0, 20021.6996745046, 21447.078734143015, 25499.74500255048, 25742.485150296514, 25933.870330648228], "value": 21104.893167281487, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.83736693114315, 390.62109753539056, 399.9340108882035, 402.50692901196027, 433.744090986318, 19021.429357119276, 20989.580208395822, 21464.785352146475, 22279.665805012937, 22354.441138971513, 19926.60146797063, 20070.0, 21339.759325270858, 21542.030608622612, 21678.783212167873, 5929.762809487626, 6231.844203894893, 6255.15555400022, 6268.592541484812, 6272.278687950876, 6104.847378815521, 6179.721912513925, 6234.8441288967915, 7564.319211270985, 7893.921060789376, 7819.296263336299, 7927.801804954865, 7945.12603613602, 8053.838923221532, 8108.310793582553, 7981.920180798175, 8039.0, 8060.032796064451, 8072.273495385414, 8097.716579919675, 7573.848523029508, 7779.688812447495, 7915.722949696733, 7954.363650907913, 7956.0, 30251.0, 31562.842185788923, 31754.206144846332, 32213.35573288521, 32658.673413265802, 2805.6072149899032, 2878.53943369062, 2895.6235689360246, 2930.355321829194, 3325.7717329389366, 16892.239849206693, 17205.053722045282, 17564.736528952075, 18326.90836545822, 18612.162452689525, 1916.1568909679697, 2013.4161093283076, 2026.199651137807, 2026.4629873083645, 2133.4986278224605, 81941.0, 112442.0, 115243.0, 127650.99999999907, 159576.0, 20655.58688826215, 22343.32970010902, 23361.41596460068, 24525.141620043214, 24850.875745621157, 42366.78816605897, 42477.362839557434, 43379.56620433818, 43800.12399751987, 43917.560824391345, 10109.848352274721, 11369.204155709022, 11500.88499115015, 11771.941140294244, 11967.0, 9366.484843333683, 9383.765405864908, 9455.952720236492, 9470.715878523655, 9608.222478841437, 9380.437173769596, 11172.0, 11180.826013268652, 11262.155338349656, 11384.37385943781, 4096.795160241976, 4120.484939382577, 4171.436856024458, 4171.893193937103, 4188.979055104766, 1038.8857225705167, 1063.3407287481812, 1066.0831684751108, 1074.5594306334365, 1112.671761830262, 21562.892185539287, 21817.67273490899, 21905.671414928787, 21960.45098872541, 21997.780022199895, 1083.9078678312273, 1093.8577984861918, 1097.91765617579, 1102.3330884814573, 1117.4803716271972, 10210.723659542557, 10594.629187978384, 11507.964283214551, 11538.88461115378, 11723.531058757555, 780282.0985895034, 806243.0, 812380.0, 821933.0, 822941.8852905697, 145913.0, 151639.0, 153858.230708848, 154246.22876885545, 156336.0, 1018.3686114608842, 1100.5377741348652, 1101.0255923507593, 1107.3023994883333, 1165.580391059218, 19709.60580788405, 20121.0, 20375.388738337875, 20899.0, 20960.790392095885, 62365.0, 64221.03668445071, 65521.01718474322, 66134.66932665306, 66280.34299142368, 90302.0, 92836.07163928275, 94417.52791236274, 95318.0, 97264.51367743115, 7740.729074482366, 8349.916500834914, 8421.578921054046, 8426.410151289596, 8620.094890036708, 11342.149338799789, 12803.871961280269, 12887.613371598867, 12889.935550322189, 13370.866291336963, 9317.767055823388, 11043.779124417628, 11504.82742758876, 11653.941730291293, 11707.941460292644, 11238.494267758135, 11251.943740281245, 11299.830502542633, 11306.83039754388, 11638.53445862156, 11418.657440276806, 11518.82721759191, 11603.303801771921, 11632.418379081182, 11942.283462992249, 8308.626111825104, 8315.792105197419, 8346.666133354598, 8621.439606425562, 8648.308135349283, 8328.708495202882, 9676.9032309676, 11116.61091861781, 11139.053180479426, 11526.94236528812], "value": 11865.418191145685, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1301.5639760680172, 1376.098655380726, 1474.9926250368746, 1505.3677455468696, 1507.2689745473447, 7607.885881711779, 7982.960085199573, 8234.711785087517, 8416.0, 8417.747467575982, 8322.0, 8400.285975692073, 8425.747227583168, 8433.156684331563, 8434.283085937703, 2355.9411014724596, 2400.0399840063938, 2400.50789588134, 2403.7476065013184, 2404.038384646138, 2131.5417185305155, 2207.4812419081504, 2208.149862303017, 2210.1932794530044, 2213.170061227032, 2321.1759825262043, 2407.9518409631796, 2409.0725070847675, 2413.095089341497, 2414.1912459326145, 2364.4679947011955, 2387.4747555537756, 2403.663487111806, 2405.9037638494437, 2409.9759002410015, 1937.0314842578712, 2369.845960012594, 2380.4405964598304, 2427.1868923910333, 2428.5021570577987, 8529.914700852974, 8574.0, 8576.914230857736, 8596.78508037304, 8603.139686031409, 5097.388313402415, 5260.0, 5260.079486089919, 5261.710605916673, 5265.973670131663, 3478.565179352581, 3481.0427132538753, 3514.7539672222956, 3545.4327307630656, 3565.2512972275854, 1244.9066320025943, 1249.3378509390038, 1253.0414233111676, 1301.1087405127519, 1301.5704817410233, 11046.889531104747, 11062.612808551743, 11075.16936229778, 11089.611863584736, 11090.445477726082, 4006.6193711597352, 4119.608637179464, 4735.786889589976, 4816.590589799836, 4816.903661926742, 8312.459690120122, 9586.95206523963, 9638.228941684649, 9638.228941684649, 9649.469279189572, 5369.7583608737705, 5383.192521121863, 5387.865303367369, 5392.703401312965, 5409.6213265071065, 4681.742504162304, 4840.782164802592, 4899.755012249445, 4965.826196083192, 4975.253711943165, 3761.3041587306434, 3858.980705096513, 3986.940195897064, 4001.91996160081, 4088.386741988666, 1305.0, 1305.5691621764795, 1308.130093487839, 1313.750387426386, 1323.0672375974914, 806.8023334283138, 821.322409012567, 825.3974598543098, 832.0193575898219, 837.6984285657159, 5633.155026745939, 5745.88508229833, 5889.411058894077, 5910.261217347832, 6070.939290607126, 917.5274733512113, 988.9752756181153, 1005.9497025148713, 1008.6671398438498, 1019.6329321444274, 3794.2032173243374, 3888.844446222176, 3908.1988192420486, 3955.3078211312904, 4005.5193376794386, 8376.916230837736, 10170.745731356776, 10176.338537995007, 10193.796124077477, 10202.38785672862, 10041.949790251001, 10089.848652270222, 10106.646267380607, 10112.393256404492, 10125.59497620087, 7521.398288136936, 7861.371090312761, 7880.921190788134, 7931.127575966639, 8020.278174964281, 5815.534757219497, 5868.765249390148, 5925.496332811759, 5933.05071188625, 6045.6070355426755, 9068.319876009458, 9329.393589416666, 9342.626294948126, 9430.481323526998, 9444.433333999981, 7746.92253077462, 9214.401063930824, 9557.808843823224, 9575.904240957501, 9586.472743999147, 7084.220735718964, 7297.160826504807, 7322.743703970335, 7361.30067643573, 7426.14599321085, 7375.926240737524, 7629.2370762923265, 7848.646810893638, 8093.676252949816, 8178.754637360888, 7222.927770722225, 7280.963595182202, 7299.8540029200185, 7307.707691692272, 7321.487495875451, 6532.248791388861, 6946.756863509753, 7113.679884405111, 7136.536125152056, 7225.277472252733, 6489.870202595827, 6547.247066587213, 6605.339466053356, 6607.174103237096, 6608.5374023819795, 4975.477574854588, 5105.744712764421, 5125.308083408692, 5183.5593974512585, 5250.847390434001, 5054.418741844588, 5055.494450554915, 5167.302414174038, 5204.8178313758835, 5322.068637988259], "value": 4496.827897000446, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.71997481976643, 364.34236203652404, 370.7515964303916, 383.38466760848854, 384.76337052712574, 4931.827386041489, 5349.170878513827, 5387.4343193964605, 5433.565314774818, 5459.208414779854, 4526.6378689704825, 5034.622403319757, 5164.483551644834, 5196.58427325814, 5304.602154838383, 4159.376093585956, 4186.79066046698, 4199.7690127043, 4247.362895565659, 4290.721103128287, 3420.2304481491715, 3672.797996110213, 4200.222958752625, 4209.452771139748, 4225.323948168294, 4065.715399922007, 4142.896427589304, 4175.0397408596045, 4199.68502362324, 4207.326827707568, 3321.9501707474287, 3538.0, 4161.56303588125, 4182.351735481006, 4235.428217190671, 3128.452520808872, 3394.6605339466105, 3699.9260014799825, 3709.069834830481, 3740.3267411865854, 4983.252512123175, 5255.1329030709885, 5274.734063824692, 5284.524392804666, 5287.4976877196605, 4538.319252112176, 4612.446506419251, 4670.579647831678, 4792.880177995578, 4832.395950506187, 4635.629149668019, 5507.0637991541535, 5587.910357480293, 5589.441055894378, 5604.8038318659055, 4087.591240875918, 4089.8568550100604, 4090.2820815257364, 4094.3858421236755, 4116.0, 4951.851444456672, 5394.0, 5507.889842203133, 5589.071770239261, 5622.381538030813, 3524.6827785499427, 3827.8468861245237, 3947.585503522146, 3947.8618248361167, 3954.7429417088374, 3625.927481450356, 3886.9222615547533, 4003.2994226010915, 4005.319095753729, 4036.6770658347264, 3977.7867750336427, 4334.523202447728, 4341.544137865541, 4577.8168873244695, 4587.52273772166, 5429.782808687608, 5693.0, 5700.059490184156, 5724.599278050497, 5724.685142317129, 1292.6057552446407, 1293.2951541409766, 1293.430890408236, 1309.7511472820133, 1312.4618906248584, 768.2125821033374, 816.7753867686433, 849.3035710717276, 860.7288704058202, 871.3203701113142, 4969.453360130383, 5045.495450454925, 5048.268001139814, 5072.340595722606, 5075.56857667095, 4774.594159496482, 5062.594992400599, 5486.506214440719, 5681.602287839894, 5683.801066962719, 4132.628063474242, 4430.933535996963, 4491.371208030879, 4592.7369973256955, 4767.356406885096, 2311.873076769376, 2334.113037045912, 2644.505854192375, 2868.942621147565, 2901.5481917779443, 5027.949720502821, 5172.353455818023, 5266.680652540961, 5706.058500347396, 5843.474087332161, 5522.889542209134, 5586.0, 5645.407232240637, 5660.773569057274, 5954.642721436728, 5100.591952643779, 6125.264968203844, 6135.0, 6145.446909778141, 6151.876962460815, 5061.822836200715, 5502.468864322296, 5925.348211696796, 5962.598789284428, 5990.730417131327, 4872.4640289567415, 5794.754937235161, 5812.709364531672, 5824.165387902797, 5824.650520968756, 4960.544530457447, 6137.355577664281, 6159.907601385893, 6165.5375846810775, 6167.5374346925055, 3267.7059064684295, 3853.3834586466032, 3875.748076375027, 3940.2316548273957, 3944.684425246031, 5382.515573598395, 5783.0, 5812.94187058141, 5823.563232757476, 5836.766529338949, 4847.551986246923, 4855.465898751205, 5727.8854422912145, 5744.798932037359, 5752.842683993503, 5266.289050978069, 5476.3702174250475, 5550.722463876709, 5651.858703532444, 5686.0, 4750.762461876823, 5093.286939828353, 5367.114426119647, 5398.627112039261, 5571.275734154534, 4710.905781884411, 4995.5004499551205, 5241.925405291982, 5393.6763794172475, 5674.269347848781, 5110.872228194325, 5218.608604354613, 5587.636803607753, 5597.972010139923, 5611.579131565068], "value": 4100.3131073826335, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.2372104174783, 759.2900637903557, 803.0925054688201, 862.8274345130972, 867.3798234262501, 15975.680486390265, 16046.679066418665, 16082.83917160828, 16140.515784526468, 16301.918490407546, 14720.0, 14829.258537073158, 14836.406543738238, 14846.628834279149, 14851.702965940674, 717.2755516927914, 739.1647438394607, 873.7990262239689, 899.6671231644301, 919.1497864475367, 906.1663269791808, 910.7176775199677, 911.3666002128523, 911.5077857956728, 912.8904531456235, 961.8509131084693, 976.3458482816494, 978.7455261631956, 979.1872745621117, 983.1741337276686, 969.5685419988108, 973.3770386952356, 975.7024107647201, 977.008336538414, 979.109010800172, 731.9194888562254, 732.0044739154745, 732.7032551816523, 732.9193788683241, 738.0626604212673, 14646.633834154125, 14736.48422305214, 16036.75944860828, 16245.431409900597, 16434.26045827929, 14996.175210363426, 15229.0, 15456.0, 15546.61133471661, 15582.844171558252, 10979.725506862313, 11668.474918628597, 11716.824247636292, 11988.820167697491, 12054.879451205552, 3867.168558759852, 3893.1824316893485, 3912.726109172359, 4045.939310910339, 4055.797210139481, 101456.0, 106528.0, 107453.0, 107758.46120769424, 110710.89289107086, 10438.582456701799, 11088.279261847954, 11321.433928303552, 11454.026407755267, 12384.071194660437, 24737.876310618332, 25309.746902531107, 25361.74638253631, 25363.365915851882, 25400.745992540207, 7445.813854653568, 8153.592320384076, 8193.385496087818, 8212.917870821335, 8491.575421229038, 4383.452068491439, 4469.530699276529, 4523.117991991596, 4597.471290801601, 4735.076660051257, 3125.5936728225183, 3719.423489359154, 3725.5343082114737, 3725.7391982561503, 3728.813559322023, 645.8320836582523, 647.1134545672459, 665.3147258323934, 685.3900028974217, 686.9347411995852, 684.3327755438507, 693.4521727835055, 694.7498900395854, 722.0144502753808, 734.0, 9235.353525253167, 10434.791304173874, 10714.839277410845, 10756.300840445347, 11184.888151118548, 662.8806814773387, 699.8810202265627, 719.1585844561876, 725.2063857899282, 756.4704706705219, 5027.245913113063, 5120.155174396183, 5135.178371460623, 5135.229715542699, 5142.6400151989, 89213.10786892047, 91135.54432227796, 106466.0, 110736.0, 111412.0, 91059.08940910506, 92053.0, 92313.0, 93221.60167597356, 93577.89069277482, 73144.63427682934, 76316.23683763202, 77168.61415692998, 78461.0, 79918.60040699875, 9822.656207033006, 9920.75198120024, 9960.053794889474, 9973.30186886911, 9977.10206081456, 52076.47923520716, 54864.45135548594, 55025.72487137539, 55606.44393556013, 56156.71921640365, 74395.88406173803, 74428.0, 74540.62729686317, 75758.0, 77552.79577633663, 12090.274583525017, 12264.632061038183, 12282.815757763461, 12595.433205505591, 12854.742905142031, 12211.572594959489, 12427.378631068592, 12453.128281020605, 12743.490260389852, 12928.353582321035, 12072.3360215189, 12194.57318993831, 12659.620211393672, 12789.232646041268, 12950.870491294967, 12153.878461215629, 12175.634730958085, 12194.57318993831, 12378.546637096868, 13046.478140874258, 11888.940555297168, 11967.222130561486, 12064.819027714415, 12175.817362739388, 12512.874871251171, 9708.85436718464, 10045.397276163454, 10508.579656813641, 10782.092584385944, 10787.603779700254, 9504.954455009805, 10424.061834434937, 11205.43972801373, 11420.942895285803, 11830.935215830272], "value": 7698.159154745796, "unit": "score"}], "name": "dromaeo_css", "value": 7702.463528005064, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 114.0, 114.0, 112.0, 112.0, 113.0, 112.0, 113.0, 113.0, 113.0], "value": 112.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 109.0, 112.0, 174.0, 139.0, 107.0, 108.0, 108.0, 125.0, 108.0], "value": 123.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 186.0, 184.0, 186.0, 183.0, 183.0, 183.0, 187.0, 184.0, 182.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 58.0, 58.0, 89.0, 61.0, 59.0, 58.0, 59.0, 73.0, 57.0], "value": 65.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 70.0, 86.0, 70.0, 67.0, 68.0, 101.0, 95.0, 53.0, 101.0], "value": 79.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 90.0, 84.0, 87.0, 82.0, 87.0, 85.0, 90.0, 129.0], "value": 90.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 92.0, 93.0, 101.0, 92.0, 93.0, 91.0, 147.0, 147.0], "value": 104.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 87.0, 86.0, 84.0, 86.0, 86.0, 88.0, 86.0, 84.0], "value": 85.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 49.0, 51.0, 55.0, 54.0, 56.0, 55.0, 55.0, 54.0, 56.0], "value": 53.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 74.0, 79.0, 73.0, 71.0, 70.0, 68.0, 69.0, 68.0, 67.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 83.0, 81.0, 83.0, 83.0, 80.0, 87.0, 87.0, 81.0, 86.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 130.0, 132.0, 133.0, 129.0, 131.0, 132.0, 137.0, 172.0, 142.0], "value": 137.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 160.0, 161.0, 162.0, 164.0, 162.0, 161.0, 158.0, 163.0], "value": 161.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 65.0, 64.0, 64.0, 63.0, 65.0, 62.0, 63.0], "value": 64.0, "unit": "score"}], "name": "kraken", "value": 1415.1999999999998, "alertThreshold": 2.0}]} 05:46:16 INFO - Return code: 0 05:46:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:46:16 INFO - # TBPL SUCCESS # 05:46:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:46:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:46:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:46:17 INFO - 2017-03-23 05:46:17.005 screenresolution[2316:26264] starting screenresolution argv=screenresolution get 05:46:17 INFO - 2017-03-23 05:46:17.008 screenresolution[2316:26264] Display 0: 1600x1200x32@60 05:46:17 INFO - 2017-03-23 05:46:17.014 screenresolution[2317:26267] starting screenresolution argv=screenresolution list 05:46:17 INFO - Available Modes on Display 0 05:46:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:46:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:46:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:46:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:46:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:46:17 INFO - Intel Iris: 05:46:17 INFO - Chipset Model: Intel Iris 05:46:17 INFO - Type: GPU 05:46:17 INFO - Bus: Built-In 05:46:17 INFO - VRAM (Dynamic, Max): 1536 MB 05:46:17 INFO - Vendor: Intel (0x8086) 05:46:17 INFO - Device ID: 0x0a2e 05:46:17 INFO - Revision ID: 0x0009 05:46:17 INFO - Displays: 05:46:17 INFO - Display: 05:46:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:46:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:46:17 INFO - Display Serial Number: 1600x1200 60 05:46:17 INFO - Main Display: Yes 05:46:17 INFO - Mirror: Off 05:46:17 INFO - Online: Yes 05:46:17 INFO - Rotation: Supported 05:46:17 INFO - Return code: 0 05:46:17 INFO - Running post-action listener: _resource_record_post_action 05:46:17 INFO - [mozharness: 2017-03-23 12:46:17.250885Z] Finished run-tests step (success) 05:46:17 INFO - Running post-run listener: _resource_record_post_run 05:46:17 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 360448; Write bytes: 419297280; Read time: 6; Write time: 1482 05:46:17 INFO - TinderboxPrint: CPU usage
53.6% 05:46:17 INFO - TinderboxPrint: I/O read bytes / time
360,448 / 6 05:46:17 INFO - TinderboxPrint: I/O write bytes / time
419,297,280 / 1,482 05:46:17 INFO - TinderboxPrint: CPU idle
2,207.2 (46.4%) 05:46:17 INFO - TinderboxPrint: CPU system
951.9 (20.0%) 05:46:17 INFO - TinderboxPrint: CPU user
1,602.6 (33.7%) 05:46:17 INFO - TinderboxPrint: Swap in / out
122,294,272 / 0 05:46:17 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 111856128; Write bytes: 104382464; Read time: 9922; Write time: 205 05:46:17 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 360448; Write bytes: 296531968; Read time: 6; Write time: 1221 05:46:17 INFO - Running post-run listener: _upload_blobber_files 05:46:17 INFO - Blob upload gear active. 05:46:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:46:17 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:46:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:46:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:46:18 INFO - (blobuploader) - INFO - Open directory for files ... 05:46:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:46:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:46:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:18 INFO - (blobuploader) - INFO - Done attempting. 05:46:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:46:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:46:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:19 INFO - (blobuploader) - INFO - Done attempting. 05:46:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:46:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:46:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:20 INFO - (blobuploader) - INFO - Done attempting. 05:46:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:46:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:46:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:46:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:46:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:46:24 INFO - (blobuploader) - INFO - Done attempting. 05:46:24 INFO - (blobuploader) - INFO - Iteration through files over. 05:46:24 INFO - Return code: 0 05:46:24 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:46:24 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:46:24 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5cdac918b02a18e3d45373aead3386cf8a7aa9dbf8161dcefa01d9050c54c7a38fa28c4135d81da0c9caecf9fa46982562f77e571705b24c3d6a9c9afd187629", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b15f6c14b17ec912ade410199dc201f9ad76dd76e4737d5090f33a47bd01bf70ce032f953503651af2b61d844784ed8752c75ca7a3147c5ebfffefd672bb2d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ab231b72bee653810faeabb59c3b3ce160e65a7d85b67106a791e7174dd408f56f6294a478b90b2a0ab76f14f29e31645edc8e0e60949d2d9a89bdf548ded724", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/28b6049405f1b1316f1f9df571b009abe352243be17f3895a11c410b96e52dae64fa08336779e1c1d294171f54af223641a8d24fcf9e17977f4adef01ec2d564"} 05:46:24 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:46:24 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:46:24 INFO - Contents: 05:46:24 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5cdac918b02a18e3d45373aead3386cf8a7aa9dbf8161dcefa01d9050c54c7a38fa28c4135d81da0c9caecf9fa46982562f77e571705b24c3d6a9c9afd187629", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b15f6c14b17ec912ade410199dc201f9ad76dd76e4737d5090f33a47bd01bf70ce032f953503651af2b61d844784ed8752c75ca7a3147c5ebfffefd672bb2d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ab231b72bee653810faeabb59c3b3ce160e65a7d85b67106a791e7174dd408f56f6294a478b90b2a0ab76f14f29e31645edc8e0e60949d2d9a89bdf548ded724", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/28b6049405f1b1316f1f9df571b009abe352243be17f3895a11c410b96e52dae64fa08336779e1c1d294171f54af223641a8d24fcf9e17977f4adef01ec2d564"} 05:46:24 INFO - Running post-run listener: copy_logs_to_upload_dir 05:46:24 INFO - Copying logs to upload dir... 05:46:24 INFO - mkdir: /builds/slave/test/build/upload/logs 05:46:24 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.532009 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2017-03-23 05:46:24.144229) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 05:46:24.148988) ========= 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.vg0HDeY8Kz/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.aCr4i2kKoH/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5cdac918b02a18e3d45373aead3386cf8a7aa9dbf8161dcefa01d9050c54c7a38fa28c4135d81da0c9caecf9fa46982562f77e571705b24c3d6a9c9afd187629", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b15f6c14b17ec912ade410199dc201f9ad76dd76e4737d5090f33a47bd01bf70ce032f953503651af2b61d844784ed8752c75ca7a3147c5ebfffefd672bb2d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ab231b72bee653810faeabb59c3b3ce160e65a7d85b67106a791e7174dd408f56f6294a478b90b2a0ab76f14f29e31645edc8e0e60949d2d9a89bdf548ded724", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/28b6049405f1b1316f1f9df571b009abe352243be17f3895a11c410b96e52dae64fa08336779e1c1d294171f54af223641a8d24fcf9e17977f4adef01ec2d564"} build_url:https://queue.taskcluster.net/v1/task/GUpN3vp_R466G4S1iEulyg/artifacts/public/build/firefox-53.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011246 build_url: 'https://queue.taskcluster.net/v1/task/GUpN3vp_R466G4S1iEulyg/artifacts/public/build/firefox-53.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5cdac918b02a18e3d45373aead3386cf8a7aa9dbf8161dcefa01d9050c54c7a38fa28c4135d81da0c9caecf9fa46982562f77e571705b24c3d6a9c9afd187629", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b15f6c14b17ec912ade410199dc201f9ad76dd76e4737d5090f33a47bd01bf70ce032f953503651af2b61d844784ed8752c75ca7a3147c5ebfffefd672bb2d7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ab231b72bee653810faeabb59c3b3ce160e65a7d85b67106a791e7174dd408f56f6294a478b90b2a0ab76f14f29e31645edc8e0e60949d2d9a89bdf548ded724", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/28b6049405f1b1316f1f9df571b009abe352243be17f3895a11c410b96e52dae64fa08336779e1c1d294171f54af223641a8d24fcf9e17977f4adef01ec2d564"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-23 05:46:24.184389) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 05:46:24.184804) ========= 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.vg0HDeY8Kz/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.aCr4i2kKoH/Listeners TMPDIR=/var/folders/jd/1y99yyv51vb4ndkbm8frkkx800000w/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.005166 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-23 05:46:24.234454) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 05:46:24.234846) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-23 05:46:24.235173) ========= ========= Total master_lag: 0.18 =========