builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0240 starttime: 1475064816.7 results: success (0) buildid: 20160928041920 builduid: f99144e20a9c49509718a383b33bce30 revision: fc513f0359ebca43d8b791a458583aeb3bb37f42 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 05:13:36.698160) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 05:13:36.698596) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 05:13:36.698897) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 05:13:36.873929) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 05:13:36.874315) ========= 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.VtYyE3dVIs/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.LVkSEUMSAr/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-09-28 05:13:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 175M=0s 2016-09-28 05:13:37 (175 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.662390 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 05:13:37.561466) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 05:13:37.561775) ========= 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.VtYyE3dVIs/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.LVkSEUMSAr/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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.028777 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 05:13:37.611035) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 05:13:37.611400) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev fc513f0359ebca43d8b791a458583aeb3bb37f42 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev fc513f0359ebca43d8b791a458583aeb3bb37f42 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VtYyE3dVIs/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.LVkSEUMSAr/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-09-28 05:13:37,695 truncating revision to first 12 chars 2016-09-28 05:13:37,696 Setting DEBUG logging. 2016-09-28 05:13:37,696 attempt 1/10 2016-09-28 05:13:37,696 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/fc513f0359eb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 05:13:38,799 unpacking tar archive at: fx-team-fc513f0359eb/testing/mozharness/ program finished with exit code 0 elapsedTime=1.376811 ========= master_lag: 0.45 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-28 05:13:39.438932) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 05:13:39.439193) ========= script_repo_revision: fc513f0359ebca43d8b791a458583aeb3bb37f42 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 05:13:39.439556) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 05:13:39.439814) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 05:13:39.479917) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-09-28 05:13:39.480170) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VtYyE3dVIs/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.LVkSEUMSAr/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:13:39 INFO - MultiFileLogger online at 20160928 05:13:39 in /builds/slave/test 05:13:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:13:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:13:39 INFO - {'append_to_log': False, 05:13:39 INFO - 'base_work_dir': '/builds/slave/test', 05:13:39 INFO - 'blob_upload_branch': 'Fx-Team', 05:13:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:13:39 INFO - 'branch': 'Fx-Team', 05:13:39 INFO - 'buildbot_json_path': 'buildprops.json', 05:13:39 INFO - 'config_files': ('talos/mac_config.py',), 05:13:39 INFO - 'default_actions': ('clobber', 05:13:39 INFO - 'read-buildbot-config', 05:13:39 INFO - 'download-and-extract', 05:13:39 INFO - 'populate-webroot', 05:13:39 INFO - 'create-virtualenv', 05:13:39 INFO - 'install', 05:13:39 INFO - 'run-tests'), 05:13:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:13:39 INFO - 'download_minidump_stackwalk': True, 05:13:39 INFO - 'download_symbols': 'ondemand', 05:13:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:13:39 INFO - 'tooltool.py': '/tools/tooltool.py', 05:13:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:13:39 INFO - '/tools/misc-python/virtualenv.py')}, 05:13:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:13:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:13:39 INFO - 'installer_path': 'installer.exe', 05:13:39 INFO - 'log_level': 'info', 05:13:39 INFO - 'log_name': 'talos', 05:13:39 INFO - 'log_to_console': True, 05:13:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:13:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:13:39 INFO - 'opt_config_files': (), 05:13:39 INFO - 'pip_index': False, 05:13:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:13:39 INFO - 'cmd': ('bash', 05:13:39 INFO - '-c', 05:13:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:13:39 INFO - 'enabled': True, 05:13:39 INFO - 'halt_on_failure': False, 05:13:39 INFO - 'name': 'check_screen_resolution'},), 05:13:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:13:39 INFO - 'cmd': ('bash', 05:13:39 INFO - '-c', 05:13:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:13:39 INFO - 'enabled': True, 05:13:39 INFO - 'halt_on_failure': False, 05:13:39 INFO - 'name': 'check_screen_resolution'},), 05:13:39 INFO - 'run_cmd_checks_enabled': True, 05:13:39 INFO - 'sps_profile': False, 05:13:39 INFO - 'sps_profile_interval': 0, 05:13:39 INFO - 'suite': 'dromaeojs', 05:13:39 INFO - 'system_bits': '32', 05:13:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:13:39 INFO - 'title': 't-yosemite-r7-0240', 05:13:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:13:39 INFO - 'use_talos_json': True, 05:13:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:13:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:13:39 INFO - 'work_dir': 'build'} 05:13:39 INFO - [mozharness: 2016-09-28 12:13:39.685082Z] Running clobber step. 05:13:39 INFO - Running pre-action listener: _resource_record_pre_action 05:13:39 INFO - Running main action method: clobber 05:13:39 INFO - rmtree: /builds/slave/test/build 05:13:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:13:41 INFO - Running post-action listener: _resource_record_post_action 05:13:41 INFO - [mozharness: 2016-09-28 12:13:41.778430Z] Finished clobber step (success) 05:13:41 INFO - [mozharness: 2016-09-28 12:13:41.778556Z] Running read-buildbot-config step. 05:13:41 INFO - Running pre-action listener: _resource_record_pre_action 05:13:41 INFO - Running main action method: read_buildbot_config 05:13:41 INFO - Using buildbot properties: 05:13:41 INFO - { 05:13:41 INFO - "project": "", 05:13:41 INFO - "product": "firefox", 05:13:41 INFO - "script_repo_revision": "production", 05:13:41 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 05:13:41 INFO - "repository": "", 05:13:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 05:13:41 INFO - "buildid": "20160928041920", 05:13:41 INFO - "pgo_build": "False", 05:13:41 INFO - "basedir": "/builds/slave/test", 05:13:41 INFO - "buildnumber": 841, 05:13:41 INFO - "slavename": "t-yosemite-r7-0240", 05:13:41 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:13:41 INFO - "platform": "yosemite_r7", 05:13:41 INFO - "scheduler": "tests-fx-team-macosx64-talos", 05:13:41 INFO - "branch": "fx-team", 05:13:41 INFO - "repo_path": "integration/fx-team", 05:13:41 INFO - "revision": "fc513f0359ebca43d8b791a458583aeb3bb37f42", 05:13:41 INFO - "stage_platform": "macosx64", 05:13:41 INFO - "builduid": "f99144e20a9c49509718a383b33bce30", 05:13:41 INFO - "slavebuilddir": "test" 05:13:41 INFO - } 05:13:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg. 05:13:41 INFO - Running post-action listener: _resource_record_post_action 05:13:41 INFO - [mozharness: 2016-09-28 12:13:41.781731Z] Finished read-buildbot-config step (success) 05:13:41 INFO - [mozharness: 2016-09-28 12:13:41.781847Z] Running download-and-extract step. 05:13:41 INFO - Running pre-action listener: _resource_record_pre_action 05:13:41 INFO - Running main action method: download_and_extract 05:13:41 INFO - mkdir: /builds/slave/test/build/tests 05:13: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:13:41 INFO - trying https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json 05:13:41 INFO - Downloading https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json'}, attempt #1 05:13:43 INFO - Downloaded 1199 bytes. 05:13:43 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.mac.test_packages.json 05:13:43 INFO - Using the following test package requirements: 05:13:43 INFO - {u'common': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:13:43 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:13:43 INFO - u'firefox-52.0a1.en-US.mac.cppunittest.tests.zip'], 05:13:43 INFO - u'gtest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:13:43 INFO - u'firefox-52.0a1.en-US.mac.gtest.tests.zip'], 05:13:43 INFO - u'jittest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:13:43 INFO - u'jsshell-mac.zip'], 05:13:43 INFO - u'mochitest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:13:43 INFO - u'firefox-52.0a1.en-US.mac.mochitest.tests.zip'], 05:13:43 INFO - u'mozbase': [u'firefox-52.0a1.en-US.mac.common.tests.zip'], 05:13:43 INFO - u'reftest': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:13:43 INFO - u'firefox-52.0a1.en-US.mac.reftest.tests.zip'], 05:13:43 INFO - u'talos': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:13:43 INFO - u'firefox-52.0a1.en-US.mac.talos.tests.zip'], 05:13:43 INFO - u'web-platform': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:13:43 INFO - u'firefox-52.0a1.en-US.mac.web-platform.tests.zip'], 05:13:43 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.mac.common.tests.zip', 05:13:43 INFO - u'firefox-52.0a1.en-US.mac.xpcshell.tests.zip']} 05:13:43 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:13:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:13:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:13:43 INFO - Fetch https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:13:43 INFO - Expected file size: 16470423 05:13:51 INFO - Downloading packages: [u'firefox-52.0a1.en-US.mac.common.tests.zip', u'firefox-52.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:13:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip 05:13:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:13:51 INFO - Fetch https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.common.tests.zip into memory 05:13:51 INFO - Expected file size: 16470423 05:13:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip 05:13:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:13:58 INFO - Fetch https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.talos.tests.zip into memory 05:13:59 INFO - Expected file size: 14414062 05:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:00 INFO - trying https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:14:00 INFO - Downloading https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg 05:14:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg'}, attempt #1 05:14:07 INFO - Downloaded 111545849 bytes. 05:14:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:14:07 INFO - mkdir: /builds/slave/test/properties 05:14:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:14:07 INFO - Writing to file /builds/slave/test/properties/build_url 05:14:07 INFO - Contents: 05:14:07 INFO - build_url:https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg 05:14:08 INFO - Running post-action listener: _resource_record_post_action 05:14:08 INFO - Running post-action listener: set_extra_try_arguments 05:14:08 INFO - [mozharness: 2016-09-28 12:14:08.328831Z] Finished download-and-extract step (success) 05:14:08 INFO - [mozharness: 2016-09-28 12:14:08.328951Z] Running populate-webroot step. 05:14:08 INFO - Running pre-action listener: _resource_record_pre_action 05:14:08 INFO - Running main action method: populate_webroot 05:14:08 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:14:08 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:14:08 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:14:08 INFO - '--tppagecycles', 05:14:08 INFO - '7'], 05:14:08 INFO - 'tests': ['tsvgm']}}, 05:14:08 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:14:08 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:14:08 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:14:08 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:14:08 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:14:08 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:14:08 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:08 INFO - 'talos_options': ['--disable-e10s'], 05:14:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:14:08 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:08 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:14:08 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:08 INFO - 'talos_options': ['--disable-e10s'], 05:14:08 INFO - 'tests': ['damp', 'tps']}, 05:14:08 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:08 INFO - 'tests': ['damp', 'tps']}, 05:14:08 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:14:08 INFO - 'tests': ['dromaeo_dom']}, 05:14:08 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:14:08 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:14:08 INFO - 'tests': ['basic_compositor_video']}, 05:14:08 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:14:08 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:14:08 INFO - 'tests': ['a11yr', 05:14:08 INFO - 'ts_paint', 05:14:08 INFO - 'tpaint', 05:14:08 INFO - 'sessionrestore', 05:14:08 INFO - 'sessionrestore_no_auto_restore', 05:14:08 INFO - 'tabpaint']}, 05:14:08 INFO - 'other-e10s': {'tests': ['a11yr', 05:14:08 INFO - 'ts_paint', 05:14:08 INFO - 'tpaint', 05:14:08 INFO - 'sessionrestore', 05:14:08 INFO - 'sessionrestore_no_auto_restore', 05:14:08 INFO - 'tabpaint']}, 05:14:08 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:14:08 INFO - 'ts_paint', 05:14:08 INFO - 'tpaint', 05:14:08 INFO - 'sessionrestore', 05:14:08 INFO - 'sessionrestore_no_auto_restore', 05:14:08 INFO - 'tabpaint']}, 05:14:08 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:14:08 INFO - 'ts_paint', 05:14:08 INFO - 'tpaint', 05:14:08 INFO - 'sessionrestore', 05:14:08 INFO - 'sessionrestore_no_auto_restore', 05:14:08 INFO - 'tabpaint']}, 05:14:08 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:14:08 INFO - 'tests': ['a11yr', 05:14:08 INFO - 'ts_paint', 05:14:08 INFO - 'tpaint', 05:14:08 INFO - 'sessionrestore', 05:14:08 INFO - 'sessionrestore_no_auto_restore', 05:14:08 INFO - 'tabpaint']}, 05:14:08 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:14:08 INFO - 'tests': ['a11yr', 05:14:08 INFO - 'ts_paint', 05:14:08 INFO - 'tpaint', 05:14:08 INFO - 'sessionrestore', 05:14:08 INFO - 'sessionrestore_no_auto_restore', 05:14:08 INFO - 'tabpaint']}, 05:14:08 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:14:08 INFO - 'tests': ['tsvgx', 05:14:08 INFO - 'tsvgr_opacity', 05:14:08 INFO - 'tart', 05:14:08 INFO - 'tscrollx', 05:14:08 INFO - 'cart']}, 05:14:08 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:14:08 INFO - 'tsvgr_opacity', 05:14:08 INFO - 'tart', 05:14:08 INFO - 'tscrollx', 05:14:08 INFO - 'cart']}, 05:14:08 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:08 INFO - 'talos_options': ['--disable-e10s'], 05:14:08 INFO - 'tests': ['tp5o']}, 05:14:08 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:08 INFO - 'tests': ['tp5o']}, 05:14:08 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:08 INFO - 'talos_options': ['--disable-e10s', 05:14:08 INFO - '--xperf_path', 05:14:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:14:08 INFO - 'tests': ['tp5n']}, 05:14:08 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:14:08 INFO - 'talos_options': ['--xperf_path', 05:14:08 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:14:08 INFO - 'tests': ['tp5n']}}, 05:14:08 INFO - 'talos.zip': {'path': '', 05:14:08 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:14:08 INFO - Running post-action listener: _resource_record_post_action 05:14:08 INFO - [mozharness: 2016-09-28 12:14:08.347698Z] Finished populate-webroot step (success) 05:14:08 INFO - [mozharness: 2016-09-28 12:14:08.347810Z] Running create-virtualenv step. 05:14:08 INFO - Running pre-action listener: _resource_record_pre_action 05:14:08 INFO - Running main action method: create_virtualenv 05:14:08 INFO - Creating virtualenv /builds/slave/test/build/venv 05:14:08 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:14:08 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:14:08 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:14:08 INFO - Using real prefix '/tools/python27' 05:14:08 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:14:09 INFO - Installing distribute.............................................................................................................................................................................................done. 05:14:12 INFO - Installing pip.................done. 05:14:12 INFO - Return code: 0 05:14:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:14:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:14:12 INFO - Reading from file tmpfile_stdout 05:14:12 INFO - Output received: 05:14:12 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:14:12 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:14:12 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:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:12 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:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:12 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 0x1037f8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10376e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f840ac58340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10360cd30>, '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 0x103432db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103604b20>, '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.VtYyE3dVIs/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.LVkSEUMSAr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:14:12 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:14:12 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:14:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VtYyE3dVIs/Render', 05:14:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:12 INFO - 'HOME': '/Users/cltbld', 05:14:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:12 INFO - 'LOGNAME': 'cltbld', 05:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:12 INFO - 'MOZ_NO_REMOTE': '1', 05:14:12 INFO - 'NO_EM_RESTART': '1', 05:14:12 INFO - 'PAGER': '/bin/cat', 05:14:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:12 INFO - 'PWD': '/builds/slave/test', 05:14:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:12 INFO - 'SHELL': '/bin/bash', 05:14:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVkSEUMSAr/Listeners', 05:14:12 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:14:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:12 INFO - 'USER': 'cltbld', 05:14:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:12 INFO - 'XPC_FLAGS': '0x0', 05:14:12 INFO - 'XPC_SERVICE_NAME': '0', 05:14:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:12 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:14:12 INFO - Cleaning up... 05:14:12 INFO - Return code: 0 05:14:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:14:12 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:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:12 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:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:12 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 0x1037f8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10376e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f840ac58340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10360cd30>, '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 0x103432db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103604b20>, '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.VtYyE3dVIs/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.LVkSEUMSAr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:14:12 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:14:12 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:14:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VtYyE3dVIs/Render', 05:14:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:12 INFO - 'HOME': '/Users/cltbld', 05:14:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:12 INFO - 'LOGNAME': 'cltbld', 05:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:12 INFO - 'MOZ_NO_REMOTE': '1', 05:14:12 INFO - 'NO_EM_RESTART': '1', 05:14:12 INFO - 'PAGER': '/bin/cat', 05:14:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:12 INFO - 'PWD': '/builds/slave/test', 05:14:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:12 INFO - 'SHELL': '/bin/bash', 05:14:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVkSEUMSAr/Listeners', 05:14:12 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:14:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:12 INFO - 'USER': 'cltbld', 05:14:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:12 INFO - 'XPC_FLAGS': '0x0', 05:14:12 INFO - 'XPC_SERVICE_NAME': '0', 05:14:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:12 INFO - Downloading/unpacking psutil>=3.1.1 05:14:12 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:14:12 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:14:12 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:14:12 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:14:12 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:14:12 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:14:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:14:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:14:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:14:16 INFO - Installing collected packages: psutil 05:14:16 INFO - Running setup.py install for psutil 05:14:16 INFO - building 'psutil._psutil_osx' extension 05:14:16 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:14:17 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:14:17 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:14:17 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:14:17 INFO - building 'psutil._psutil_posix' extension 05:14:17 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:14:17 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:14:17 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:14:17 INFO - ^ 05:14:17 INFO - 1 warning generated. 05:14:17 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:14:17 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:14:17 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:14:17 INFO - Successfully installed psutil 05:14:17 INFO - Cleaning up... 05:14:17 INFO - Return code: 0 05:14:17 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:14:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1037f8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10376e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f840ac58340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10360cd30>, '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 0x103432db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103604b20>, '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.VtYyE3dVIs/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.LVkSEUMSAr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:14:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:14:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VtYyE3dVIs/Render', 05:14:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:17 INFO - 'HOME': '/Users/cltbld', 05:14:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:17 INFO - 'LOGNAME': 'cltbld', 05:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:17 INFO - 'MOZ_NO_REMOTE': '1', 05:14:17 INFO - 'NO_EM_RESTART': '1', 05:14:17 INFO - 'PAGER': '/bin/cat', 05:14:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:17 INFO - 'PWD': '/builds/slave/test', 05:14:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:17 INFO - 'SHELL': '/bin/bash', 05:14:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVkSEUMSAr/Listeners', 05:14:17 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:14:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:17 INFO - 'USER': 'cltbld', 05:14:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:17 INFO - 'XPC_FLAGS': '0x0', 05:14:17 INFO - 'XPC_SERVICE_NAME': '0', 05:14:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:18 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:14:18 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:14:18 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:14:18 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:14:18 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:14:18 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:14:18 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:14:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:14:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:14:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:14:20 INFO - Installing collected packages: mozsystemmonitor 05:14:20 INFO - Running setup.py install for mozsystemmonitor 05:14:20 INFO - Successfully installed mozsystemmonitor 05:14:20 INFO - Cleaning up... 05:14:21 INFO - Return code: 0 05:14:21 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1037f8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10376e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f840ac58340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10360cd30>, '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 0x103432db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103604b20>, '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.VtYyE3dVIs/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.LVkSEUMSAr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:14:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:14:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:14:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VtYyE3dVIs/Render', 05:14:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:21 INFO - 'HOME': '/Users/cltbld', 05:14:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:21 INFO - 'LOGNAME': 'cltbld', 05:14:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:21 INFO - 'MOZ_NO_REMOTE': '1', 05:14:21 INFO - 'NO_EM_RESTART': '1', 05:14:21 INFO - 'PAGER': '/bin/cat', 05:14:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:21 INFO - 'PWD': '/builds/slave/test', 05:14:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:21 INFO - 'SHELL': '/bin/bash', 05:14:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVkSEUMSAr/Listeners', 05:14:21 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:14:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:21 INFO - 'USER': 'cltbld', 05:14:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:21 INFO - 'XPC_FLAGS': '0x0', 05:14:21 INFO - 'XPC_SERVICE_NAME': '0', 05:14:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:21 INFO - Downloading/unpacking jsonschema==2.5.1 05:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:14:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:14:23 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:14:23 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:14:23 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:14:23 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:14:23 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:14:23 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:14:24 INFO - Downloading functools32-3.2.3-2.tar.gz 05:14:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:14:24 INFO - warning: no files found matching '*.txt' 05:14:24 INFO - no previously-included directories found matching 'build' 05:14:24 INFO - no previously-included directories found matching 'dist' 05:14:24 INFO - no previously-included directories found matching '.git*' 05:14:24 INFO - Installing collected packages: jsonschema, functools32 05:14:24 INFO - Running setup.py install for functools32 05:14:24 INFO - warning: no files found matching '*.txt' 05:14:24 INFO - no previously-included directories found matching 'build' 05:14:24 INFO - no previously-included directories found matching 'dist' 05:14:24 INFO - no previously-included directories found matching '.git*' 05:14:24 INFO - Successfully installed jsonschema functools32 05:14:24 INFO - Cleaning up... 05:14:24 INFO - Return code: 0 05:14:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:14:24 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:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:24 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:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:24 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 0x1037f8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10376e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f840ac58340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10360cd30>, '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 0x103432db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103604b20>, '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.VtYyE3dVIs/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.LVkSEUMSAr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:14:24 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:14:24 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:14:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VtYyE3dVIs/Render', 05:14:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:24 INFO - 'HOME': '/Users/cltbld', 05:14:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:24 INFO - 'LOGNAME': 'cltbld', 05:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:24 INFO - 'MOZ_NO_REMOTE': '1', 05:14:24 INFO - 'NO_EM_RESTART': '1', 05:14:24 INFO - 'PAGER': '/bin/cat', 05:14:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:24 INFO - 'PWD': '/builds/slave/test', 05:14:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:24 INFO - 'SHELL': '/bin/bash', 05:14:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVkSEUMSAr/Listeners', 05:14:24 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:14:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:24 INFO - 'USER': 'cltbld', 05:14:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:24 INFO - 'XPC_FLAGS': '0x0', 05:14:24 INFO - 'XPC_SERVICE_NAME': '0', 05:14:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:14:24 INFO - Cleaning up... 05:14:24 INFO - Return code: 0 05:14:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:14:24 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:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:24 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:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:24 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 0x1037f8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10376e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f840ac58340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10360cd30>, '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 0x103432db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103604b20>, '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.VtYyE3dVIs/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.LVkSEUMSAr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:14:24 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:14:24 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:14:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VtYyE3dVIs/Render', 05:14:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:24 INFO - 'HOME': '/Users/cltbld', 05:14:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:24 INFO - 'LOGNAME': 'cltbld', 05:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:24 INFO - 'MOZ_NO_REMOTE': '1', 05:14:24 INFO - 'NO_EM_RESTART': '1', 05:14:24 INFO - 'PAGER': '/bin/cat', 05:14:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:24 INFO - 'PWD': '/builds/slave/test', 05:14:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:24 INFO - 'SHELL': '/bin/bash', 05:14:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVkSEUMSAr/Listeners', 05:14:24 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:14:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:24 INFO - 'USER': 'cltbld', 05:14:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:24 INFO - 'XPC_FLAGS': '0x0', 05:14:24 INFO - 'XPC_SERVICE_NAME': '0', 05:14:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:25 INFO - Downloading/unpacking blobuploader==1.2.4 05:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:27 INFO - Downloading blobuploader-1.2.4.tar.gz 05:14:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:14:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:14:27 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:14:27 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:14:27 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:14:27 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:14:27 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:14:27 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:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:14:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:14:28 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:14:28 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:14:28 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:14:28 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:14:28 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:14:28 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:14:28 INFO - Downloading docopt-0.6.1.tar.gz 05:14:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:14:28 INFO - Installing collected packages: blobuploader, requests, docopt 05:14:28 INFO - Running setup.py install for blobuploader 05:14:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:14:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:14:28 INFO - Running setup.py install for requests 05:14:29 INFO - Running setup.py install for docopt 05:14:29 INFO - Successfully installed blobuploader requests docopt 05:14:29 INFO - Cleaning up... 05:14:29 INFO - Return code: 0 05:14:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:29 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 0x1037f8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10376e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f840ac58340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10360cd30>, '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 0x103432db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103604b20>, '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.VtYyE3dVIs/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.LVkSEUMSAr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:14:29 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:14:29 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:14:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VtYyE3dVIs/Render', 05:14:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:29 INFO - 'HOME': '/Users/cltbld', 05:14:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:29 INFO - 'LOGNAME': 'cltbld', 05:14:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:29 INFO - 'MOZ_NO_REMOTE': '1', 05:14:29 INFO - 'NO_EM_RESTART': '1', 05:14:29 INFO - 'PAGER': '/bin/cat', 05:14:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:29 INFO - 'PWD': '/builds/slave/test', 05:14:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:29 INFO - 'SHELL': '/bin/bash', 05:14:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVkSEUMSAr/Listeners', 05:14:29 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:14:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:29 INFO - 'USER': 'cltbld', 05:14:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:29 INFO - 'XPC_FLAGS': '0x0', 05:14:29 INFO - 'XPC_SERVICE_NAME': '0', 05:14:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:14:29 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-yaqSVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:14:30 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-n__7i0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:14:30 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-kA8nJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:14:30 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-0pPtt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:14:30 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-JamLe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:14:30 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-yGVkqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:14:30 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-LVIN1R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:14:30 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-CWcvL1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:14:30 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-UHBV9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:14:30 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-hrZBkk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:14:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:14:30 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-um4jGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:14:31 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-7s0DWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:14:31 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-tX18e7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:14:31 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-5XgMhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:31 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-9apbFN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:14:31 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-HuerLk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:14:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:14:31 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-63S5Eo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:14:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:14:31 INFO - Running setup.py install for manifestparser 05:14:31 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:14:31 INFO - Running setup.py install for mozcrash 05:14:31 INFO - Running setup.py install for mozdebug 05:14:32 INFO - Running setup.py install for mozdevice 05:14:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:14:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:14:32 INFO - Running setup.py install for mozfile 05:14:32 INFO - Running setup.py install for mozhttpd 05:14:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:14:32 INFO - Running setup.py install for mozinfo 05:14:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:14:32 INFO - Running setup.py install for mozInstall 05:14:32 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:14:32 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:14:32 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:14:32 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:14:32 INFO - Running setup.py install for mozleak 05:14:32 INFO - Running setup.py install for mozlog 05:14:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:14:33 INFO - Running setup.py install for moznetwork 05:14:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:14:33 INFO - Running setup.py install for mozprocess 05:14:33 INFO - Running setup.py install for mozprofile 05:14:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:14:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:14:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:14:33 INFO - Running setup.py install for mozrunner 05:14:33 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:14:33 INFO - Running setup.py install for mozscreenshot 05:14:33 INFO - Running setup.py install for moztest 05:14:34 INFO - Running setup.py install for mozversion 05:14:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:14:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:14:34 INFO - Cleaning up... 05:14:34 INFO - Return code: 0 05:14:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14: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:14:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14: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:14:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:34 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 0x1037f8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10376e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f840ac58340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10360cd30>, '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 0x103432db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103604b20>, '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.VtYyE3dVIs/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.LVkSEUMSAr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:14:34 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:14:34 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:14:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VtYyE3dVIs/Render', 05:14:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:34 INFO - 'HOME': '/Users/cltbld', 05:14:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:34 INFO - 'LOGNAME': 'cltbld', 05:14:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:34 INFO - 'MOZ_NO_REMOTE': '1', 05:14:34 INFO - 'NO_EM_RESTART': '1', 05:14:34 INFO - 'PAGER': '/bin/cat', 05:14:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:34 INFO - 'PWD': '/builds/slave/test', 05:14:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:34 INFO - 'SHELL': '/bin/bash', 05:14:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVkSEUMSAr/Listeners', 05:14:34 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:14:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:34 INFO - 'USER': 'cltbld', 05:14:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:34 INFO - 'XPC_FLAGS': '0x0', 05:14:34 INFO - 'XPC_SERVICE_NAME': '0', 05:14:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:14:34 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-vqjaN6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:14:34 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:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:14:34 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-QAKiOS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:14:34 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-TNR0UZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:14:34 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:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:14:34 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-acDdpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:14:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:14:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:14:34 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-5RVtUF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:14:35 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:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:14:35 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-bDDDxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:14:35 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:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:14:35 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-4LLrDr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:14:35 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:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:14:35 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-B2lQqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:14:35 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:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:14:35 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-L5YhgE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:14:35 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:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:14:35 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-2rFykO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:14:35 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:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:14:35 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-t1Inri-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:14:35 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:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:14:35 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-Wfn5c2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:14:35 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-PfBSgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:14:35 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:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:14:35 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-ZGd3q8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:14:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:14:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:35 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-CEAM7s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:36 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:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:14:36 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-8V6tCr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:14:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:14:36 INFO - Running setup.py (path:/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/pip-pLkpfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:14:36 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:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:14:36 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:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:14:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:14:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:38 INFO - Downloading blessings-1.6.tar.gz 05:14:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:14:38 INFO - Installing collected packages: blessings 05:14:38 INFO - Running setup.py install for blessings 05:14:39 INFO - Successfully installed blessings 05:14:39 INFO - Cleaning up... 05:14:39 INFO - Return code: 0 05:14:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:14:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:14:39 INFO - Reading from file tmpfile_stdout 05:14:39 INFO - Current package versions: 05:14:39 INFO - blessings == 1.6 05:14:39 INFO - blobuploader == 1.2.4 05:14:39 INFO - docopt == 0.6.1 05:14:39 INFO - functools32 == 3.2.3-2 05:14:39 INFO - jsonschema == 2.5.1 05:14:39 INFO - manifestparser == 1.1 05:14:39 INFO - mozInstall == 1.12 05:14:39 INFO - mozcrash == 0.17 05:14:39 INFO - mozdebug == 0.1 05:14:39 INFO - mozdevice == 0.48 05:14:39 INFO - mozfile == 1.2 05:14:39 INFO - mozhttpd == 0.7 05:14:39 INFO - mozinfo == 0.9 05:14:39 INFO - mozleak == 0.1 05:14:39 INFO - mozlog == 3.4 05:14:39 INFO - moznetwork == 0.27 05:14:39 INFO - mozprocess == 0.23 05:14:39 INFO - mozprofile == 0.28 05:14:39 INFO - mozrunner == 6.12 05:14:39 INFO - mozscreenshot == 0.1 05:14:39 INFO - mozsystemmonitor == 0.3 05:14:39 INFO - moztest == 0.7 05:14:39 INFO - mozversion == 1.4 05:14:39 INFO - psutil == 3.1.1 05:14:39 INFO - requests == 1.2.3 05:14:39 INFO - wsgiref == 0.1.2 05:14:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14:39 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:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:39 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:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:39 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 0x1037f8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10376e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f840ac58340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10360cd30>, '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 0x103432db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103604b20>, '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.VtYyE3dVIs/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.LVkSEUMSAr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:14:39 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:14:39 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:14:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VtYyE3dVIs/Render', 05:14:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:39 INFO - 'HOME': '/Users/cltbld', 05:14:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:39 INFO - 'LOGNAME': 'cltbld', 05:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:39 INFO - 'MOZ_NO_REMOTE': '1', 05:14:39 INFO - 'NO_EM_RESTART': '1', 05:14:39 INFO - 'PAGER': '/bin/cat', 05:14:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:39 INFO - 'PWD': '/builds/slave/test', 05:14:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:39 INFO - 'SHELL': '/bin/bash', 05:14:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVkSEUMSAr/Listeners', 05:14:39 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:14:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:39 INFO - 'USER': 'cltbld', 05:14:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:39 INFO - 'XPC_FLAGS': '0x0', 05:14:39 INFO - 'XPC_SERVICE_NAME': '0', 05:14:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:39 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:14:39 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:14:39 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:14:39 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:14:39 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:14:39 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:14:39 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:14:39 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:14:39 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:14:39 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:14:39 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:14:39 INFO - Cleaning up... 05:14:39 INFO - Return code: 0 05:14:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:14:39 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:14:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:39 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:14:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:39 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 0x1037f8490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10376e570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f840ac58340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10360cd30>, '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 0x103432db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103604b20>, '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.VtYyE3dVIs/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.LVkSEUMSAr/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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:14:39 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:14:39 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:14:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VtYyE3dVIs/Render', 05:14:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:39 INFO - 'HOME': '/Users/cltbld', 05:14:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:39 INFO - 'LOGNAME': 'cltbld', 05:14:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:39 INFO - 'MOZ_NO_REMOTE': '1', 05:14:39 INFO - 'NO_EM_RESTART': '1', 05:14:39 INFO - 'PAGER': '/bin/cat', 05:14:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:39 INFO - 'PWD': '/builds/slave/test', 05:14:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:39 INFO - 'SHELL': '/bin/bash', 05:14:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVkSEUMSAr/Listeners', 05:14:39 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:14:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:39 INFO - 'USER': 'cltbld', 05:14:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:39 INFO - 'XPC_FLAGS': '0x0', 05:14:39 INFO - 'XPC_SERVICE_NAME': '0', 05:14:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:14:39 INFO - Cleaning up... 05:14:39 INFO - Return code: 0 05:14:39 INFO - Running post-action listener: _resource_record_post_action 05:14:39 INFO - Running post-action listener: _start_resource_monitoring 05:14:39 INFO - Starting resource monitoring. 05:14:39 INFO - [mozharness: 2016-09-28 12:14:39.967200Z] Finished create-virtualenv step (success) 05:14:39 INFO - [mozharness: 2016-09-28 12:14:39.968188Z] Running install step. 05:14:39 INFO - Running pre-action listener: _resource_record_pre_action 05:14:39 INFO - Running main action method: install 05:14:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:14:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:14:40 INFO - Reading from file tmpfile_stdout 05:14:40 INFO - Detecting whether we're running mozinstall >=1.0... 05:14:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:14:40 INFO - Reading from file tmpfile_stdout 05:14:40 INFO - Output received: 05:14:40 INFO - Usage: mozinstall [options] installer 05:14:40 INFO - Options: 05:14:40 INFO - -h, --help show this help message and exit 05:14:40 INFO - -d DEST, --destination=DEST 05:14:40 INFO - Directory to install application into. [default: 05:14:40 INFO - "/builds/slave/test"] 05:14:40 INFO - --app=APP Application being installed. [default: firefox] 05:14:40 INFO - mkdir: /builds/slave/test/build/application 05:14:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:14:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:15:14 INFO - Reading from file tmpfile_stdout 05:15:14 INFO - Output received: 05:15:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:15:14 INFO - Running post-action listener: _resource_record_post_action 05:15:14 INFO - [mozharness: 2016-09-28 12:15:14.670174Z] Finished install step (success) 05:15:14 INFO - [mozharness: 2016-09-28 12:15:14.670320Z] Running run-tests step. 05:15:14 INFO - Running pre-action listener: _resource_record_pre_action 05:15:14 INFO - Running main action method: run_tests 05:15:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:15:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:15:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:15:14 INFO - 2016-09-28 05:15:14.685 screenresolution[1647:8229] starting screenresolution argv=screenresolution get 05:15:14 INFO - 2016-09-28 05:15:14.687 screenresolution[1647:8229] Display 0: 1600x1200x32@60 05:15:14 INFO - 2016-09-28 05:15:14.694 screenresolution[1648:8231] starting screenresolution argv=screenresolution list 05:15:14 INFO - Available Modes on Display 0 05:15:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:15:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:15:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:15:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:15:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:15:14 INFO - Intel Iris: 05:15:14 INFO - Chipset Model: Intel Iris 05:15:14 INFO - Type: GPU 05:15:14 INFO - Bus: Built-In 05:15:14 INFO - VRAM (Dynamic, Max): 1536 MB 05:15:14 INFO - Vendor: Intel (0x8086) 05:15:14 INFO - Device ID: 0x0a2e 05:15:14 INFO - Revision ID: 0x0009 05:15:14 INFO - Displays: 05:15:14 INFO - Display: 05:15:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:15:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:15:14 INFO - Display Serial Number: 1600x1200 60 05:15:14 INFO - Main Display: Yes 05:15:14 INFO - Mirror: Off 05:15:14 INFO - Online: Yes 05:15:14 INFO - Rotation: Supported 05:15:14 INFO - Return code: 0 05:15:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:15:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:15:14 INFO - Python 2.7.3 05:15:14 INFO - Return code: 0 05:15:14 INFO - grabbing minidump binary from tooltool 05:15:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:14 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 0x10360cd30>, '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 0x103432db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103604b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:15:14 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:15:14 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:15:14 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:15:15 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:15:15 INFO - Return code: 0 05:15:15 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:15:15 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:15:15 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:15:15 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:15:15 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:15:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0240', '--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:15:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0240 --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:15:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VtYyE3dVIs/Render', 05:15:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:15 INFO - 'HOME': '/Users/cltbld', 05:15:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:15 INFO - 'LOGNAME': 'cltbld', 05:15:15 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:15:15 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:15:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:15 INFO - 'MOZ_NO_REMOTE': '1', 05:15:15 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:15:15 INFO - 'NO_EM_RESTART': '1', 05:15:15 INFO - 'PAGER': '/bin/cat', 05:15:15 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:15 INFO - 'PWD': '/builds/slave/test', 05:15:15 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:15:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:15 INFO - 'SHELL': '/bin/bash', 05:15:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LVkSEUMSAr/Listeners', 05:15:15 INFO - 'TMPDIR': '/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/', 05:15:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:15 INFO - 'USER': 'cltbld', 05:15:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:15 INFO - 'XPC_FLAGS': '0x0', 05:15:15 INFO - 'XPC_SERVICE_NAME': '0', 05:15:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:15 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0240', '--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:15:15 INFO - mozversion application_buildid: 20160928041920 05:15:15 INFO - mozversion application_changeset: fc513f0359ebca43d8b791a458583aeb3bb37f42 05:15:15 INFO - mozversion application_display_name: Nightly 05:15:15 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:15:15 INFO - mozversion application_name: Firefox 05:15:15 INFO - mozversion application_remotingname: firefox 05:15:15 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:15:15 INFO - mozversion application_vendor: Mozilla 05:15:15 INFO - mozversion application_version: 52.0a1 05:15:15 INFO - mozversion platform_buildid: 20160928041920 05:15:15 INFO - mozversion platform_changeset: fc513f0359ebca43d8b791a458583aeb3bb37f42 05:15:15 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:15:15 INFO - mozversion platform_version: 52.0a1 05:15:15 INFO - using testdate: 1475064915 05:15:15 INFO - actual date: 1475064915 05:15:15 INFO - starting webserver on 'localhost:49273' 05:15:15 INFO - SUITE-START | Running 2 tests 05:15:15 INFO - TEST-START | dromaeo_css 05:15:15 INFO - operating with platform_type : mac_ 05:15:15 INFO - Initialising browser for dromaeo_css test... 05:15:15 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmpwv3CTA/profile http://localhost:49273/getInfo.html) 05:15:17 INFO - PROCESS | 1658 | __metrics Screen width/height:1600/1200 05:15:17 INFO - PROCESS | 1658 | colorDepth:24 05:15:17 INFO - PROCESS | 1658 | Browser inner width/height: 1024/689 05:15:17 INFO - PROCESS | 1658 | __metrics 05:15:17 INFO - PROCESS | 1658 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:15:17 INFO - PROCESS | 1658 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:15:18 INFO - TEST-INFO | 1658: exit 0 05:15:18 INFO - Browser initialized. 05:15:18 INFO - Running cycle 1/1 for dromaeo_css test... 05:15:18 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmpwv3CTA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:15:30 INFO - PROCESS | 1661 | RSS: Main: 235634688 05:15:30 INFO - PROCESS | 1661 | 05:16:21 INFO - PROCESS | 1661 | 1475064981246 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:18:32 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 05:18:35 INFO - PROCESS | 1661 | RSS: Main: 493158400 05:18:35 INFO - PROCESS | 1661 | 05:21:38 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 05:21:39 INFO - PROCESS | 1661 | RSS: Main: 375304192 05:21:39 INFO - PROCESS | 1661 | 05:24:41 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 05:24:42 INFO - PROCESS | 1661 | RSS: Main: 343248896 05:24:42 INFO - PROCESS | 1661 | 05:27:44 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 05:27:45 INFO - PROCESS | 1661 | RSS: Main: 356417536 05:27:45 INFO - PROCESS | 1661 | 05:30:48 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 05:30:49 INFO - PROCESS | 1661 | RSS: Main: 337063936 05:30:49 INFO - PROCESS | 1661 | 05:33:52 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 05:33:52 INFO - PROCESS | 1661 | RSS: Main: 550559744 05:33:52 INFO - PROCESS | 1661 | 05:33:52 INFO - PROCESS | 1661 | __start_tp_report 05:33:52 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 05:33:52 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 05:33:52 INFO - PROCESS | 1661 | |i|pagename|runs| 05:33:52 INFO - PROCESS | 1661 | |0;dojo.html;2686.435848471821;3285.737141028718;3311.2880730642905;3345.665433456656;3364.3103163851415;5403.675779453226;5543.944560554393;5569.331680198372;5621.494065534106;5640.520555752756;5567.025770490169;5589.273394458724;5656.773729050833;5666.065099258617;5684.118961560965;5026.396832380119;5042.117629414856;5063.822766203184;5111.744412779365;5126.436092029874;5124.743762811863;5211.218317252424;5213.191955246943;5219.269302297681;5275.86810329741;5194.610404219661;5201;5201.219817027439;5214.426413094557;5249.527542521172;5011.223260394645;5071.46749591295;5077.441481437076;5087.771050302708;5096.61775366849;5091.949080509185;5100.081985242655;5115.923261151086;5134.0758663440565;5192.636515443921;5564.693941833198;5566.165075238706;5610.803621873215;5616.073347897592;5639.6334238274385;5784.161296611967;5796.710164491758;5834.737436815353;6088.786892458743;6091.634501929899;6057.42454466825;6077.9392206078255;6136.127537158367;6141.587434890001;6150.66171360575;5656.830295091154;5658.74535645897;5668.234788303526;5680.289963754531;5695.088785794253;6120.908186377119;6170.259568851767;6243.500519958392;6260.46786023184;6272.905906411407;5073.568746656576;5866.911996320058;5913.2608423947;5936.5250779937505;5982.162497250389;6122.418445057339;6125.540694081788;6139.1146161305005;6143.017117261216;6149.370416839541;5996.820095397145;6061.666608336495;6074.362191969868;6100.550895826113;6115.4801841843055;5827.737751801179;5857.765689372377;5858.326292476335;5932.614380065282;6127.571070025056;4768.61851051915;4770.880727981758;4773.546513081252;4776.426828780569;4781.6891902026255;4254.617084462413;4299.656027517791;4386.188555117314;4391.912161756747;4393.7363758174615;5458.181272809031;5485.369182543979;5523.806666766724;5528.695921724263;5529.889402211933;5985.910211346833;6007.098935159674;6018.518518518508;6019.097135429721;6046.879062418727;5564.415736347706;5615.382307946123;5635.746391412315;5679.943200568024;5699.373068962411;5253.789848406097;5262.394824595144;5280.445553216857;5280.471952804689;5299;6249.281332646804;6274.780382686584;6278.905816412757;6287.622742635456;6294.590851594723;6016.939830601638;6048.879022419439;6052.788152414821;6138.662373569318;6158.291796443287;6166.784162554469;6213.782517611862;6232.065190221503;6267.780627678009;6276.497880169667;6032.457078862748;6054.939450605614;6058.636481811105;6062.090686397076;6085.939140608714;5962.07587823888;5977.521798256216;6109.083637454418;6145.385461453819;6150.354212807591;5817.185594016925;5884.529237661062;5885.588008839341;5895.380984996686;5896.528277737856;5829.59192856496;5836.620619659709;5848.473637372657;5851.502622277154;5858.94141058584;5567.582431317748;5695.715214239354;5714.514266287412;5745.827625171251;5759.193712880284;5870.412958704095;5880.029795083763;5886.440788125121;5888.852778680567;5888.941110588839;5537.695426751407;5705.343885453226;5723.055695810144;5774.335951365647;5802.187693722966 05:33:52 INFO - PROCESS | 1661 | |1;ext.html;466.8236045166181;470.7340352700724;487.1888305970559;524.9790008399665;525.0417987173407;29290.85354573227;38576;39393.99999999996;39667;41990.790046049806;41594.58405415945;42031.78984105091;42061.36907946376;42085.36871946923;42184.57815421853;8655;9694.612215511406;9838.311318207729;9849.16282116021;9864.408135511856;8647.264982476465;8832.337574681893;8852.690155844546;8858.867116993219;11719;11707.180497365187;11938.940305298462;11967.22213056153;11970.82043769344;12041.97643200329;11792.646220613353;11877.049836013099;11890.048796096335;11891.464884080237;11965.282083074957;8640.17918297767;8857;8877.600507977157;11657;11771.23486973344;31531.684683153104;31928.521072183936;38203.42694859579;38730.41904371437;38746.80626596849;3176.9841150794327;3305.5041743738393;3389.86440542378;3433.3819912415756;3690.2066055797864;30317.545236821465;30318.242043948856;30553.541696874563;30601.846990764905;31310.843445782626;3142.874285028596;3176.126565194567;3211.96788032119;3234.3531293741344;3277.918052048694;440362;448353;449373;449555;457049;55109.448905510435;55357;55369.72315138399;55432.44567554354;55472.44527554673;50069;50848.491515085116;57058.58238428977;58023.419765802646;58143.8371232573;15139.848601514064;15264.855135864855;15287.770683439758;15293.6176595586;15299.694006119815;11742.647720568397;11855.525778968917;11861.229020113666;11867.406629668481;11884.88115118855;13483.730325393633;13686;13700.314984250748;14840.183789891444;15115.773263401057;6329.4303512683155;6387.552871299057;6464.838379040561;6549.803505894831;6560.540762146699;798.9920100799034;875.5884734174928;910.8314961732101;918.903515130915;1022.5807418958192;23447.296581102593;29187.56218656722;29191.416171676447;29638;29998.550021749692;972.1687956796978;997.7106639074732;1037.190991027;1056.0653821368144;1164.2897832322276;13247.801282980763;14741.115533067836;15412.768808467881;15433.768493472608;15536.83473739474;560673;573079;573807;574175;575096;55058.44941550533;55213.89572208533;55248;55280;55379.33861984147;1311.6392991927296;1350.8108864758942;1368.0423703407455;1371.91082579632;1372.3961456959105;24774.628380574668;28632.427351453272;29169.56245656359;29613.85193074021;29774;47772.522274778195;47943.287939687776;47995.280070799665;48082.51917480781;48111.75944120257;552350;555036;555356;555360;555425;35426.645733543366;39355.409668854416;39372;39592;39604.80197598993;37822.62177378301;44075.77962110169;45259.321110184035;45263.77368113138;45452;37460.87617371483;37667.623323767504;38240.04399890025;38633.227335453696;39014.82955511339;37579.436308454846;37763.05592360213;38444;38686.419703703905;39745.60254397535;36983;37615.6238437623;38074.619253807105;38128.42807357836;38230.42654360131;32575;33201.66798331986;34048.65951340554;34267.314653706286;34396.31207375888;24468;25033.87483062573;25170.370740730894;25591.616125757755;25601.809413733652 05:33:52 INFO - PROCESS | 1661 | |2;jquery.html;348.51034296812986;368.4914817551778;370.6923253699428;377.694067805078;397.8050755129987;15016.24918754062;15195.84804151958;16083.919580402111;20077.899610501965;20680.586388272262;19422.892337226047;20281.797182028175;20412.387628371136;20512.897435512838;20655.586888262227;5217.269582258468;5827.446392592697;6100.755969761204;6109.389061093877;6115.571909966304;5409.6213265071465;6045.304789949146;6112.327643959161;6114.785982490614;6115.969420152893;5791.247137872092;5958.79144229952;6053.545984051192;6062.181605483247;6065.514758819284;5939.732712027948;5979.312379076418;5984.192134061933;5987.072003839412;5992.310884248323;4994.575461085812;5000.82497112603;5212.58299336056;5276.419593844674;5295.338082739658;25558.616620750705;26207.868960655265;26240.0815971442;26313.21060368192;26590.6011409829;1897.3643829317057;2003.8096380843797;2333.49829786595;2382.6783384243076;2432.7323994360604;9815.460149691764;10042.849357259647;10243.641472548425;10430.739231519197;10498.055175034207;1623.62656588984;1864.683003889342;1939.7963213862483;1942.5435022769639;1943.8542109341856;122484;125961;127013.72986270112;127499.61254068375;128390;11280.435978201058;11377.431128443544;11393.316401015965;11485.483153257956;11666.941665291619;14246.572602821932;14250.643733906736;14258.928705356408;14268.714625707635;14274.929380296519;6622.503312251601;8269.173082691683;8293.087760346358;8310.8337833243;8449.450785699033;8124;8130.75607731769;8283.461574997606;8294.626741796634;8304.211099945496;3731.9813400933363;4359.760213188241;4455.131249406335;4461.286194208911;4544.931826022612;1498.4755335632442;1848.4824249210242;1873.0353867758115;1937.1766999025358;1937.7190307405347;763.8434121005181;844.5397258494136;918.191991047887;951.6336210558985;958.8226178157063;20093.091156340124;21170.78829211719;21582.78417215839;21587;21742.565148697253;913.7578541686458;914.7713071732067;923.2244914272044;944.4994153098869;1017.7710015246658;10510.369377837202;11252.774944501065;11259.493322800494;11265.887341126483;11290.209685321948;489739;574725;575489;584216.0789196027;587747;88137;93846.0615393851;106310.46844765727;125928;134028;848.2747251100344;871.847426700325;941.7833898203452;944.15026476172;945.2910317262053;15477.767833482732;19205;19242.23031078797;19252.94108823972;19419.4174174775;53691.46308537021;54806;54888.45111548834;56322;56699.71650141723;68318;68816.6559167221;70167.29832701811;78444.82332765128;81823.5908820452;7998.080220774686;8120.187981201832;8251.092379838334;8268.83462330762;8318.292945099734;11692.35692036946;12833.42249598789;12837.743245135232;13344.399502022627;13391.531296404579;11047.392393418439;11090.611828585961;11461.36962467039;11541.307521548399;11608.24546404481;8462.603670394315;9075.54622268897;10809.973052559993;11370.431478426211;11655.358955257543;11566.710832229262;11680.123990700562;11825.994790442564;11844.822327665264;12038.337891416057;6157.72290246931;7145.714171433085;7448.925510744823;7630.198829122862;8431.578421078799;9050.411723238232;9703.708888733348;10764.3541387517;11079.556817727524;11566.826497602711 05:33:52 INFO - PROCESS | 1661 | |3;mootools.html;1299.8375203099615;1514.3412615512252;1648.7526870969352;1869.5699989002537;1908.3606991657794;8371.790705232364;8910.331725120617;8913.68802091927;8917.643294268222;8918.554072296392;6952.2700116487795;7754.302112809846;8081.313088387494;8098.959505202481;8660.437071590342;2338.24007197661;2372.5729368713623;2374.95250094998;2375.6911601491784;2379.988100059506;2326.1044497868274;2337.497438050819;2372.8457650252763;2373.264288070695;2377.762223777626;2359.9410014749596;2372.229025566689;2373.501564671421;2388.880555972203;2390.5577468168444;2065.2152182170753;2329.94175145621;2331.4870728439714;2363.078399424226;2396.1852969990287;2354.8469349492398;2355.3522781235297;2359.127122964497;2359.433735903388;2361.374235827507;7458.664360103809;8774.429662072009;8781.165789250012;8853.468791872509;8854.513001784899;5060.84817455477;5294.126469132589;5299.311089558333;5302.231176479428;5303.7082960437165;3395.1002984209204;3601.621829707869;3639.290338384016;3663.322285377187;3665.2852693724735;1048.8374301983206;1081.1026847716375;1088.6189833558271;1095.6548687163518;1106.3140852671315;11510.079193664487;11559.075273978062;11577.131715121399;11577.363245021435;11585.710357241052;4454.532274111237;4538.319252112144;4708.411448568929;4724.173269677862;4736.573708366263;9751.317407781387;9865.704028879145;9866.408015519091;9867.802643947081;9867.851982220272;4540.205464043779;5234.717494213942;5284.075286824867;5293.655912365684;5311.362636483646;3604.711623070148;4341.110072435144;4497.977510112429;4818.759062046954;4845.733484658307;3514.9982255057184;3598.208394153282;3830.2339532093692;3911.9217615647526;3937.684985201177;1105.3865104866716;1216.1730023584048;1261.4575732435142;1281.641140480667;1284.743051389726;726.9127704675367;811.8985126859143;889.1242126505387;903.3270213690843;944.15026476172;5297.284866543045;5794.391588883191;5910.911336329958;5921.644701317935;6023.849403764941;905.6241659711278;935.4901578639658;950.9286803489766;953.9618415263451;991.9305648604673;3774.4338349247832;3784.6404591563755;3855.7879316637855;3880.963797650412;3938.783366914847;10297.485125743682;10536.57853685844;10680.412577308323;10707.785844283226;10714.089302409382;9362.578683959238;10438.895611043945;10445.11216546602;10624.575016999233;10641.733956651145;7672.769816905502;7873.448858579959;7879.212078792075;7880.645370958206;7882.369410447151;5565.081761509306;5600.551955843442;5745.2818397700285;5879.911801323069;5913.172155898092;9696.369735967139;9949.452780096875;10005.399676019462;10008.199344052313;10013.649522266685;9487.715368538955;9915.157211636802;9919.305648604817;10080.747981300527;10084.647037353658;6808.9659551701925;7020.648967551704;7041.471889608198;7427.44294177928;7608.125065617525;7627.656755445907;7735;7827.647755850887;8103.513789172668;8232.670693172206;7303.926960730325;7409.666565004695;7451.105867295742;7510.924890751023;7571.3942884568005;7232.349088582053;7271.745488907863;7283.126024877049;7312.670929808065;7438.293362130589;6818.31816818334;6819.181698196248;6921.8961715575315;6970.581765094111;6980.057692211486;4892.510748925079;4936.8765780855765;4969;4988.775505102207;5064.113780088396;4812.205986012269;4919.139150648693;4931.9753401232765;4946.134426475424;5142 05:33:52 INFO - PROCESS | 1661 | |4;prototype.html;291.31104936824414;299.8695567428169;306.6121356484047;314.2959770114942;316.26152932901675;4144.647704945076;4988.825391111312;5133.818127295898;5175.2053890898915;5218.530332270095;4550.817967281313;5059.3169922060515;5129.6409251352425;5171.11254392147;5177.767000484978;2988.5965394671657;3194.7923384980018;3591.604923458424;3700.243318727552;4052.533958594755;3307.4046671599103;3971.4312846425787;3991.840326386941;4031.7177797554036;4042.555318914932;2836.3618185908213;3259.5762550868353;3681.7606855554436;3722.236941427001;3901.6683581895572;3573.874229617662;3937.1731936293413;3962.7226094173275;3969.642732154091;3980.880573582768;2869.268336574181;3273.29624130813;3470.410030294856;3475.461303497962;3488.075659950115;4726.1879181886725;5076.36545431821;5079.968012794875;5094.31226784383;5103.311053007834;3724.5158129443;3802.923941521182;4463.419755431773;4469.553044695537;4479.820807167709;5446.346438427375;5488.396276409591;5506.201600767907;5510.393856675762;5569.693666848321;2895.724906133914;2953.9261518461994;3761.322961866863;3766.9058273543105;3771.547414310273;5368.731563421813;5448.782048718086;5598.552115830724;5715.971420142872;5749.597528172988;3645.6901163400876;3694.2057457646733;3770.7171962102952;3790.3556395412293;3798.924021519554;3519.806410647439;3819.1788765415567;3826.100866296418;3838.1939792643857;3846.1538461538416;3676.191237927652;4162.396452514368;4464.15181115587;4475.209916033613;4477.395551600557;5302.655327403783;5405.162244836696;5483.670979741229;5501.944980550144;5517.689386368227;1284.0113112903011;1306.6863952651486;1306.9477220911247;1311.4164196932463;1313.1923866822026;687.4946914018193;750.6772088002102;791.6635429942252;807.7617102954642;808.878668199763;3860.4402361657403;3902;3906.570277269498;4109.260333140063;4121.155163191538;4037.6164264394833;4607.44710634726;4661.790219440066;4665.440147182359;4692.533198823333;3757.267332870119;4046.656034237064;4048.8785336439955;4107.514953453177;4289.7640629765665;2046.4167712201952;2067.9379618611465;2250.6061439248065;2391.916282930089;2493.962590561143;4726.905461890743;4771.403574553181;4777.761111944389;4810.628970743322;4827.972251654313;3871;4051.9392209116886;4779.665423420397;4799.3760811094335;4801.975990120027;4260.573942605839;4336.891577710582;4783.712977221308;4802.399700037496;4873.708467256109;3751.549814022335;4160.687948403821;4619.930701039554;4652.790624421841;4679.157751604744;3700.389435743072;3934.586868378779;3961.0493481564795;3963.5243770746542;4562.749048802348;4191.392248124066;4295.4201182839915;4416.1609294233995;4875.464228767927;4935.4570997190995;3270.738340932672;3743.4384842273876;3764.887053388403;3769.4911186990503;3789.389509458524;4747.311639812277;5638.830835074954;5682.261306030189;5693.718913244486;5696.971515142398;4947.777350019186;5167.974160129175;5496.7526461310135;5502.9174562382395;5513.9448605513435;5457.5633949283165;5522.696251706195;5536.7231638418725;5562.554995600423;5660.915086273627;5368.792021795065;5410.513053825174;5470.91793623104;5473.644213126134;5494.2582751329655;4399.9120017598825;4609.3777340060005;5288.5769138469595;5542.861428464321;5553.750730953971;4375.759333236702;5010.899782004412;5437.864053398538;5446.754896029609;5580.665160090408 05:33:52 INFO - PROCESS | 1661 | |5;yui.html;708.5500707051023;718.0808565036751;768.646422645583;794.2414993681035;813.6338647608574;15651.530454086382;15896.920515397407;15924.283407246672;15940.282687279072;15942.601434964132;14251.287435628228;14359.282035898215;14364.712705745878;14376.137431754101;14794.704105917903;685.9074025006635;703.8873780195145;704.6371118873784;835.2107258640588;843.6794018273079;700.7162099349746;852.3862818770475;853.2107800284742;853.3216093205885;853.4452605806214;897.3808072430035;901.4140808474478;902.5848109869468;903.6791938861708;907.4555266839909;716.527092119204;731.7109741652017;895.8477058900003;896.4083704754863;901.3465237702613;650.187265917603;663.6316844151543;663.7179198840473;666.0841343153164;667.2626747444101;14960;15018.549443516602;15023;15031.098134111988;15098.320575574126;13451.394687239;13631.913487294922;13751.381187846471;13931.442742290295;14216.857831421657;10270.794584108351;12664.873351266462;12717.809232861515;12720.300383478905;12867.485300587965;4506.256467682829;4531.43357080365;4543.34121552373;4674.813007479696;4786.880327991793;116441.2533812002;116524;116566;116597;116913;10503.369797812156;10653.296415475505;10768.94615526933;10896.727581810519;11243.718907027389;21566.460838478848;21566.892165539073;21583.352499425044;21586.89206553957;21600.891995540234;7819.17898620648;8076.353891688651;8097.635606397726;8108.067572229151;8124.796880078045;4223.092035212444;4362.0839623679385;4385.202067152452;4425.35832304314;4563.452385713736;3425.828708564562;3480.2343484433386;3504.789712617251;3540.504329393887;3546.1843775931166;644.3588629313863;646.9676516174172;659.1661548141604;666.6866572710818;668.7425341243656;500.7020822610541;539.6303532080537;540.7377421950351;552.5883217003358;617.6263360666821;8796.516191609395;9029.954850225839;9138.223251023604;9172.816543669223;9356.251499879992;515.8504033830147;547.3349879895945;616.4328817487922;631.5200447659812;641.3970867384644;4299;4329.675274354436;4346.9347959780625;4396.296592545242;4462.888427789331;92706;92816;106564.93435065706;114762.4261878702;158951;124054;137163.31418343043;140262;141548;144573.27713361365;112411.4379428114;118982;120759;121451;124456.37771811083;8587.914120858712;8597.484150950962;8599.097094804956;8693.739187824376;8836.916112828842;53332.466675334304;56490;62210.68894655679;63949.3605063962;65259.67370163119;84248;92205;93374;96329.51835240779;97205;9802.950985245028;10769.9461502692;11638.243514171552;11905;12118.757624847278;12167;12206.450709717907;12281.69295767613;12784.424700888296;12897.806532902201;11849.940750296193;11982.161248712855;12039.939800300943;12413.379331033231;12453.501859925502;11703.882961170279;12018.278903265833;12094.879051209728;12142.692888351185;12429.875701242872;11654.359010254517;11751;11883.405829708307;12002.039836812859;12272.570460033856;9734.610068709024;9785;10026.097651211427;10239.948800255952;10365;7599.278068583476;8854.513001784964;9866.309358344846;9997.900020999989;10068 05:33:52 INFO - PROCESS | 1661 | __end_tp_report 05:33:52 INFO - PROCESS | 1661 | __start_cc_report 05:33:52 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,2411 05:33:52 INFO - PROCESS | 1661 | __end_cc_report 05:33:52 INFO - PROCESS | 1661 | __startTimestamp1475066032849__endTimestamp 05:33:52 INFO - PROCESS | 1661 | 05:33:52 INFO - PROCESS | 1661 | ------- Summary: start ------- 05:33:52 INFO - PROCESS | 1661 | Number of tests: 6 05:33:52 INFO - PROCESS | 1661 | 05:33:52 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5598.74 Median:5745.83 stddev:624.96 (10.9%) stddev-sans-first:583.63 05:33:52 INFO - PROCESS | 1661 | Values: 2686.4 3285.7 3311.3 3345.7 3364.3 5403.7 5543.9 5569.3 5621.5 5640.5 5567.0 5589.3 5656.8 5666.1 5684.1 5026.4 5042.1 5063.8 5111.7 5126.4 5124.7 5211.2 5213.2 5219.3 5275.9 5194.6 5201.0 5201.2 5214.4 5249.5 5011.2 5071.5 5077.4 5087.8 5096.6 5091.9 5100.1 5115.9 5134.1 5192.6 5564.7 5566.2 5610.8 5616.1 5639.6 5784.2 5796.7 5834.7 6088.8 6091.6 6057.4 6077.9 6136.1 6141.6 6150.7 5656.8 5658.7 5668.2 5680.3 5695.1 6120.9 6170.3 6243.5 6260.5 6272.9 5073.6 5866.9 5913.3 5936.5 5982.2 6122.4 6125.5 6139.1 6143.0 6149.4 5996.8 6061.7 6074.4 6100.6 6115.5 5827.7 5857.8 5858.3 5932.6 6127.6 4768.6 4770.9 4773.5 4776.4 4781.7 4254.6 4299.7 4386.2 4391.9 4393.7 5458.2 5485.4 5523.8 5528.7 5529.9 5985.9 6007.1 6018.5 6019.1 6046.9 5564.4 5615.4 5635.7 5679.9 5699.4 5253.8 5262.4 5280.4 5280.5 5299.0 6249.3 6274.8 6278.9 6287.6 6294.6 6016.9 6048.9 6052.8 6138.7 6158.3 6166.8 6213.8 6232.1 6267.8 6276.5 6032.5 6054.9 6058.6 6062.1 6085.9 5962.1 5977.5 6109.1 6145.4 6150.4 5817.2 5884.5 5885.6 5895.4 5896.5 5829.6 5836.6 5848.5 5851.5 5858.9 5567.6 5695.7 5714.5 5745.8 5759.2 5870.4 5880.0 5886.4 5888.9 5888.9 5537.7 5705.3 5723.1 5774.3 5802.2 05:33:52 INFO - PROCESS | 1661 | 05:33:52 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:65906.11 Median:38216.93 stddev:140714.34 (368.2%) stddev-sans-first:141023.30 05:33:52 INFO - PROCESS | 1661 | Values: 466.8 470.7 487.2 525.0 525.0 29290.9 38576.0 39394.0 39667.0 41990.8 41594.6 42031.8 42061.4 42085.4 42184.6 8655.0 9694.6 9838.3 9849.2 9864.4 8647.3 8832.3 8852.7 8858.9 11719.0 11707.2 11938.9 11967.2 11970.8 12042.0 11792.6 11877.0 11890.0 11891.5 11965.3 8640.2 8857.0 8877.6 11657.0 11771.2 31531.7 31928.5 38203.4 38730.4 38746.8 3177.0 3305.5 3389.9 3433.4 3690.2 30317.5 30318.2 30553.5 30601.8 31310.8 3142.9 3176.1 3212.0 3234.4 3277.9 440362.0 448353.0 449373.0 449555.0 457049.0 55109.4 55357.0 55369.7 55432.4 55472.4 50069.0 50848.5 57058.6 58023.4 58143.8 15139.8 15264.9 15287.8 15293.6 15299.7 11742.6 11855.5 11861.2 11867.4 11884.9 13483.7 13686.0 13700.3 14840.2 15115.8 6329.4 6387.6 6464.8 6549.8 6560.5 799.0 875.6 910.8 918.9 1022.6 23447.3 29187.6 29191.4 29638.0 29998.6 972.2 997.7 1037.2 1056.1 1164.3 13247.8 14741.1 15412.8 15433.8 15536.8 560673.0 573079.0 573807.0 574175.0 575096.0 55058.4 55213.9 55248.0 55280.0 55379.3 1311.6 1350.8 1368.0 1371.9 1372.4 24774.6 28632.4 29169.6 29613.9 29774.0 47772.5 47943.3 47995.3 48082.5 48111.8 552350.0 555036.0 555356.0 555360.0 555425.0 35426.6 39355.4 39372.0 39592.0 39604.8 37822.6 44075.8 45259.3 45263.8 45452.0 37460.9 37667.6 38240.0 38633.2 39014.8 37579.4 37763.1 38444.0 38686.4 39745.6 36983.0 37615.6 38074.6 38128.4 38230.4 32575.0 33201.7 34048.7 34267.3 34396.3 24468.0 25033.9 25170.4 25591.6 25601.8 05:33:52 INFO - PROCESS | 1661 | 05:33:52 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:33567.58 Median:369.59 stddev:94204.12 (25488.7%) stddev-sans-first:94435.37 05:33:52 INFO - PROCESS | 1661 | Values: 348.5 368.5 370.7 377.7 397.8 15016.2 15195.8 16083.9 20077.9 20680.6 19422.9 20281.8 20412.4 20512.9 20655.6 5217.3 5827.4 6100.8 6109.4 6115.6 5409.6 6045.3 6112.3 6114.8 6116.0 5791.2 5958.8 6053.5 6062.2 6065.5 5939.7 5979.3 5984.2 5987.1 5992.3 4994.6 5000.8 5212.6 5276.4 5295.3 25558.6 26207.9 26240.1 26313.2 26590.6 1897.4 2003.8 2333.5 2382.7 2432.7 9815.5 10042.8 10243.6 10430.7 10498.1 1623.6 1864.7 1939.8 1942.5 1943.9 122484.0 125961.0 127013.7 127499.6 128390.0 11280.4 11377.4 11393.3 11485.5 11666.9 14246.6 14250.6 14258.9 14268.7 14274.9 6622.5 8269.2 8293.1 8310.8 8449.5 8124.0 8130.8 8283.5 8294.6 8304.2 3732.0 4359.8 4455.1 4461.3 4544.9 1498.5 1848.5 1873.0 1937.2 1937.7 763.8 844.5 918.2 951.6 958.8 20093.1 21170.8 21582.8 21587.0 21742.6 913.8 914.8 923.2 944.5 1017.8 10510.4 11252.8 11259.5 11265.9 11290.2 489739.0 574725.0 575489.0 584216.1 587747.0 88137.0 93846.1 106310.5 125928.0 134028.0 848.3 871.8 941.8 944.2 945.3 15477.8 19205.0 19242.2 19252.9 19419.4 53691.5 54806.0 54888.5 56322.0 56699.7 68318.0 68816.7 70167.3 78444.8 81823.6 7998.1 8120.2 8251.1 8268.8 8318.3 11692.4 12833.4 12837.7 13344.4 13391.5 11047.4 11090.6 11461.4 11541.3 11608.2 8462.6 9075.5 10810.0 11370.4 11655.4 11566.7 11680.1 11826.0 11844.8 12038.3 6157.7 7145.7 7448.9 7630.2 8431.6 9050.4 9703.7 10764.4 11079.6 11566.8 05:33:52 INFO - PROCESS | 1661 | 05:33:52 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5599.51 Median:4957.57 stddev:3129.75 (63.1%) stddev-sans-first:3121.84 05:33:52 INFO - PROCESS | 1661 | Values: 1299.8 1514.3 1648.8 1869.6 1908.4 8371.8 8910.3 8913.7 8917.6 8918.6 6952.3 7754.3 8081.3 8099.0 8660.4 2338.2 2372.6 2375.0 2375.7 2380.0 2326.1 2337.5 2372.8 2373.3 2377.8 2359.9 2372.2 2373.5 2388.9 2390.6 2065.2 2329.9 2331.5 2363.1 2396.2 2354.8 2355.4 2359.1 2359.4 2361.4 7458.7 8774.4 8781.2 8853.5 8854.5 5060.8 5294.1 5299.3 5302.2 5303.7 3395.1 3601.6 3639.3 3663.3 3665.3 1048.8 1081.1 1088.6 1095.7 1106.3 11510.1 11559.1 11577.1 11577.4 11585.7 4454.5 4538.3 4708.4 4724.2 4736.6 9751.3 9865.7 9866.4 9867.8 9867.9 4540.2 5234.7 5284.1 5293.7 5311.4 3604.7 4341.1 4498.0 4818.8 4845.7 3515.0 3598.2 3830.2 3911.9 3937.7 1105.4 1216.2 1261.5 1281.6 1284.7 726.9 811.9 889.1 903.3 944.2 5297.3 5794.4 5910.9 5921.6 6023.8 905.6 935.5 950.9 954.0 991.9 3774.4 3784.6 3855.8 3881.0 3938.8 10297.5 10536.6 10680.4 10707.8 10714.1 9362.6 10438.9 10445.1 10624.6 10641.7 7672.8 7873.4 7879.2 7880.6 7882.4 5565.1 5600.6 5745.3 5879.9 5913.2 9696.4 9949.5 10005.4 10008.2 10013.6 9487.7 9915.2 9919.3 10080.7 10084.6 6809.0 7020.6 7041.5 7427.4 7608.1 7627.7 7735.0 7827.6 8103.5 8232.7 7303.9 7409.7 7451.1 7510.9 7571.4 7232.3 7271.7 7283.1 7312.7 7438.3 6818.3 6819.2 6921.9 6970.6 6980.1 4892.5 4936.9 4969.0 4988.8 5064.1 4812.2 4919.1 4932.0 4946.1 5142.0 05:33:52 INFO - PROCESS | 1661 | 05:33:52 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:4128.79 Median:4439.79 stddev:1301.49 (29.3%) stddev-sans-first:1272.87 05:33:52 INFO - PROCESS | 1661 | Values: 291.3 299.9 306.6 314.3 316.3 4144.6 4988.8 5133.8 5175.2 5218.5 4550.8 5059.3 5129.6 5171.1 5177.8 2988.6 3194.8 3591.6 3700.2 4052.5 3307.4 3971.4 3991.8 4031.7 4042.6 2836.4 3259.6 3681.8 3722.2 3901.7 3573.9 3937.2 3962.7 3969.6 3980.9 2869.3 3273.3 3470.4 3475.5 3488.1 4726.2 5076.4 5080.0 5094.3 5103.3 3724.5 3802.9 4463.4 4469.6 4479.8 5446.3 5488.4 5506.2 5510.4 5569.7 2895.7 2953.9 3761.3 3766.9 3771.5 5368.7 5448.8 5598.6 5716.0 5749.6 3645.7 3694.2 3770.7 3790.4 3798.9 3519.8 3819.2 3826.1 3838.2 3846.2 3676.2 4162.4 4464.2 4475.2 4477.4 5302.7 5405.2 5483.7 5501.9 5517.7 1284.0 1306.7 1306.9 1311.4 1313.2 687.5 750.7 791.7 807.8 808.9 3860.4 3902.0 3906.6 4109.3 4121.2 4037.6 4607.4 4661.8 4665.4 4692.5 3757.3 4046.7 4048.9 4107.5 4289.8 2046.4 2067.9 2250.6 2391.9 2494.0 4726.9 4771.4 4777.8 4810.6 4828.0 3871.0 4051.9 4779.7 4799.4 4802.0 4260.6 4336.9 4783.7 4802.4 4873.7 3751.5 4160.7 4619.9 4652.8 4679.2 3700.4 3934.6 3961.0 3963.5 4562.7 4191.4 4295.4 4416.2 4875.5 4935.5 3270.7 3743.4 3764.9 3769.5 3789.4 4747.3 5638.8 5682.3 5693.7 5697.0 4947.8 5168.0 5496.8 5502.9 5513.9 5457.6 5522.7 5536.7 5562.6 5660.9 5368.8 5410.5 5470.9 5473.6 5494.3 4399.9 4609.4 5288.6 5542.9 5553.8 4375.8 5010.9 5437.9 5446.8 5580.7 05:33:52 INFO - PROCESS | 1661 | 05:33:52 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:24220.82 Median:4373.64 stddev:38923.96 (890.0%) stddev-sans-first:38993.12 05:33:52 INFO - PROCESS | 1661 | Values: 708.6 718.1 768.6 794.2 813.6 15651.5 15896.9 15924.3 15940.3 15942.6 14251.3 14359.3 14364.7 14376.1 14794.7 685.9 703.9 704.6 835.2 843.7 700.7 852.4 853.2 853.3 853.4 897.4 901.4 902.6 903.7 907.5 716.5 731.7 895.8 896.4 901.3 650.2 663.6 663.7 666.1 667.3 14960.0 15018.5 15023.0 15031.1 15098.3 13451.4 13631.9 13751.4 13931.4 14216.9 10270.8 12664.9 12717.8 12720.3 12867.5 4506.3 4531.4 4543.3 4674.8 4786.9 116441.3 116524.0 116566.0 116597.0 116913.0 10503.4 10653.3 10768.9 10896.7 11243.7 21566.5 21566.9 21583.4 21586.9 21600.9 7819.2 8076.4 8097.6 8108.1 8124.8 4223.1 4362.1 4385.2 4425.4 4563.5 3425.8 3480.2 3504.8 3540.5 3546.2 644.4 647.0 659.2 666.7 668.7 500.7 539.6 540.7 552.6 617.6 8796.5 9030.0 9138.2 9172.8 9356.3 515.9 547.3 616.4 631.5 641.4 4299.0 4329.7 4346.9 4396.3 4462.9 92706.0 92816.0 106564.9 114762.4 158951.0 124054.0 137163.3 140262.0 141548.0 144573.3 112411.4 118982.0 120759.0 121451.0 124456.4 8587.9 8597.5 8599.1 8693.7 8836.9 53332.5 56490.0 62210.7 63949.4 65259.7 84248.0 92205.0 93374.0 96329.5 97205.0 9803.0 10769.9 11638.2 11905.0 12118.8 12167.0 12206.5 12281.7 12784.4 12897.8 11849.9 11982.2 12039.9 12413.4 12453.5 11703.9 12018.3 12094.9 12142.7 12429.9 11654.4 11751.0 11883.4 12002.0 12272.6 9734.6 9785.0 10026.1 10239.9 10365.0 7599.3 8854.5 9866.3 9997.9 10068.0 05:33:52 INFO - PROCESS | 1661 | -------- Summary: end -------- 05:33:52 INFO - PROCESS | 1661 | 05:33:53 INFO - TEST-INFO | 1661: exit 0 05:33:53 INFO - TEST-OK | dromaeo_css | took 1118226ms 05:33:53 INFO - TEST-START | kraken 05:33:53 INFO - operating with platform_type : mac_ 05:33:53 INFO - Initialising browser for kraken test... 05:33:53 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmpI5VO5N/profile http://localhost:49273/getInfo.html) 05:33:55 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 05:33:55 INFO - PROCESS | 1668 | colorDepth:24 05:33:55 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 05:33:55 INFO - PROCESS | 1668 | __metrics 05:33:55 INFO - PROCESS | 1668 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:33:55 INFO - PROCESS | 1668 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:33:56 INFO - TEST-INFO | 1668: exit 0 05:33:56 INFO - Browser initialized. 05:33:56 INFO - Running cycle 1/1 for kraken test... 05:33:56 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/tmpI5VO5N/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:08 INFO - PROCESS | 1669 | RSS: Main: 235970560 05:34:08 INFO - PROCESS | 1669 | 05:34:11 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 05:34:12 INFO - PROCESS | 1669 | RSS: Main: 294522880 05:34:12 INFO - PROCESS | 1669 | 05:34:14 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 05:34:15 INFO - PROCESS | 1669 | RSS: Main: 293441536 05:34:15 INFO - PROCESS | 1669 | 05:34:18 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 05:34:19 INFO - PROCESS | 1669 | RSS: Main: 385851392 05:34:19 INFO - PROCESS | 1669 | 05:34:21 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 05:34:22 INFO - PROCESS | 1669 | RSS: Main: 286097408 05:34:22 INFO - PROCESS | 1669 | 05:34:24 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:34:24 INFO - PROCESS | 1669 | RSS: Main: 288841728 05:34:24 INFO - PROCESS | 1669 | 05:34:27 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 05:34:28 INFO - PROCESS | 1669 | RSS: Main: 326492160 05:34:28 INFO - PROCESS | 1669 | 05:34:31 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 05:34:31 INFO - PROCESS | 1669 | RSS: Main: 327684096 05:34:31 INFO - PROCESS | 1669 | 05:34:34 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 05:34:35 INFO - PROCESS | 1669 | RSS: Main: 326000640 05:34:35 INFO - PROCESS | 1669 | 05:34:36 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:34:37 INFO - PROCESS | 1669 | RSS: Main: 300576768 05:34:37 INFO - PROCESS | 1669 | 05:34:39 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:34:39 INFO - PROCESS | 1669 | RSS: Main: 304848896 05:34:39 INFO - PROCESS | 1669 | 05:34:42 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:34:42 INFO - PROCESS | 1669 | RSS: Main: 310038528 05:34:42 INFO - PROCESS | 1669 | 05:34:45 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:34:46 INFO - PROCESS | 1669 | RSS: Main: 316751872 05:34:46 INFO - PROCESS | 1669 | 05:34:49 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:34:50 INFO - PROCESS | 1669 | RSS: Main: 318648320 05:34:50 INFO - PROCESS | 1669 | 05:34:51 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 05:34:52 INFO - PROCESS | 1669 | RSS: Main: 361918464 05:34:52 INFO - PROCESS | 1669 | 05:34:52 INFO - PROCESS | 1669 | __start_tp_report 05:34:52 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 05:34:52 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 05:34:52 INFO - PROCESS | 1669 | |i|pagename|runs| 05:34:52 INFO - PROCESS | 1669 | |0;ai-astar;112;111;110;112;111;111;110;111;110;110 05:34:52 INFO - PROCESS | 1669 | |1;audio-beat-detection;171;97;128;178;116;141;137;140;136;108 05:34:52 INFO - PROCESS | 1669 | |2;audio-dft;183;181;183;182;183;183;180;183;184;182 05:34:52 INFO - PROCESS | 1669 | |3;audio-fft;82;83;59;87;60;59;64;62;89;76 05:34:52 INFO - PROCESS | 1669 | |4;audio-oscillator;90;58;90;91;98;99;127;68;70;89 05:34:52 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;88;92;89;87;87;87;92;88;89;88 05:34:52 INFO - PROCESS | 1669 | |6;imaging-darkroom;94;94;95;93;93;94;93;94;94;96 05:34:52 INFO - PROCESS | 1669 | |7;imaging-desaturate;84;83;84;84;86;84;83;86;105;134 05:34:52 INFO - PROCESS | 1669 | |8;json-parse-financial;57;56;53;53;53;54;55;55;55;54 05:34:52 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;65;71;68;77;73;69;69;71;71;69 05:34:52 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;88;89;84;88;86;84;82;89;85;86 05:34:52 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;142;147;159;151;139;136;159;158;244;140 05:34:52 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;167;168;165;168;170;176;235;206;168;169 05:34:52 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;70;72;84;89;86;71;67;68;67;67 05:34:52 INFO - PROCESS | 1669 | __end_tp_report 05:34:52 INFO - PROCESS | 1669 | __start_cc_report 05:34:52 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1940 05:34:52 INFO - PROCESS | 1669 | __end_cc_report 05:34:52 INFO - PROCESS | 1669 | __startTimestamp1475066092248__endTimestamp 05:34:52 INFO - PROCESS | 1669 | 05:34:52 INFO - PROCESS | 1669 | ------- Summary: start ------- 05:34:52 INFO - PROCESS | 1669 | Number of tests: 14 05:34:52 INFO - PROCESS | 1669 | 05:34:52 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:110.80 Median:111.00 stddev:0.79 (0.7%) stddev-sans-first:0.71 05:34:52 INFO - PROCESS | 1669 | Values: 112.0 111.0 110.0 112.0 111.0 111.0 110.0 111.0 110.0 110.0 05:34:52 INFO - PROCESS | 1669 | 05:34:52 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:140.50 stddev:25.37 (18.1%) stddev-sans-first:23.37 05:34:52 INFO - PROCESS | 1669 | Values: 171.0 97.0 128.0 178.0 116.0 141.0 137.0 140.0 136.0 108.0 05:34:52 INFO - PROCESS | 1669 | 05:34:52 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:182.40 Median:183.00 stddev:1.17 (0.6%) stddev-sans-first:1.22 05:34:52 INFO - PROCESS | 1669 | Values: 183.0 181.0 183.0 182.0 183.0 183.0 180.0 183.0 184.0 182.0 05:34:52 INFO - PROCESS | 1669 | 05:34:52 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:72.10 Median:79.00 stddev:12.46 (15.8%) stddev-sans-first:12.69 05:34:52 INFO - PROCESS | 1669 | Values: 82.0 83.0 59.0 87.0 60.0 59.0 64.0 62.0 89.0 76.0 05:34:52 INFO - PROCESS | 1669 | 05:34:52 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:88.00 Median:90.00 stddev:19.39 (21.5%) stddev-sans-first:20.55 05:34:52 INFO - PROCESS | 1669 | Values: 90.0 58.0 90.0 91.0 98.0 99.0 127.0 68.0 70.0 89.0 05:34:52 INFO - PROCESS | 1669 | 05:34:52 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:88.70 Median:88.50 stddev:1.89 (2.1%) stddev-sans-first:1.99 05:34:52 INFO - PROCESS | 1669 | Values: 88.0 92.0 89.0 87.0 87.0 87.0 92.0 88.0 89.0 88.0 05:34:52 INFO - PROCESS | 1669 | 05:34:52 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:94.00 Median:94.00 stddev:0.94 (1.0%) stddev-sans-first:1.00 05:34:52 INFO - PROCESS | 1669 | Values: 94.0 94.0 95.0 93.0 93.0 94.0 93.0 94.0 94.0 96.0 05:34:52 INFO - PROCESS | 1669 | 05:34:52 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:91.30 Median:84.00 stddev:16.39 (19.5%) stddev-sans-first:17.17 05:34:52 INFO - PROCESS | 1669 | Values: 84.0 83.0 84.0 84.0 86.0 84.0 83.0 86.0 105.0 134.0 05:34:52 INFO - PROCESS | 1669 | 05:34:52 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:54.50 Median:55.00 stddev:1.35 (2.5%) stddev-sans-first:1.09 05:34:52 INFO - PROCESS | 1669 | Values: 57.0 56.0 53.0 53.0 53.0 54.0 55.0 55.0 55.0 54.0 05:34:52 INFO - PROCESS | 1669 | 05:34:52 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:71.00 stddev:3.20 (4.5%) stddev-sans-first:2.76 05:34:52 INFO - PROCESS | 1669 | Values: 65.0 71.0 68.0 77.0 73.0 69.0 69.0 71.0 71.0 69.0 05:34:52 INFO - PROCESS | 1669 | 05:34:52 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:87.00 stddev:2.38 (2.7%) stddev-sans-first:2.42 05:34:52 INFO - PROCESS | 1669 | Values: 88.0 89.0 84.0 88.0 86.0 84.0 82.0 89.0 85.0 86.0 05:34:52 INFO - PROCESS | 1669 | 05:34:52 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:157.50 Median:154.50 stddev:31.61 (20.5%) stddev-sans-first:33.02 05:34:52 INFO - PROCESS | 1669 | Values: 142.0 147.0 159.0 151.0 139.0 136.0 159.0 158.0 244.0 140.0 05:34:52 INFO - PROCESS | 1669 | 05:34:52 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.20 Median:169.50 stddev:22.99 (13.6%) stddev-sans-first:23.96 05:34:52 INFO - PROCESS | 1669 | Values: 167.0 168.0 165.0 168.0 170.0 176.0 235.0 206.0 168.0 169.0 05:34:52 INFO - PROCESS | 1669 | 05:34:52 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.10 Median:71.50 stddev:8.70 (12.2%) stddev-sans-first:9.10 05:34:52 INFO - PROCESS | 1669 | Values: 70.0 72.0 84.0 89.0 86.0 71.0 67.0 68.0 67.0 67.0 05:34:52 INFO - PROCESS | 1669 | -------- Summary: end -------- 05:34:52 INFO - PROCESS | 1669 | 05:34:53 INFO - TEST-INFO | 1669: exit 0 05:34:53 INFO - TEST-OK | kraken | took 59606ms 05:34:53 INFO - SUITE-END | took 1177s 05:34:53 INFO - Completed test suite (00:19:38) 05:34:53 INFO - javascript benchmark 05:34:53 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2686.435848471821, 3285.737141028718, 3311.2880730642905, 3345.665433456656, 3364.3103163851415, 5403.675779453226, 5543.944560554393, 5569.331680198372, 5621.494065534106, 5640.520555752756, 5567.025770490169, 5589.273394458724, 5656.773729050833, 5666.065099258617, 5684.118961560965, 5026.396832380119, 5042.117629414856, 5063.822766203184, 5111.744412779365, 5126.436092029874, 5124.743762811863, 5211.218317252424, 5213.191955246943, 5219.269302297681, 5275.86810329741, 5194.610404219661, 5201.0, 5201.219817027439, 5214.426413094557, 5249.527542521172, 5011.223260394645, 5071.46749591295, 5077.441481437076, 5087.771050302708, 5096.61775366849, 5091.949080509185, 5100.081985242655, 5115.923261151086, 5134.0758663440565, 5192.636515443921, 5564.693941833198, 5566.165075238706, 5610.803621873215, 5616.073347897592, 5639.6334238274385, 5784.161296611967, 5796.710164491758, 5834.737436815353, 6088.786892458743, 6091.634501929899, 6057.42454466825, 6077.9392206078255, 6136.127537158367, 6141.587434890001, 6150.66171360575, 5656.830295091154, 5658.74535645897, 5668.234788303526, 5680.289963754531, 5695.088785794253, 6120.908186377119, 6170.259568851767, 6243.500519958392, 6260.46786023184, 6272.905906411407, 5073.568746656576, 5866.911996320058, 5913.2608423947, 5936.5250779937505, 5982.162497250389, 6122.418445057339, 6125.540694081788, 6139.1146161305005, 6143.017117261216, 6149.370416839541, 5996.820095397145, 6061.666608336495, 6074.362191969868, 6100.550895826113, 6115.4801841843055, 5827.737751801179, 5857.765689372377, 5858.326292476335, 5932.614380065282, 6127.571070025056, 4768.61851051915, 4770.880727981758, 4773.546513081252, 4776.426828780569, 4781.6891902026255, 4254.617084462413, 4299.656027517791, 4386.188555117314, 4391.912161756747, 4393.7363758174615, 5458.181272809031, 5485.369182543979, 5523.806666766724, 5528.695921724263, 5529.889402211933, 5985.910211346833, 6007.098935159674, 6018.518518518508, 6019.097135429721, 6046.879062418727, 5564.415736347706, 5615.382307946123, 5635.746391412315, 5679.943200568024, 5699.373068962411, 5253.789848406097, 5262.394824595144, 5280.445553216857, 5280.471952804689, 5299.0, 6249.281332646804, 6274.780382686584, 6278.905816412757, 6287.622742635456, 6294.590851594723, 6016.939830601638, 6048.879022419439, 6052.788152414821, 6138.662373569318, 6158.291796443287, 6166.784162554469, 6213.782517611862, 6232.065190221503, 6267.780627678009, 6276.497880169667, 6032.457078862748, 6054.939450605614, 6058.636481811105, 6062.090686397076, 6085.939140608714, 5962.07587823888, 5977.521798256216, 6109.083637454418, 6145.385461453819, 6150.354212807591, 5817.185594016925, 5884.529237661062, 5885.588008839341, 5895.380984996686, 5896.528277737856, 5829.59192856496, 5836.620619659709, 5848.473637372657, 5851.502622277154, 5858.94141058584, 5567.582431317748, 5695.715214239354, 5714.514266287412, 5745.827625171251, 5759.193712880284, 5870.412958704095, 5880.029795083763, 5886.440788125121, 5888.852778680567, 5888.941110588839, 5537.695426751407, 5705.343885453226, 5723.055695810144, 5774.335951365647, 5802.187693722966], "value": 5557.664583495859, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [466.8236045166181, 470.7340352700724, 487.1888305970559, 524.9790008399665, 525.0417987173407, 29290.85354573227, 38576.0, 39393.99999999996, 39667.0, 41990.790046049806, 41594.58405415945, 42031.78984105091, 42061.36907946376, 42085.36871946923, 42184.57815421853, 8655.0, 9694.612215511406, 9838.311318207729, 9849.16282116021, 9864.408135511856, 8647.264982476465, 8832.337574681893, 8852.690155844546, 8858.867116993219, 11719.0, 11707.180497365187, 11938.940305298462, 11967.22213056153, 11970.82043769344, 12041.97643200329, 11792.646220613353, 11877.049836013099, 11890.048796096335, 11891.464884080237, 11965.282083074957, 8640.17918297767, 8857.0, 8877.600507977157, 11657.0, 11771.23486973344, 31531.684683153104, 31928.521072183936, 38203.42694859579, 38730.41904371437, 38746.80626596849, 3176.9841150794327, 3305.5041743738393, 3389.86440542378, 3433.3819912415756, 3690.2066055797864, 30317.545236821465, 30318.242043948856, 30553.541696874563, 30601.846990764905, 31310.843445782626, 3142.874285028596, 3176.126565194567, 3211.96788032119, 3234.3531293741344, 3277.918052048694, 440362.0, 448353.0, 449373.0, 449555.0, 457049.0, 55109.448905510435, 55357.0, 55369.72315138399, 55432.44567554354, 55472.44527554673, 50069.0, 50848.491515085116, 57058.58238428977, 58023.419765802646, 58143.8371232573, 15139.848601514064, 15264.855135864855, 15287.770683439758, 15293.6176595586, 15299.694006119815, 11742.647720568397, 11855.525778968917, 11861.229020113666, 11867.406629668481, 11884.88115118855, 13483.730325393633, 13686.0, 13700.314984250748, 14840.183789891444, 15115.773263401057, 6329.4303512683155, 6387.552871299057, 6464.838379040561, 6549.803505894831, 6560.540762146699, 798.9920100799034, 875.5884734174928, 910.8314961732101, 918.903515130915, 1022.5807418958192, 23447.296581102593, 29187.56218656722, 29191.416171676447, 29638.0, 29998.550021749692, 972.1687956796978, 997.7106639074732, 1037.190991027, 1056.0653821368144, 1164.2897832322276, 13247.801282980763, 14741.115533067836, 15412.768808467881, 15433.768493472608, 15536.83473739474, 560673.0, 573079.0, 573807.0, 574175.0, 575096.0, 55058.44941550533, 55213.89572208533, 55248.0, 55280.0, 55379.33861984147, 1311.6392991927296, 1350.8108864758942, 1368.0423703407455, 1371.91082579632, 1372.3961456959105, 24774.628380574668, 28632.427351453272, 29169.56245656359, 29613.85193074021, 29774.0, 47772.522274778195, 47943.287939687776, 47995.280070799665, 48082.51917480781, 48111.75944120257, 552350.0, 555036.0, 555356.0, 555360.0, 555425.0, 35426.645733543366, 39355.409668854416, 39372.0, 39592.0, 39604.80197598993, 37822.62177378301, 44075.77962110169, 45259.321110184035, 45263.77368113138, 45452.0, 37460.87617371483, 37667.623323767504, 38240.04399890025, 38633.227335453696, 39014.82955511339, 37579.436308454846, 37763.05592360213, 38444.0, 38686.419703703905, 39745.60254397535, 36983.0, 37615.6238437623, 38074.619253807105, 38128.42807357836, 38230.42654360131, 32575.0, 33201.66798331986, 34048.65951340554, 34267.314653706286, 34396.31207375888, 24468.0, 25033.87483062573, 25170.370740730894, 25591.616125757755, 25601.809413733652], "value": 19498.880448991695, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.51034296812986, 368.4914817551778, 370.6923253699428, 377.694067805078, 397.8050755129987, 15016.24918754062, 15195.84804151958, 16083.919580402111, 20077.899610501965, 20680.586388272262, 19422.892337226047, 20281.797182028175, 20412.387628371136, 20512.897435512838, 20655.586888262227, 5217.269582258468, 5827.446392592697, 6100.755969761204, 6109.389061093877, 6115.571909966304, 5409.6213265071465, 6045.304789949146, 6112.327643959161, 6114.785982490614, 6115.969420152893, 5791.247137872092, 5958.79144229952, 6053.545984051192, 6062.181605483247, 6065.514758819284, 5939.732712027948, 5979.312379076418, 5984.192134061933, 5987.072003839412, 5992.310884248323, 4994.575461085812, 5000.82497112603, 5212.58299336056, 5276.419593844674, 5295.338082739658, 25558.616620750705, 26207.868960655265, 26240.0815971442, 26313.21060368192, 26590.6011409829, 1897.3643829317057, 2003.8096380843797, 2333.49829786595, 2382.6783384243076, 2432.7323994360604, 9815.460149691764, 10042.849357259647, 10243.641472548425, 10430.739231519197, 10498.055175034207, 1623.62656588984, 1864.683003889342, 1939.7963213862483, 1942.5435022769639, 1943.8542109341856, 122484.0, 125961.0, 127013.72986270112, 127499.61254068375, 128390.0, 11280.435978201058, 11377.431128443544, 11393.316401015965, 11485.483153257956, 11666.941665291619, 14246.572602821932, 14250.643733906736, 14258.928705356408, 14268.714625707635, 14274.929380296519, 6622.503312251601, 8269.173082691683, 8293.087760346358, 8310.8337833243, 8449.450785699033, 8124.0, 8130.75607731769, 8283.461574997606, 8294.626741796634, 8304.211099945496, 3731.9813400933363, 4359.760213188241, 4455.131249406335, 4461.286194208911, 4544.931826022612, 1498.4755335632442, 1848.4824249210242, 1873.0353867758115, 1937.1766999025358, 1937.7190307405347, 763.8434121005181, 844.5397258494136, 918.191991047887, 951.6336210558985, 958.8226178157063, 20093.091156340124, 21170.78829211719, 21582.78417215839, 21587.0, 21742.565148697253, 913.7578541686458, 914.7713071732067, 923.2244914272044, 944.4994153098869, 1017.7710015246658, 10510.369377837202, 11252.774944501065, 11259.493322800494, 11265.887341126483, 11290.209685321948, 489739.0, 574725.0, 575489.0, 584216.0789196027, 587747.0, 88137.0, 93846.0615393851, 106310.46844765727, 125928.0, 134028.0, 848.2747251100344, 871.847426700325, 941.7833898203452, 944.15026476172, 945.2910317262053, 15477.767833482732, 19205.0, 19242.23031078797, 19252.94108823972, 19419.4174174775, 53691.46308537021, 54806.0, 54888.45111548834, 56322.0, 56699.71650141723, 68318.0, 68816.6559167221, 70167.29832701811, 78444.82332765128, 81823.5908820452, 7998.080220774686, 8120.187981201832, 8251.092379838334, 8268.83462330762, 8318.292945099734, 11692.35692036946, 12833.42249598789, 12837.743245135232, 13344.399502022627, 13391.531296404579, 11047.392393418439, 11090.611828585961, 11461.36962467039, 11541.307521548399, 11608.24546404481, 8462.603670394315, 9075.54622268897, 10809.973052559993, 11370.431478426211, 11655.358955257543, 11566.710832229262, 11680.123990700562, 11825.994790442564, 11844.822327665264, 12038.337891416057, 6157.72290246931, 7145.714171433085, 7448.925510744823, 7630.198829122862, 8431.578421078799, 9050.411723238232, 9703.708888733348, 10764.3541387517, 11079.556817727524, 11566.826497602711], "value": 9359.619853726921, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1299.8375203099615, 1514.3412615512252, 1648.7526870969352, 1869.5699989002537, 1908.3606991657794, 8371.790705232364, 8910.331725120617, 8913.68802091927, 8917.643294268222, 8918.554072296392, 6952.2700116487795, 7754.302112809846, 8081.313088387494, 8098.959505202481, 8660.437071590342, 2338.24007197661, 2372.5729368713623, 2374.95250094998, 2375.6911601491784, 2379.988100059506, 2326.1044497868274, 2337.497438050819, 2372.8457650252763, 2373.264288070695, 2377.762223777626, 2359.9410014749596, 2372.229025566689, 2373.501564671421, 2388.880555972203, 2390.5577468168444, 2065.2152182170753, 2329.94175145621, 2331.4870728439714, 2363.078399424226, 2396.1852969990287, 2354.8469349492398, 2355.3522781235297, 2359.127122964497, 2359.433735903388, 2361.374235827507, 7458.664360103809, 8774.429662072009, 8781.165789250012, 8853.468791872509, 8854.513001784899, 5060.84817455477, 5294.126469132589, 5299.311089558333, 5302.231176479428, 5303.7082960437165, 3395.1002984209204, 3601.621829707869, 3639.290338384016, 3663.322285377187, 3665.2852693724735, 1048.8374301983206, 1081.1026847716375, 1088.6189833558271, 1095.6548687163518, 1106.3140852671315, 11510.079193664487, 11559.075273978062, 11577.131715121399, 11577.363245021435, 11585.710357241052, 4454.532274111237, 4538.319252112144, 4708.411448568929, 4724.173269677862, 4736.573708366263, 9751.317407781387, 9865.704028879145, 9866.408015519091, 9867.802643947081, 9867.851982220272, 4540.205464043779, 5234.717494213942, 5284.075286824867, 5293.655912365684, 5311.362636483646, 3604.711623070148, 4341.110072435144, 4497.977510112429, 4818.759062046954, 4845.733484658307, 3514.9982255057184, 3598.208394153282, 3830.2339532093692, 3911.9217615647526, 3937.684985201177, 1105.3865104866716, 1216.1730023584048, 1261.4575732435142, 1281.641140480667, 1284.743051389726, 726.9127704675367, 811.8985126859143, 889.1242126505387, 903.3270213690843, 944.15026476172, 5297.284866543045, 5794.391588883191, 5910.911336329958, 5921.644701317935, 6023.849403764941, 905.6241659711278, 935.4901578639658, 950.9286803489766, 953.9618415263451, 991.9305648604673, 3774.4338349247832, 3784.6404591563755, 3855.7879316637855, 3880.963797650412, 3938.783366914847, 10297.485125743682, 10536.57853685844, 10680.412577308323, 10707.785844283226, 10714.089302409382, 9362.578683959238, 10438.895611043945, 10445.11216546602, 10624.575016999233, 10641.733956651145, 7672.769816905502, 7873.448858579959, 7879.212078792075, 7880.645370958206, 7882.369410447151, 5565.081761509306, 5600.551955843442, 5745.2818397700285, 5879.911801323069, 5913.172155898092, 9696.369735967139, 9949.452780096875, 10005.399676019462, 10008.199344052313, 10013.649522266685, 9487.715368538955, 9915.157211636802, 9919.305648604817, 10080.747981300527, 10084.647037353658, 6808.9659551701925, 7020.648967551704, 7041.471889608198, 7427.44294177928, 7608.125065617525, 7627.656755445907, 7735.0, 7827.647755850887, 8103.513789172668, 8232.670693172206, 7303.926960730325, 7409.666565004695, 7451.105867295742, 7510.924890751023, 7571.3942884568005, 7232.349088582053, 7271.745488907863, 7283.126024877049, 7312.670929808065, 7438.293362130589, 6818.31816818334, 6819.181698196248, 6921.8961715575315, 6970.581765094111, 6980.057692211486, 4892.510748925079, 4936.8765780855765, 4969.0, 4988.775505102207, 5064.113780088396, 4812.205986012269, 4919.139150648693, 4931.9753401232765, 4946.134426475424, 5142.0], "value": 4513.698098389502, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.31104936824414, 299.8695567428169, 306.6121356484047, 314.2959770114942, 316.26152932901675, 4144.647704945076, 4988.825391111312, 5133.818127295898, 5175.2053890898915, 5218.530332270095, 4550.817967281313, 5059.3169922060515, 5129.6409251352425, 5171.11254392147, 5177.767000484978, 2988.5965394671657, 3194.7923384980018, 3591.604923458424, 3700.243318727552, 4052.533958594755, 3307.4046671599103, 3971.4312846425787, 3991.840326386941, 4031.7177797554036, 4042.555318914932, 2836.3618185908213, 3259.5762550868353, 3681.7606855554436, 3722.236941427001, 3901.6683581895572, 3573.874229617662, 3937.1731936293413, 3962.7226094173275, 3969.642732154091, 3980.880573582768, 2869.268336574181, 3273.29624130813, 3470.410030294856, 3475.461303497962, 3488.075659950115, 4726.1879181886725, 5076.36545431821, 5079.968012794875, 5094.31226784383, 5103.311053007834, 3724.5158129443, 3802.923941521182, 4463.419755431773, 4469.553044695537, 4479.820807167709, 5446.346438427375, 5488.396276409591, 5506.201600767907, 5510.393856675762, 5569.693666848321, 2895.724906133914, 2953.9261518461994, 3761.322961866863, 3766.9058273543105, 3771.547414310273, 5368.731563421813, 5448.782048718086, 5598.552115830724, 5715.971420142872, 5749.597528172988, 3645.6901163400876, 3694.2057457646733, 3770.7171962102952, 3790.3556395412293, 3798.924021519554, 3519.806410647439, 3819.1788765415567, 3826.100866296418, 3838.1939792643857, 3846.1538461538416, 3676.191237927652, 4162.396452514368, 4464.15181115587, 4475.209916033613, 4477.395551600557, 5302.655327403783, 5405.162244836696, 5483.670979741229, 5501.944980550144, 5517.689386368227, 1284.0113112903011, 1306.6863952651486, 1306.9477220911247, 1311.4164196932463, 1313.1923866822026, 687.4946914018193, 750.6772088002102, 791.6635429942252, 807.7617102954642, 808.878668199763, 3860.4402361657403, 3902.0, 3906.570277269498, 4109.260333140063, 4121.155163191538, 4037.6164264394833, 4607.44710634726, 4661.790219440066, 4665.440147182359, 4692.533198823333, 3757.267332870119, 4046.656034237064, 4048.8785336439955, 4107.514953453177, 4289.7640629765665, 2046.4167712201952, 2067.9379618611465, 2250.6061439248065, 2391.916282930089, 2493.962590561143, 4726.905461890743, 4771.403574553181, 4777.761111944389, 4810.628970743322, 4827.972251654313, 3871.0, 4051.9392209116886, 4779.665423420397, 4799.3760811094335, 4801.975990120027, 4260.573942605839, 4336.891577710582, 4783.712977221308, 4802.399700037496, 4873.708467256109, 3751.549814022335, 4160.687948403821, 4619.930701039554, 4652.790624421841, 4679.157751604744, 3700.389435743072, 3934.586868378779, 3961.0493481564795, 3963.5243770746542, 4562.749048802348, 4191.392248124066, 4295.4201182839915, 4416.1609294233995, 4875.464228767927, 4935.4570997190995, 3270.738340932672, 3743.4384842273876, 3764.887053388403, 3769.4911186990503, 3789.389509458524, 4747.311639812277, 5638.830835074954, 5682.261306030189, 5693.718913244486, 5696.971515142398, 4947.777350019186, 5167.974160129175, 5496.7526461310135, 5502.9174562382395, 5513.9448605513435, 5457.5633949283165, 5522.696251706195, 5536.7231638418725, 5562.554995600423, 5660.915086273627, 5368.792021795065, 5410.513053825174, 5470.91793623104, 5473.644213126134, 5494.2582751329655, 4399.9120017598825, 4609.3777340060005, 5288.5769138469595, 5542.861428464321, 5553.750730953971, 4375.759333236702, 5010.899782004412, 5437.864053398538, 5446.754896029609, 5580.665160090408], "value": 3726.1362465409597, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.5500707051023, 718.0808565036751, 768.646422645583, 794.2414993681035, 813.6338647608574, 15651.530454086382, 15896.920515397407, 15924.283407246672, 15940.282687279072, 15942.601434964132, 14251.287435628228, 14359.282035898215, 14364.712705745878, 14376.137431754101, 14794.704105917903, 685.9074025006635, 703.8873780195145, 704.6371118873784, 835.2107258640588, 843.6794018273079, 700.7162099349746, 852.3862818770475, 853.2107800284742, 853.3216093205885, 853.4452605806214, 897.3808072430035, 901.4140808474478, 902.5848109869468, 903.6791938861708, 907.4555266839909, 716.527092119204, 731.7109741652017, 895.8477058900003, 896.4083704754863, 901.3465237702613, 650.187265917603, 663.6316844151543, 663.7179198840473, 666.0841343153164, 667.2626747444101, 14960.0, 15018.549443516602, 15023.0, 15031.098134111988, 15098.320575574126, 13451.394687239, 13631.913487294922, 13751.381187846471, 13931.442742290295, 14216.857831421657, 10270.794584108351, 12664.873351266462, 12717.809232861515, 12720.300383478905, 12867.485300587965, 4506.256467682829, 4531.43357080365, 4543.34121552373, 4674.813007479696, 4786.880327991793, 116441.2533812002, 116524.0, 116566.0, 116597.0, 116913.0, 10503.369797812156, 10653.296415475505, 10768.94615526933, 10896.727581810519, 11243.718907027389, 21566.460838478848, 21566.892165539073, 21583.352499425044, 21586.89206553957, 21600.891995540234, 7819.17898620648, 8076.353891688651, 8097.635606397726, 8108.067572229151, 8124.796880078045, 4223.092035212444, 4362.0839623679385, 4385.202067152452, 4425.35832304314, 4563.452385713736, 3425.828708564562, 3480.2343484433386, 3504.789712617251, 3540.504329393887, 3546.1843775931166, 644.3588629313863, 646.9676516174172, 659.1661548141604, 666.6866572710818, 668.7425341243656, 500.7020822610541, 539.6303532080537, 540.7377421950351, 552.5883217003358, 617.6263360666821, 8796.516191609395, 9029.954850225839, 9138.223251023604, 9172.816543669223, 9356.251499879992, 515.8504033830147, 547.3349879895945, 616.4328817487922, 631.5200447659812, 641.3970867384644, 4299.0, 4329.675274354436, 4346.9347959780625, 4396.296592545242, 4462.888427789331, 92706.0, 92816.0, 106564.93435065706, 114762.4261878702, 158951.0, 124054.0, 137163.31418343043, 140262.0, 141548.0, 144573.27713361365, 112411.4379428114, 118982.0, 120759.0, 121451.0, 124456.37771811083, 8587.914120858712, 8597.484150950962, 8599.097094804956, 8693.739187824376, 8836.916112828842, 53332.466675334304, 56490.0, 62210.68894655679, 63949.3605063962, 65259.67370163119, 84248.0, 92205.0, 93374.0, 96329.51835240779, 97205.0, 9802.950985245028, 10769.9461502692, 11638.243514171552, 11905.0, 12118.757624847278, 12167.0, 12206.450709717907, 12281.69295767613, 12784.424700888296, 12897.806532902201, 11849.940750296193, 11982.161248712855, 12039.939800300943, 12413.379331033231, 12453.501859925502, 11703.882961170279, 12018.278903265833, 12094.879051209728, 12142.692888351185, 12429.875701242872, 11654.359010254517, 11751.0, 11883.405829708307, 12002.039836812859, 12272.570460033856, 9734.610068709024, 9785.0, 10026.097651211427, 10239.948800255952, 10365.0, 7599.278068583476, 8854.513001784964, 9866.309358344846, 9997.900020999989, 10068.0], "value": 7532.313117958107, "unit": "score"}], "name": "dromaeo_css", "value": 7103.76151625633, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 111.0, 110.0, 112.0, 111.0, 111.0, 110.0, 111.0, 110.0, 110.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 97.0, 128.0, 178.0, 116.0, 141.0, 137.0, 140.0, 136.0, 108.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 181.0, 183.0, 182.0, 183.0, 183.0, 180.0, 183.0, 184.0, 182.0], "value": 182.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 59.0, 87.0, 60.0, 59.0, 64.0, 62.0, 89.0, 76.0], "value": 72.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 58.0, 90.0, 91.0, 98.0, 99.0, 127.0, 68.0, 70.0, 89.0], "value": 88.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 92.0, 89.0, 87.0, 87.0, 87.0, 92.0, 88.0, 89.0, 88.0], "value": 88.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 93.0, 93.0, 94.0, 93.0, 94.0, 94.0, 96.0], "value": 94.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 84.0, 84.0, 86.0, 84.0, 83.0, 86.0, 105.0, 134.0], "value": 91.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 56.0, 53.0, 53.0, 53.0, 54.0, 55.0, 55.0, 55.0, 54.0], "value": 54.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 68.0, 77.0, 73.0, 69.0, 69.0, 71.0, 71.0, 69.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 84.0, 88.0, 86.0, 84.0, 82.0, 89.0, 85.0, 86.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 147.0, 159.0, 151.0, 139.0, 136.0, 159.0, 158.0, 244.0, 140.0], "value": 157.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 168.0, 165.0, 168.0, 170.0, 176.0, 235.0, 206.0, 168.0, 169.0], "value": 179.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 72.0, 84.0, 89.0, 86.0, 71.0, 67.0, 68.0, 67.0, 67.0], "value": 74.1, "unit": "score"}], "name": "kraken", "value": 1484.1999999999998, "alertThreshold": 2.0}]} 05:34:53 INFO - Return code: 0 05:34:53 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:34:53 INFO - # TBPL SUCCESS # 05:34:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:34:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:34:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:34:53 INFO - 2016-09-28 05:34:53.574 screenresolution[1673:10551] starting screenresolution argv=screenresolution get 05:34:53 INFO - 2016-09-28 05:34:53.576 screenresolution[1673:10551] Display 0: 1600x1200x32@60 05:34:53 INFO - 2016-09-28 05:34:53.582 screenresolution[1674:10554] starting screenresolution argv=screenresolution list 05:34:53 INFO - Available Modes on Display 0 05:34:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:34:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:34:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:34:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:34:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:34:53 INFO - Intel Iris: 05:34:53 INFO - Chipset Model: Intel Iris 05:34:53 INFO - Type: GPU 05:34:53 INFO - Bus: Built-In 05:34:53 INFO - VRAM (Dynamic, Max): 1536 MB 05:34:53 INFO - Vendor: Intel (0x8086) 05:34:53 INFO - Device ID: 0x0a2e 05:34:53 INFO - Revision ID: 0x0009 05:34:53 INFO - Displays: 05:34:53 INFO - Display: 05:34:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:34:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:34:53 INFO - Display Serial Number: 1600x1200 60 05:34:53 INFO - Main Display: Yes 05:34:53 INFO - Mirror: Off 05:34:53 INFO - Online: Yes 05:34:53 INFO - Rotation: Supported 05:34:53 INFO - Return code: 0 05:34:53 INFO - Running post-action listener: _resource_record_post_action 05:34:53 INFO - [mozharness: 2016-09-28 12:34:53.826726Z] Finished run-tests step (success) 05:34:53 INFO - Running post-run listener: _resource_record_post_run 05:34:53 INFO - Total resource usage - Wall time: 1213s; CPU: 54.0%; Read bytes: 31108096; Write bytes: 709350912; Read time: 198; Write time: 1968 05:34:53 INFO - TinderboxPrint: CPU usage
53.6% 05:34:53 INFO - TinderboxPrint: I/O read bytes / time
31,108,096 / 198 05:34:53 INFO - TinderboxPrint: I/O write bytes / time
709,350,912 / 1,968 05:34:53 INFO - TinderboxPrint: CPU idle
2,250.8 (46.4%) 05:34:53 INFO - TinderboxPrint: CPU system
973.6 (20.1%) 05:34:53 INFO - TinderboxPrint: CPU user
1,629.3 (33.6%) 05:34:53 INFO - TinderboxPrint: Swap in / out
434,806,784 / 0 05:34:53 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 393191936; Write bytes: 387446784; Read time: 29332; Write time: 789 05:34:53 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 30182400; Write bytes: 299769344; Read time: 187; Write time: 1123 05:34:54 INFO - Running post-run listener: _upload_blobber_files 05:34:54 INFO - Blob upload gear active. 05:34:54 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:34:54 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:34:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:34:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:34:54 INFO - (blobuploader) - INFO - Open directory for files ... 05:34:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:34:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:34:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:34:55 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:34:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:34:55 INFO - (blobuploader) - INFO - Done attempting. 05:34:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:34:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:34:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:34:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:34:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:34:56 INFO - (blobuploader) - INFO - Done attempting. 05:34:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:34:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:34:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:34:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:34:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:34:58 INFO - (blobuploader) - INFO - Done attempting. 05:34:58 INFO - (blobuploader) - INFO - Iteration through files over. 05:34:58 INFO - Return code: 0 05:34:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:34:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:34:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5fb739a5cca69832847e611a381a592e15b72f51cae4ebc6eef1b0291bd9932e8ea611190565eff027bd9a1d354227e40d9b7c9f70f07dc7ca48e47cacae044", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/650d9d87f1cdb22a3410de545eb1e76c68288936003d9415d84cf9687202f0ef6d653402a162507dd947779be6f843e9d7eca9b04d5801f867edc4e6ef143840", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b04ea4e25e6321f59bbf55ca5271553df6b3e00813735c87f075cfdc49216780e6869f373d908faea55d88b71c4fd655458e69803bfe9cd7432d3c050e6893b6"} 05:34:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:34:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:34:58 INFO - Contents: 05:34:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5fb739a5cca69832847e611a381a592e15b72f51cae4ebc6eef1b0291bd9932e8ea611190565eff027bd9a1d354227e40d9b7c9f70f07dc7ca48e47cacae044", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/650d9d87f1cdb22a3410de545eb1e76c68288936003d9415d84cf9687202f0ef6d653402a162507dd947779be6f843e9d7eca9b04d5801f867edc4e6ef143840", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b04ea4e25e6321f59bbf55ca5271553df6b3e00813735c87f075cfdc49216780e6869f373d908faea55d88b71c4fd655458e69803bfe9cd7432d3c050e6893b6"} 05:34:58 INFO - Running post-run listener: copy_logs_to_upload_dir 05:34:58 INFO - Copying logs to upload dir... 05:34:58 INFO - mkdir: /builds/slave/test/build/upload/logs 05:34:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.329429 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2016-09-28 05:34:58.858815) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 05:34:58.863774) ========= 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.VtYyE3dVIs/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.LVkSEUMSAr/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5fb739a5cca69832847e611a381a592e15b72f51cae4ebc6eef1b0291bd9932e8ea611190565eff027bd9a1d354227e40d9b7c9f70f07dc7ca48e47cacae044", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/650d9d87f1cdb22a3410de545eb1e76c68288936003d9415d84cf9687202f0ef6d653402a162507dd947779be6f843e9d7eca9b04d5801f867edc4e6ef143840", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b04ea4e25e6321f59bbf55ca5271553df6b3e00813735c87f075cfdc49216780e6869f373d908faea55d88b71c4fd655458e69803bfe9cd7432d3c050e6893b6"} build_url:https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010917 build_url: 'https://queue.taskcluster.net/v1/task/NRpPDNC-QCGACoq9NhNB6Q/artifacts/public/build/firefox-52.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c5fb739a5cca69832847e611a381a592e15b72f51cae4ebc6eef1b0291bd9932e8ea611190565eff027bd9a1d354227e40d9b7c9f70f07dc7ca48e47cacae044", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/650d9d87f1cdb22a3410de545eb1e76c68288936003d9415d84cf9687202f0ef6d653402a162507dd947779be6f843e9d7eca9b04d5801f867edc4e6ef143840", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b04ea4e25e6321f59bbf55ca5271553df6b3e00813735c87f075cfdc49216780e6869f373d908faea55d88b71c4fd655458e69803bfe9cd7432d3c050e6893b6"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 05:34:58.896696) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 05:34:58.897035) ========= 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.VtYyE3dVIs/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.LVkSEUMSAr/Listeners TMPDIR=/var/folders/rl/6cxjq2sd5dg7sqq1wv3b47pm00000w/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.004493 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 05:34:58.945177) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 05:34:58.945762) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 05:34:58.946100) ========= ========= Total master_lag: 0.61 =========