builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0075 starttime: 1483821612.57 results: success (0) buildid: 20170107112355 builduid: 316b01b4431441b2b7a0f182462e4da4 revision: 5df4fe2cddb45311fa3e8ac0dc58f04364ffffb9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-07 12:40:12.567739) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-07 12:40:12.568430) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-07 12:40:12.568956) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-07 12:40:12.596571) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 12:40:12.596962) ========= 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.0m3AnHdmu8/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.PDWqTPsmb8/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-07 12:40:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 55.8M=0s 2017-01-07 12:40:12 (55.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.131574 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 12:40:12.752731) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 12:40:12.753272) ========= 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.0m3AnHdmu8/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.PDWqTPsmb8/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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.025544 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 12:40:12.802070) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-07 12:40:12.802438) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5df4fe2cddb45311fa3e8ac0dc58f04364ffffb9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5df4fe2cddb45311fa3e8ac0dc58f04364ffffb9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0m3AnHdmu8/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.PDWqTPsmb8/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-07 12:40:12,893 truncating revision to first 12 chars 2017-01-07 12:40:12,894 Setting DEBUG logging. 2017-01-07 12:40:12,894 attempt 1/10 2017-01-07 12:40:12,894 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5df4fe2cddb4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-07 12:40:14,283 unpacking tar archive at: mozilla-beta-5df4fe2cddb4/testing/mozharness/ program finished with exit code 0 elapsedTime=1.654316 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-07 12:40:14.480554) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-07 12:40:14.480871) ========= script_repo_revision: 5df4fe2cddb45311fa3e8ac0dc58f04364ffffb9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-07 12:40:14.481286) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-07 12:40:14.481552) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-07 12:40:14.513193) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-01-07 12:40:14.513562) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0m3AnHdmu8/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.PDWqTPsmb8/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 12:40:14 INFO - MultiFileLogger online at 20170107 12:40:14 in /builds/slave/test 12:40:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 12:40:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:40:14 INFO - {'append_to_log': False, 12:40:14 INFO - 'base_work_dir': '/builds/slave/test', 12:40:14 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:40:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:40:14 INFO - 'branch': 'Mozilla-Beta', 12:40:14 INFO - 'buildbot_json_path': 'buildprops.json', 12:40:14 INFO - 'config_files': ('talos/mac_config.py',), 12:40:14 INFO - 'default_actions': ('clobber', 12:40:14 INFO - 'read-buildbot-config', 12:40:14 INFO - 'download-and-extract', 12:40:14 INFO - 'populate-webroot', 12:40:14 INFO - 'create-virtualenv', 12:40:14 INFO - 'install', 12:40:14 INFO - 'run-tests'), 12:40:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:40:14 INFO - 'download_minidump_stackwalk': True, 12:40:14 INFO - 'download_symbols': 'ondemand', 12:40:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:40:14 INFO - 'tooltool.py': '/tools/tooltool.py', 12:40:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:40:14 INFO - '/tools/misc-python/virtualenv.py')}, 12:40:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:40:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:40:14 INFO - 'installer_path': 'installer.exe', 12:40:14 INFO - 'log_level': 'info', 12:40:14 INFO - 'log_name': 'talos', 12:40:14 INFO - 'log_to_console': True, 12:40:14 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:40:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:40:14 INFO - 'opt_config_files': (), 12:40:14 INFO - 'pip_index': False, 12:40:14 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:40:14 INFO - 'cmd': ('bash', 12:40:14 INFO - '-c', 12:40:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:40:14 INFO - 'enabled': True, 12:40:14 INFO - 'halt_on_failure': False, 12:40:14 INFO - 'name': 'check_screen_resolution'},), 12:40:14 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:40:14 INFO - 'cmd': ('bash', 12:40:14 INFO - '-c', 12:40:14 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:40:14 INFO - 'enabled': True, 12:40:14 INFO - 'halt_on_failure': False, 12:40:14 INFO - 'name': 'check_screen_resolution'},), 12:40:14 INFO - 'run_cmd_checks_enabled': True, 12:40:14 INFO - 'sps_profile': False, 12:40:14 INFO - 'sps_profile_interval': 0, 12:40:14 INFO - 'suite': 'dromaeojs', 12:40:14 INFO - 'system_bits': '32', 12:40:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:40:14 INFO - 'title': 't-yosemite-r7-0075', 12:40:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:40:14 INFO - 'use_talos_json': True, 12:40:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:40:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:40:14 INFO - 'work_dir': 'build'} 12:40:14 INFO - [mozharness: 2017-01-07 20:40:14.708567Z] Running clobber step. 12:40:14 INFO - Running pre-action listener: _resource_record_pre_action 12:40:14 INFO - Running main action method: clobber 12:40:14 INFO - rmtree: /builds/slave/test/build 12:40:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:40:17 INFO - Running post-action listener: _resource_record_post_action 12:40:17 INFO - [mozharness: 2017-01-07 20:40:17.100642Z] Finished clobber step (success) 12:40:17 INFO - [mozharness: 2017-01-07 20:40:17.100769Z] Running read-buildbot-config step. 12:40:17 INFO - Running pre-action listener: _resource_record_pre_action 12:40:17 INFO - Running main action method: read_buildbot_config 12:40:17 INFO - Using buildbot properties: 12:40:17 INFO - { 12:40:17 INFO - "project": "", 12:40:17 INFO - "product": "firefox", 12:40:17 INFO - "script_repo_revision": "production", 12:40:17 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 12:40:17 INFO - "repository": "", 12:40:17 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 12:40:17 INFO - "buildid": "20170107112355", 12:40:17 INFO - "pgo_build": "False", 12:40:17 INFO - "basedir": "/builds/slave/test", 12:40:17 INFO - "buildnumber": 9, 12:40:17 INFO - "slavename": "t-yosemite-r7-0075", 12:40:17 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 12:40:17 INFO - "platform": "yosemite_r7", 12:40:17 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 12:40:17 INFO - "branch": "mozilla-beta", 12:40:17 INFO - "repo_path": "releases/mozilla-beta", 12:40:17 INFO - "revision": "5df4fe2cddb45311fa3e8ac0dc58f04364ffffb9", 12:40:17 INFO - "stage_platform": "macosx64", 12:40:17 INFO - "builduid": "316b01b4431441b2b7a0f182462e4da4", 12:40:17 INFO - "slavebuilddir": "test" 12:40:17 INFO - } 12:40:17 INFO - Found installer url https://queue.taskcluster.net/v1/task/EFD4NuKNQEKMlLs2ffi64Q/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 12:40:17 INFO - Running post-action listener: _resource_record_post_action 12:40:17 INFO - [mozharness: 2017-01-07 20:40:17.104101Z] Finished read-buildbot-config step (success) 12:40:17 INFO - [mozharness: 2017-01-07 20:40:17.104251Z] Running download-and-extract step. 12:40:17 INFO - Running pre-action listener: _resource_record_pre_action 12:40:17 INFO - Running main action method: download_and_extract 12:40:17 INFO - mkdir: /builds/slave/test/build/tests 12:40: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')]} 12:40:17 INFO - trying https://queue.taskcluster.net/v1/task/EFD4NuKNQEKMlLs2ffi64Q/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 12:40:17 INFO - Downloading https://queue.taskcluster.net/v1/task/EFD4NuKNQEKMlLs2ffi64Q/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 12:40:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EFD4NuKNQEKMlLs2ffi64Q/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 12:40:18 INFO - Downloaded 1165 bytes. 12:40:18 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 12:40:18 INFO - Using the following test package requirements: 12:40:18 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 12:40:18 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:40:18 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 12:40:18 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:40:18 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 12:40:18 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 12:40:18 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:40:18 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 12:40:18 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 12:40:18 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:40:18 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 12:40:18 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:40:18 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 12:40:18 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:40:18 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 12:40:18 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:40:18 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 12:40:18 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 12:40:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EFD4NuKNQEKMlLs2ffi64Q/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 12:40:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EFD4NuKNQEKMlLs2ffi64Q/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 12:40:18 INFO - Fetch https://queue.taskcluster.net/v1/task/EFD4NuKNQEKMlLs2ffi64Q/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 12:40:18 INFO - Expected file size: 16234489 12:40:26 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 12:40:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EFD4NuKNQEKMlLs2ffi64Q/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 12:40:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EFD4NuKNQEKMlLs2ffi64Q/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 12:40:26 INFO - Fetch https://queue.taskcluster.net/v1/task/EFD4NuKNQEKMlLs2ffi64Q/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 12:40:26 INFO - Expected file size: 16234489 12:40:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/EFD4NuKNQEKMlLs2ffi64Q/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 12:40:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/EFD4NuKNQEKMlLs2ffi64Q/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 12:40:33 INFO - Fetch https://queue.taskcluster.net/v1/task/EFD4NuKNQEKMlLs2ffi64Q/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 12:40:33 INFO - Expected file size: 14414089 12:40: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')]} 12:40:34 INFO - trying https://queue.taskcluster.net/v1/task/EFD4NuKNQEKMlLs2ffi64Q/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:40:34 INFO - Downloading https://queue.taskcluster.net/v1/task/EFD4NuKNQEKMlLs2ffi64Q/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 12:40:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/EFD4NuKNQEKMlLs2ffi64Q/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 12:40:36 INFO - Downloaded 86147213 bytes. 12:40:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/EFD4NuKNQEKMlLs2ffi64Q/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:40:36 INFO - mkdir: /builds/slave/test/properties 12:40:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:40:36 INFO - Writing to file /builds/slave/test/properties/build_url 12:40:36 INFO - Contents: 12:40:36 INFO - build_url:https://queue.taskcluster.net/v1/task/EFD4NuKNQEKMlLs2ffi64Q/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:40:37 INFO - Running post-action listener: _resource_record_post_action 12:40:37 INFO - Running post-action listener: set_extra_try_arguments 12:40:37 INFO - [mozharness: 2017-01-07 20:40:37.389799Z] Finished download-and-extract step (success) 12:40:37 INFO - [mozharness: 2017-01-07 20:40:37.389924Z] Running populate-webroot step. 12:40:37 INFO - Running pre-action listener: _resource_record_pre_action 12:40:37 INFO - Running main action method: populate_webroot 12:40:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:40:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:40:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:40:37 INFO - '--tppagecycles', 12:40:37 INFO - '7'], 12:40:37 INFO - 'tests': ['tsvgm']}}, 12:40:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:40:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:40:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:40:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:40:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:40:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:40:37 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:40:37 INFO - 'talos_options': ['--disable-e10s'], 12:40:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:40:37 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:40:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:40:37 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:40:37 INFO - 'talos_options': ['--disable-e10s'], 12:40:37 INFO - 'tests': ['damp', 'tps']}, 12:40:37 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:40:37 INFO - 'tests': ['damp', 'tps']}, 12:40:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:40:37 INFO - 'tests': ['dromaeo_dom']}, 12:40:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:40:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:40:37 INFO - 'tests': ['basic_compositor_video']}, 12:40:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:40:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:40:37 INFO - 'tests': ['a11yr', 12:40:37 INFO - 'ts_paint', 12:40:37 INFO - 'tpaint', 12:40:37 INFO - 'sessionrestore', 12:40:37 INFO - 'sessionrestore_no_auto_restore', 12:40:37 INFO - 'tabpaint']}, 12:40:37 INFO - 'other-e10s': {'tests': ['a11yr', 12:40:37 INFO - 'ts_paint', 12:40:37 INFO - 'tpaint', 12:40:37 INFO - 'sessionrestore', 12:40:37 INFO - 'sessionrestore_no_auto_restore', 12:40:37 INFO - 'tabpaint']}, 12:40:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:40:37 INFO - 'ts_paint', 12:40:37 INFO - 'tpaint', 12:40:37 INFO - 'sessionrestore', 12:40:37 INFO - 'sessionrestore_no_auto_restore', 12:40:37 INFO - 'tabpaint']}, 12:40:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:40:37 INFO - 'ts_paint', 12:40:37 INFO - 'tpaint', 12:40:37 INFO - 'sessionrestore', 12:40:37 INFO - 'sessionrestore_no_auto_restore', 12:40:37 INFO - 'tabpaint']}, 12:40:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:40:37 INFO - 'tests': ['a11yr', 12:40:37 INFO - 'ts_paint', 12:40:37 INFO - 'tpaint', 12:40:37 INFO - 'sessionrestore', 12:40:37 INFO - 'sessionrestore_no_auto_restore', 12:40:37 INFO - 'tabpaint']}, 12:40:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:40:37 INFO - 'tests': ['a11yr', 12:40:37 INFO - 'ts_paint', 12:40:37 INFO - 'tpaint', 12:40:37 INFO - 'sessionrestore', 12:40:37 INFO - 'sessionrestore_no_auto_restore', 12:40:37 INFO - 'tabpaint']}, 12:40:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:40:37 INFO - 'tests': ['tsvgx', 12:40:37 INFO - 'tsvgr_opacity', 12:40:37 INFO - 'tart', 12:40:37 INFO - 'tscrollx', 12:40:37 INFO - 'cart']}, 12:40:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:40:37 INFO - 'tsvgr_opacity', 12:40:37 INFO - 'tart', 12:40:37 INFO - 'tscrollx', 12:40:37 INFO - 'cart']}, 12:40:37 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:40:37 INFO - 'talos_options': ['--disable-e10s'], 12:40:37 INFO - 'tests': ['tp5o']}, 12:40:37 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:40:37 INFO - 'tests': ['tp5o']}, 12:40:37 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:40:37 INFO - 'talos_options': ['--disable-e10s', 12:40:37 INFO - '--xperf_path', 12:40:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:40:37 INFO - 'tests': ['tp5n']}, 12:40:37 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:40:37 INFO - 'talos_options': ['--xperf_path', 12:40:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:40:37 INFO - 'tests': ['tp5n']}}, 12:40:37 INFO - 'talos.zip': {'path': '', 12:40:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:40:37 INFO - Running post-action listener: _resource_record_post_action 12:40:37 INFO - [mozharness: 2017-01-07 20:40:37.409165Z] Finished populate-webroot step (success) 12:40:37 INFO - [mozharness: 2017-01-07 20:40:37.409296Z] Running create-virtualenv step. 12:40:37 INFO - Running pre-action listener: _resource_record_pre_action 12:40:37 INFO - Running main action method: create_virtualenv 12:40:37 INFO - Creating virtualenv /builds/slave/test/build/venv 12:40:37 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 12:40:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:40:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:40:37 INFO - Using real prefix '/tools/python27' 12:40:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:40:38 INFO - Installing distribute.............................................................................................................................................................................................done. 12:40:41 INFO - Installing pip.................done. 12:40:41 INFO - Return code: 0 12:40:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:40: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')]} 12:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40: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')]} 12:40:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1055dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105553570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd252cb6390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053f1d30>, '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 0x105257db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053e9b20>, '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.0m3AnHdmu8/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.PDWqTPsmb8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 12:40:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:40:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:40:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0m3AnHdmu8/Render', 12:40:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:40:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:40:41 INFO - 'HOME': '/Users/cltbld', 12:40:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:40:41 INFO - 'LOGNAME': 'cltbld', 12:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:41 INFO - 'MOZ_NO_REMOTE': '1', 12:40:41 INFO - 'NO_EM_RESTART': '1', 12:40:41 INFO - 'PAGER': '/bin/cat', 12:40:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:41 INFO - 'PWD': '/builds/slave/test', 12:40:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:40:41 INFO - 'SHELL': '/bin/bash', 12:40:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PDWqTPsmb8/Listeners', 12:40:41 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:40:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:40:41 INFO - 'USER': 'cltbld', 12:40:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:40:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:41 INFO - 'XPC_FLAGS': '0x0', 12:40:41 INFO - 'XPC_SERVICE_NAME': '0', 12:40:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:40:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:41 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 12:40:41 INFO - Cleaning up... 12:40:41 INFO - Return code: 0 12:40:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:40: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')]} 12:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40: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')]} 12:40:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1055dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105553570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd252cb6390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053f1d30>, '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 0x105257db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053e9b20>, '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.0m3AnHdmu8/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.PDWqTPsmb8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 12:40:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:40:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:40:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0m3AnHdmu8/Render', 12:40:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:40:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:40:41 INFO - 'HOME': '/Users/cltbld', 12:40:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:40:41 INFO - 'LOGNAME': 'cltbld', 12:40:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:41 INFO - 'MOZ_NO_REMOTE': '1', 12:40:41 INFO - 'NO_EM_RESTART': '1', 12:40:41 INFO - 'PAGER': '/bin/cat', 12:40:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:40:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:41 INFO - 'PWD': '/builds/slave/test', 12:40:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:40:41 INFO - 'SHELL': '/bin/bash', 12:40:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PDWqTPsmb8/Listeners', 12:40:41 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:40:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:40:41 INFO - 'USER': 'cltbld', 12:40:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:40:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:40:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:41 INFO - 'XPC_FLAGS': '0x0', 12:40:41 INFO - 'XPC_SERVICE_NAME': '0', 12:40:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:40:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:41 INFO - Downloading/unpacking psutil>=3.1.1 12:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:40:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:40:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:40:44 INFO - Installing collected packages: psutil 12:40:44 INFO - Running setup.py install for psutil 12:40:44 INFO - building 'psutil._psutil_osx' extension 12:40:44 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 12:40:45 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 12:40:45 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 12:40:45 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 12:40:45 INFO - building 'psutil._psutil_posix' extension 12:40:45 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 12:40:45 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:40:45 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:40:45 INFO - ^ 12:40:45 INFO - 1 warning generated. 12:40:45 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 12:40:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:40:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:40:45 INFO - Successfully installed psutil 12:40:45 INFO - Cleaning up... 12:40:46 INFO - Return code: 0 12:40:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:40:46 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')]} 12:40:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:46 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')]} 12:40:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:46 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 0x1055dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105553570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd252cb6390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053f1d30>, '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 0x105257db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053e9b20>, '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.0m3AnHdmu8/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.PDWqTPsmb8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 12:40:46 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 12:40:46 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 12:40:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0m3AnHdmu8/Render', 12:40:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:40:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:40:46 INFO - 'HOME': '/Users/cltbld', 12:40:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:40:46 INFO - 'LOGNAME': 'cltbld', 12:40:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:46 INFO - 'MOZ_NO_REMOTE': '1', 12:40:46 INFO - 'NO_EM_RESTART': '1', 12:40:46 INFO - 'PAGER': '/bin/cat', 12:40:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:40:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:46 INFO - 'PWD': '/builds/slave/test', 12:40:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:40:46 INFO - 'SHELL': '/bin/bash', 12:40:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PDWqTPsmb8/Listeners', 12:40:46 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:40:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:40:46 INFO - 'USER': 'cltbld', 12:40:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:40:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:40:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:46 INFO - 'XPC_FLAGS': '0x0', 12:40:46 INFO - 'XPC_SERVICE_NAME': '0', 12:40:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:40:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:46 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:40:46 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 12:40:46 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 12:40:46 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 12:40:46 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 12:40:46 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 12:40:46 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 12:40:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:40:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:40:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:40:49 INFO - Installing collected packages: mozsystemmonitor 12:40:49 INFO - Running setup.py install for mozsystemmonitor 12:40:49 INFO - Successfully installed mozsystemmonitor 12:40:49 INFO - Cleaning up... 12:40:49 INFO - Return code: 0 12:40:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:40:49 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')]} 12:40:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:49 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')]} 12:40:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:49 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 0x1055dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105553570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd252cb6390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053f1d30>, '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 0x105257db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053e9b20>, '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.0m3AnHdmu8/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.PDWqTPsmb8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 12:40:49 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 12:40:49 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 12:40:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0m3AnHdmu8/Render', 12:40:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:40:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:40:49 INFO - 'HOME': '/Users/cltbld', 12:40:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:40:49 INFO - 'LOGNAME': 'cltbld', 12:40:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:49 INFO - 'MOZ_NO_REMOTE': '1', 12:40:49 INFO - 'NO_EM_RESTART': '1', 12:40:49 INFO - 'PAGER': '/bin/cat', 12:40:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:40:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:49 INFO - 'PWD': '/builds/slave/test', 12:40:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:40:49 INFO - 'SHELL': '/bin/bash', 12:40:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PDWqTPsmb8/Listeners', 12:40:49 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:40:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:40:49 INFO - 'USER': 'cltbld', 12:40:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:40:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:40:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:49 INFO - 'XPC_FLAGS': '0x0', 12:40:49 INFO - 'XPC_SERVICE_NAME': '0', 12:40:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:40:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:49 INFO - Downloading/unpacking jsonschema==2.5.1 12:40:49 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 12:40:49 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 12:40:49 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 12:40:49 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 12:40:49 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 12:40:49 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 12:40:52 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:40:52 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:40:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:40:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:40:52 INFO - Downloading functools32-3.2.3-2.tar.gz 12:40:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:40:52 INFO - warning: no files found matching '*.txt' 12:40:52 INFO - no previously-included directories found matching 'build' 12:40:52 INFO - no previously-included directories found matching 'dist' 12:40:52 INFO - no previously-included directories found matching '.git*' 12:40:52 INFO - Installing collected packages: jsonschema, functools32 12:40:52 INFO - Running setup.py install for functools32 12:40:53 INFO - warning: no files found matching '*.txt' 12:40:53 INFO - no previously-included directories found matching 'build' 12:40:53 INFO - no previously-included directories found matching 'dist' 12:40:53 INFO - no previously-included directories found matching '.git*' 12:40:53 INFO - Successfully installed jsonschema functools32 12:40:53 INFO - Cleaning up... 12:40:53 INFO - Return code: 0 12:40:53 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:40:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1055dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105553570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd252cb6390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053f1d30>, '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 0x105257db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053e9b20>, '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.0m3AnHdmu8/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.PDWqTPsmb8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 12:40:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:40:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:40:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0m3AnHdmu8/Render', 12:40:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:40:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:40:53 INFO - 'HOME': '/Users/cltbld', 12:40:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:40:53 INFO - 'LOGNAME': 'cltbld', 12:40:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:53 INFO - 'MOZ_NO_REMOTE': '1', 12:40:53 INFO - 'NO_EM_RESTART': '1', 12:40:53 INFO - 'PAGER': '/bin/cat', 12:40:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:40:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:53 INFO - 'PWD': '/builds/slave/test', 12:40:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:40:53 INFO - 'SHELL': '/bin/bash', 12:40:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PDWqTPsmb8/Listeners', 12:40:53 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:40:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:40:53 INFO - 'USER': 'cltbld', 12:40:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:40:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:40:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:53 INFO - 'XPC_FLAGS': '0x0', 12:40:53 INFO - 'XPC_SERVICE_NAME': '0', 12:40:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:40:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:53 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:40:53 INFO - Cleaning up... 12:40:53 INFO - Return code: 0 12:40:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:40:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1055dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105553570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd252cb6390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053f1d30>, '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 0x105257db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053e9b20>, '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.0m3AnHdmu8/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.PDWqTPsmb8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 12:40:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:40:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:40:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0m3AnHdmu8/Render', 12:40:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:40:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:40:53 INFO - 'HOME': '/Users/cltbld', 12:40:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:40:53 INFO - 'LOGNAME': 'cltbld', 12:40:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:53 INFO - 'MOZ_NO_REMOTE': '1', 12:40:53 INFO - 'NO_EM_RESTART': '1', 12:40:53 INFO - 'PAGER': '/bin/cat', 12:40:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:40:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:53 INFO - 'PWD': '/builds/slave/test', 12:40:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:40:53 INFO - 'SHELL': '/bin/bash', 12:40:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PDWqTPsmb8/Listeners', 12:40:53 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:40:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:40:53 INFO - 'USER': 'cltbld', 12:40:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:40:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:40:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:53 INFO - 'XPC_FLAGS': '0x0', 12:40:53 INFO - 'XPC_SERVICE_NAME': '0', 12:40:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:40:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:53 INFO - Downloading/unpacking blobuploader==1.2.4 12:40:53 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 12:40:53 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 12:40:53 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 12:40:53 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 12:40:53 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 12:40:53 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 12:40:56 INFO - Downloading blobuploader-1.2.4.tar.gz 12:40:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:40:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:40:56 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 12:40:56 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 12:40:56 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 12:40:56 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 12:40:56 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 12:40:56 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 12:40:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:40:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:40:56 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 12:40:56 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 12:40:56 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 12:40:56 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 12:40:56 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 12:40:56 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 12:40:57 INFO - Downloading docopt-0.6.1.tar.gz 12:40:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:40:57 INFO - Installing collected packages: blobuploader, requests, docopt 12:40:57 INFO - Running setup.py install for blobuploader 12:40:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:40:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:40:57 INFO - Running setup.py install for requests 12:40:58 INFO - Running setup.py install for docopt 12:40:58 INFO - Successfully installed blobuploader requests docopt 12:40:58 INFO - Cleaning up... 12:40:58 INFO - Return code: 0 12:40:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:40:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:40:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:40:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:40:58 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 0x1055dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105553570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd252cb6390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053f1d30>, '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 0x105257db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053e9b20>, '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.0m3AnHdmu8/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.PDWqTPsmb8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 12:40:58 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 12:40:58 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 12:40:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0m3AnHdmu8/Render', 12:40:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:40:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:40:58 INFO - 'HOME': '/Users/cltbld', 12:40:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:40:58 INFO - 'LOGNAME': 'cltbld', 12:40:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:40:58 INFO - 'MOZ_NO_REMOTE': '1', 12:40:58 INFO - 'NO_EM_RESTART': '1', 12:40:58 INFO - 'PAGER': '/bin/cat', 12:40:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:40:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:40:58 INFO - 'PWD': '/builds/slave/test', 12:40:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:40:58 INFO - 'SHELL': '/bin/bash', 12:40:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PDWqTPsmb8/Listeners', 12:40:58 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:40:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:40:58 INFO - 'USER': 'cltbld', 12:40:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:40:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:40:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:40:58 INFO - 'XPC_FLAGS': '0x0', 12:40:58 INFO - 'XPC_SERVICE_NAME': '0', 12:40:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:40:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:40:58 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-7uVZof-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:40:58 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-ibzeuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:40:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:40:58 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-KJS0Fl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:40:59 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-8gqqzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:40:59 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-xm5tGR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:40:59 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-LYPc6O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:40:59 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-LfptaN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:40:59 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-JSgxxA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:40:59 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-LZIkZc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:40:59 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-yGnhd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:40:59 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-qKJRPP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:40:59 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-unCbLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:40:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:40:59 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-wHkokj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:41:00 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-e_WO4E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:41:00 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-GI6hC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:41:00 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-TpM_ar-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:41:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:41:00 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-rOrr3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:41:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:41:00 INFO - Running setup.py install for manifestparser 12:41:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:41:00 INFO - Running setup.py install for mozcrash 12:41:00 INFO - Running setup.py install for mozdebug 12:41:00 INFO - Running setup.py install for mozdevice 12:41:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:41:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:41:01 INFO - Running setup.py install for mozfile 12:41:01 INFO - Running setup.py install for mozhttpd 12:41:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:41:01 INFO - Running setup.py install for mozinfo 12:41:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:41:01 INFO - Running setup.py install for mozInstall 12:41:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:41:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:41:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:41:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:41:01 INFO - Running setup.py install for mozleak 12:41:01 INFO - Running setup.py install for mozlog 12:41:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:41:02 INFO - Running setup.py install for moznetwork 12:41:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:41:02 INFO - Running setup.py install for mozprocess 12:41:02 INFO - Running setup.py install for mozprofile 12:41:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:41:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:41:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:41:02 INFO - Running setup.py install for mozrunner 12:41:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:41:02 INFO - Running setup.py install for mozscreenshot 12:41:02 INFO - Running setup.py install for moztest 12:41:02 INFO - Running setup.py install for mozversion 12:41:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:41:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:41:03 INFO - Cleaning up... 12:41:03 INFO - Return code: 0 12:41:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:03 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 0x1055dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105553570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd252cb6390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053f1d30>, '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 0x105257db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053e9b20>, '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.0m3AnHdmu8/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.PDWqTPsmb8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 12:41:03 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 12:41:03 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 12:41:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0m3AnHdmu8/Render', 12:41:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:41:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:41:03 INFO - 'HOME': '/Users/cltbld', 12:41:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:41:03 INFO - 'LOGNAME': 'cltbld', 12:41:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:03 INFO - 'MOZ_NO_REMOTE': '1', 12:41:03 INFO - 'NO_EM_RESTART': '1', 12:41:03 INFO - 'PAGER': '/bin/cat', 12:41:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:41:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:03 INFO - 'PWD': '/builds/slave/test', 12:41:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:41:03 INFO - 'SHELL': '/bin/bash', 12:41:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PDWqTPsmb8/Listeners', 12:41:03 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:41:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:41:03 INFO - 'USER': 'cltbld', 12:41:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:41:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:41:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:03 INFO - 'XPC_FLAGS': '0x0', 12:41:03 INFO - 'XPC_SERVICE_NAME': '0', 12:41:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:41:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:41:03 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-iEgRlx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:41:03 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)) 12:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:41:03 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-mcQNG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:41:03 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)) 12:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:41:03 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-bUadk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:41:03 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)) 12:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:41:03 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-1CckUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:41:03 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)) 12:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:41:03 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-TQaAfq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:41:03 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)) 12:41:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:41:03 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-LGEEhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:41:04 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)) 12:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:41:04 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-yh_B9G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:41:04 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)) 12:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:41:04 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-jGu6Vk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:41:04 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)) 12:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:41:04 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Gmx76G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:41:04 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)) 12:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:41:04 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-yPecxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:41:04 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)) 12:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:41:04 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-08N_U1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:41:04 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)) 12:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:41:04 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-zLJOom-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:41:04 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)) 12:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:41:04 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-_2a6JZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:41:04 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)) 12:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:41:04 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-6gQPaM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:41:04 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)) 12:41:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:41:04 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-0uoV8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:41:05 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)) 12:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:41:05 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-V2pCLV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:41:05 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)) 12:41:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:41:05 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-yc6sds-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:41:05 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)) 12:41:05 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)) 12:41:05 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)) 12:41:05 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)) 12:41:05 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)) 12:41:05 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)) 12:41:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:41:05 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 12:41:05 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 12:41:05 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 12:41:05 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 12:41:05 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 12:41:05 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 12:41:07 INFO - Downloading blessings-1.6.tar.gz 12:41:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:41:08 INFO - Installing collected packages: blessings 12:41:08 INFO - Running setup.py install for blessings 12:41:08 INFO - Successfully installed blessings 12:41:08 INFO - Cleaning up... 12:41:08 INFO - Return code: 0 12:41:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:41:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:41:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:41:08 INFO - Reading from file tmpfile_stdout 12:41:08 INFO - Current package versions: 12:41:08 INFO - blessings == 1.6 12:41:08 INFO - blobuploader == 1.2.4 12:41:08 INFO - docopt == 0.6.1 12:41:08 INFO - functools32 == 3.2.3-2 12:41:08 INFO - jsonschema == 2.5.1 12:41:08 INFO - manifestparser == 1.1 12:41:08 INFO - mozInstall == 1.12 12:41:08 INFO - mozcrash == 0.17 12:41:08 INFO - mozdebug == 0.1 12:41:08 INFO - mozdevice == 0.48 12:41:08 INFO - mozfile == 1.2 12:41:08 INFO - mozhttpd == 0.7 12:41:08 INFO - mozinfo == 0.9 12:41:08 INFO - mozleak == 0.1 12:41:08 INFO - mozlog == 3.4 12:41:08 INFO - moznetwork == 0.27 12:41:08 INFO - mozprocess == 0.23 12:41:08 INFO - mozprofile == 0.28 12:41:08 INFO - mozrunner == 6.12 12:41:08 INFO - mozscreenshot == 0.1 12:41:08 INFO - mozsystemmonitor == 0.3 12:41:08 INFO - moztest == 0.7 12:41:08 INFO - mozversion == 1.4 12:41:08 INFO - psutil == 3.1.1 12:41:08 INFO - requests == 1.2.3 12:41:08 INFO - wsgiref == 0.1.2 12:41:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:41:08 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')]} 12:41:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:08 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')]} 12:41:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:08 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 0x1055dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105553570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd252cb6390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053f1d30>, '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 0x105257db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053e9b20>, '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.0m3AnHdmu8/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.PDWqTPsmb8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 12:41:08 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 12:41:08 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 12:41:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0m3AnHdmu8/Render', 12:41:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:41:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:41:08 INFO - 'HOME': '/Users/cltbld', 12:41:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:41:08 INFO - 'LOGNAME': 'cltbld', 12:41:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:08 INFO - 'MOZ_NO_REMOTE': '1', 12:41:08 INFO - 'NO_EM_RESTART': '1', 12:41:08 INFO - 'PAGER': '/bin/cat', 12:41:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:41:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:08 INFO - 'PWD': '/builds/slave/test', 12:41:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:41:08 INFO - 'SHELL': '/bin/bash', 12:41:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PDWqTPsmb8/Listeners', 12:41:08 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:41:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:41:08 INFO - 'USER': 'cltbld', 12:41:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:41:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:41:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:08 INFO - 'XPC_FLAGS': '0x0', 12:41:08 INFO - 'XPC_SERVICE_NAME': '0', 12:41:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:09 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)) 12:41:09 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)) 12:41:09 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)) 12:41:09 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)) 12:41:09 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)) 12:41:09 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)) 12:41:09 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)) 12:41:09 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)) 12:41:09 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)) 12:41:09 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)) 12:41:09 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)) 12:41:09 INFO - Cleaning up... 12:41:09 INFO - Return code: 0 12:41:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:41:09 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')]} 12:41:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:41:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:09 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')]} 12:41:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:41:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:41:09 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 0x1055dd490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105553570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd252cb6390>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053f1d30>, '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 0x105257db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053e9b20>, '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.0m3AnHdmu8/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.PDWqTPsmb8/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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 12:41:09 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 12:41:09 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 12:41:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0m3AnHdmu8/Render', 12:41:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:41:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:41:09 INFO - 'HOME': '/Users/cltbld', 12:41:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:41:09 INFO - 'LOGNAME': 'cltbld', 12:41:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:09 INFO - 'MOZ_NO_REMOTE': '1', 12:41:09 INFO - 'NO_EM_RESTART': '1', 12:41:09 INFO - 'PAGER': '/bin/cat', 12:41:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:41:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:09 INFO - 'PWD': '/builds/slave/test', 12:41:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:41:09 INFO - 'SHELL': '/bin/bash', 12:41:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PDWqTPsmb8/Listeners', 12:41:09 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:41:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:41:09 INFO - 'USER': 'cltbld', 12:41:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:41:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:41:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:09 INFO - 'XPC_FLAGS': '0x0', 12:41:09 INFO - 'XPC_SERVICE_NAME': '0', 12:41:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:41:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:41:09 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:41:09 INFO - Cleaning up... 12:41:09 INFO - Return code: 0 12:41:09 INFO - Running post-action listener: _resource_record_post_action 12:41:09 INFO - Running post-action listener: _start_resource_monitoring 12:41:09 INFO - Starting resource monitoring. 12:41:09 INFO - [mozharness: 2017-01-07 20:41:09.464360Z] Finished create-virtualenv step (success) 12:41:09 INFO - [mozharness: 2017-01-07 20:41:09.465358Z] Running install step. 12:41:09 INFO - Running pre-action listener: _resource_record_pre_action 12:41:09 INFO - Running main action method: install 12:41:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:41:09 INFO - Reading from file tmpfile_stdout 12:41:09 INFO - Detecting whether we're running mozinstall >=1.0... 12:41:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:41:09 INFO - Reading from file tmpfile_stdout 12:41:09 INFO - Output received: 12:41:09 INFO - Usage: mozinstall [options] installer 12:41:09 INFO - Options: 12:41:09 INFO - -h, --help show this help message and exit 12:41:09 INFO - -d DEST, --destination=DEST 12:41:09 INFO - Directory to install application into. [default: 12:41:09 INFO - "/builds/slave/test"] 12:41:09 INFO - --app=APP Application being installed. [default: firefox] 12:41:09 INFO - mkdir: /builds/slave/test/build/application 12:41:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:41:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 12:41:31 INFO - Reading from file tmpfile_stdout 12:41:31 INFO - Output received: 12:41:31 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 12:41:31 INFO - Running post-action listener: _resource_record_post_action 12:41:31 INFO - [mozharness: 2017-01-07 20:41:31.754590Z] Finished install step (success) 12:41:31 INFO - [mozharness: 2017-01-07 20:41:31.754751Z] Running run-tests step. 12:41:31 INFO - Running pre-action listener: _resource_record_pre_action 12:41:31 INFO - Running main action method: run_tests 12:41:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:41:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:41:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:41:31 INFO - 2017-01-07 12:41:31.769 screenresolution[1624:7572] starting screenresolution argv=screenresolution get 12:41:31 INFO - 2017-01-07 12:41:31.772 screenresolution[1624:7572] Display 0: 1600x1200x32@60 12:41:31 INFO - 2017-01-07 12:41:31.777 screenresolution[1625:7574] starting screenresolution argv=screenresolution list 12:41:31 INFO - Available Modes on Display 0 12:41:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:41:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:41:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:41:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:41:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:41:32 INFO - Intel Iris: 12:41:32 INFO - Chipset Model: Intel Iris 12:41:32 INFO - Type: GPU 12:41:32 INFO - Bus: Built-In 12:41:32 INFO - VRAM (Dynamic, Max): 1536 MB 12:41:32 INFO - Vendor: Intel (0x8086) 12:41:32 INFO - Device ID: 0x0a2e 12:41:32 INFO - Revision ID: 0x0009 12:41:32 INFO - Displays: 12:41:32 INFO - Display: 12:41:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:41:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:41:32 INFO - Display Serial Number: 1600x1200 60 12:41:32 INFO - Main Display: Yes 12:41:32 INFO - Mirror: Off 12:41:32 INFO - Online: Yes 12:41:32 INFO - Rotation: Supported 12:41:32 INFO - Return code: 0 12:41:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:41:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:41:32 INFO - Python 2.7.3 12:41:32 INFO - Return code: 0 12:41:32 INFO - grabbing minidump binary from tooltool 12:41:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:41:32 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1053f1d30>, '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 0x105257db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1053e9b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:41:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 12:41:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 12:41:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 12:41:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:41:32 INFO - Return code: 0 12:41:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:41:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:41:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:41:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:41:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:41:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EFD4NuKNQEKMlLs2ffi64Q/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0075', '--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 12:41:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/EFD4NuKNQEKMlLs2ffi64Q/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0075 --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 12:41:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0m3AnHdmu8/Render', 12:41:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:41:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:41:32 INFO - 'HOME': '/Users/cltbld', 12:41:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:41:32 INFO - 'LOGNAME': 'cltbld', 12:41:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:41:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:41:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:41:32 INFO - 'MOZ_NO_REMOTE': '1', 12:41:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:41:32 INFO - 'NO_EM_RESTART': '1', 12:41:32 INFO - 'PAGER': '/bin/cat', 12:41:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:41:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:41:32 INFO - 'PWD': '/builds/slave/test', 12:41:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:41:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:41:32 INFO - 'SHELL': '/bin/bash', 12:41:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.PDWqTPsmb8/Listeners', 12:41:32 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:41:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:41:32 INFO - 'USER': 'cltbld', 12:41:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:41:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:41:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:41:32 INFO - 'XPC_FLAGS': '0x0', 12:41:32 INFO - 'XPC_SERVICE_NAME': '0', 12:41:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:41:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/EFD4NuKNQEKMlLs2ffi64Q/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0075', '--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 12:41:32 INFO - mozversion application_buildid: 20170107112355 12:41:32 INFO - mozversion application_changeset: 5df4fe2cddb45311fa3e8ac0dc58f04364ffffb9 12:41:32 INFO - mozversion application_display_name: Firefox 12:41:32 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:41:32 INFO - mozversion application_name: Firefox 12:41:32 INFO - mozversion application_remotingname: firefox 12:41:32 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:41:32 INFO - mozversion application_vendor: Mozilla 12:41:32 INFO - mozversion application_version: 51.0 12:41:32 INFO - mozversion platform_buildid: 20170107112355 12:41:32 INFO - mozversion platform_changeset: 5df4fe2cddb45311fa3e8ac0dc58f04364ffffb9 12:41:32 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:41:32 INFO - mozversion platform_version: 51.0 12:41:32 INFO - using testdate: 1483821692 12:41:32 INFO - actual date: 1483821692 12:41:32 INFO - starting webserver on 'localhost:49251' 12:41:32 INFO - SUITE-START | Running 2 tests 12:41:32 INFO - TEST-START | dromaeo_css 12:41:32 INFO - operating with platform_type : mac_ 12:41:32 INFO - Initialising browser for dromaeo_css test... 12:41:32 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpEWdMb_/profile http://localhost:49251/getInfo.html) 12:41:34 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 12:41:34 INFO - PROCESS | 1635 | colorDepth:24 12:41:34 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 12:41:34 INFO - PROCESS | 1635 | __metrics 12:41:34 INFO - PROCESS | 1635 | 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" 12:41:34 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:41:35 INFO - TEST-INFO | 1635: exit 0 12:41:35 INFO - Browser initialized. 12:41:35 INFO - Running cycle 1/1 for dromaeo_css test... 12:41:35 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpEWdMb_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:41:47 INFO - PROCESS | 1638 | RSS: Main: 168820736 12:41:47 INFO - PROCESS | 1638 | 12:42:39 INFO - PROCESS | 1638 | 1483821759500 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] 12:44:49 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49251/tests/dromaeo/cssquery-ext.html) 12:44:50 INFO - PROCESS | 1638 | RSS: Main: 316059648 12:44:50 INFO - PROCESS | 1638 | 12:47:54 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-ext.html (next: http://localhost:49251/tests/dromaeo/cssquery-jquery.html) 12:47:54 INFO - PROCESS | 1638 | RSS: Main: 303046656 12:47:54 INFO - PROCESS | 1638 | 12:50:56 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49251/tests/dromaeo/cssquery-mootools.html) 12:50:57 INFO - PROCESS | 1638 | RSS: Main: 276324352 12:50:57 INFO - PROCESS | 1638 | 12:53:59 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49251/tests/dromaeo/cssquery-prototype.html) 12:54:00 INFO - PROCESS | 1638 | RSS: Main: 278257664 12:54:00 INFO - PROCESS | 1638 | 12:57:03 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49251/tests/dromaeo/cssquery-yui.html) 12:57:04 INFO - PROCESS | 1638 | RSS: Main: 261722112 12:57:04 INFO - PROCESS | 1638 | 13:00:06 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49251/tests/dromaeo/cssquery-yui.html (next: http://localhost:49251/tests/dromaeo/cssquery-dojo.html) 13:00:07 INFO - PROCESS | 1638 | RSS: Main: 379187200 13:00:07 INFO - PROCESS | 1638 | 13:00:07 INFO - PROCESS | 1638 | __start_tp_report 13:00:07 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 13:00:07 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 13:00:07 INFO - PROCESS | 1638 | |i|pagename|runs| 13:00:07 INFO - PROCESS | 1638 | |0;dojo.html;3081.8767249310026;3482.4079906415914;3508.2808024354995;3530.117470632342;3531.982340088299;5785.045467497863;5869.530437564995;5900.380460051697;5920.911186332209;5921.467067963882;5838.503727183184;5868.501177399916;5908.586398952075;5916.319623243328;5922.052471604544;5266.34170728658;5283.973580132113;5331.067063263933;5355;5366.329208848894;5221.216817477371;5224.320838291036;5247.816326428557;5370.248165256867;5389.9191512127345;5260.710660913648;5262.079136151177;5321.547668448186;5324.387695415038;5338.252644629755;5283.6037297202865;5289.233061206142;5293.311869456985;5353.411124776271;5355.384130824966;5209.47905209476;5293.708846013467;5301.045811753883;5302.390225124083;5327.147656375;5682.829515114553;5714.9714251428895;5778.624389414675;5782.566307526952;5928.229330187048;5780.84383123377;6255.906161407583;6323.019931910515;6339.049142628596;6340.873182536324;5040.672356296829;5158.638895277332;6297.811065668037;6309.400606942333;6316.778912738078;5777.480026797609;5833.7083145842535;5839.240898683144;5853.765849365977;5908.350081491032;6258.217722784652;6314.179156709598;6320.5259605528845;6327.651979141191;6328.6519241442165;6248.781292654826;6261.373862613702;6261.96869015652;6278.215223097113;6284.402981716729;6166.352532984062;6195;6261.7182226799905;6279.591826531261;6334.683265836782;6244.718987645567;6300.8424789379715;6316;6352.6823658816875;6357.523185761086;5217.191335342952;6157.641593426515;6345.587536810092;6365.522585806083;6384.52116091295;4950.480199579064;4995.650304478724;5038.697678139323;5039.143345631252;5057.848264552069;4477.261251893401;4528.479224889114;4532.88667783308;4546.249868771615;4547.431571053618;5855.941440585625;5860.70696465175;5862.237909071793;5862.560307976919;5878.206442130343;5920.970395148083;6294.937050629526;6311.621302721851;6311.684415779193;6330.208723909512;5626.85932851682;5696.914546281809;5754.539636829044;5763.020286551213;5818.44724751148;4698.812047518061;5448.782048718086;5460;5472.781088756485;5476.890462190734;6429.196350456193;6435.549511534241;6441.0982462455295;6449.484041276686;6455.257645370749;6255.311915689362;6255.53083518747;6290.874182516232;6301.747930082745;6315.621062736251;5311.3891902431715;6254.593451425642;6271.560990730605;6289.685515724104;6336.081268216175;6246.219222597176;6284.937150628435;6299.937000629935;6300.401461861299;6307.779227727007;5301.1783173608155;6274.278457977391;6282.308946016026;6289.276733175743;6371.299157092809;5880.26496687914;6121.361519882508;6142.345304543789;6220.688965551613;6274.498040156868;6124.441964285778;6247.125402443752;6253.5622506424115;6260.217472815898;6280.623162610258;6088.634681919099;6096.1465394845645;6098.939010609837;6103.450689437795;6106.175666284995;6051.788187413419;6109.633421994695;6203.596766210362;6236.812895613139;6246.437820596168;6048.6975651218145;6050.636961782131;6073.665948372705;6120.0205129226715;6131.741070982759 13:00:07 INFO - PROCESS | 1638 | |1;ext.html;509.80117754075894;530.4350866327362;542.3302221756131;550.6778534557284;557.7657383898762;30533.847330763343;30817.69182308176;33444.83277583609;33474.49364778588;33496.83251583745;34795.478067829004;34902.476462853076;35588.82205588975;35642.821785891036;43685;9796.853047204298;9960.003999600054;9971.252156088287;9972;9982.101610855021;9751.463669498175;9854.753631159243;9864.90135098647;9865.309428340019;9872.259580531489;9205.677801276957;9242.260619150451;9821.116099551038;9874.308798384116;12022.27866328023;12175.756484870342;12468.875311246862;12476.3138027408;12480.687982800411;12517.624471265877;12244.938775306067;12312.876871231263;12344.259344439362;12344.321062341567;12344.62966111018;41792.791036044626;42243;42278.15443691109;42330.78834605807;42368.940776480835;3408.216110294621;3449.085992212066;3505.3164632896596;3693.519842420468;3694.9445758313645;30865.074047778602;30868.91958781432;31010;32462.837685811657;32654;2789.9302517437022;3332.350191712617;3408.659134086596;3412.129906873731;3554.626764189749;525395;526708;529506;529669.9999999962;531551;34639.30721385609;35246.29507409889;35465.1133721659;63221.735565288436;63903.680481597294;36057.278854422766;36189.45715814265;36198.63801362005;36241.45637815435;36320;15777.763333550007;15873.841261587468;15917.761233581505;15924.68150637004;15928.203589820463;13342.332883355988;13468.461261549624;13475.797863032063;13483.325833708275;13486.05597608158;7945.28492435672;7965.920340796633;8003.599820008976;8053.557054361949;8086.83826323482;3131.780775345704;3170.1757543038516;3264.2981758921946;3319.153615827997;3357.7933073914355;947.625687853294;965.285688590438;973.9464329461948;1039.1323245090282;1068.2148620763733;26277.948882044504;30889.382212355627;30914.227144321572;31270.530942035886;31580.52629210564;943.9103285187896;971.848359693751;1027;1043.4782608695652;1096.1066730614523;14045.648858778408;15256;15425.460108896135;15899.28453219608;16125.11311877858;381875;385129;386285;386355.0682246571;386697.06651467126;52911;61419.07871381933;62090.37909620936;62136;62229.68885155545;1327.6548097494529;1386.7226554689103;1429.585420228143;1434.0678558936565;1445.7469942760185;30530.542041868946;31981;32019.67980320167;32171.51742723814;32573.674263257064;51097.744511277204;51628.74185629048;51742.482575173766;51761.48238517567;51892.740536297075;564557;566686;567028;824434;847226;23879.283621491384;24170.51658966846;24178.637320439855;26584.468310634067;27026.189214322814;48341.758291208316;48542.27186592275;48619.02761944812;49409.50590494049;49870;39948.80025599853;41631.7918410406;41710.95722606959;42412.15175696531;43067.923301917705;38827.80586097051;38989.830305090894;39748.80125599354;40210.597894021856;40240;39622.811315660576;40058.798236052964;40874.59125408827;40977.38533921934;41196.38205426861;34442.48336275008;36152;36685.449718253716;36786.26427471489;36858.26283474369;26637.866810665822;26817;26908.327291817863;26943.86528067347;27376.58935115935 13:00:07 INFO - PROCESS | 1638 | |2;jquery.html;381.8167279705741;384.50590990577103;392.5270049590245;400.2235662814142;415.22974881594644;14198.503052393142;20010.59978800423;20628.793712062874;21378.89310553447;21402.35792926213;20979.47551311218;21187;21324.893375533138;21586.460338491546;21721.02255398507;5461.344638643368;6245.250569931592;6271.968640156792;6276.780312689057;6278.121063051177;5354.705491197982;5919.585629005971;6096.35988221237;6123.785667501638;6243.719032643542;6157.076438534211;6158.907616385758;6164.87670246597;6169.352218017111;6179.598326108811;5902.055671092626;6089.391060893941;6148.323684394713;6174.0430233313455;6186.876262474771;5355.464453554652;5362.249285100089;5364.249005139283;5366.195070739382;5370.597205209625;26583.468330633474;27026.729732702814;27254.45491090167;27304.45391092167;27607.86196069027;2290.9656355154684;2382.559226543078;2571.4985577812336;2930.7655387568943;2992.7156920092775;10376.584936602527;12166.452509637087;14023.29883505831;16183.757243641356;16768.41310554137;1854.249029143199;1875.8030406807225;1908.895010774407;1927.44104209779;1948.6005368899484;135587.64412355848;136600.31699841536;138026;142115.99999999895;143182;10141;11849.585264515701;11896.524139034515;11939.462724177432;12066.577669781516;13634.522791702242;14101.576952691436;15132.243387830784;15178.241087945558;15179.544613661608;8259.182979744446;8445.831083378422;8543.786405339917;8799.208071273617;8905.465672059698;7611.3910887128895;8745.644425114118;8811.559422029;8836.381453298336;8993.505357205286;3795.5445346558035;4532.32015197723;4628.190066738307;4667.696599721007;4675.836345727951;1873.4379686094117;1929.1318906492136;1931.0923865783059;1933.5649478867142;1942.3493129801393;909.7407238936871;925.6343744220995;931.4923366765129;946.5267366316841;957.2963871554402;18292.74371218079;20719.689204661943;21956.670649940264;22052.448688782908;22267.331980040624;940.722486866376;1025.2976710952871;1030.3663247102977;1035.9119474844572;1079.7624522605015;10862.891371086345;11475.254108482923;11500.654980350602;11516.596919107791;11518.712032199095;591469;623882;639630;649966;656741;133917;133978.33010835078;136433;139392;140357;945.2390825385493;963.9855402168973;968.3463662028103;970.9223262139012;995.6913356859542;15378.461753838563;17328.48014559565;17757.644847103245;19054;19071.427857164308;53421.66445838885;54169.187462187314;54547.454525455825;57129.85740285254;57283.713581431824;71395.64302178664;78111;81550.368992621;82739.17260827555;82817.58591207246;7673.386129109769;8267.545285009382;8321.95839020801;8479.19447652472;8585.969683638003;11776.646700598996;13204.141730787853;13214.27321497327;13256.867431325949;13413.932930335286;11569.768604628029;11618.302901825917;11620.186586938833;11650.359230242419;11964.9829764471;11351.432428378714;11477.48351324209;11626.302421854716;11849.763004740029;11889.346085965355;11497.425128743362;11868.82196767032;11873.584424545099;11903.880961190278;12066.818997714865;8179.877301840358;8219.095899450936;8469.57652117404;8633.82732345337;8642.135786421559;11114.388708621103;11482.311061336346;11521.53913843437;11850.288982661068;11909 13:00:07 INFO - PROCESS | 1638 | |3;mootools.html;1384.259421209653;1464.4508309383982;1555.0980431349815;1735.3839387017608;1913.5885784556326;8194;8706.477611343324;9046.773830654229;9260.212881905029;9267.119623635745;9071.138241867013;9156.359054866145;9162.129597688225;9167.77080572986;9186.402883812547;2064.9070791814406;2411.481531470738;2439.3657649011207;2441.694788151481;2442.6091825307954;2103.9900847593162;2384.988075059622;2389.522095580891;2407.265783935899;2448.52253810507;2400.147947478646;2418.842775219614;2429.392651837041;2433.902643894251;2438.158835201861;2377.2630484549845;2392.7487613800563;2394.1141777542334;2394.437307232799;2428.307932239321;2370.2059809963685;2397.640353946922;2402.111218849037;2403.579373609629;2404.7955923746504;9101.590428430736;9239.538023098885;9262.629494820267;9276.443413395218;9374.812503749956;5548.861278468071;5764.769409223626;5766.538676905838;5771.509421699118;5772.989726797836;3654.5614526256754;3697.4268988306853;3725.9813700931595;3755.267722794056;3759.6804271636943;1125.9324440533512;1130.909527237819;1133.4559411482535;1142.9199956003083;1152.8789477104867;12287.815682764765;12343;12400.75198496043;12441;12447.439865206088;3951.249262640089;4547.522510136388;4785.569298763058;4798.424189097261;4808.422989241243;9602.9039709602;9614;9624.37441566296;9632.181264592447;9634.90365096354;5510.8071217507195;5516.255305533782;5517.227588137664;5523.28197334344;5525.557955363562;4357.237483440385;4673.275642275453;4750.691205071659;4794.760261986957;5167.0957582422925;3901.08324543732;3947.644711975936;3981.92036159281;4075.959240407558;4082.8775136745944;1173.23153334566;1190.613050758507;1191.2316555821446;1199.3283761093815;1203.0676225924979;744.2594618354772;894.5571941888807;921.7688426238675;933.4819175357605;934.0752654871628;5213.504717051874;5810.331811841692;6069.635821850703;6181.165542651775;6215.223097112861;793.8690116130774;944.738773737055;950.2493030505962;959.4770849886828;962.2542529539663;3823.7323387363176;3905.3751399776465;3975.522937247491;4073.837046518106;4100.507939047274;11204.271722338022;11588.420578971187;11591.594294199662;11604.477798499087;11611.303321800719;9367.437953722798;11410;11411.942940285246;11494.770104598028;11545.422728863523;8190.672373105128;8314.501129932223;8531.402801803813;8747.431416957877;8747.475151490931;5942.405759424023;5972;5993.61041532299;6097.817065488042;6151.907721384094;10026;10468.790624187626;10557.894421055691;10618;10663.57345706194;9646.469444180357;9850.556724947251;10797.29817561856;10813.24307298513;10819.729506762395;7587.696492140252;7708.460407771402;7782.766517004499;7852.528848269122;7931.484453510503;8705.782355441164;8707.608157633049;8804.955975220082;8805.559722014003;8849.734507964771;7673.8848917267405;7797.649105790139;7824.84350313002;7845.803854903673;7849.332806711265;7685.4620176587105;7702.961485192538;7710.498817576839;7718.151003389735;7743.651535680795;7143.678534465857;7291.744788932362;7295.452841037049;7305.890411643723;7309.890351644836;4919.877003074808;4979.327790748347;4981.252812078217;5075.949240507548;5076.263941728503;5023.146065168857;5031.899362012812;5070.163423035306;5133.178691409356;5206.479352064764 13:00:07 INFO - PROCESS | 1638 | |4;prototype.html;283.13219980758976;309.10051749409223;316.1937060495735;322.2041557353338;323.2710238412383;5169.638125331228;5301.6818990860575;5349.7057661828685;5374.408815030343;5376.408595054546;5066.807911016064;5222.527019532016;5238.188080847474;5245.377311344328;5249.5012973767525;3824.464574959508;3976.065624578222;4079.5920407959115;4082.6935380678196;4099.979500102495;3759.3233218020746;3902.2585708715396;4038.5961403859524;4073.920411091063;4104.240715467633;3342.8997130086013;4035.878923632281;4061.532923713766;4069.552349241581;4091.5499295077516;4025.4565633639377;4042.2319759245647;4043.5349934757587;4059.1991525847366;4069.532003819569;3198.1205168578595;3448.8792892248653;3502.807345595991;3566.144125409909;3571.5178450909057;3832.9233415331814;4848.563629273347;5122.9754049190315;5166.5866730661455;5198.2722418861385;4621.514740952185;4633.351330813689;4681.812727490897;4687.414073240845;4702.49520153551;5566.916496252559;5579.804706835242;5594.552435805126;5603.049849855842;5617.719114044281;3786.678132358753;3902.551206611219;3917.8060286239797;3934.0361611405388;3936.4844534854287;5038.748062596856;5345.471988487619;5538.6122971392015;5793.884122317572;5807.912881306784;3149.4173577888164;3997.300472417315;4023.879283621496;4025.3358195897936;4033.4756481657196;3690.538682664667;3783.0920579061376;4069.145479449349;4088.34586466164;4101.364288535282;3746.269477451925;3967.0479085019388;4593.311003349524;4620.696202215432;4634.351190833286;5140.691558506502;5463.399026107125;5527.751251193706;5618.971905140448;5675.262215911905;1139.9512448547357;1155.6648571914218;1283.3903895649678;1336.9732605348033;1352.763266428371;891.4383938119073;932.8479328029878;947.6777895515557;953.9666111686197;955.3360414511986;4623.306504024423;5093.592512598983;5130.256112863689;5341.732913354317;5381.650192737459;4637.287186995578;5127.87180320495;5547.39125653564;5677.37548869624;5750.654960702372;4077.26609210345;4445.555444455593;4483.686141970031;5171.276021357013;5242.981452140877;2204.8787316697735;2246.79778819907;2257.830662700304;2522.672052633146;2555.2078855554837;4056.215265283266;4251.234777739975;4455.509893911667;4883.265371392032;5001.7499125043605;4075.5924407559005;4892.510748925079;4936.308916751657;4962.551027036176;4995.925061124086;4301.60173462967;4630.976845115752;4718.834840780556;4718.929216061831;4952.479989601112;4065.5527891932456;4400.955990440055;4667.556582124693;4676.7895444705755;4735.6211503078985;4215.9552616981355;4511.977440112779;4613.976930115328;4637.791299391603;4639.747268237625;4699.861562988764;4810.5670489656095;4867.10183028612;4892.339534162842;4918.532739389752;3096.708435757568;3170.4306368347816;3234.142952117738;3244.836284622474;3245;3876.4960555127655;3905.882823515299;4440.511543730123;4566.406367172379;4579.290210017452;3698.5931547529212;3790.166163444148;3862.24686186191;4666.896513818273;4702.600278976189;4376.518582955936;4584.312353147055;4605.125026245003;4661;4661.906761864811;4237.936430953477;4242.469691288589;4739.795994862406;4767.69010014348;5158.4583618721;4590.3933623231605;5543.223948647274;5564.33228012641;5567.888642227052;5590.357108932525;4808.7595620219545;4941.777620007037;5227.451117632746;5475.206095116107;5560.833175004756 13:00:07 INFO - PROCESS | 1638 | |5;yui.html;755.5428965475887;780.6018930345522;789.4671097009517;799.7840583042575;851.5699571716283;15876;16730.66538669226;16800.579985500353;16839.74740378895;16863;14952.626184345398;15093.849061509409;15112.773308400356;15117.470888518905;15121.773173402407;716.8852983522625;737.8229224985992;871.9346049046316;901.5807649443008;908.4776253654143;900.4102312985005;905.1582028713294;906.4017748286133;909.9954500227523;910.7040211931115;964.3105179796444;965.6041023180462;966.9613215471372;967.729035869954;971.3637567393368;952.1002652493396;954.2938225712992;958.0419580419581;958.5542722633938;959.1751094059103;607.5564837668483;721.0266140710052;721.0770214125927;721.3507842941342;725.6480606905646;15699;15707.214639267992;15707.214639268104;15707.607309817346;15716.921415392964;13822.37799299024;13916.86083139176;14287.714245715131;14448.855511444855;15193.772093418607;11914.523419063227;13606;13686.247256400893;13888.166709997433;13967.125105860341;4859.58693511052;4859.829905953275;4872.78072486739;4874.366332376804;5066.442691303953;129421;129672.05491917628;130734;130988.34505827409;136109;11376.374299413446;11728.765424691459;11742.00192983606;11850.525978960744;12124.636260912186;23391.41521461977;23649.408764780674;23690.7630923692;23748.406289842893;24406.87796561006;8039.598020098972;8136.918630813734;8182.7954301142945;8223.794405139799;8257.42198046143;4454.465464144323;4456.68803183774;4634.907301853944;4640.373549570832;4777.9727358617365;3642.3807952648112;3752.549694036733;3803.3154032274456;3804.866829661004;3810.923781524354;681.6489507903434;693.462566510958;704.1585305559909;705.0341032785014;707.5012116457988;549.5054450994137;599.5952731906033;604.305049193431;610.8137018209488;613.7084884679741;8774;9622.951885240529;9625.470599117116;9633.662821801203;9758.710477371358;584.5498965796313;654.898490733937;678.2742465561802;683.1494788987742;706.2161001288565;4512.323151527232;4698.577128058491;4719.504452032487;4734.242521196661;4790.808367665254;78760.60619696979;142062;161713.29720216588;166601;181248.18751812578;128279.35860320639;139341;140926;148400;148928.25535872253;98252;101826.98173018175;123045;123156;128485.35757321154;7887.408444366581;9283.210927071275;9391.671291504765;9600.183984361129;9913.702588922344;63496.68251658712;64955.376115597486;65718.34281657122;66510.34427590022;67916;95812;98817.50591246998;100502;102016;103149.48425258126;14151.363188656742;14272.785908211592;14348.928255359075;14371.353289101806;14577.635559111108;14900;14977.925110374379;15655;15709.842901571295;16365.936214146042;14001.649958751113;14514.782278265624;14547.199904005382;15283.312250948511;15392.153431560924;14094.859051409765;14438.278086095863;14674.266286685837;14763.704725905636;15351.309191086204;13512.79730804019;14161.858381416054;14165.43338266499;14519.709605808035;14694.853051469348;11597.88402115968;11687.298762074302;11927.642170734893;12004.39978001079;12207.38963051826;12132.636020919386;12165.148439609497;12288.877111228774;12368.072394570263;12448.564300249447 13:00:07 INFO - PROCESS | 1638 | __end_tp_report 13:00:07 INFO - PROCESS | 1638 | __start_cc_report 13:00:07 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,1310 13:00:07 INFO - PROCESS | 1638 | __end_cc_report 13:00:07 INFO - PROCESS | 1638 | __startTimestamp1483822807184__endTimestamp 13:00:07 INFO - PROCESS | 1638 | 13:00:07 INFO - PROCESS | 1638 | ------- Summary: start ------- 13:00:07 INFO - PROCESS | 1638 | Number of tests: 6 13:00:07 INFO - PROCESS | 1638 | 13:00:07 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5794.10 Median:5928.23 stddev:642.57 (10.8%) stddev-sans-first:608.30 13:00:07 INFO - PROCESS | 1638 | Values: 3081.9 3482.4 3508.3 3530.1 3532.0 5785.0 5869.5 5900.4 5920.9 5921.5 5838.5 5868.5 5908.6 5916.3 5922.1 5266.3 5284.0 5331.1 5355.0 5366.3 5221.2 5224.3 5247.8 5370.2 5389.9 5260.7 5262.1 5321.5 5324.4 5338.3 5283.6 5289.2 5293.3 5353.4 5355.4 5209.5 5293.7 5301.0 5302.4 5327.1 5682.8 5715.0 5778.6 5782.6 5928.2 5780.8 6255.9 6323.0 6339.0 6340.9 5040.7 5158.6 6297.8 6309.4 6316.8 5777.5 5833.7 5839.2 5853.8 5908.4 6258.2 6314.2 6320.5 6327.7 6328.7 6248.8 6261.4 6262.0 6278.2 6284.4 6166.4 6195.0 6261.7 6279.6 6334.7 6244.7 6300.8 6316.0 6352.7 6357.5 5217.2 6157.6 6345.6 6365.5 6384.5 4950.5 4995.7 5038.7 5039.1 5057.8 4477.3 4528.5 4532.9 4546.2 4547.4 5855.9 5860.7 5862.2 5862.6 5878.2 5921.0 6294.9 6311.6 6311.7 6330.2 5626.9 5696.9 5754.5 5763.0 5818.4 4698.8 5448.8 5460.0 5472.8 5476.9 6429.2 6435.5 6441.1 6449.5 6455.3 6255.3 6255.5 6290.9 6301.7 6315.6 5311.4 6254.6 6271.6 6289.7 6336.1 6246.2 6284.9 6299.9 6300.4 6307.8 5301.2 6274.3 6282.3 6289.3 6371.3 5880.3 6121.4 6142.3 6220.7 6274.5 6124.4 6247.1 6253.6 6260.2 6280.6 6088.6 6096.1 6098.9 6103.5 6106.2 6051.8 6109.6 6203.6 6236.8 6246.4 6048.7 6050.6 6073.7 6120.0 6131.7 13:00:07 INFO - PROCESS | 1638 | 13:00:07 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:65773.58 Median:36220.05 stddev:146880.96 (405.5%) stddev-sans-first:147211.26 13:00:07 INFO - PROCESS | 1638 | Values: 509.8 530.4 542.3 550.7 557.8 30533.8 30817.7 33444.8 33474.5 33496.8 34795.5 34902.5 35588.8 35642.8 43685.0 9796.9 9960.0 9971.3 9972.0 9982.1 9751.5 9854.8 9864.9 9865.3 9872.3 9205.7 9242.3 9821.1 9874.3 12022.3 12175.8 12468.9 12476.3 12480.7 12517.6 12244.9 12312.9 12344.3 12344.3 12344.6 41792.8 42243.0 42278.2 42330.8 42368.9 3408.2 3449.1 3505.3 3693.5 3694.9 30865.1 30868.9 31010.0 32462.8 32654.0 2789.9 3332.4 3408.7 3412.1 3554.6 525395.0 526708.0 529506.0 529670.0 531551.0 34639.3 35246.3 35465.1 63221.7 63903.7 36057.3 36189.5 36198.6 36241.5 36320.0 15777.8 15873.8 15917.8 15924.7 15928.2 13342.3 13468.5 13475.8 13483.3 13486.1 7945.3 7965.9 8003.6 8053.6 8086.8 3131.8 3170.2 3264.3 3319.2 3357.8 947.6 965.3 973.9 1039.1 1068.2 26277.9 30889.4 30914.2 31270.5 31580.5 943.9 971.8 1027.0 1043.5 1096.1 14045.6 15256.0 15425.5 15899.3 16125.1 381875.0 385129.0 386285.0 386355.1 386697.1 52911.0 61419.1 62090.4 62136.0 62229.7 1327.7 1386.7 1429.6 1434.1 1445.7 30530.5 31981.0 32019.7 32171.5 32573.7 51097.7 51628.7 51742.5 51761.5 51892.7 564557.0 566686.0 567028.0 824434.0 847226.0 23879.3 24170.5 24178.6 26584.5 27026.2 48341.8 48542.3 48619.0 49409.5 49870.0 39948.8 41631.8 41711.0 42412.2 43067.9 38827.8 38989.8 39748.8 40210.6 40240.0 39622.8 40058.8 40874.6 40977.4 41196.4 34442.5 36152.0 36685.4 36786.3 36858.3 26637.9 26817.0 26908.3 26943.9 27376.6 13:00:07 INFO - PROCESS | 1638 | 13:00:07 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:37186.89 Median:2477.03 stddev:106007.19 (4279.6%) stddev-sans-first:106268.54 13:00:07 INFO - PROCESS | 1638 | Values: 381.8 384.5 392.5 400.2 415.2 14198.5 20010.6 20628.8 21378.9 21402.4 20979.5 21187.0 21324.9 21586.5 21721.0 5461.3 6245.3 6272.0 6276.8 6278.1 5354.7 5919.6 6096.4 6123.8 6243.7 6157.1 6158.9 6164.9 6169.4 6179.6 5902.1 6089.4 6148.3 6174.0 6186.9 5355.5 5362.2 5364.2 5366.2 5370.6 26583.5 27026.7 27254.5 27304.5 27607.9 2291.0 2382.6 2571.5 2930.8 2992.7 10376.6 12166.5 14023.3 16183.8 16768.4 1854.2 1875.8 1908.9 1927.4 1948.6 135587.6 136600.3 138026.0 142116.0 143182.0 10141.0 11849.6 11896.5 11939.5 12066.6 13634.5 14101.6 15132.2 15178.2 15179.5 8259.2 8445.8 8543.8 8799.2 8905.5 7611.4 8745.6 8811.6 8836.4 8993.5 3795.5 4532.3 4628.2 4667.7 4675.8 1873.4 1929.1 1931.1 1933.6 1942.3 909.7 925.6 931.5 946.5 957.3 18292.7 20719.7 21956.7 22052.4 22267.3 940.7 1025.3 1030.4 1035.9 1079.8 10862.9 11475.3 11500.7 11516.6 11518.7 591469.0 623882.0 639630.0 649966.0 656741.0 133917.0 133978.3 136433.0 139392.0 140357.0 945.2 964.0 968.3 970.9 995.7 15378.5 17328.5 17757.6 19054.0 19071.4 53421.7 54169.2 54547.5 57129.9 57283.7 71395.6 78111.0 81550.4 82739.2 82817.6 7673.4 8267.5 8322.0 8479.2 8586.0 11776.6 13204.1 13214.3 13256.9 13413.9 11569.8 11618.3 11620.2 11650.4 11965.0 11351.4 11477.5 11626.3 11849.8 11889.3 11497.4 11868.8 11873.6 11903.9 12066.8 8179.9 8219.1 8469.6 8633.8 8642.1 11114.4 11482.3 11521.5 11850.3 11909.0 13:00:07 INFO - PROCESS | 1638 | 13:00:07 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:5903.19 Median:5051.03 stddev:3369.77 (66.7%) stddev-sans-first:3362.11 13:00:07 INFO - PROCESS | 1638 | Values: 1384.3 1464.5 1555.1 1735.4 1913.6 8194.0 8706.5 9046.8 9260.2 9267.1 9071.1 9156.4 9162.1 9167.8 9186.4 2064.9 2411.5 2439.4 2441.7 2442.6 2104.0 2385.0 2389.5 2407.3 2448.5 2400.1 2418.8 2429.4 2433.9 2438.2 2377.3 2392.7 2394.1 2394.4 2428.3 2370.2 2397.6 2402.1 2403.6 2404.8 9101.6 9239.5 9262.6 9276.4 9374.8 5548.9 5764.8 5766.5 5771.5 5773.0 3654.6 3697.4 3726.0 3755.3 3759.7 1125.9 1130.9 1133.5 1142.9 1152.9 12287.8 12343.0 12400.8 12441.0 12447.4 3951.2 4547.5 4785.6 4798.4 4808.4 9602.9 9614.0 9624.4 9632.2 9634.9 5510.8 5516.3 5517.2 5523.3 5525.6 4357.2 4673.3 4750.7 4794.8 5167.1 3901.1 3947.6 3981.9 4076.0 4082.9 1173.2 1190.6 1191.2 1199.3 1203.1 744.3 894.6 921.8 933.5 934.1 5213.5 5810.3 6069.6 6181.2 6215.2 793.9 944.7 950.2 959.5 962.3 3823.7 3905.4 3975.5 4073.8 4100.5 11204.3 11588.4 11591.6 11604.5 11611.3 9367.4 11410.0 11411.9 11494.8 11545.4 8190.7 8314.5 8531.4 8747.4 8747.5 5942.4 5972.0 5993.6 6097.8 6151.9 10026.0 10468.8 10557.9 10618.0 10663.6 9646.5 9850.6 10797.3 10813.2 10819.7 7587.7 7708.5 7782.8 7852.5 7931.5 8705.8 8707.6 8805.0 8805.6 8849.7 7673.9 7797.6 7824.8 7845.8 7849.3 7685.5 7703.0 7710.5 7718.2 7743.7 7143.7 7291.7 7295.5 7305.9 7309.9 4919.9 4979.3 4981.3 5075.9 5076.3 5023.1 5031.9 5070.2 5133.2 5206.5 13:00:07 INFO - PROCESS | 1638 | 13:00:07 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4201.50 Median:4617.34 stddev:1259.42 (27.3%) stddev-sans-first:1228.13 13:00:07 INFO - PROCESS | 1638 | Values: 283.1 309.1 316.2 322.2 323.3 5169.6 5301.7 5349.7 5374.4 5376.4 5066.8 5222.5 5238.2 5245.4 5249.5 3824.5 3976.1 4079.6 4082.7 4100.0 3759.3 3902.3 4038.6 4073.9 4104.2 3342.9 4035.9 4061.5 4069.6 4091.5 4025.5 4042.2 4043.5 4059.2 4069.5 3198.1 3448.9 3502.8 3566.1 3571.5 3832.9 4848.6 5123.0 5166.6 5198.3 4621.5 4633.4 4681.8 4687.4 4702.5 5566.9 5579.8 5594.6 5603.0 5617.7 3786.7 3902.6 3917.8 3934.0 3936.5 5038.7 5345.5 5538.6 5793.9 5807.9 3149.4 3997.3 4023.9 4025.3 4033.5 3690.5 3783.1 4069.1 4088.3 4101.4 3746.3 3967.0 4593.3 4620.7 4634.4 5140.7 5463.4 5527.8 5619.0 5675.3 1140.0 1155.7 1283.4 1337.0 1352.8 891.4 932.8 947.7 954.0 955.3 4623.3 5093.6 5130.3 5341.7 5381.7 4637.3 5127.9 5547.4 5677.4 5750.7 4077.3 4445.6 4483.7 5171.3 5243.0 2204.9 2246.8 2257.8 2522.7 2555.2 4056.2 4251.2 4455.5 4883.3 5001.7 4075.6 4892.5 4936.3 4962.6 4995.9 4301.6 4631.0 4718.8 4718.9 4952.5 4065.6 4401.0 4667.6 4676.8 4735.6 4216.0 4512.0 4614.0 4637.8 4639.7 4699.9 4810.6 4867.1 4892.3 4918.5 3096.7 3170.4 3234.1 3244.8 3245.0 3876.5 3905.9 4440.5 4566.4 4579.3 3698.6 3790.2 3862.2 4666.9 4702.6 4376.5 4584.3 4605.1 4661.0 4661.9 4237.9 4242.5 4739.8 4767.7 5158.5 4590.4 5543.2 5564.3 5567.9 5590.4 4808.8 4941.8 5227.5 5475.2 5560.8 13:00:07 INFO - PROCESS | 1638 | 13:00:07 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:26656.90 Median:14024.63 stddev:42791.43 (305.1%) stddev-sans-first:42867.28 13:00:07 INFO - PROCESS | 1638 | Values: 755.5 780.6 789.5 799.8 851.6 15876.0 16730.7 16800.6 16839.7 16863.0 14952.6 15093.8 15112.8 15117.5 15121.8 716.9 737.8 871.9 901.6 908.5 900.4 905.2 906.4 910.0 910.7 964.3 965.6 967.0 967.7 971.4 952.1 954.3 958.0 958.6 959.2 607.6 721.0 721.1 721.4 725.6 15699.0 15707.2 15707.2 15707.6 15716.9 13822.4 13916.9 14287.7 14448.9 15193.8 11914.5 13606.0 13686.2 13888.2 13967.1 4859.6 4859.8 4872.8 4874.4 5066.4 129421.0 129672.1 130734.0 130988.3 136109.0 11376.4 11728.8 11742.0 11850.5 12124.6 23391.4 23649.4 23690.8 23748.4 24406.9 8039.6 8136.9 8182.8 8223.8 8257.4 4454.5 4456.7 4634.9 4640.4 4778.0 3642.4 3752.5 3803.3 3804.9 3810.9 681.6 693.5 704.2 705.0 707.5 549.5 599.6 604.3 610.8 613.7 8774.0 9623.0 9625.5 9633.7 9758.7 584.5 654.9 678.3 683.1 706.2 4512.3 4698.6 4719.5 4734.2 4790.8 78760.6 142062.0 161713.3 166601.0 181248.2 128279.4 139341.0 140926.0 148400.0 148928.3 98252.0 101827.0 123045.0 123156.0 128485.4 7887.4 9283.2 9391.7 9600.2 9913.7 63496.7 64955.4 65718.3 66510.3 67916.0 95812.0 98817.5 100502.0 102016.0 103149.5 14151.4 14272.8 14348.9 14371.4 14577.6 14900.0 14977.9 15655.0 15709.8 16365.9 14001.6 14514.8 14547.2 15283.3 15392.2 14094.9 14438.3 14674.3 14763.7 15351.3 13512.8 14161.9 14165.4 14519.7 14694.9 11597.9 11687.3 11927.6 12004.4 12207.4 12132.6 12165.1 12288.9 12368.1 12448.6 13:00:07 INFO - PROCESS | 1638 | -------- Summary: end -------- 13:00:07 INFO - PROCESS | 1638 | 13:00:07 INFO - TEST-INFO | 1638: exit 0 13:00:07 INFO - TEST-OK | dromaeo_css | took 1115394ms 13:00:07 INFO - TEST-START | kraken 13:00:07 INFO - operating with platform_type : mac_ 13:00:07 INFO - Initialising browser for kraken test... 13:00:07 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpIVCwIs/profile http://localhost:49251/getInfo.html) 13:00:09 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 13:00:09 INFO - PROCESS | 1647 | colorDepth:24 13:00:09 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 13:00:09 INFO - PROCESS | 1647 | __metrics 13:00:10 INFO - PROCESS | 1647 | 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" 13:00:10 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:00:10 INFO - TEST-INFO | 1647: exit 0 13:00:10 INFO - Browser initialized. 13:00:10 INFO - Running cycle 1/1 for kraken test... 13:00:10 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpIVCwIs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:00:22 INFO - PROCESS | 1649 | RSS: Main: 169017344 13:00:22 INFO - PROCESS | 1649 | 13:00:25 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-beat-detection) 13:00:26 INFO - PROCESS | 1649 | RSS: Main: 220041216 13:00:26 INFO - PROCESS | 1649 | 13:00:29 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-dft) 13:00:29 INFO - PROCESS | 1649 | RSS: Main: 232976384 13:00:29 INFO - PROCESS | 1649 | 13:00:32 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-fft) 13:00:33 INFO - PROCESS | 1649 | RSS: Main: 330338304 13:00:33 INFO - PROCESS | 1649 | 13:00:35 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49251/tests/kraken/driver.html?testName=audio-oscillator) 13:00:36 INFO - PROCESS | 1649 | RSS: Main: 229212160 13:00:36 INFO - PROCESS | 1649 | 13:00:38 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:00:38 INFO - PROCESS | 1649 | RSS: Main: 230977536 13:00:38 INFO - PROCESS | 1649 | 13:00:41 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-darkroom) 13:00:42 INFO - PROCESS | 1649 | RSS: Main: 267345920 13:00:42 INFO - PROCESS | 1649 | 13:00:44 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49251/tests/kraken/driver.html?testName=imaging-desaturate) 13:00:45 INFO - PROCESS | 1649 | RSS: Main: 268853248 13:00:45 INFO - PROCESS | 1649 | 13:00:48 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49251/tests/kraken/driver.html?testName=json-parse-financial) 13:00:48 INFO - PROCESS | 1649 | RSS: Main: 268271616 13:00:48 INFO - PROCESS | 1649 | 13:00:50 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49251/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:00:50 INFO - PROCESS | 1649 | RSS: Main: 240967680 13:00:50 INFO - PROCESS | 1649 | 13:00:52 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:00:53 INFO - PROCESS | 1649 | RSS: Main: 247029760 13:00:53 INFO - PROCESS | 1649 | 13:00:55 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:00:56 INFO - PROCESS | 1649 | RSS: Main: 252006400 13:00:56 INFO - PROCESS | 1649 | 13:00:58 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:00:59 INFO - PROCESS | 1649 | RSS: Main: 266047488 13:00:59 INFO - PROCESS | 1649 | 13:01:02 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:01:03 INFO - PROCESS | 1649 | RSS: Main: 260337664 13:01:03 INFO - PROCESS | 1649 | 13:01:04 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49251/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49251/tests/kraken/driver.html?testName=ai-astar) 13:01:05 INFO - PROCESS | 1649 | RSS: Main: 303947776 13:01:05 INFO - PROCESS | 1649 | 13:01:05 INFO - PROCESS | 1649 | __start_tp_report 13:01:05 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 13:01:05 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 13:01:05 INFO - PROCESS | 1649 | |i|pagename|runs| 13:01:05 INFO - PROCESS | 1649 | |0;ai-astar;114;114;114;115;114;114;114;115;114;112 13:01:05 INFO - PROCESS | 1649 | |1;audio-beat-detection;142;106;114;125;128;134;134;139;135;107 13:01:05 INFO - PROCESS | 1649 | |2;audio-dft;182;184;183;183;184;184;182;182;183;185 13:01:05 INFO - PROCESS | 1649 | |3;audio-fft;81;57;58;90;62;59;57;58;81;57 13:01:05 INFO - PROCESS | 1649 | |4;audio-oscillator;82;71;118;100;96;79;91;66;69;98 13:01:05 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;87;83;87;84;88;84;87;84;90;84 13:01:05 INFO - PROCESS | 1649 | |6;imaging-darkroom;93;92;93;93;93;93;92;93;92;92 13:01:05 INFO - PROCESS | 1649 | |7;imaging-desaturate;86;84;84;86;83;86;87;86;101;139 13:01:05 INFO - PROCESS | 1649 | |8;json-parse-financial;55;53;52;52;56;58;58;56;58;58 13:01:05 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;64;71;70;80;74;70;68;67;69;70 13:01:05 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;76;83;74;78;75;82;82;84;82;82 13:01:05 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;146;145;126;133;133;139;143;124;196;165 13:01:05 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;159;157;159;155;160;148;210;166;161;163 13:01:05 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;68;81;82;67;65;67;65;66;88;76 13:01:05 INFO - PROCESS | 1649 | __end_tp_report 13:01:05 INFO - PROCESS | 1649 | __start_cc_report 13:01:05 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,1887 13:01:05 INFO - PROCESS | 1649 | __end_cc_report 13:01:05 INFO - PROCESS | 1649 | __startTimestamp1483822865134__endTimestamp 13:01:05 INFO - PROCESS | 1649 | 13:01:05 INFO - PROCESS | 1649 | ------- Summary: start ------- 13:01:05 INFO - PROCESS | 1649 | Number of tests: 14 13:01:05 INFO - PROCESS | 1649 | 13:01:05 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:0.82 (0.7%) stddev-sans-first:0.87 13:01:05 INFO - PROCESS | 1649 | Values: 114.0 114.0 114.0 115.0 114.0 114.0 114.0 115.0 114.0 112.0 13:01:05 INFO - PROCESS | 1649 | 13:01:05 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:126.40 Median:134.00 stddev:13.09 (9.8%) stddev-sans-first:12.61 13:01:05 INFO - PROCESS | 1649 | Values: 142.0 106.0 114.0 125.0 128.0 134.0 134.0 139.0 135.0 107.0 13:01:05 INFO - PROCESS | 1649 | 13:01:05 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:183.20 Median:183.50 stddev:1.03 (0.6%) stddev-sans-first:1.00 13:01:05 INFO - PROCESS | 1649 | Values: 182.0 184.0 183.0 183.0 184.0 184.0 182.0 182.0 183.0 185.0 13:01:05 INFO - PROCESS | 1649 | 13:01:05 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:66.00 Median:60.50 stddev:12.75 (21.1%) stddev-sans-first:12.31 13:01:05 INFO - PROCESS | 1649 | Values: 81.0 57.0 58.0 90.0 62.0 59.0 57.0 58.0 81.0 57.0 13:01:05 INFO - PROCESS | 1649 | 13:01:05 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:87.00 Median:80.50 stddev:16.53 (20.5%) stddev-sans-first:17.43 13:01:05 INFO - PROCESS | 1649 | Values: 82.0 71.0 118.0 100.0 96.0 79.0 91.0 66.0 69.0 98.0 13:01:05 INFO - PROCESS | 1649 | 13:01:05 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:87.00 stddev:2.30 (2.6%) stddev-sans-first:2.40 13:01:05 INFO - PROCESS | 1649 | Values: 87.0 83.0 87.0 84.0 88.0 84.0 87.0 84.0 90.0 84.0 13:01:05 INFO - PROCESS | 1649 | 13:01:05 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:92.60 Median:93.00 stddev:0.52 (0.6%) stddev-sans-first:0.53 13:01:05 INFO - PROCESS | 1649 | Values: 93.0 92.0 93.0 93.0 93.0 93.0 92.0 93.0 92.0 92.0 13:01:05 INFO - PROCESS | 1649 | 13:01:05 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:92.20 Median:86.00 stddev:17.22 (20.0%) stddev-sans-first:18.11 13:01:05 INFO - PROCESS | 1649 | Values: 86.0 84.0 84.0 86.0 83.0 86.0 87.0 86.0 101.0 139.0 13:01:05 INFO - PROCESS | 1649 | 13:01:05 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:57.00 stddev:2.50 (4.4%) stddev-sans-first:2.65 13:01:05 INFO - PROCESS | 1649 | Values: 55.0 53.0 52.0 52.0 56.0 58.0 58.0 56.0 58.0 58.0 13:01:05 INFO - PROCESS | 1649 | 13:01:05 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:70.30 Median:70.00 stddev:4.30 (6.1%) stddev-sans-first:3.91 13:01:05 INFO - PROCESS | 1649 | Values: 64.0 71.0 70.0 80.0 74.0 70.0 68.0 67.0 69.0 70.0 13:01:05 INFO - PROCESS | 1649 | 13:01:05 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:82.00 stddev:3.68 (4.5%) stddev-sans-first:3.63 13:01:05 INFO - PROCESS | 1649 | Values: 76.0 83.0 74.0 78.0 75.0 82.0 82.0 84.0 82.0 82.0 13:01:05 INFO - PROCESS | 1649 | 13:01:05 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:145.00 Median:144.00 stddev:21.43 (14.9%) stddev-sans-first:22.72 13:01:05 INFO - PROCESS | 1649 | Values: 146.0 145.0 126.0 133.0 133.0 139.0 143.0 124.0 196.0 165.0 13:01:05 INFO - PROCESS | 1649 | 13:01:05 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.80 Median:160.50 stddev:16.94 (10.6%) stddev-sans-first:17.87 13:01:05 INFO - PROCESS | 1649 | Values: 159.0 157.0 159.0 155.0 160.0 148.0 210.0 166.0 161.0 163.0 13:01:05 INFO - PROCESS | 1649 | 13:01:05 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.50 Median:72.00 stddev:8.50 (11.8%) stddev-sans-first:8.86 13:01:05 INFO - PROCESS | 1649 | Values: 68.0 81.0 82.0 67.0 65.0 67.0 65.0 66.0 88.0 76.0 13:01:05 INFO - PROCESS | 1649 | -------- Summary: end -------- 13:01:05 INFO - PROCESS | 1649 | 13:01:05 INFO - TEST-INFO | 1649: exit 0 13:01:05 INFO - TEST-OK | kraken | took 58199ms 13:01:05 INFO - SUITE-END | took 1173s 13:01:06 INFO - Completed test suite (00:19:33) 13:01:06 INFO - javascript benchmark 13:01:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3081.8767249310026, 3482.4079906415914, 3508.2808024354995, 3530.117470632342, 3531.982340088299, 5785.045467497863, 5869.530437564995, 5900.380460051697, 5920.911186332209, 5921.467067963882, 5838.503727183184, 5868.501177399916, 5908.586398952075, 5916.319623243328, 5922.052471604544, 5266.34170728658, 5283.973580132113, 5331.067063263933, 5355.0, 5366.329208848894, 5221.216817477371, 5224.320838291036, 5247.816326428557, 5370.248165256867, 5389.9191512127345, 5260.710660913648, 5262.079136151177, 5321.547668448186, 5324.387695415038, 5338.252644629755, 5283.6037297202865, 5289.233061206142, 5293.311869456985, 5353.411124776271, 5355.384130824966, 5209.47905209476, 5293.708846013467, 5301.045811753883, 5302.390225124083, 5327.147656375, 5682.829515114553, 5714.9714251428895, 5778.624389414675, 5782.566307526952, 5928.229330187048, 5780.84383123377, 6255.906161407583, 6323.019931910515, 6339.049142628596, 6340.873182536324, 5040.672356296829, 5158.638895277332, 6297.811065668037, 6309.400606942333, 6316.778912738078, 5777.480026797609, 5833.7083145842535, 5839.240898683144, 5853.765849365977, 5908.350081491032, 6258.217722784652, 6314.179156709598, 6320.5259605528845, 6327.651979141191, 6328.6519241442165, 6248.781292654826, 6261.373862613702, 6261.96869015652, 6278.215223097113, 6284.402981716729, 6166.352532984062, 6195.0, 6261.7182226799905, 6279.591826531261, 6334.683265836782, 6244.718987645567, 6300.8424789379715, 6316.0, 6352.6823658816875, 6357.523185761086, 5217.191335342952, 6157.641593426515, 6345.587536810092, 6365.522585806083, 6384.52116091295, 4950.480199579064, 4995.650304478724, 5038.697678139323, 5039.143345631252, 5057.848264552069, 4477.261251893401, 4528.479224889114, 4532.88667783308, 4546.249868771615, 4547.431571053618, 5855.941440585625, 5860.70696465175, 5862.237909071793, 5862.560307976919, 5878.206442130343, 5920.970395148083, 6294.937050629526, 6311.621302721851, 6311.684415779193, 6330.208723909512, 5626.85932851682, 5696.914546281809, 5754.539636829044, 5763.020286551213, 5818.44724751148, 4698.812047518061, 5448.782048718086, 5460.0, 5472.781088756485, 5476.890462190734, 6429.196350456193, 6435.549511534241, 6441.0982462455295, 6449.484041276686, 6455.257645370749, 6255.311915689362, 6255.53083518747, 6290.874182516232, 6301.747930082745, 6315.621062736251, 5311.3891902431715, 6254.593451425642, 6271.560990730605, 6289.685515724104, 6336.081268216175, 6246.219222597176, 6284.937150628435, 6299.937000629935, 6300.401461861299, 6307.779227727007, 5301.1783173608155, 6274.278457977391, 6282.308946016026, 6289.276733175743, 6371.299157092809, 5880.26496687914, 6121.361519882508, 6142.345304543789, 6220.688965551613, 6274.498040156868, 6124.441964285778, 6247.125402443752, 6253.5622506424115, 6260.217472815898, 6280.623162610258, 6088.634681919099, 6096.1465394845645, 6098.939010609837, 6103.450689437795, 6106.175666284995, 6051.788187413419, 6109.633421994695, 6203.596766210362, 6236.812895613139, 6246.437820596168, 6048.6975651218145, 6050.636961782131, 6073.665948372705, 6120.0205129226715, 6131.741070982759], "value": 5755.240211777057, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [509.80117754075894, 530.4350866327362, 542.3302221756131, 550.6778534557284, 557.7657383898762, 30533.847330763343, 30817.69182308176, 33444.83277583609, 33474.49364778588, 33496.83251583745, 34795.478067829004, 34902.476462853076, 35588.82205588975, 35642.821785891036, 43685.0, 9796.853047204298, 9960.003999600054, 9971.252156088287, 9972.0, 9982.101610855021, 9751.463669498175, 9854.753631159243, 9864.90135098647, 9865.309428340019, 9872.259580531489, 9205.677801276957, 9242.260619150451, 9821.116099551038, 9874.308798384116, 12022.27866328023, 12175.756484870342, 12468.875311246862, 12476.3138027408, 12480.687982800411, 12517.624471265877, 12244.938775306067, 12312.876871231263, 12344.259344439362, 12344.321062341567, 12344.62966111018, 41792.791036044626, 42243.0, 42278.15443691109, 42330.78834605807, 42368.940776480835, 3408.216110294621, 3449.085992212066, 3505.3164632896596, 3693.519842420468, 3694.9445758313645, 30865.074047778602, 30868.91958781432, 31010.0, 32462.837685811657, 32654.0, 2789.9302517437022, 3332.350191712617, 3408.659134086596, 3412.129906873731, 3554.626764189749, 525395.0, 526708.0, 529506.0, 529669.9999999962, 531551.0, 34639.30721385609, 35246.29507409889, 35465.1133721659, 63221.735565288436, 63903.680481597294, 36057.278854422766, 36189.45715814265, 36198.63801362005, 36241.45637815435, 36320.0, 15777.763333550007, 15873.841261587468, 15917.761233581505, 15924.68150637004, 15928.203589820463, 13342.332883355988, 13468.461261549624, 13475.797863032063, 13483.325833708275, 13486.05597608158, 7945.28492435672, 7965.920340796633, 8003.599820008976, 8053.557054361949, 8086.83826323482, 3131.780775345704, 3170.1757543038516, 3264.2981758921946, 3319.153615827997, 3357.7933073914355, 947.625687853294, 965.285688590438, 973.9464329461948, 1039.1323245090282, 1068.2148620763733, 26277.948882044504, 30889.382212355627, 30914.227144321572, 31270.530942035886, 31580.52629210564, 943.9103285187896, 971.848359693751, 1027.0, 1043.4782608695652, 1096.1066730614523, 14045.648858778408, 15256.0, 15425.460108896135, 15899.28453219608, 16125.11311877858, 381875.0, 385129.0, 386285.0, 386355.0682246571, 386697.06651467126, 52911.0, 61419.07871381933, 62090.37909620936, 62136.0, 62229.68885155545, 1327.6548097494529, 1386.7226554689103, 1429.585420228143, 1434.0678558936565, 1445.7469942760185, 30530.542041868946, 31981.0, 32019.67980320167, 32171.51742723814, 32573.674263257064, 51097.744511277204, 51628.74185629048, 51742.482575173766, 51761.48238517567, 51892.740536297075, 564557.0, 566686.0, 567028.0, 824434.0, 847226.0, 23879.283621491384, 24170.51658966846, 24178.637320439855, 26584.468310634067, 27026.189214322814, 48341.758291208316, 48542.27186592275, 48619.02761944812, 49409.50590494049, 49870.0, 39948.80025599853, 41631.7918410406, 41710.95722606959, 42412.15175696531, 43067.923301917705, 38827.80586097051, 38989.830305090894, 39748.80125599354, 40210.597894021856, 40240.0, 39622.811315660576, 40058.798236052964, 40874.59125408827, 40977.38533921934, 41196.38205426861, 34442.48336275008, 36152.0, 36685.449718253716, 36786.26427471489, 36858.26283474369, 26637.866810665822, 26817.0, 26908.327291817863, 26943.86528067347, 27376.58935115935], "value": 18969.81792969079, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.8167279705741, 384.50590990577103, 392.5270049590245, 400.2235662814142, 415.22974881594644, 14198.503052393142, 20010.59978800423, 20628.793712062874, 21378.89310553447, 21402.35792926213, 20979.47551311218, 21187.0, 21324.893375533138, 21586.460338491546, 21721.02255398507, 5461.344638643368, 6245.250569931592, 6271.968640156792, 6276.780312689057, 6278.121063051177, 5354.705491197982, 5919.585629005971, 6096.35988221237, 6123.785667501638, 6243.719032643542, 6157.076438534211, 6158.907616385758, 6164.87670246597, 6169.352218017111, 6179.598326108811, 5902.055671092626, 6089.391060893941, 6148.323684394713, 6174.0430233313455, 6186.876262474771, 5355.464453554652, 5362.249285100089, 5364.249005139283, 5366.195070739382, 5370.597205209625, 26583.468330633474, 27026.729732702814, 27254.45491090167, 27304.45391092167, 27607.86196069027, 2290.9656355154684, 2382.559226543078, 2571.4985577812336, 2930.7655387568943, 2992.7156920092775, 10376.584936602527, 12166.452509637087, 14023.29883505831, 16183.757243641356, 16768.41310554137, 1854.249029143199, 1875.8030406807225, 1908.895010774407, 1927.44104209779, 1948.6005368899484, 135587.64412355848, 136600.31699841536, 138026.0, 142115.99999999895, 143182.0, 10141.0, 11849.585264515701, 11896.524139034515, 11939.462724177432, 12066.577669781516, 13634.522791702242, 14101.576952691436, 15132.243387830784, 15178.241087945558, 15179.544613661608, 8259.182979744446, 8445.831083378422, 8543.786405339917, 8799.208071273617, 8905.465672059698, 7611.3910887128895, 8745.644425114118, 8811.559422029, 8836.381453298336, 8993.505357205286, 3795.5445346558035, 4532.32015197723, 4628.190066738307, 4667.696599721007, 4675.836345727951, 1873.4379686094117, 1929.1318906492136, 1931.0923865783059, 1933.5649478867142, 1942.3493129801393, 909.7407238936871, 925.6343744220995, 931.4923366765129, 946.5267366316841, 957.2963871554402, 18292.74371218079, 20719.689204661943, 21956.670649940264, 22052.448688782908, 22267.331980040624, 940.722486866376, 1025.2976710952871, 1030.3663247102977, 1035.9119474844572, 1079.7624522605015, 10862.891371086345, 11475.254108482923, 11500.654980350602, 11516.596919107791, 11518.712032199095, 591469.0, 623882.0, 639630.0, 649966.0, 656741.0, 133917.0, 133978.33010835078, 136433.0, 139392.0, 140357.0, 945.2390825385493, 963.9855402168973, 968.3463662028103, 970.9223262139012, 995.6913356859542, 15378.461753838563, 17328.48014559565, 17757.644847103245, 19054.0, 19071.427857164308, 53421.66445838885, 54169.187462187314, 54547.454525455825, 57129.85740285254, 57283.713581431824, 71395.64302178664, 78111.0, 81550.368992621, 82739.17260827555, 82817.58591207246, 7673.386129109769, 8267.545285009382, 8321.95839020801, 8479.19447652472, 8585.969683638003, 11776.646700598996, 13204.141730787853, 13214.27321497327, 13256.867431325949, 13413.932930335286, 11569.768604628029, 11618.302901825917, 11620.186586938833, 11650.359230242419, 11964.9829764471, 11351.432428378714, 11477.48351324209, 11626.302421854716, 11849.763004740029, 11889.346085965355, 11497.425128743362, 11868.82196767032, 11873.584424545099, 11903.880961190278, 12066.818997714865, 8179.877301840358, 8219.095899450936, 8469.57652117404, 8633.82732345337, 8642.135786421559, 11114.388708621103, 11482.311061336346, 11521.53913843437, 11850.288982661068, 11909.0], "value": 9958.7355946918, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1384.259421209653, 1464.4508309383982, 1555.0980431349815, 1735.3839387017608, 1913.5885784556326, 8194.0, 8706.477611343324, 9046.773830654229, 9260.212881905029, 9267.119623635745, 9071.138241867013, 9156.359054866145, 9162.129597688225, 9167.77080572986, 9186.402883812547, 2064.9070791814406, 2411.481531470738, 2439.3657649011207, 2441.694788151481, 2442.6091825307954, 2103.9900847593162, 2384.988075059622, 2389.522095580891, 2407.265783935899, 2448.52253810507, 2400.147947478646, 2418.842775219614, 2429.392651837041, 2433.902643894251, 2438.158835201861, 2377.2630484549845, 2392.7487613800563, 2394.1141777542334, 2394.437307232799, 2428.307932239321, 2370.2059809963685, 2397.640353946922, 2402.111218849037, 2403.579373609629, 2404.7955923746504, 9101.590428430736, 9239.538023098885, 9262.629494820267, 9276.443413395218, 9374.812503749956, 5548.861278468071, 5764.769409223626, 5766.538676905838, 5771.509421699118, 5772.989726797836, 3654.5614526256754, 3697.4268988306853, 3725.9813700931595, 3755.267722794056, 3759.6804271636943, 1125.9324440533512, 1130.909527237819, 1133.4559411482535, 1142.9199956003083, 1152.8789477104867, 12287.815682764765, 12343.0, 12400.75198496043, 12441.0, 12447.439865206088, 3951.249262640089, 4547.522510136388, 4785.569298763058, 4798.424189097261, 4808.422989241243, 9602.9039709602, 9614.0, 9624.37441566296, 9632.181264592447, 9634.90365096354, 5510.8071217507195, 5516.255305533782, 5517.227588137664, 5523.28197334344, 5525.557955363562, 4357.237483440385, 4673.275642275453, 4750.691205071659, 4794.760261986957, 5167.0957582422925, 3901.08324543732, 3947.644711975936, 3981.92036159281, 4075.959240407558, 4082.8775136745944, 1173.23153334566, 1190.613050758507, 1191.2316555821446, 1199.3283761093815, 1203.0676225924979, 744.2594618354772, 894.5571941888807, 921.7688426238675, 933.4819175357605, 934.0752654871628, 5213.504717051874, 5810.331811841692, 6069.635821850703, 6181.165542651775, 6215.223097112861, 793.8690116130774, 944.738773737055, 950.2493030505962, 959.4770849886828, 962.2542529539663, 3823.7323387363176, 3905.3751399776465, 3975.522937247491, 4073.837046518106, 4100.507939047274, 11204.271722338022, 11588.420578971187, 11591.594294199662, 11604.477798499087, 11611.303321800719, 9367.437953722798, 11410.0, 11411.942940285246, 11494.770104598028, 11545.422728863523, 8190.672373105128, 8314.501129932223, 8531.402801803813, 8747.431416957877, 8747.475151490931, 5942.405759424023, 5972.0, 5993.61041532299, 6097.817065488042, 6151.907721384094, 10026.0, 10468.790624187626, 10557.894421055691, 10618.0, 10663.57345706194, 9646.469444180357, 9850.556724947251, 10797.29817561856, 10813.24307298513, 10819.729506762395, 7587.696492140252, 7708.460407771402, 7782.766517004499, 7852.528848269122, 7931.484453510503, 8705.782355441164, 8707.608157633049, 8804.955975220082, 8805.559722014003, 8849.734507964771, 7673.8848917267405, 7797.649105790139, 7824.84350313002, 7845.803854903673, 7849.332806711265, 7685.4620176587105, 7702.961485192538, 7710.498817576839, 7718.151003389735, 7743.651535680795, 7143.678534465857, 7291.744788932362, 7295.452841037049, 7305.890411643723, 7309.890351644836, 4919.877003074808, 4979.327790748347, 4981.252812078217, 5075.949240507548, 5076.263941728503, 5023.146065168857, 5031.899362012812, 5070.163423035306, 5133.178691409356, 5206.479352064764], "value": 4702.362390369359, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [283.13219980758976, 309.10051749409223, 316.1937060495735, 322.2041557353338, 323.2710238412383, 5169.638125331228, 5301.6818990860575, 5349.7057661828685, 5374.408815030343, 5376.408595054546, 5066.807911016064, 5222.527019532016, 5238.188080847474, 5245.377311344328, 5249.5012973767525, 3824.464574959508, 3976.065624578222, 4079.5920407959115, 4082.6935380678196, 4099.979500102495, 3759.3233218020746, 3902.2585708715396, 4038.5961403859524, 4073.920411091063, 4104.240715467633, 3342.8997130086013, 4035.878923632281, 4061.532923713766, 4069.552349241581, 4091.5499295077516, 4025.4565633639377, 4042.2319759245647, 4043.5349934757587, 4059.1991525847366, 4069.532003819569, 3198.1205168578595, 3448.8792892248653, 3502.807345595991, 3566.144125409909, 3571.5178450909057, 3832.9233415331814, 4848.563629273347, 5122.9754049190315, 5166.5866730661455, 5198.2722418861385, 4621.514740952185, 4633.351330813689, 4681.812727490897, 4687.414073240845, 4702.49520153551, 5566.916496252559, 5579.804706835242, 5594.552435805126, 5603.049849855842, 5617.719114044281, 3786.678132358753, 3902.551206611219, 3917.8060286239797, 3934.0361611405388, 3936.4844534854287, 5038.748062596856, 5345.471988487619, 5538.6122971392015, 5793.884122317572, 5807.912881306784, 3149.4173577888164, 3997.300472417315, 4023.879283621496, 4025.3358195897936, 4033.4756481657196, 3690.538682664667, 3783.0920579061376, 4069.145479449349, 4088.34586466164, 4101.364288535282, 3746.269477451925, 3967.0479085019388, 4593.311003349524, 4620.696202215432, 4634.351190833286, 5140.691558506502, 5463.399026107125, 5527.751251193706, 5618.971905140448, 5675.262215911905, 1139.9512448547357, 1155.6648571914218, 1283.3903895649678, 1336.9732605348033, 1352.763266428371, 891.4383938119073, 932.8479328029878, 947.6777895515557, 953.9666111686197, 955.3360414511986, 4623.306504024423, 5093.592512598983, 5130.256112863689, 5341.732913354317, 5381.650192737459, 4637.287186995578, 5127.87180320495, 5547.39125653564, 5677.37548869624, 5750.654960702372, 4077.26609210345, 4445.555444455593, 4483.686141970031, 5171.276021357013, 5242.981452140877, 2204.8787316697735, 2246.79778819907, 2257.830662700304, 2522.672052633146, 2555.2078855554837, 4056.215265283266, 4251.234777739975, 4455.509893911667, 4883.265371392032, 5001.7499125043605, 4075.5924407559005, 4892.510748925079, 4936.308916751657, 4962.551027036176, 4995.925061124086, 4301.60173462967, 4630.976845115752, 4718.834840780556, 4718.929216061831, 4952.479989601112, 4065.5527891932456, 4400.955990440055, 4667.556582124693, 4676.7895444705755, 4735.6211503078985, 4215.9552616981355, 4511.977440112779, 4613.976930115328, 4637.791299391603, 4639.747268237625, 4699.861562988764, 4810.5670489656095, 4867.10183028612, 4892.339534162842, 4918.532739389752, 3096.708435757568, 3170.4306368347816, 3234.142952117738, 3244.836284622474, 3245.0, 3876.4960555127655, 3905.882823515299, 4440.511543730123, 4566.406367172379, 4579.290210017452, 3698.5931547529212, 3790.166163444148, 3862.24686186191, 4666.896513818273, 4702.600278976189, 4376.518582955936, 4584.312353147055, 4605.125026245003, 4661.0, 4661.906761864811, 4237.936430953477, 4242.469691288589, 4739.795994862406, 4767.69010014348, 5158.4583618721, 4590.3933623231605, 5543.223948647274, 5564.33228012641, 5567.888642227052, 5590.357108932525, 4808.7595620219545, 4941.777620007037, 5227.451117632746, 5475.206095116107, 5560.833175004756], "value": 3816.068960004528, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.5428965475887, 780.6018930345522, 789.4671097009517, 799.7840583042575, 851.5699571716283, 15876.0, 16730.66538669226, 16800.579985500353, 16839.74740378895, 16863.0, 14952.626184345398, 15093.849061509409, 15112.773308400356, 15117.470888518905, 15121.773173402407, 716.8852983522625, 737.8229224985992, 871.9346049046316, 901.5807649443008, 908.4776253654143, 900.4102312985005, 905.1582028713294, 906.4017748286133, 909.9954500227523, 910.7040211931115, 964.3105179796444, 965.6041023180462, 966.9613215471372, 967.729035869954, 971.3637567393368, 952.1002652493396, 954.2938225712992, 958.0419580419581, 958.5542722633938, 959.1751094059103, 607.5564837668483, 721.0266140710052, 721.0770214125927, 721.3507842941342, 725.6480606905646, 15699.0, 15707.214639267992, 15707.214639268104, 15707.607309817346, 15716.921415392964, 13822.37799299024, 13916.86083139176, 14287.714245715131, 14448.855511444855, 15193.772093418607, 11914.523419063227, 13606.0, 13686.247256400893, 13888.166709997433, 13967.125105860341, 4859.58693511052, 4859.829905953275, 4872.78072486739, 4874.366332376804, 5066.442691303953, 129421.0, 129672.05491917628, 130734.0, 130988.34505827409, 136109.0, 11376.374299413446, 11728.765424691459, 11742.00192983606, 11850.525978960744, 12124.636260912186, 23391.41521461977, 23649.408764780674, 23690.7630923692, 23748.406289842893, 24406.87796561006, 8039.598020098972, 8136.918630813734, 8182.7954301142945, 8223.794405139799, 8257.42198046143, 4454.465464144323, 4456.68803183774, 4634.907301853944, 4640.373549570832, 4777.9727358617365, 3642.3807952648112, 3752.549694036733, 3803.3154032274456, 3804.866829661004, 3810.923781524354, 681.6489507903434, 693.462566510958, 704.1585305559909, 705.0341032785014, 707.5012116457988, 549.5054450994137, 599.5952731906033, 604.305049193431, 610.8137018209488, 613.7084884679741, 8774.0, 9622.951885240529, 9625.470599117116, 9633.662821801203, 9758.710477371358, 584.5498965796313, 654.898490733937, 678.2742465561802, 683.1494788987742, 706.2161001288565, 4512.323151527232, 4698.577128058491, 4719.504452032487, 4734.242521196661, 4790.808367665254, 78760.60619696979, 142062.0, 161713.29720216588, 166601.0, 181248.18751812578, 128279.35860320639, 139341.0, 140926.0, 148400.0, 148928.25535872253, 98252.0, 101826.98173018175, 123045.0, 123156.0, 128485.35757321154, 7887.408444366581, 9283.210927071275, 9391.671291504765, 9600.183984361129, 9913.702588922344, 63496.68251658712, 64955.376115597486, 65718.34281657122, 66510.34427590022, 67916.0, 95812.0, 98817.50591246998, 100502.0, 102016.0, 103149.48425258126, 14151.363188656742, 14272.785908211592, 14348.928255359075, 14371.353289101806, 14577.635559111108, 14900.0, 14977.925110374379, 15655.0, 15709.842901571295, 16365.936214146042, 14001.649958751113, 14514.782278265624, 14547.199904005382, 15283.312250948511, 15392.153431560924, 14094.859051409765, 14438.278086095863, 14674.266286685837, 14763.704725905636, 15351.309191086204, 13512.79730804019, 14161.858381416054, 14165.43338266499, 14519.709605808035, 14694.853051469348, 11597.88402115968, 11687.298762074302, 11927.642170734893, 12004.39978001079, 12207.38963051826, 12132.636020919386, 12165.148439609497, 12288.877111228774, 12368.072394570263, 12448.564300249447], "value": 8317.64476638805, "unit": "score"}], "name": "dromaeo_css", "value": 7385.589542952696, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 115.0, 114.0, 112.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 106.0, 114.0, 125.0, 128.0, 134.0, 134.0, 139.0, 135.0, 107.0], "value": 126.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 184.0, 183.0, 183.0, 184.0, 184.0, 182.0, 182.0, 183.0, 185.0], "value": 183.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 58.0, 90.0, 62.0, 59.0, 57.0, 58.0, 81.0, 57.0], "value": 66.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 71.0, 118.0, 100.0, 96.0, 79.0, 91.0, 66.0, 69.0, 98.0], "value": 87.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 83.0, 87.0, 84.0, 88.0, 84.0, 87.0, 84.0, 90.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 92.0, 93.0, 93.0, 93.0, 93.0, 92.0, 93.0, 92.0, 92.0], "value": 92.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 86.0, 83.0, 86.0, 87.0, 86.0, 101.0, 139.0], "value": 92.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 53.0, 52.0, 52.0, 56.0, 58.0, 58.0, 56.0, 58.0, 58.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 71.0, 70.0, 80.0, 74.0, 70.0, 68.0, 67.0, 69.0, 70.0], "value": 70.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 83.0, 74.0, 78.0, 75.0, 82.0, 82.0, 84.0, 82.0, 82.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 126.0, 133.0, 133.0, 139.0, 143.0, 124.0, 196.0, 165.0], "value": 145.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 157.0, 159.0, 155.0, 160.0, 148.0, 210.0, 166.0, 161.0, 163.0], "value": 163.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 81.0, 82.0, 67.0, 65.0, 67.0, 65.0, 66.0, 88.0, 76.0], "value": 72.5, "unit": "score"}], "name": "kraken", "value": 1434.2, "alertThreshold": 2.0}]} 13:01:06 INFO - Return code: 0 13:01:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:01:06 INFO - # TBPL SUCCESS # 13:01:06 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:01:06 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:01:06 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:01:06 INFO - 2017-01-07 13:01:06.453 screenresolution[1653:10085] starting screenresolution argv=screenresolution get 13:01:06 INFO - 2017-01-07 13:01:06.456 screenresolution[1653:10085] Display 0: 1600x1200x32@60 13:01:06 INFO - 2017-01-07 13:01:06.462 screenresolution[1654:10089] starting screenresolution argv=screenresolution list 13:01:06 INFO - Available Modes on Display 0 13:01:06 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:01:06 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:01:06 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:01:06 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:01:06 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:01:06 INFO - Intel Iris: 13:01:06 INFO - Chipset Model: Intel Iris 13:01:06 INFO - Type: GPU 13:01:06 INFO - Bus: Built-In 13:01:06 INFO - VRAM (Dynamic, Max): 1536 MB 13:01:06 INFO - Vendor: Intel (0x8086) 13:01:06 INFO - Device ID: 0x0a2e 13:01:06 INFO - Revision ID: 0x0009 13:01:06 INFO - Displays: 13:01:06 INFO - Display: 13:01:06 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:01:06 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:01:06 INFO - Display Serial Number: 1600x1200 60 13:01:06 INFO - Main Display: Yes 13:01:06 INFO - Mirror: Off 13:01:06 INFO - Online: Yes 13:01:06 INFO - Rotation: Supported 13:01:06 INFO - Return code: 0 13:01:06 INFO - Running post-action listener: _resource_record_post_action 13:01:06 INFO - [mozharness: 2017-01-07 21:01:06.696436Z] Finished run-tests step (success) 13:01:06 INFO - Running post-run listener: _resource_record_post_run 13:01:06 INFO - Total resource usage - Wall time: 1196s; CPU: 53.0%; Read bytes: 38827008; Write bytes: 496669696; Read time: 387; Write time: 1675 13:01:06 INFO - TinderboxPrint: CPU usage
53.4% 13:01:06 INFO - TinderboxPrint: I/O read bytes / time
38,827,008 / 387 13:01:06 INFO - TinderboxPrint: I/O write bytes / time
496,669,696 / 1,675 13:01:06 INFO - TinderboxPrint: CPU idle
2,227.9 (46.6%) 13:01:06 INFO - TinderboxPrint: CPU system
958.1 (20.0%) 13:01:06 INFO - TinderboxPrint: CPU user
1,599.8 (33.4%) 13:01:06 INFO - TinderboxPrint: Swap in / out
234,135,552 / 0 13:01:06 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194822656; Write bytes: 190117888; Read time: 17880; Write time: 532 13:01:06 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 36766720; Write bytes: 295304192; Read time: 365; Write time: 1105 13:01:07 INFO - Running post-run listener: _upload_blobber_files 13:01:07 INFO - Blob upload gear active. 13:01:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:01:07 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:01:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:01:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:01:07 INFO - (blobuploader) - INFO - Open directory for files ... 13:01:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:01:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:01:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:01:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:01:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:01:10 INFO - (blobuploader) - INFO - Done attempting. 13:01:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:01:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:01:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:01:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:01:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:01:11 INFO - (blobuploader) - INFO - Done attempting. 13:01:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:01:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:01:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:01:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:01:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:01:13 INFO - (blobuploader) - INFO - Done attempting. 13:01:13 INFO - (blobuploader) - INFO - Iteration through files over. 13:01:13 INFO - Return code: 0 13:01:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:01:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:01:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1c0480d1a5ef1e767aa227cecc2a941a93c22830ddd330944739be956275bce9f6e0d22ecea07f820d08ffa0c4575a25bd58787833d50cae4b5bdcbed468c7df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/92658e3b396fb92de872a3747294eb94ed6741be6c0370b2621166823477d2876887937ffeaa78788f76f78f851a47fe7bce23217ca2f24830ad268b0071d461", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b1b33a2c794091ef4cb0e6c1454e3f7a46af1fb556d05f478380b406875ec8b77ef6e9be7f3776b62c15668d9e866dd8e27e46dbd3343552ab125914eba36054"} 13:01:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:01:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:01:13 INFO - Contents: 13:01:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1c0480d1a5ef1e767aa227cecc2a941a93c22830ddd330944739be956275bce9f6e0d22ecea07f820d08ffa0c4575a25bd58787833d50cae4b5bdcbed468c7df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/92658e3b396fb92de872a3747294eb94ed6741be6c0370b2621166823477d2876887937ffeaa78788f76f78f851a47fe7bce23217ca2f24830ad268b0071d461", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b1b33a2c794091ef4cb0e6c1454e3f7a46af1fb556d05f478380b406875ec8b77ef6e9be7f3776b62c15668d9e866dd8e27e46dbd3343552ab125914eba36054"} 13:01:13 INFO - Running post-run listener: copy_logs_to_upload_dir 13:01:13 INFO - Copying logs to upload dir... 13:01:13 INFO - mkdir: /builds/slave/test/build/upload/logs 13:01:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1259.275115 ========= master_lag: 0.66 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 59 secs) (at 2017-01-07 13:01:14.447018) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-07 13:01:14.450240) ========= 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.0m3AnHdmu8/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.PDWqTPsmb8/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1c0480d1a5ef1e767aa227cecc2a941a93c22830ddd330944739be956275bce9f6e0d22ecea07f820d08ffa0c4575a25bd58787833d50cae4b5bdcbed468c7df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/92658e3b396fb92de872a3747294eb94ed6741be6c0370b2621166823477d2876887937ffeaa78788f76f78f851a47fe7bce23217ca2f24830ad268b0071d461", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b1b33a2c794091ef4cb0e6c1454e3f7a46af1fb556d05f478380b406875ec8b77ef6e9be7f3776b62c15668d9e866dd8e27e46dbd3343552ab125914eba36054"} build_url:https://queue.taskcluster.net/v1/task/EFD4NuKNQEKMlLs2ffi64Q/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011192 build_url: 'https://queue.taskcluster.net/v1/task/EFD4NuKNQEKMlLs2ffi64Q/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1c0480d1a5ef1e767aa227cecc2a941a93c22830ddd330944739be956275bce9f6e0d22ecea07f820d08ffa0c4575a25bd58787833d50cae4b5bdcbed468c7df", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/92658e3b396fb92de872a3747294eb94ed6741be6c0370b2621166823477d2876887937ffeaa78788f76f78f851a47fe7bce23217ca2f24830ad268b0071d461", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b1b33a2c794091ef4cb0e6c1454e3f7a46af1fb556d05f478380b406875ec8b77ef6e9be7f3776b62c15668d9e866dd8e27e46dbd3343552ab125914eba36054"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-07 13:01:14.485017) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 13:01:14.485364) ========= 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.0m3AnHdmu8/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.PDWqTPsmb8/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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.005027 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-07 13:01:14.534319) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-07 13:01:14.534650) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-07 13:01:14.535005) ========= ========= Total master_lag: 0.80 =========