builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0075 starttime: 1484166845.25 results: success (0) buildid: 20170111094025 builduid: e382e865f9714fe0b6b1d8f5d5fd11dc revision: 6dd3d485a0598df6175e0d0551237b427ba3bf04 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-11 12:34:05.252568) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-11 12:34:05.263096) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-11 12:34:05.263398) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-11 12:34:05.337784) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 12:34:05.338070) ========= 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.jWPTQq5aFJ/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.TU5bNoLigy/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-11 12:34:05-- 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% 24.3M=0s 2017-01-11 12:34:05 (24.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.111482 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 12:34:05.474025) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 12:34:05.474398) ========= 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.jWPTQq5aFJ/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.TU5bNoLigy/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.029209 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 12:34:05.525147) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 12:34:05.525506) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 6dd3d485a0598df6175e0d0551237b427ba3bf04 --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 6dd3d485a0598df6175e0d0551237b427ba3bf04 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.jWPTQq5aFJ/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.TU5bNoLigy/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-11 12:34:05,622 truncating revision to first 12 chars 2017-01-11 12:34:05,622 Setting DEBUG logging. 2017-01-11 12:34:05,622 attempt 1/10 2017-01-11 12:34:05,622 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/6dd3d485a059?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-11 12:34:06,310 unpacking tar archive at: mozilla-beta-6dd3d485a059/testing/mozharness/ program finished with exit code 0 elapsedTime=0.964635 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 12:34:06.513831) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-11 12:34:06.514263) ========= script_repo_revision: 6dd3d485a0598df6175e0d0551237b427ba3bf04 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-11 12:34:06.514848) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-11 12:34:06.515125) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-11 12:34:06.539409) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-01-11 12:34:06.539822) ========= /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.jWPTQq5aFJ/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.TU5bNoLigy/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:34:06 INFO - MultiFileLogger online at 20170111 12:34:06 in /builds/slave/test 12:34:06 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:34:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:34:06 INFO - {'append_to_log': False, 12:34:06 INFO - 'base_work_dir': '/builds/slave/test', 12:34:06 INFO - 'blob_upload_branch': 'Mozilla-Beta', 12:34:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:34:06 INFO - 'branch': 'Mozilla-Beta', 12:34:06 INFO - 'buildbot_json_path': 'buildprops.json', 12:34:06 INFO - 'config_files': ('talos/mac_config.py',), 12:34:06 INFO - 'default_actions': ('clobber', 12:34:06 INFO - 'read-buildbot-config', 12:34:06 INFO - 'download-and-extract', 12:34:06 INFO - 'populate-webroot', 12:34:06 INFO - 'create-virtualenv', 12:34:06 INFO - 'install', 12:34:06 INFO - 'run-tests'), 12:34:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:34:06 INFO - 'download_minidump_stackwalk': True, 12:34:06 INFO - 'download_symbols': 'ondemand', 12:34:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:34:06 INFO - 'tooltool.py': '/tools/tooltool.py', 12:34:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:34:06 INFO - '/tools/misc-python/virtualenv.py')}, 12:34:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:34:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:34:06 INFO - 'installer_path': 'installer.exe', 12:34:06 INFO - 'log_level': 'info', 12:34:06 INFO - 'log_name': 'talos', 12:34:06 INFO - 'log_to_console': True, 12:34:06 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:34:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:34:06 INFO - 'opt_config_files': (), 12:34:06 INFO - 'pip_index': False, 12:34:06 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:34:06 INFO - 'cmd': ('bash', 12:34:06 INFO - '-c', 12:34:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:34:06 INFO - 'enabled': True, 12:34:06 INFO - 'halt_on_failure': False, 12:34:06 INFO - 'name': 'check_screen_resolution'},), 12:34:06 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:34:06 INFO - 'cmd': ('bash', 12:34:06 INFO - '-c', 12:34:06 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:34:06 INFO - 'enabled': True, 12:34:06 INFO - 'halt_on_failure': False, 12:34:06 INFO - 'name': 'check_screen_resolution'},), 12:34:06 INFO - 'run_cmd_checks_enabled': True, 12:34:06 INFO - 'sps_profile': False, 12:34:06 INFO - 'sps_profile_interval': 0, 12:34:06 INFO - 'suite': 'dromaeojs', 12:34:06 INFO - 'system_bits': '32', 12:34:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:34:06 INFO - 'title': 't-yosemite-r7-0075', 12:34:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:34:06 INFO - 'use_talos_json': True, 12:34:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:34:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:34:06 INFO - 'work_dir': 'build'} 12:34:06 INFO - [mozharness: 2017-01-11 20:34:06.738326Z] Running clobber step. 12:34:06 INFO - Running pre-action listener: _resource_record_pre_action 12:34:06 INFO - Running main action method: clobber 12:34:06 INFO - rmtree: /builds/slave/test/build 12:34:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:34:08 INFO - Running post-action listener: _resource_record_post_action 12:34:08 INFO - [mozharness: 2017-01-11 20:34:08.970474Z] Finished clobber step (success) 12:34:08 INFO - [mozharness: 2017-01-11 20:34:08.970637Z] Running read-buildbot-config step. 12:34:08 INFO - Running pre-action listener: _resource_record_pre_action 12:34:08 INFO - Running main action method: read_buildbot_config 12:34:08 INFO - Using buildbot properties: 12:34:08 INFO - { 12:34:08 INFO - "project": "", 12:34:08 INFO - "product": "firefox", 12:34:08 INFO - "script_repo_revision": "production", 12:34:08 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 12:34:08 INFO - "repository": "", 12:34:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 12:34:08 INFO - "buildid": "20170111094025", 12:34:08 INFO - "pgo_build": "False", 12:34:08 INFO - "basedir": "/builds/slave/test", 12:34:08 INFO - "buildnumber": 11, 12:34:08 INFO - "slavename": "t-yosemite-r7-0075", 12:34:08 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 12:34:08 INFO - "platform": "yosemite_r7", 12:34:08 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 12:34:08 INFO - "branch": "mozilla-beta", 12:34:08 INFO - "repo_path": "releases/mozilla-beta", 12:34:08 INFO - "revision": "6dd3d485a0598df6175e0d0551237b427ba3bf04", 12:34:08 INFO - "stage_platform": "macosx64", 12:34:08 INFO - "builduid": "e382e865f9714fe0b6b1d8f5d5fd11dc", 12:34:08 INFO - "slavebuilddir": "test" 12:34:08 INFO - } 12:34:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/V59AsRtZQ16D-TpRgTLa2g/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 12:34:08 INFO - Running post-action listener: _resource_record_post_action 12:34:08 INFO - [mozharness: 2017-01-11 20:34:08.973850Z] Finished read-buildbot-config step (success) 12:34:08 INFO - [mozharness: 2017-01-11 20:34:08.973981Z] Running download-and-extract step. 12:34:08 INFO - Running pre-action listener: _resource_record_pre_action 12:34:08 INFO - Running main action method: download_and_extract 12:34:08 INFO - mkdir: /builds/slave/test/build/tests 12:34: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:34:08 INFO - trying https://queue.taskcluster.net/v1/task/V59AsRtZQ16D-TpRgTLa2g/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 12:34:08 INFO - Downloading https://queue.taskcluster.net/v1/task/V59AsRtZQ16D-TpRgTLa2g/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:34:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V59AsRtZQ16D-TpRgTLa2g/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:34:10 INFO - Downloaded 1165 bytes. 12:34:10 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 12:34:10 INFO - Using the following test package requirements: 12:34:10 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 12:34:10 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:34:10 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 12:34:10 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:34:10 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 12:34:10 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 12:34:10 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:34:10 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 12:34:10 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 12:34:10 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:34:10 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 12:34:10 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:34:10 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 12:34:10 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:34:10 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 12:34:10 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 12:34:10 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 12:34:10 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 12:34:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V59AsRtZQ16D-TpRgTLa2g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 12:34:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V59AsRtZQ16D-TpRgTLa2g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 12:34:10 INFO - Fetch https://queue.taskcluster.net/v1/task/V59AsRtZQ16D-TpRgTLa2g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 12:34:10 INFO - Expected file size: 16235246 12:34:17 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:34:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V59AsRtZQ16D-TpRgTLa2g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 12:34:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V59AsRtZQ16D-TpRgTLa2g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 12:34:17 INFO - Fetch https://queue.taskcluster.net/v1/task/V59AsRtZQ16D-TpRgTLa2g/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 12:34:18 INFO - Expected file size: 16235246 12:34:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/V59AsRtZQ16D-TpRgTLa2g/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 12:34:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/V59AsRtZQ16D-TpRgTLa2g/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 12:34:25 INFO - Fetch https://queue.taskcluster.net/v1/task/V59AsRtZQ16D-TpRgTLa2g/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 12:34:25 INFO - Expected file size: 14414089 12:34:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:26 INFO - trying https://queue.taskcluster.net/v1/task/V59AsRtZQ16D-TpRgTLa2g/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:34:26 INFO - Downloading https://queue.taskcluster.net/v1/task/V59AsRtZQ16D-TpRgTLa2g/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 12:34:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/V59AsRtZQ16D-TpRgTLa2g/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:34:28 INFO - Downloaded 86143094 bytes. 12:34:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/V59AsRtZQ16D-TpRgTLa2g/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:34:28 INFO - mkdir: /builds/slave/test/properties 12:34:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:34:28 INFO - Writing to file /builds/slave/test/properties/build_url 12:34:28 INFO - Contents: 12:34:28 INFO - build_url:https://queue.taskcluster.net/v1/task/V59AsRtZQ16D-TpRgTLa2g/artifacts/public/build/firefox-51.0.en-US.mac.dmg 12:34:29 INFO - Running post-action listener: _resource_record_post_action 12:34:29 INFO - Running post-action listener: set_extra_try_arguments 12:34:29 INFO - [mozharness: 2017-01-11 20:34:29.412837Z] Finished download-and-extract step (success) 12:34:29 INFO - [mozharness: 2017-01-11 20:34:29.412980Z] Running populate-webroot step. 12:34:29 INFO - Running pre-action listener: _resource_record_pre_action 12:34:29 INFO - Running main action method: populate_webroot 12:34:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:34:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:34:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:34:29 INFO - '--tppagecycles', 12:34:29 INFO - '7'], 12:34:29 INFO - 'tests': ['tsvgm']}}, 12:34:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:34:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:34:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:34:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:34:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:34:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:34:29 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:29 INFO - 'talos_options': ['--disable-e10s'], 12:34:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:34:29 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:34:29 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:29 INFO - 'talos_options': ['--disable-e10s'], 12:34:29 INFO - 'tests': ['damp', 'tps']}, 12:34:29 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:29 INFO - 'tests': ['damp', 'tps']}, 12:34:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:34:29 INFO - 'tests': ['dromaeo_dom']}, 12:34:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:34:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:34:29 INFO - 'tests': ['basic_compositor_video']}, 12:34:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:34:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:34:29 INFO - 'tests': ['a11yr', 12:34:29 INFO - 'ts_paint', 12:34:29 INFO - 'tpaint', 12:34:29 INFO - 'sessionrestore', 12:34:29 INFO - 'sessionrestore_no_auto_restore', 12:34:29 INFO - 'tabpaint']}, 12:34:29 INFO - 'other-e10s': {'tests': ['a11yr', 12:34:29 INFO - 'ts_paint', 12:34:29 INFO - 'tpaint', 12:34:29 INFO - 'sessionrestore', 12:34:29 INFO - 'sessionrestore_no_auto_restore', 12:34:29 INFO - 'tabpaint']}, 12:34:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:34:29 INFO - 'ts_paint', 12:34:29 INFO - 'tpaint', 12:34:29 INFO - 'sessionrestore', 12:34:29 INFO - 'sessionrestore_no_auto_restore', 12:34:29 INFO - 'tabpaint']}, 12:34:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:34:29 INFO - 'ts_paint', 12:34:29 INFO - 'tpaint', 12:34:29 INFO - 'sessionrestore', 12:34:29 INFO - 'sessionrestore_no_auto_restore', 12:34:29 INFO - 'tabpaint']}, 12:34:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:34:29 INFO - 'tests': ['a11yr', 12:34:29 INFO - 'ts_paint', 12:34:29 INFO - 'tpaint', 12:34:29 INFO - 'sessionrestore', 12:34:29 INFO - 'sessionrestore_no_auto_restore', 12:34:29 INFO - 'tabpaint']}, 12:34:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:34:29 INFO - 'tests': ['a11yr', 12:34:29 INFO - 'ts_paint', 12:34:29 INFO - 'tpaint', 12:34:29 INFO - 'sessionrestore', 12:34:29 INFO - 'sessionrestore_no_auto_restore', 12:34:29 INFO - 'tabpaint']}, 12:34:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:34:29 INFO - 'tests': ['tsvgx', 12:34:29 INFO - 'tsvgr_opacity', 12:34:29 INFO - 'tart', 12:34:29 INFO - 'tscrollx', 12:34:29 INFO - 'cart']}, 12:34:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:34:29 INFO - 'tsvgr_opacity', 12:34:29 INFO - 'tart', 12:34:29 INFO - 'tscrollx', 12:34:29 INFO - 'cart']}, 12:34:29 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:29 INFO - 'talos_options': ['--disable-e10s'], 12:34:29 INFO - 'tests': ['tp5o']}, 12:34:29 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:29 INFO - 'tests': ['tp5o']}, 12:34:29 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:29 INFO - 'talos_options': ['--disable-e10s', 12:34:29 INFO - '--xperf_path', 12:34:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:34:29 INFO - 'tests': ['tp5n']}, 12:34:29 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:34:29 INFO - 'talos_options': ['--xperf_path', 12:34:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:34:29 INFO - 'tests': ['tp5n']}}, 12:34:29 INFO - 'talos.zip': {'path': '', 12:34:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:34:29 INFO - Running post-action listener: _resource_record_post_action 12:34:29 INFO - [mozharness: 2017-01-11 20:34:29.431675Z] Finished populate-webroot step (success) 12:34:29 INFO - [mozharness: 2017-01-11 20:34:29.431804Z] Running create-virtualenv step. 12:34:29 INFO - Running pre-action listener: _resource_record_pre_action 12:34:29 INFO - Running main action method: create_virtualenv 12:34:29 INFO - Creating virtualenv /builds/slave/test/build/venv 12:34:29 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:34:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:34:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:34:29 INFO - Using real prefix '/tools/python27' 12:34:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:34:30 INFO - Installing distribute.............................................................................................................................................................................................done. 12:34:33 INFO - Installing pip.................done. 12:34:33 INFO - Return code: 0 12:34:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:34:33 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:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:33 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:34:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:33 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 0x1100a7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11001d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee94a8a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10febbd30>, '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 0x10fd21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feb3b20>, '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.jWPTQq5aFJ/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.TU5bNoLigy/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:34:33 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:34:33 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:34:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jWPTQq5aFJ/Render', 12:34:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:34:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:34:33 INFO - 'HOME': '/Users/cltbld', 12:34:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:34:33 INFO - 'LOGNAME': 'cltbld', 12:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:33 INFO - 'MOZ_NO_REMOTE': '1', 12:34:33 INFO - 'NO_EM_RESTART': '1', 12:34:33 INFO - 'PAGER': '/bin/cat', 12:34:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:33 INFO - 'PWD': '/builds/slave/test', 12:34:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:34:33 INFO - 'SHELL': '/bin/bash', 12:34:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TU5bNoLigy/Listeners', 12:34:33 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:34:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:34:33 INFO - 'USER': 'cltbld', 12:34:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:34:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:33 INFO - 'XPC_FLAGS': '0x0', 12:34:33 INFO - 'XPC_SERVICE_NAME': '0', 12:34:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:33 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:34:33 INFO - Cleaning up... 12:34:33 INFO - Return code: 0 12:34:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:34:33 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:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:33 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:34:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:33 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 0x1100a7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11001d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee94a8a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10febbd30>, '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 0x10fd21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feb3b20>, '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.jWPTQq5aFJ/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.TU5bNoLigy/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:34:33 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:34:33 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:34:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jWPTQq5aFJ/Render', 12:34:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:34:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:34:33 INFO - 'HOME': '/Users/cltbld', 12:34:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:34:33 INFO - 'LOGNAME': 'cltbld', 12:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:33 INFO - 'MOZ_NO_REMOTE': '1', 12:34:33 INFO - 'NO_EM_RESTART': '1', 12:34:33 INFO - 'PAGER': '/bin/cat', 12:34:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:33 INFO - 'PWD': '/builds/slave/test', 12:34:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:34:33 INFO - 'SHELL': '/bin/bash', 12:34:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TU5bNoLigy/Listeners', 12:34:33 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:34:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:34:33 INFO - 'USER': 'cltbld', 12:34:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:34:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:33 INFO - 'XPC_FLAGS': '0x0', 12:34:33 INFO - 'XPC_SERVICE_NAME': '0', 12:34:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:33 INFO - Downloading/unpacking psutil>=3.1.1 12:34:33 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:34:33 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:34:33 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:34:33 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:34:33 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:34:33 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:34:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:34:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:34:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:34:37 INFO - Installing collected packages: psutil 12:34:37 INFO - Running setup.py install for psutil 12:34:37 INFO - building 'psutil._psutil_osx' extension 12:34:37 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:34:38 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:34:38 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:34:38 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:34:38 INFO - building 'psutil._psutil_posix' extension 12:34:38 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:34:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:34:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:34:38 INFO - ^ 12:34:38 INFO - 1 warning generated. 12:34:38 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:34:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:34:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:34:38 INFO - Successfully installed psutil 12:34:38 INFO - Cleaning up... 12:34:38 INFO - Return code: 0 12:34:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:34:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1100a7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11001d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee94a8a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10febbd30>, '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 0x10fd21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feb3b20>, '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.jWPTQq5aFJ/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.TU5bNoLigy/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:34:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 12:34:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 12:34:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jWPTQq5aFJ/Render', 12:34:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:34:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:34:38 INFO - 'HOME': '/Users/cltbld', 12:34:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:34:38 INFO - 'LOGNAME': 'cltbld', 12:34:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:38 INFO - 'MOZ_NO_REMOTE': '1', 12:34:38 INFO - 'NO_EM_RESTART': '1', 12:34:38 INFO - 'PAGER': '/bin/cat', 12:34:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:34:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:38 INFO - 'PWD': '/builds/slave/test', 12:34:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:34:38 INFO - 'SHELL': '/bin/bash', 12:34:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TU5bNoLigy/Listeners', 12:34:38 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:34:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:34:38 INFO - 'USER': 'cltbld', 12:34:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:34:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:34:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:38 INFO - 'XPC_FLAGS': '0x0', 12:34:38 INFO - 'XPC_SERVICE_NAME': '0', 12:34:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:34:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:34:39 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:34:39 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:34:39 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:34:39 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:34:39 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:34:39 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:34:41 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:34:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:34:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:34:41 INFO - Installing collected packages: mozsystemmonitor 12:34:41 INFO - Running setup.py install for mozsystemmonitor 12:34:41 INFO - Successfully installed mozsystemmonitor 12:34:41 INFO - Cleaning up... 12:34:42 INFO - Return code: 0 12:34:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:34:42 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:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:42 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:34:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:42 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 0x1100a7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11001d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee94a8a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10febbd30>, '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 0x10fd21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feb3b20>, '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.jWPTQq5aFJ/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.TU5bNoLigy/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:34:42 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:34:42 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:34:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jWPTQq5aFJ/Render', 12:34:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:34:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:34:42 INFO - 'HOME': '/Users/cltbld', 12:34:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:34:42 INFO - 'LOGNAME': 'cltbld', 12:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:42 INFO - 'MOZ_NO_REMOTE': '1', 12:34:42 INFO - 'NO_EM_RESTART': '1', 12:34:42 INFO - 'PAGER': '/bin/cat', 12:34:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:42 INFO - 'PWD': '/builds/slave/test', 12:34:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:34:42 INFO - 'SHELL': '/bin/bash', 12:34:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TU5bNoLigy/Listeners', 12:34:42 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:34:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:34:42 INFO - 'USER': 'cltbld', 12:34:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:34:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:42 INFO - 'XPC_FLAGS': '0x0', 12:34:42 INFO - 'XPC_SERVICE_NAME': '0', 12:34:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:34:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:42 INFO - Downloading/unpacking jsonschema==2.5.1 12:34:42 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:34:42 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:34:42 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:34:42 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:34:42 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:34:42 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:34:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:34:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:45 INFO - Downloading functools32-3.2.3-2.tar.gz 12:34:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:34:45 INFO - warning: no files found matching '*.txt' 12:34:45 INFO - no previously-included directories found matching 'build' 12:34:45 INFO - no previously-included directories found matching 'dist' 12:34:45 INFO - no previously-included directories found matching '.git*' 12:34:45 INFO - Installing collected packages: jsonschema, functools32 12:34:45 INFO - Running setup.py install for functools32 12:34:45 INFO - warning: no files found matching '*.txt' 12:34:45 INFO - no previously-included directories found matching 'build' 12:34:45 INFO - no previously-included directories found matching 'dist' 12:34:45 INFO - no previously-included directories found matching '.git*' 12:34:45 INFO - Successfully installed jsonschema functools32 12:34:45 INFO - Cleaning up... 12:34:45 INFO - Return code: 0 12:34:45 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:34:45 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:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:45 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:34:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:45 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 0x1100a7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11001d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee94a8a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10febbd30>, '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 0x10fd21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feb3b20>, '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.jWPTQq5aFJ/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.TU5bNoLigy/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:34:45 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:34:45 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:34:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jWPTQq5aFJ/Render', 12:34:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:34:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:34:45 INFO - 'HOME': '/Users/cltbld', 12:34:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:34:45 INFO - 'LOGNAME': 'cltbld', 12:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:45 INFO - 'MOZ_NO_REMOTE': '1', 12:34:45 INFO - 'NO_EM_RESTART': '1', 12:34:45 INFO - 'PAGER': '/bin/cat', 12:34:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:45 INFO - 'PWD': '/builds/slave/test', 12:34:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:34:45 INFO - 'SHELL': '/bin/bash', 12:34:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TU5bNoLigy/Listeners', 12:34:45 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:34:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:34:45 INFO - 'USER': 'cltbld', 12:34:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:34:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:45 INFO - 'XPC_FLAGS': '0x0', 12:34:45 INFO - 'XPC_SERVICE_NAME': '0', 12:34:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:34:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:34:45 INFO - Cleaning up... 12:34:45 INFO - Return code: 0 12:34:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:34:45 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:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:45 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:34:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:45 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 0x1100a7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11001d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee94a8a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10febbd30>, '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 0x10fd21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feb3b20>, '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.jWPTQq5aFJ/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.TU5bNoLigy/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:34:45 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:34:45 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:34:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jWPTQq5aFJ/Render', 12:34:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:34:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:34:45 INFO - 'HOME': '/Users/cltbld', 12:34:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:34:45 INFO - 'LOGNAME': 'cltbld', 12:34:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:45 INFO - 'MOZ_NO_REMOTE': '1', 12:34:45 INFO - 'NO_EM_RESTART': '1', 12:34:45 INFO - 'PAGER': '/bin/cat', 12:34:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:34:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:45 INFO - 'PWD': '/builds/slave/test', 12:34:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:34:45 INFO - 'SHELL': '/bin/bash', 12:34:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TU5bNoLigy/Listeners', 12:34:45 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:34:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:34:45 INFO - 'USER': 'cltbld', 12:34:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:34:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:34:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:45 INFO - 'XPC_FLAGS': '0x0', 12:34:45 INFO - 'XPC_SERVICE_NAME': '0', 12:34:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:34:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:46 INFO - Downloading/unpacking blobuploader==1.2.4 12:34: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:34: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:34: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:34: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:34: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:34: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:34:48 INFO - Downloading blobuploader-1.2.4.tar.gz 12:34:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:34:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:34:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:34:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:34:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:34:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:34: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:34: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:34: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:34: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:34: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:34: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:34:50 INFO - Downloading docopt-0.6.1.tar.gz 12:34:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:34:50 INFO - Installing collected packages: blobuploader, requests, docopt 12:34:50 INFO - Running setup.py install for blobuploader 12:34:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:34:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:34:50 INFO - Running setup.py install for requests 12:34:50 INFO - Running setup.py install for docopt 12:34:51 INFO - Successfully installed blobuploader requests docopt 12:34:51 INFO - Cleaning up... 12:34:51 INFO - Return code: 0 12:34:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:34:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:51 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 0x1100a7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11001d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee94a8a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10febbd30>, '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 0x10fd21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feb3b20>, '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.jWPTQq5aFJ/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.TU5bNoLigy/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:34:51 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:34:51 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:34:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jWPTQq5aFJ/Render', 12:34:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:34:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:34:51 INFO - 'HOME': '/Users/cltbld', 12:34:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:34:51 INFO - 'LOGNAME': 'cltbld', 12:34:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:51 INFO - 'MOZ_NO_REMOTE': '1', 12:34:51 INFO - 'NO_EM_RESTART': '1', 12:34:51 INFO - 'PAGER': '/bin/cat', 12:34:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:34:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:51 INFO - 'PWD': '/builds/slave/test', 12:34:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:34:51 INFO - 'SHELL': '/bin/bash', 12:34:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TU5bNoLigy/Listeners', 12:34:51 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:34:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:34:51 INFO - 'USER': 'cltbld', 12:34:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:34:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:34:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:51 INFO - 'XPC_FLAGS': '0x0', 12:34:51 INFO - 'XPC_SERVICE_NAME': '0', 12:34:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:34:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:34:51 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-y2Lne6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:34:51 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-n437tH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:34:51 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-ThT5JX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:34:51 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-2ztW9l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:34:51 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-eTLOK3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:34:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:34:51 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-WESK04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:34:52 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-3KBFp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:34:52 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-VPpkcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:34:52 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-gXXMBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:34:52 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-NDCgHd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:34:52 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-6Eg7c4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:34:52 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-I1nBX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:34:52 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-ixLS7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:34:52 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-KoPenp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:34:52 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-dzZyMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:34:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:34:52 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-0ooBY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:34:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:34:53 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Dgnj_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:34:53 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:34:53 INFO - Running setup.py install for manifestparser 12:34:53 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:34:53 INFO - Running setup.py install for mozcrash 12:34:53 INFO - Running setup.py install for mozdebug 12:34:53 INFO - Running setup.py install for mozdevice 12:34:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:34:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:34:53 INFO - Running setup.py install for mozfile 12:34:53 INFO - Running setup.py install for mozhttpd 12:34:54 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:34:54 INFO - Running setup.py install for mozinfo 12:34:54 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:34:54 INFO - Running setup.py install for mozInstall 12:34:54 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:34:54 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:34:54 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:34:54 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:34:54 INFO - Running setup.py install for mozleak 12:34:54 INFO - Running setup.py install for mozlog 12:34:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:34:54 INFO - Running setup.py install for moznetwork 12:34:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:34:54 INFO - Running setup.py install for mozprocess 12:34:54 INFO - Running setup.py install for mozprofile 12:34:55 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:34:55 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:34:55 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:34:55 INFO - Running setup.py install for mozrunner 12:34:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:34:55 INFO - Running setup.py install for mozscreenshot 12:34:55 INFO - Running setup.py install for moztest 12:34:55 INFO - Running setup.py install for mozversion 12:34:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:34:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:34:55 INFO - Cleaning up... 12:34:55 INFO - Return code: 0 12:34:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:34:55 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:34:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:34:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:55 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:34:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:34:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:34:55 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 0x1100a7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11001d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee94a8a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10febbd30>, '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 0x10fd21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feb3b20>, '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.jWPTQq5aFJ/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.TU5bNoLigy/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:34:55 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:34:55 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:34:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jWPTQq5aFJ/Render', 12:34:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:34:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:34:55 INFO - 'HOME': '/Users/cltbld', 12:34:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:34:55 INFO - 'LOGNAME': 'cltbld', 12:34:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:34:55 INFO - 'MOZ_NO_REMOTE': '1', 12:34:55 INFO - 'NO_EM_RESTART': '1', 12:34:55 INFO - 'PAGER': '/bin/cat', 12:34:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:34:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:34:55 INFO - 'PWD': '/builds/slave/test', 12:34:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:34:55 INFO - 'SHELL': '/bin/bash', 12:34:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TU5bNoLigy/Listeners', 12:34:55 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:34:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:34:55 INFO - 'USER': 'cltbld', 12:34:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:34:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:34:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:34:55 INFO - 'XPC_FLAGS': '0x0', 12:34:55 INFO - 'XPC_SERVICE_NAME': '0', 12:34:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:34:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:34:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:34:56 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-UOvqhW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:34:56 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:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:34:56 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-dLpYv5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:34:56 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:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:34:56 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-mIWRen-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:34:56 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:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:34:56 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-wgpJFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:34:56 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:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:34:56 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Kx9dKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:34:56 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:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:34:56 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-IPNxgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:34:56 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:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:34:56 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-jm6t12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:34:56 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:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:34:56 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-VG8J73-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:34:56 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:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:34:56 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-WnRe2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:34:56 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:34:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:34:56 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-G0wsZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:34:57 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:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:34:57 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-Ebl40H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:34:57 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:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:34:57 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-mDFlZy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:34:57 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:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:34:57 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-4dGarQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:34:57 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:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:34:57 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-C9POyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:34:57 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:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:34:57 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-H5kqYa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:34:57 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:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:34:57 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-seZCWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:34:57 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:34:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:34:57 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-o7fViE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:34:57 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:34:57 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:34:57 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:34:57 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:34:57 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:34:57 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:34:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:34:57 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:34:57 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:34:57 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:34:57 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:34:57 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:34:57 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:35:00 INFO - Downloading blessings-1.6.tar.gz 12:35:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:35:00 INFO - Installing collected packages: blessings 12:35:00 INFO - Running setup.py install for blessings 12:35:00 INFO - Successfully installed blessings 12:35:00 INFO - Cleaning up... 12:35:00 INFO - Return code: 0 12:35:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:35:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:35:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:35:01 INFO - Reading from file tmpfile_stdout 12:35:01 INFO - Current package versions: 12:35:01 INFO - blessings == 1.6 12:35:01 INFO - blobuploader == 1.2.4 12:35:01 INFO - docopt == 0.6.1 12:35:01 INFO - functools32 == 3.2.3-2 12:35:01 INFO - jsonschema == 2.5.1 12:35:01 INFO - manifestparser == 1.1 12:35:01 INFO - mozInstall == 1.12 12:35:01 INFO - mozcrash == 0.17 12:35:01 INFO - mozdebug == 0.1 12:35:01 INFO - mozdevice == 0.48 12:35:01 INFO - mozfile == 1.2 12:35:01 INFO - mozhttpd == 0.7 12:35:01 INFO - mozinfo == 0.9 12:35:01 INFO - mozleak == 0.1 12:35:01 INFO - mozlog == 3.4 12:35:01 INFO - moznetwork == 0.27 12:35:01 INFO - mozprocess == 0.23 12:35:01 INFO - mozprofile == 0.28 12:35:01 INFO - mozrunner == 6.12 12:35:01 INFO - mozscreenshot == 0.1 12:35:01 INFO - mozsystemmonitor == 0.3 12:35:01 INFO - moztest == 0.7 12:35:01 INFO - mozversion == 1.4 12:35:01 INFO - psutil == 3.1.1 12:35:01 INFO - requests == 1.2.3 12:35:01 INFO - wsgiref == 0.1.2 12:35:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:35:01 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:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:01 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:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:01 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 0x1100a7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11001d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee94a8a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10febbd30>, '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 0x10fd21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feb3b20>, '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.jWPTQq5aFJ/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.TU5bNoLigy/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:35:01 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:35:01 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:35:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jWPTQq5aFJ/Render', 12:35:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:35:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:35:01 INFO - 'HOME': '/Users/cltbld', 12:35:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:35:01 INFO - 'LOGNAME': 'cltbld', 12:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:01 INFO - 'MOZ_NO_REMOTE': '1', 12:35:01 INFO - 'NO_EM_RESTART': '1', 12:35:01 INFO - 'PAGER': '/bin/cat', 12:35:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:01 INFO - 'PWD': '/builds/slave/test', 12:35:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:35:01 INFO - 'SHELL': '/bin/bash', 12:35:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TU5bNoLigy/Listeners', 12:35:01 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:35:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:35:01 INFO - 'USER': 'cltbld', 12:35:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:35:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:01 INFO - 'XPC_FLAGS': '0x0', 12:35:01 INFO - 'XPC_SERVICE_NAME': '0', 12:35:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:01 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:35:01 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:35:01 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:35:01 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:35:01 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:35:01 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:35:01 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:35:01 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:35:01 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:35:01 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:35:01 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:35:01 INFO - Cleaning up... 12:35:01 INFO - Return code: 0 12:35:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:35:01 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:35:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:35:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:01 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:35:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:35:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:35:01 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 0x1100a7490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11001d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9ee94a8a90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10febbd30>, '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 0x10fd21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feb3b20>, '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.jWPTQq5aFJ/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.TU5bNoLigy/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:35:01 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:35:01 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:35:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jWPTQq5aFJ/Render', 12:35:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:35:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:35:01 INFO - 'HOME': '/Users/cltbld', 12:35:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:35:01 INFO - 'LOGNAME': 'cltbld', 12:35:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:01 INFO - 'MOZ_NO_REMOTE': '1', 12:35:01 INFO - 'NO_EM_RESTART': '1', 12:35:01 INFO - 'PAGER': '/bin/cat', 12:35:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:35:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:01 INFO - 'PWD': '/builds/slave/test', 12:35:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:35:01 INFO - 'SHELL': '/bin/bash', 12:35:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TU5bNoLigy/Listeners', 12:35:01 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:35:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:35:01 INFO - 'USER': 'cltbld', 12:35:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:35:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:35:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:01 INFO - 'XPC_FLAGS': '0x0', 12:35:01 INFO - 'XPC_SERVICE_NAME': '0', 12:35:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:35:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:35:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:35:01 INFO - Cleaning up... 12:35:01 INFO - Return code: 0 12:35:01 INFO - Running post-action listener: _resource_record_post_action 12:35:01 INFO - Running post-action listener: _start_resource_monitoring 12:35:01 INFO - Starting resource monitoring. 12:35:01 INFO - [mozharness: 2017-01-11 20:35:01.651840Z] Finished create-virtualenv step (success) 12:35:01 INFO - [mozharness: 2017-01-11 20:35:01.652872Z] Running install step. 12:35:01 INFO - Running pre-action listener: _resource_record_pre_action 12:35:01 INFO - Running main action method: install 12:35:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:35:01 INFO - Reading from file tmpfile_stdout 12:35:01 INFO - Detecting whether we're running mozinstall >=1.0... 12:35:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:35:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:35:02 INFO - Reading from file tmpfile_stdout 12:35:02 INFO - Output received: 12:35:02 INFO - Usage: mozinstall [options] installer 12:35:02 INFO - Options: 12:35:02 INFO - -h, --help show this help message and exit 12:35:02 INFO - -d DEST, --destination=DEST 12:35:02 INFO - Directory to install application into. [default: 12:35:02 INFO - "/builds/slave/test"] 12:35:02 INFO - --app=APP Application being installed. [default: firefox] 12:35:02 INFO - mkdir: /builds/slave/test/build/application 12:35:02 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:35:02 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:35:24 INFO - Reading from file tmpfile_stdout 12:35:24 INFO - Output received: 12:35:24 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 12:35:24 INFO - Running post-action listener: _resource_record_post_action 12:35:24 INFO - [mozharness: 2017-01-11 20:35:24.272560Z] Finished install step (success) 12:35:24 INFO - [mozharness: 2017-01-11 20:35:24.272707Z] Running run-tests step. 12:35:24 INFO - Running pre-action listener: _resource_record_pre_action 12:35:24 INFO - Running main action method: run_tests 12:35:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:35:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:35:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:35:24 INFO - 2017-01-11 12:35:24.287 screenresolution[1624:7690] starting screenresolution argv=screenresolution get 12:35:24 INFO - 2017-01-11 12:35:24.289 screenresolution[1624:7690] Display 0: 1600x1200x32@60 12:35:24 INFO - 2017-01-11 12:35:24.295 screenresolution[1625:7692] starting screenresolution argv=screenresolution list 12:35:24 INFO - Available Modes on Display 0 12:35:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:35:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:35:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:35:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:35:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:35:24 INFO - Intel Iris: 12:35:24 INFO - Chipset Model: Intel Iris 12:35:24 INFO - Type: GPU 12:35:24 INFO - Bus: Built-In 12:35:24 INFO - VRAM (Dynamic, Max): 1536 MB 12:35:24 INFO - Vendor: Intel (0x8086) 12:35:24 INFO - Device ID: 0x0a2e 12:35:24 INFO - Revision ID: 0x0009 12:35:24 INFO - Displays: 12:35:24 INFO - Display: 12:35:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:35:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:35:24 INFO - Display Serial Number: 1600x1200 60 12:35:24 INFO - Main Display: Yes 12:35:24 INFO - Mirror: Off 12:35:24 INFO - Online: Yes 12:35:24 INFO - Rotation: Supported 12:35:24 INFO - Return code: 0 12:35:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:35:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:35:24 INFO - Python 2.7.3 12:35:24 INFO - Return code: 0 12:35:24 INFO - grabbing minidump binary from tooltool 12:35:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:35:24 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 0x10febbd30>, '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 0x10fd21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10feb3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:35:24 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:35:24 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:35:24 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:35:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:35:24 INFO - Return code: 0 12:35:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:35:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:35:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:35:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:35:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:35:24 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/V59AsRtZQ16D-TpRgTLa2g/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:35:24 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/V59AsRtZQ16D-TpRgTLa2g/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:35:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.jWPTQq5aFJ/Render', 12:35:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:35:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:35:24 INFO - 'HOME': '/Users/cltbld', 12:35:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:35:24 INFO - 'LOGNAME': 'cltbld', 12:35:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:35:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:35:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:35:24 INFO - 'MOZ_NO_REMOTE': '1', 12:35:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:35:24 INFO - 'NO_EM_RESTART': '1', 12:35:24 INFO - 'PAGER': '/bin/cat', 12:35:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:35:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:35:24 INFO - 'PWD': '/builds/slave/test', 12:35:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:35:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:35:24 INFO - 'SHELL': '/bin/bash', 12:35:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.TU5bNoLigy/Listeners', 12:35:24 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 12:35:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:35:24 INFO - 'USER': 'cltbld', 12:35:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:35:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:35:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:35:24 INFO - 'XPC_FLAGS': '0x0', 12:35:24 INFO - 'XPC_SERVICE_NAME': '0', 12:35:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:35:24 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/V59AsRtZQ16D-TpRgTLa2g/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:35:24 INFO - mozversion application_buildid: 20170111094025 12:35:24 INFO - mozversion application_changeset: 6dd3d485a0598df6175e0d0551237b427ba3bf04 12:35:24 INFO - mozversion application_display_name: Firefox 12:35:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:35:24 INFO - mozversion application_name: Firefox 12:35:24 INFO - mozversion application_remotingname: firefox 12:35:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 12:35:24 INFO - mozversion application_vendor: Mozilla 12:35:24 INFO - mozversion application_version: 51.0 12:35:24 INFO - mozversion platform_buildid: 20170111094025 12:35:24 INFO - mozversion platform_changeset: 6dd3d485a0598df6175e0d0551237b427ba3bf04 12:35:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 12:35:24 INFO - mozversion platform_version: 51.0 12:35:24 INFO - using testdate: 1484166924 12:35:24 INFO - actual date: 1484166924 12:35:24 INFO - starting webserver on 'localhost:49240' 12:35:24 INFO - SUITE-START | Running 2 tests 12:35:24 INFO - TEST-START | dromaeo_css 12:35:24 INFO - operating with platform_type : mac_ 12:35:24 INFO - Initialising browser for dromaeo_css test... 12:35:24 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpb7_ZfL/profile http://localhost:49240/getInfo.html) 12:35:27 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 12:35:27 INFO - PROCESS | 1635 | colorDepth:24 12:35:27 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 12:35:27 INFO - PROCESS | 1635 | __metrics 12:35:27 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:35:27 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:35:28 INFO - TEST-INFO | 1635: exit 0 12:35:28 INFO - Browser initialized. 12:35:28 INFO - Running cycle 1/1 for dromaeo_css test... 12:35:28 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpb7_ZfL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:35:40 INFO - PROCESS | 1639 | RSS: Main: 168591360 12:35:40 INFO - PROCESS | 1639 | 12:36:31 INFO - PROCESS | 1639 | 1484166991977 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:38:41 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 12:38:43 INFO - PROCESS | 1639 | RSS: Main: 265732096 12:38:43 INFO - PROCESS | 1639 | 12:41:46 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 12:41:46 INFO - PROCESS | 1639 | RSS: Main: 301293568 12:41:46 INFO - PROCESS | 1639 | 12:44:49 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 12:44:49 INFO - PROCESS | 1639 | RSS: Main: 282705920 12:44:49 INFO - PROCESS | 1639 | 12:47:51 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 12:47:52 INFO - PROCESS | 1639 | RSS: Main: 296402944 12:47:52 INFO - PROCESS | 1639 | 12:50:55 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 12:50:56 INFO - PROCESS | 1639 | RSS: Main: 263012352 12:50:56 INFO - PROCESS | 1639 | 12:53:58 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 12:53:59 INFO - PROCESS | 1639 | RSS: Main: 326950912 12:53:59 INFO - PROCESS | 1639 | 12:53:59 INFO - PROCESS | 1639 | __start_tp_report 12:53:59 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 12:53:59 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 12:53:59 INFO - PROCESS | 1639 | |i|pagename|runs| 12:53:59 INFO - PROCESS | 1639 | |0;dojo.html;3323.800571965682;3407.1311815487056;3465.8786942457004;3471.455202434914;3512.7892326460415;5751.65490070596;5838.41615838416;5860.560457965654;5893.440123188301;5905.822825315242;5794.130880367937;5819.476247137757;5835.883282334351;5850.180974663551;5850.88298234035;5215.217717342391;5227.9738601307035;5300.363956325246;5314.574834013289;5320.654157479771;4396.516383197845;5210.452902445246;5241.2400201970695;5351.384590772072;5358.062339090663;5276.34045744282;5283.63014588979;5292.2061690746505;5309.33633295838;5356.223347614594;5294.49702278281;5304.336957880265;5339.733013349317;5355.223492593591;5376.569874410038;5170.6122040847085;5210.036143313499;5291.391489978625;5313.548348390392;5333;5700.971495142498;5711.314642242957;5719.084946408596;5758.992176369161;5822.243108395924;6185.319614842409;6234.220722409699;6253.155823963798;6269.720813196494;6282.937170628281;6219.315875253718;6270.341614130496;6282.183316168915;6286.308506064329;6287.779927702509;5732.684702341411;5823.272090988627;5828.12578113278;5914.585978981516;5926.407359264039;6346.57781590739;6410.775622853271;6415.518836087312;6418.133551970518;6429.903551446732;6223.0354295084335;6225.688715564203;6229.127922090911;6236.594621349688;6239.937600624026;6126.884121540732;6151.907721384183;6167.352427995085;6196.00863861789;6208.192934918522;6227.688615569204;6255.906161407583;6270.6864656766975;6298.055291706189;6347;6253.093301471352;6325.873482530324;6326.4622507087415;6334.5249106317215;6348.650824204713;4932.383452068491;4992.101421744121;5001.099802035668;5024.522670346311;5063.063333283354;4434.13534360803;4500.797464114123;4510.188166130062;4512.503624601291;4566.474855391606;5697.4587414195585;5974.9402505974385;5990.430909063632;5998.100284957204;6009.06859436788;4944.802207911715;6119.41115851624;6280.9685951569945;6285.842853928597;6315.526335524854;5829.94170058294;5898.469137777621;5910.734016969247;5925.792597259076;5939.940600594025;5529.170624406372;5540.196671482612;5544.944550554443;5548.750306236148;5580.860478487989;6490.675466226669;6518.543701940914;6528.967355163289;6535.705893234721;6541.901871471931;6065.484433823174;6201.069839523927;6227.532935029801;6250;6310.5898116622275;6390.840228994312;6471.579347342407;6505.739770409131;6517.217933847968;6518.9895566187315;6268.937310627018;6299.905501417574;6303.968480157753;6311.495080393465;6325.430711236011;6187.969060154671;6207.099970504342;6231.844203894939;6317.147185130132;6336.271328797063;6138.204480310071;6145.13968044483;6219.533534984985;6266.968665156645;6274.278457977391;6213.5339849510565;6222.782202622887;6241.21984751906;6250.906236406367;6251.062340648939;5913.70431478433;6066.7269972850445;6112.694365281629;6153.938460615515;6161.4146656067605;4917.803287868445;6082.513398928164;6118.558266176107;6126.24286675468;6250.249970003629;5214.504622060898;6099.268087829311;6116.541259405473;6119.8470038247615;6124.846878828065 12:53:59 INFO - PROCESS | 1639 | |1;ext.html;446.2792589967203;498.1481666350543;544.6160456877901;547.780887644942;558.7820749907536;31860.044198674048;43171.92070198247;44649;44710.999999999956;46857;45757.771211143896;46238;46272.76863615677;46285;46353.53646463534;10022.949885250564;10226.488675566228;10235.948820255926;10239.385636861774;10239.744006399826;9332.393394429375;9565.139137477625;12327.26036437812;12576.496940122384;12594.181378210433;12398.876011239863;12524.812127818044;12526.624201273977;12536.373181340941;12541.623751287476;12508.687282817957;12610.684732881706;12614.68463288416;12620.747585048339;12646;12121.696957576043;12321.075919306088;12388.442520086617;12405.503779848796;12405.875941240653;42368.51710190159;42671.78664106691;42742.78628606868;42771.57228427707;42783.78608106971;3381.1885147564653;3551.2897420516;3702.5186725725753;3831.8658846940225;4117.238310912461;30343;31023.052809983015;31031;31437.685623143934;33764.6623533764;3393.474011528217;3430.3996800560053;3482.2165012872156;3505.4391297392294;3553.8578456861696;499619;502417;502477;503922;504910.99999999633;35139;35890.461643075374;35905.82047089748;66499.66750166315;66986.33013669899;37079.4438083429;37163.25673486569;37278.06804829847;37344.81327593345;37356.25287494235;15933.840661593467;16143.919280403523;16153.919230403773;16173;16188.838111618734;12443.751124977449;12640;13441.193528388329;13556.11885227457;13558.254296013616;7042.471814613822;8107.067687216046;8113.350931925432;8135.430519863671;8173.918260817316;3296.4725643896863;3326.5841769778776;3330.4837750148768;3333.6499667535045;3357.026462325898;946.9242460603135;956.2015716876347;1043.9895601044045;1066.7813098314828;1107.7064577886867;25271.36821579475;30215.848920755696;31293.8435307822;31357.686423135932;31924.521132183036;1043.2436483549366;1110.1119104716356;1202.2125507792234;1208.6555331730415;1221.450347343699;14047;15633.592976632157;16440;16447.506574802774;16577.336906523844;725374;733968;735219;735865;736301;62227.377726223065;62739;62819;62821.74356512844;62857.37142628515;1224.6693392784077;1277.9424925878359;1307.5358247822076;1398.223985687953;1436.2244388030347;31699.366012679155;31789.04632861018;32863.342733145684;33025.66254108081;33204;52565.211521827965;53207;53238.20142697785;53238.73380633072;53256.2011569819;585366;586590;588688;589593;820960;21603.135874564843;24617;27461.725382746718;28148.577771333035;29167.416651667274;49050.75474622604;49426.25860612022;49701.25448118353;49933;50221.74889125677;39675.404868927566;40951.7952410236;42057.61194178197;42124.57875421329;42403;40778;40892.79553602213;40910.9772255696;41994.37008444937;42436.36345454759;39935;42128;42517.14965700607;42641.36037959495;42658.14683706371;33170.50244246387;36876;37281.81359093187;37424.064398390256;37788.24423511569;26993.59509607397;27001.86499067492;27004.86497567578;27070.72929270682;27233 12:53:59 INFO - PROCESS | 1639 | |2;jquery.html;383.8349509710823;385.87709764585065;387.1965671232193;395.8812356293112;412.9401236820661;14835.480758173466;20614.381568552948;21206.469838254052;21818.781812181875;21857.67213491799;16848.663026739458;19181.616367672672;21307.57384852302;21349.35951921441;21453.892730536325;5855.209546711203;6200.751969921198;6205.472534834545;6208.751649933997;6213.502919766408;5856.443637854397;6110.847228819271;6128.38716128388;6181.227346581677;6199.318075011745;6210.31686514483;6217.56477046607;6221.844453888666;6227.314995350508;6231.189945307104;5477.315335583052;5593.881223755266;6181.690915454209;6187.443130118266;6197.380261973789;5783.942160578425;5940.613830148398;5977.432143946318;5985.25184351956;5990.97004514979;13296.867031329757;13357.398917048757;13582.913366930721;13601.59195224135;13604.59186224405;2236.642137258047;2314.90740370385;2395.568797616428;2614.673165854268;2655.0176434719083;8363.372747043995;9748.31761776676;10020.198384129251;10134.797304053951;10264.281500294983;1882.2471011595335;1909.961800763977;1927.171316333976;1952.7754308254591;1961.9313324033733;114069;119369.40315298455;121689.39155304167;121969.78030219673;122708;11478.704259148204;11632.695902516123;11644.3595602241;11688.70778230551;11867.76264474723;14763.704725905422;14810.259487025605;14814.777778333333;14815.629609259855;14837.406503739945;6332.841678958063;8271.13153118926;8272.33821294295;8353.33173346131;8611.181937715906;7621.161672216052;7911.564863932424;8230.8353832923;8527.275181609633;8955.820883582292;4463.352813841975;4504.369388285642;4516.548345165457;4525.004499010212;4602.746848923274;1645.9506214813575;1888.2824526679774;1935.9612807743765;1936.0803618281486;1952.5021119614407;612.6640101555217;721.1706537481833;819.8729196974479;936.578539657157;972.2465089555651;18110.728339074925;20761.27335543279;21145.942702864795;21691.132354705634;22057;955.5174636808367;961.5528779117744;984.1978787288338;991.7173605522391;1042.4475028235047;11249.987501124775;11579.829515870608;11582.247153934968;11708.356040417688;11711.707207319714;612637;614491;618968;623215;627914;119153;132129;138714.61285387218;138987.91518127237;139698;400.8595545672615;955.1928620315822;973.8149751547184;976.4824642939253;980.5734505490135;9993;10863;10956.945215273872;11153.665390038312;11727.589534366256;56912.71543642421;57125.42874571201;57528;57707.7114614441;57961;84405;84864;85298.14701852902;85703;87846;6992.860142797013;8112;8148.3888708348295;8223.506589604644;8694.434861733967;11383.943080284545;11556.728759836244;12529.310887900889;13016.674583135118;13116.950643948652;11381.601643942422;11454.026407755435;11503.079753619522;11537.88462115368;11539.21122734056;11002.614908478165;11077.889221108007;11183.832242516206;11338.829917551078;11773.058155347722;11391;11451.25566838153;11684.591039313584;11828.940855295668;11878.46546905374;7785.493942893694;8042.597870106354;8068.7175948841505;8541.871871921801;8542.40203185771;8245.340372770284;10305.53625086888;11090.778184436427;11542.538298467967;11594.6521604352 12:53:59 INFO - PROCESS | 1639 | |3;mootools.html;1557.5794535475422;1586.3495966653672;1639.8524132828059;1818.2545156485835;1965.3219639224462;7942.245486678764;9496.38273512223;9503.904960950389;9523.952380238106;9533.998930112342;8053.234942680436;8356.289715374185;8833.867491987625;8851.159139881702;8854.203121719043;2411.7949974252165;2443.743406942272;2443.987780061097;2450.0444826517673;2450.1179575352858;2417.4319035026842;2420.588499955003;2454.644076608891;2456.803455723538;2458.2502336787275;2157.374361435182;2429.5626787178303;2445.6331550267514;2446.4617784087563;2447.657327974085;2411.409204744831;2414.263649586875;2423.0671191591186;2427.07771047001;2439.695038120235;2415.915442959488;2419.9516009679883;2423.260905423845;2430.86630235337;2433.914812981555;9062.909370906273;9253.120953509473;9254.6298148074;9270.21203197729;9277.768055798591;5521.613487055908;5701.230333904911;5701.372848986608;5703.942960570383;5708.001099807559;3556.5732112146447;3632.1827588792576;3663.9450408243897;3715.869944551928;3716.535433070866;1130.8021096308196;1143.9885601143965;1145.0381679389352;1157.9421028948602;1838.8161183881639;12318.753624927542;12644.304563249018;12650.240985540897;12667.556635517712;12667.93666031664;4641.301414748856;4722.716637001791;4764.595009424169;4832.661713680079;4900.093482705711;9741.123298903132;9747.707568772948;9751.658691945748;9759.707208783748;9764.462954537426;5563.248961390242;5566.721663916788;5567.053600887859;5572.359178694421;5580.246666700024;4618.769061546909;4750.904981900343;4762.857114286577;5143.794248230029;5191.6884986900905;3907.905786379818;3948.249832531867;4013.3779264214095;4039.3335099708806;4050.736702114412;1198.1668047886747;1211.273236058358;1211.2853416484318;1221.8961388281919;1222.144498850808;922.9953850230706;923.1138107416955;924.2698268368049;926.8563372677246;943.3773709351794;5310.92033619496;5884.9705751470965;6145.354737752561;6246.656433896179;6385.169927909342;920.7753687595482;923.4274749655123;936.6534382278464;982.7739619887323;1027.8869324374314;3595.82020898954;3924.9803750981064;3939.763614183158;3990.780507072139;4017.8995525112105;11006.229563930608;11387.715307117223;11411.429428528707;11419.60031398897;11502.964733174054;11439.88560114405;11441.256318339281;11442;11456.427178641201;11476;8222.424430289822;8645.178708022602;8675.175858293453;8814.955925220333;8822.779430514289;5268.6575372600655;6054.545909056927;6183.938160618336;6190.535709821691;6215.564910456405;9815.46014969155;10267.281290309607;10477.266591338534;10527.052565269163;10566.366018038942;9526.904405993122;10354.5340459678;10580.89419105799;10711.839322410015;10716.785664286826;7228.385587225145;7390.630468476662;7439.590822504814;7444.032275804111;7997.520148791091;8200.26197642215;8280.792980175303;8286.337093032422;8505.82988340242;8688.565571721516;6483.902741458976;6729.7644582441335;7702.4608277422285;7858.724944627139;7947.642356093874;7671.654775535003;7698.03774528184;7767.145613982344;7835.529868207926;7899.921000789918;7227.638618068971;7396.260373962776;7402.1857595665515;7410.258974102547;7419.814504637211;5079.085764562415;5120.820771272987;5129.563987061141;5237.240600113038;5370.973145134406;5100.311457953128;5209.453007434165;5384.569234461155;5418.566514678895;5446.891062178814 12:53:59 INFO - PROCESS | 1639 | |4;prototype.html;307.33155387033213;311.79421581756037;319.2274695237526;323.9433099207638;327.7083395777757;5351.598630102739;5388.147474555692;5398.732532336418;5457.808976685817;5470.167493889542;4454.554544545544;4634.374359461472;5341.30563026806;5419.458054194579;5449.555867695064;3819.2622356827715;4178.603032711888;4184.811683474236;4231.217224813419;4238.703290769639;3890.708196885231;4197.748135111888;4202.852900148496;4207.978960105195;4230.132822771325;4095.89760255993;4108.5686002969705;4111.60939710727;4139.917201655965;4153.190127925056;4112.897177570555;4116;4123.36087906375;4125.8968525786795;4131.483564554431;3592.604813470516;3598.946015809765;3600.459931010343;3604.981975090108;3609.657082577151;4351.630111440531;4539.957019341309;5081.974590127063;5368.3826359968325;5389.865253368658;4006.779627120507;4696.463909488872;4711.693739906895;4713.2458806590785;4747.406574178228;4395.978020109911;5265.447128051538;5642;5695.857603559903;5733.713314334266;3136.7176954074016;3303.339332133559;3860.7297489175767;3886.514185726784;3948.447217389568;4572.4055872736335;5656.2929633795775;5885.970570147122;5993.760249590011;6093.573449858467;3148.449021421242;3434.759566830298;3501.964980350164;3838.8272527736317;3858.803770831051;3354.446516324779;4016.2369149861433;4017.2367250222364;4020.3567429211184;4022.5977402260123;3914.6085391461197;4066.877993660195;4668.439787225487;4692.6245900327895;4697.718136911796;5578.63738856973;5771.249737534177;5796.710164491758;5823.359430462646;5824.213731146241;1179.4102948525738;1342.234926092118;1346.373936119709;1370.5477192526441;1376.7108907129414;793.7499687598388;827.7103013945072;838.5723281126669;848.7878030492377;852.3394369363792;3854.0537028800836;4022.02920568925;4556.863294101182;4588.701734387254;4604.286335617984;4075.5109386873764;4581.594662802056;4748.477667456577;4923.621386011922;5015.623828212826;3780.640839120279;4033.6974726895014;4057.4522439470293;4592.609628181642;4619.2378257587125;2167.5556510915226;2422.8304018718522;2486.0677246032737;2606.2572166932714;2612.6342312076326;4748.857534273978;5030.541143068543;5124.795008199705;5140.897182056338;5187.584993200535;4342.522322544518;4803;5003.449620541737;5043.87390315245;5072.949270507322;4571.1543364477675;4599.448066232074;4797.856064318076;5140.331756871583;5157.767900444489;4605.953940460552;4664.906701866012;4909.729964851825;4936.593750312273;4943.209086546135;4447.577480139382;4608.9629833287245;4630.901652037904;4871.442492691365;4877.585405240594;4755.619550436026;5141.8687888664435;5169.353830771153;5770.807093304686;5913.674747888907;3317.9548442240616;3553.7867727935372;3937.3306537888056;3956.624120708528;3962.7027972902724;5847.502962248256;5889.293284805851;5904.763809447746;5905.763769449174;5907.85230369227;5515.586331025109;5654.794630094349;5660.097352487185;5699.150424787606;5816.21481100063;5001.24981252815;5459.962607104638;5545.417731138334;5719.656820590778;5740.827775166752;4719.905601888012;5289.57683385336;5623.465770751772;5639.746211420414;5650.971745141248;4793.352897358812;5356.651817631841;5665.49010589049;5735.598508104559;5746.9712651436475;5620.739970816998;5622.493975542221;5623.8875222496135;5637.069883469182;5650.773969041193 12:53:59 INFO - PROCESS | 1639 | |5;yui.html;608.2943785209156;724.7427163357008;746.6901235987066;761.4517547365898;790.4624855098531;15462.226888655565;16685.33258669655;16693.415730449437;16696.332146714118;16715.749263761038;15002.699946001101;15123.243837808093;15135.848641513581;15144.924275378607;15150.090994540307;724.971001159953;745.4893398022344;747.7495039161887;752.8456666383406;892.2906289499847;742.5581778841607;748.5546100070477;887.9023307436177;908.3823000359753;912.6212621761961;894.1952242981304;928.8606708993638;947.6209516193543;948.0188005414398;950.1021534649759;942.2556180617304;944.489975413276;944.7779771753633;945.8581212818063;947.2564037230775;699.9955064482484;701.5615240474704;701.8034950213897;702.5363260248212;705.3158436316764;15313.540593782092;15388.692226155526;15426;15460.226988650522;15464.5360639181;13674.521391751241;14723.705525889422;14988.025778324374;15091.622709432351;15116.848831511654;13342.19946803195;13428.261445620486;13529.32353382327;13738.587842364745;13741.175529468264;4668.743219122947;4746.501617330199;4791.47293797682;4792.736399498026;4924.4583095859425;123660.03745652389;126031.3698431502;130939;131558.3422082893;132392.99999999904;11089.72275693098;11194;11323.094152467947;11390.829137562943;11590.88409115898;21536.353909382742;21718.78281217199;22039.889800550896;22069.448263793212;22129;7742.690292388242;8063.717769878026;8106.2299081588335;8156.5513896735065;8221.835563288701;4508.1659892919915;4513.007138429541;4558.544145585482;4593.793279302439;4644.9767751161025;3662.9450558241647;3820.7707537547835;3823.8279277432584;3826.330392181357;3830.904227394282;675.787127054976;705.5096707788038;729.5185177782638;748.3451979517922;752.7892190186647;633.3002032753833;674.9122614060141;676.2586340174072;691.9792406227821;697.8848489999194;9201.401908875901;9470.100340467645;9567.330286879851;9653.71038868835;9843.901560984441;675.8817206988757;696.8884978403431;697.424624684627;697.5814511293183;703.8521910398771;4167.666586673059;4236.788160591958;4401.471823381215;4616.884577885513;4648.48866624671;109732.35401468984;135406;139272;150597.49402506053;154666.22666886594;132445;133351.33324333315;133756.9936450954;138924.30537847246;138993;93651.59522607303;107608.46195768971;107821;109695.45152274187;119536.40231798786;9720.562574684014;9720.708378748648;9977.351472154287;10105.39367637944;10138.138258247836;48834.511654884416;58461.12308315294;59344.406555933885;59764.80470390481;60284.095738564836;86104;88868;90002;93580;93912;12969.740605188032;13526.120802147829;13669.248191349572;13740.793888091886;14103.012789104665;15910.522054634766;15944.601384965004;16068.758968615246;16295.59261018484;16802.411915582896;14008.439662413797;14090.36593353281;14294.070885392417;14820.428988953201;15193.316300766714;14474.638134046732;14478.420863165355;14559.708805824037;15500.92249538745;15514.9224253878;14030.508932187324;14043.50847720325;14262.358193881508;14355.425782968565;14739.631509211926;11139.665810025712;11215.214934954474;11253.71865703364;11942.582009629969;12120.759452071292;11603.245789023686;11871.465784039567;12034.939825300817;12085.093617978862;12122.515099395925 12:53:59 INFO - PROCESS | 1639 | __end_tp_report 12:53:59 INFO - PROCESS | 1639 | __start_cc_report 12:53:59 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,1328 12:53:59 INFO - PROCESS | 1639 | __end_cc_report 12:53:59 INFO - PROCESS | 1639 | __startTimestamp1484168039216__endTimestamp 12:53:59 INFO - PROCESS | 1639 | 12:53:59 INFO - PROCESS | 1639 | ------- Summary: start ------- 12:53:59 INFO - PROCESS | 1639 | Number of tests: 6 12:53:59 INFO - PROCESS | 1639 | 12:53:59 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5815.86 Median:6099.27 stddev:654.91 (10.7%) stddev-sans-first:627.06 12:53:59 INFO - PROCESS | 1639 | Values: 3323.8 3407.1 3465.9 3471.5 3512.8 5751.7 5838.4 5860.6 5893.4 5905.8 5794.1 5819.5 5835.9 5850.2 5850.9 5215.2 5228.0 5300.4 5314.6 5320.7 4396.5 5210.5 5241.2 5351.4 5358.1 5276.3 5283.6 5292.2 5309.3 5356.2 5294.5 5304.3 5339.7 5355.2 5376.6 5170.6 5210.0 5291.4 5313.5 5333.0 5701.0 5711.3 5719.1 5759.0 5822.2 6185.3 6234.2 6253.2 6269.7 6282.9 6219.3 6270.3 6282.2 6286.3 6287.8 5732.7 5823.3 5828.1 5914.6 5926.4 6346.6 6410.8 6415.5 6418.1 6429.9 6223.0 6225.7 6229.1 6236.6 6239.9 6126.9 6151.9 6167.4 6196.0 6208.2 6227.7 6255.9 6270.7 6298.1 6347.0 6253.1 6325.9 6326.5 6334.5 6348.7 4932.4 4992.1 5001.1 5024.5 5063.1 4434.1 4500.8 4510.2 4512.5 4566.5 5697.5 5974.9 5990.4 5998.1 6009.1 4944.8 6119.4 6281.0 6285.8 6315.5 5829.9 5898.5 5910.7 5925.8 5939.9 5529.2 5540.2 5544.9 5548.8 5580.9 6490.7 6518.5 6529.0 6535.7 6541.9 6065.5 6201.1 6227.5 6250.0 6310.6 6390.8 6471.6 6505.7 6517.2 6519.0 6268.9 6299.9 6304.0 6311.5 6325.4 6188.0 6207.1 6231.8 6317.1 6336.3 6138.2 6145.1 6219.5 6267.0 6274.3 6213.5 6222.8 6241.2 6250.9 6251.1 5913.7 6066.7 6112.7 6153.9 6161.4 4917.8 6082.5 6118.6 6126.2 6250.2 5214.5 6099.3 6116.5 6119.8 6124.8 12:53:59 INFO - PROCESS | 1639 | 12:53:59 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:74645.14 Median:19722.16 stddev:169801.29 (861.0%) stddev-sans-first:170186.24 12:53:59 INFO - PROCESS | 1639 | Values: 446.3 498.1 544.6 547.8 558.8 31860.0 43171.9 44649.0 44711.0 46857.0 45757.8 46238.0 46272.8 46285.0 46353.5 10022.9 10226.5 10235.9 10239.4 10239.7 9332.4 9565.1 12327.3 12576.5 12594.2 12398.9 12524.8 12526.6 12536.4 12541.6 12508.7 12610.7 12614.7 12620.7 12646.0 12121.7 12321.1 12388.4 12405.5 12405.9 42368.5 42671.8 42742.8 42771.6 42783.8 3381.2 3551.3 3702.5 3831.9 4117.2 30343.0 31023.1 31031.0 31437.7 33764.7 3393.5 3430.4 3482.2 3505.4 3553.9 499619.0 502417.0 502477.0 503922.0 504911.0 35139.0 35890.5 35905.8 66499.7 66986.3 37079.4 37163.3 37278.1 37344.8 37356.3 15933.8 16143.9 16153.9 16173.0 16188.8 12443.8 12640.0 13441.2 13556.1 13558.3 7042.5 8107.1 8113.4 8135.4 8173.9 3296.5 3326.6 3330.5 3333.6 3357.0 946.9 956.2 1044.0 1066.8 1107.7 25271.4 30215.8 31293.8 31357.7 31924.5 1043.2 1110.1 1202.2 1208.7 1221.5 14047.0 15633.6 16440.0 16447.5 16577.3 725374.0 733968.0 735219.0 735865.0 736301.0 62227.4 62739.0 62819.0 62821.7 62857.4 1224.7 1277.9 1307.5 1398.2 1436.2 31699.4 31789.0 32863.3 33025.7 33204.0 52565.2 53207.0 53238.2 53238.7 53256.2 585366.0 586590.0 588688.0 589593.0 820960.0 21603.1 24617.0 27461.7 28148.6 29167.4 49050.8 49426.3 49701.3 49933.0 50221.7 39675.4 40951.8 42057.6 42124.6 42403.0 40778.0 40892.8 40911.0 41994.4 42436.4 39935.0 42128.0 42517.1 42641.4 42658.1 33170.5 36876.0 37281.8 37424.1 37788.2 26993.6 27001.9 27004.9 27070.7 27233.0 12:53:59 INFO - PROCESS | 1639 | 12:53:59 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:35641.46 Median:2634.85 stddev:103603.97 (3932.1%) stddev-sans-first:103860.78 12:53:59 INFO - PROCESS | 1639 | Values: 383.8 385.9 387.2 395.9 412.9 14835.5 20614.4 21206.5 21818.8 21857.7 16848.7 19181.6 21307.6 21349.4 21453.9 5855.2 6200.8 6205.5 6208.8 6213.5 5856.4 6110.8 6128.4 6181.2 6199.3 6210.3 6217.6 6221.8 6227.3 6231.2 5477.3 5593.9 6181.7 6187.4 6197.4 5783.9 5940.6 5977.4 5985.3 5991.0 13296.9 13357.4 13582.9 13601.6 13604.6 2236.6 2314.9 2395.6 2614.7 2655.0 8363.4 9748.3 10020.2 10134.8 10264.3 1882.2 1910.0 1927.2 1952.8 1961.9 114069.0 119369.4 121689.4 121969.8 122708.0 11478.7 11632.7 11644.4 11688.7 11867.8 14763.7 14810.3 14814.8 14815.6 14837.4 6332.8 8271.1 8272.3 8353.3 8611.2 7621.2 7911.6 8230.8 8527.3 8955.8 4463.4 4504.4 4516.5 4525.0 4602.7 1646.0 1888.3 1936.0 1936.1 1952.5 612.7 721.2 819.9 936.6 972.2 18110.7 20761.3 21145.9 21691.1 22057.0 955.5 961.6 984.2 991.7 1042.4 11250.0 11579.8 11582.2 11708.4 11711.7 612637.0 614491.0 618968.0 623215.0 627914.0 119153.0 132129.0 138714.6 138987.9 139698.0 400.9 955.2 973.8 976.5 980.6 9993.0 10863.0 10956.9 11153.7 11727.6 56912.7 57125.4 57528.0 57707.7 57961.0 84405.0 84864.0 85298.1 85703.0 87846.0 6992.9 8112.0 8148.4 8223.5 8694.4 11383.9 11556.7 12529.3 13016.7 13117.0 11381.6 11454.0 11503.1 11537.9 11539.2 11002.6 11077.9 11183.8 11338.8 11773.1 11391.0 11451.3 11684.6 11828.9 11878.5 7785.5 8042.6 8068.7 8541.9 8542.4 8245.3 10305.5 11090.8 11542.5 11594.7 12:53:59 INFO - PROCESS | 1639 | 12:53:59 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:5917.06 Median:5136.68 stddev:3347.80 (65.2%) stddev-sans-first:3341.16 12:53:59 INFO - PROCESS | 1639 | Values: 1557.6 1586.3 1639.9 1818.3 1965.3 7942.2 9496.4 9503.9 9524.0 9534.0 8053.2 8356.3 8833.9 8851.2 8854.2 2411.8 2443.7 2444.0 2450.0 2450.1 2417.4 2420.6 2454.6 2456.8 2458.3 2157.4 2429.6 2445.6 2446.5 2447.7 2411.4 2414.3 2423.1 2427.1 2439.7 2415.9 2420.0 2423.3 2430.9 2433.9 9062.9 9253.1 9254.6 9270.2 9277.8 5521.6 5701.2 5701.4 5703.9 5708.0 3556.6 3632.2 3663.9 3715.9 3716.5 1130.8 1144.0 1145.0 1157.9 1838.8 12318.8 12644.3 12650.2 12667.6 12667.9 4641.3 4722.7 4764.6 4832.7 4900.1 9741.1 9747.7 9751.7 9759.7 9764.5 5563.2 5566.7 5567.1 5572.4 5580.2 4618.8 4750.9 4762.9 5143.8 5191.7 3907.9 3948.2 4013.4 4039.3 4050.7 1198.2 1211.3 1211.3 1221.9 1222.1 923.0 923.1 924.3 926.9 943.4 5310.9 5885.0 6145.4 6246.7 6385.2 920.8 923.4 936.7 982.8 1027.9 3595.8 3925.0 3939.8 3990.8 4017.9 11006.2 11387.7 11411.4 11419.6 11503.0 11439.9 11441.3 11442.0 11456.4 11476.0 8222.4 8645.2 8675.2 8815.0 8822.8 5268.7 6054.5 6183.9 6190.5 6215.6 9815.5 10267.3 10477.3 10527.1 10566.4 9526.9 10354.5 10580.9 10711.8 10716.8 7228.4 7390.6 7439.6 7444.0 7997.5 8200.3 8280.8 8286.3 8505.8 8688.6 6483.9 6729.8 7702.5 7858.7 7947.6 7671.7 7698.0 7767.1 7835.5 7899.9 7227.6 7396.3 7402.2 7410.3 7419.8 5079.1 5120.8 5129.6 5237.2 5371.0 5100.3 5209.5 5384.6 5418.6 5446.9 12:53:59 INFO - PROCESS | 1639 | 12:53:59 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4371.12 Median:4694.54 stddev:1346.71 (28.7%) stddev-sans-first:1315.50 12:53:59 INFO - PROCESS | 1639 | Values: 307.3 311.8 319.2 323.9 327.7 5351.6 5388.1 5398.7 5457.8 5470.2 4454.6 4634.4 5341.3 5419.5 5449.6 3819.3 4178.6 4184.8 4231.2 4238.7 3890.7 4197.7 4202.9 4208.0 4230.1 4095.9 4108.6 4111.6 4139.9 4153.2 4112.9 4116.0 4123.4 4125.9 4131.5 3592.6 3598.9 3600.5 3605.0 3609.7 4351.6 4540.0 5082.0 5368.4 5389.9 4006.8 4696.5 4711.7 4713.2 4747.4 4396.0 5265.4 5642.0 5695.9 5733.7 3136.7 3303.3 3860.7 3886.5 3948.4 4572.4 5656.3 5886.0 5993.8 6093.6 3148.4 3434.8 3502.0 3838.8 3858.8 3354.4 4016.2 4017.2 4020.4 4022.6 3914.6 4066.9 4668.4 4692.6 4697.7 5578.6 5771.2 5796.7 5823.4 5824.2 1179.4 1342.2 1346.4 1370.5 1376.7 793.7 827.7 838.6 848.8 852.3 3854.1 4022.0 4556.9 4588.7 4604.3 4075.5 4581.6 4748.5 4923.6 5015.6 3780.6 4033.7 4057.5 4592.6 4619.2 2167.6 2422.8 2486.1 2606.3 2612.6 4748.9 5030.5 5124.8 5140.9 5187.6 4342.5 4803.0 5003.4 5043.9 5072.9 4571.2 4599.4 4797.9 5140.3 5157.8 4606.0 4664.9 4909.7 4936.6 4943.2 4447.6 4609.0 4630.9 4871.4 4877.6 4755.6 5141.9 5169.4 5770.8 5913.7 3318.0 3553.8 3937.3 3956.6 3962.7 5847.5 5889.3 5904.8 5905.8 5907.9 5515.6 5654.8 5660.1 5699.2 5816.2 5001.2 5460.0 5545.4 5719.7 5740.8 4719.9 5289.6 5623.5 5639.7 5651.0 4793.4 5356.7 5665.5 5735.6 5747.0 5620.7 5622.5 5623.9 5637.1 5650.8 12:53:59 INFO - PROCESS | 1639 | 12:53:59 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:25426.81 Median:12895.97 stddev:40113.24 (311.1%) stddev-sans-first:40182.48 12:53:59 INFO - PROCESS | 1639 | Values: 608.3 724.7 746.7 761.5 790.5 15462.2 16685.3 16693.4 16696.3 16715.7 15002.7 15123.2 15135.8 15144.9 15150.1 725.0 745.5 747.7 752.8 892.3 742.6 748.6 887.9 908.4 912.6 894.2 928.9 947.6 948.0 950.1 942.3 944.5 944.8 945.9 947.3 700.0 701.6 701.8 702.5 705.3 15313.5 15388.7 15426.0 15460.2 15464.5 13674.5 14723.7 14988.0 15091.6 15116.8 13342.2 13428.3 13529.3 13738.6 13741.2 4668.7 4746.5 4791.5 4792.7 4924.5 123660.0 126031.4 130939.0 131558.3 132393.0 11089.7 11194.0 11323.1 11390.8 11590.9 21536.4 21718.8 22039.9 22069.4 22129.0 7742.7 8063.7 8106.2 8156.6 8221.8 4508.2 4513.0 4558.5 4593.8 4645.0 3662.9 3820.8 3823.8 3826.3 3830.9 675.8 705.5 729.5 748.3 752.8 633.3 674.9 676.3 692.0 697.9 9201.4 9470.1 9567.3 9653.7 9843.9 675.9 696.9 697.4 697.6 703.9 4167.7 4236.8 4401.5 4616.9 4648.5 109732.4 135406.0 139272.0 150597.5 154666.2 132445.0 133351.3 133757.0 138924.3 138993.0 93651.6 107608.5 107821.0 109695.5 119536.4 9720.6 9720.7 9977.4 10105.4 10138.1 48834.5 58461.1 59344.4 59764.8 60284.1 86104.0 88868.0 90002.0 93580.0 93912.0 12969.7 13526.1 13669.2 13740.8 14103.0 15910.5 15944.6 16068.8 16295.6 16802.4 14008.4 14090.4 14294.1 14820.4 15193.3 14474.6 14478.4 14559.7 15500.9 15514.9 14030.5 14043.5 14262.4 14355.4 14739.6 11139.7 11215.2 11253.7 11942.6 12120.8 11603.2 11871.5 12034.9 12085.1 12122.5 12:53:59 INFO - PROCESS | 1639 | -------- Summary: end -------- 12:53:59 INFO - PROCESS | 1639 | 12:53:59 INFO - TEST-INFO | 1639: exit 0 12:53:59 INFO - TEST-OK | dromaeo_css | took 1114916ms 12:53:59 INFO - TEST-START | kraken 12:53:59 INFO - operating with platform_type : mac_ 12:53:59 INFO - Initialising browser for kraken test... 12:53:59 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpuKYOiD/profile http://localhost:49240/getInfo.html) 12:54:01 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 12:54:01 INFO - PROCESS | 1649 | colorDepth:24 12:54:01 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 12:54:01 INFO - PROCESS | 1649 | __metrics 12:54:02 INFO - PROCESS | 1649 | 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:54:02 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:54:02 INFO - TEST-INFO | 1649: exit 0 12:54:02 INFO - Browser initialized. 12:54:02 INFO - Running cycle 1/1 for kraken test... 12:54:02 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpuKYOiD/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:54:14 INFO - PROCESS | 1651 | RSS: Main: 169058304 12:54:14 INFO - PROCESS | 1651 | 12:54:17 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 12:54:18 INFO - PROCESS | 1651 | RSS: Main: 218923008 12:54:18 INFO - PROCESS | 1651 | 12:54:20 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 12:54:21 INFO - PROCESS | 1651 | RSS: Main: 233558016 12:54:21 INFO - PROCESS | 1651 | 12:54:24 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 12:54:24 INFO - PROCESS | 1651 | RSS: Main: 330776576 12:54:24 INFO - PROCESS | 1651 | 12:54:26 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 12:54:27 INFO - PROCESS | 1651 | RSS: Main: 229855232 12:54:27 INFO - PROCESS | 1651 | 12:54:29 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:54:29 INFO - PROCESS | 1651 | RSS: Main: 230453248 12:54:29 INFO - PROCESS | 1651 | 12:54:32 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 12:54:33 INFO - PROCESS | 1651 | RSS: Main: 267956224 12:54:33 INFO - PROCESS | 1651 | 12:54:36 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 12:54:36 INFO - PROCESS | 1651 | RSS: Main: 268992512 12:54:36 INFO - PROCESS | 1651 | 12:54:39 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 12:54:39 INFO - PROCESS | 1651 | RSS: Main: 267104256 12:54:39 INFO - PROCESS | 1651 | 12:54:41 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:54:42 INFO - PROCESS | 1651 | RSS: Main: 240541696 12:54:42 INFO - PROCESS | 1651 | 12:54:43 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:54:44 INFO - PROCESS | 1651 | RSS: Main: 245129216 12:54:44 INFO - PROCESS | 1651 | 12:54:46 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:54:47 INFO - PROCESS | 1651 | RSS: Main: 254472192 12:54:47 INFO - PROCESS | 1651 | 12:54:50 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:54:50 INFO - PROCESS | 1651 | RSS: Main: 258723840 12:54:50 INFO - PROCESS | 1651 | 12:54:53 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:54:54 INFO - PROCESS | 1651 | RSS: Main: 259899392 12:54:54 INFO - PROCESS | 1651 | 12:54:56 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 12:54:56 INFO - PROCESS | 1651 | RSS: Main: 303833088 12:54:56 INFO - PROCESS | 1651 | 12:54:56 INFO - PROCESS | 1651 | __start_tp_report 12:54:56 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 12:54:56 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 12:54:56 INFO - PROCESS | 1651 | |i|pagename|runs| 12:54:56 INFO - PROCESS | 1651 | |0;ai-astar;111;113;113;113;110;113;112;112;110;112 12:54:56 INFO - PROCESS | 1651 | |1;audio-beat-detection;143;107;106;143;107;107;107;106;135;108 12:54:56 INFO - PROCESS | 1651 | |2;audio-dft;184;181;184;184;183;183;186;185;183;185 12:54:56 INFO - PROCESS | 1651 | |3;audio-fft;82;61;57;87;59;57;58;58;81;61 12:54:56 INFO - PROCESS | 1651 | |4;audio-oscillator;86;69;94;68;68;69;91;68;69;89 12:54:56 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;89;86;89;85;88;86;90;88;89;86 12:54:56 INFO - PROCESS | 1651 | |6;imaging-darkroom;93;95;95;94;94;95;94;93;94;94 12:54:56 INFO - PROCESS | 1651 | |7;imaging-desaturate;86;85;83;84;85;85;86;84;85;84 12:54:56 INFO - PROCESS | 1651 | |8;json-parse-financial;57;53;53;55;55;56;57;58;52;55 12:54:56 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;68;68;67;79;73;72;68;69;69;69 12:54:56 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;79;80;83;84;83;83;85;88;88;102 12:54:56 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;137;132;135;134;134;136;132;130;139;152 12:54:56 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;204;217;160;160;158;158;212;218;160;159 12:54:56 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;64;66;68;83;78;66;66;64;66;79 12:54:56 INFO - PROCESS | 1651 | __end_tp_report 12:54:56 INFO - PROCESS | 1651 | __start_cc_report 12:54:56 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1933 12:54:56 INFO - PROCESS | 1651 | __end_cc_report 12:54:56 INFO - PROCESS | 1651 | __startTimestamp1484168096400__endTimestamp 12:54:56 INFO - PROCESS | 1651 | 12:54:56 INFO - PROCESS | 1651 | ------- Summary: start ------- 12:54:56 INFO - PROCESS | 1651 | Number of tests: 14 12:54:56 INFO - PROCESS | 1651 | 12:54:56 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:111.90 Median:112.50 stddev:1.20 (1.1%) stddev-sans-first:1.22 12:54:56 INFO - PROCESS | 1651 | Values: 111.0 113.0 113.0 113.0 110.0 113.0 112.0 112.0 110.0 112.0 12:54:56 INFO - PROCESS | 1651 | 12:54:56 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:116.90 Median:107.50 stddev:16.33 (15.2%) stddev-sans-first:14.33 12:54:56 INFO - PROCESS | 1651 | Values: 143.0 107.0 106.0 143.0 107.0 107.0 107.0 106.0 135.0 108.0 12:54:56 INFO - PROCESS | 1651 | 12:54:56 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:183.80 Median:184.00 stddev:1.40 (0.8%) stddev-sans-first:1.48 12:54:56 INFO - PROCESS | 1651 | Values: 184.0 181.0 184.0 184.0 183.0 183.0 186.0 185.0 183.0 185.0 12:54:56 INFO - PROCESS | 1651 | 12:54:56 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:66.10 Median:61.00 stddev:12.07 (19.8%) stddev-sans-first:11.35 12:54:56 INFO - PROCESS | 1651 | Values: 82.0 61.0 57.0 87.0 59.0 57.0 58.0 58.0 81.0 61.0 12:54:56 INFO - PROCESS | 1651 | 12:54:56 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:77.50 stddev:11.28 (14.6%) stddev-sans-first:11.49 12:54:56 INFO - PROCESS | 1651 | Values: 86.0 69.0 94.0 68.0 68.0 69.0 91.0 68.0 69.0 89.0 12:54:56 INFO - PROCESS | 1651 | 12:54:56 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:88.50 stddev:1.71 (1.9%) stddev-sans-first:1.74 12:54:56 INFO - PROCESS | 1651 | Values: 89.0 86.0 89.0 85.0 88.0 86.0 90.0 88.0 89.0 86.0 12:54:56 INFO - PROCESS | 1651 | 12:54:56 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:94.10 Median:94.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 12:54:56 INFO - PROCESS | 1651 | Values: 93.0 95.0 95.0 94.0 94.0 95.0 94.0 93.0 94.0 94.0 12:54:56 INFO - PROCESS | 1651 | 12:54:56 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:0.95 (1.1%) stddev-sans-first:0.88 12:54:56 INFO - PROCESS | 1651 | Values: 86.0 85.0 83.0 84.0 85.0 85.0 86.0 84.0 85.0 84.0 12:54:56 INFO - PROCESS | 1651 | 12:54:56 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:55.10 Median:55.50 stddev:1.97 (3.5%) stddev-sans-first:1.96 12:54:56 INFO - PROCESS | 1651 | Values: 57.0 53.0 53.0 55.0 55.0 56.0 57.0 58.0 52.0 55.0 12:54:56 INFO - PROCESS | 1651 | 12:54:56 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:69.00 stddev:3.61 (5.2%) stddev-sans-first:3.75 12:54:56 INFO - PROCESS | 1651 | Values: 68.0 68.0 67.0 79.0 73.0 72.0 68.0 69.0 69.0 69.0 12:54:56 INFO - PROCESS | 1651 | 12:54:56 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:83.50 stddev:6.49 (7.8%) stddev-sans-first:6.44 12:54:56 INFO - PROCESS | 1651 | Values: 79.0 80.0 83.0 84.0 83.0 83.0 85.0 88.0 88.0 102.0 12:54:56 INFO - PROCESS | 1651 | 12:54:56 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:136.10 Median:135.50 stddev:6.17 (4.6%) stddev-sans-first:6.54 12:54:56 INFO - PROCESS | 1651 | Values: 137.0 132.0 135.0 134.0 134.0 136.0 132.0 130.0 139.0 152.0 12:54:56 INFO - PROCESS | 1651 | 12:54:56 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:180.60 Median:182.00 stddev:27.93 (15.3%) stddev-sans-first:28.31 12:54:56 INFO - PROCESS | 1651 | Values: 204.0 217.0 160.0 160.0 158.0 158.0 212.0 218.0 160.0 159.0 12:54:56 INFO - PROCESS | 1651 | 12:54:56 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:67.00 stddev:7.10 (10.6%) stddev-sans-first:7.19 12:54:56 INFO - PROCESS | 1651 | Values: 64.0 66.0 68.0 83.0 78.0 66.0 66.0 64.0 66.0 79.0 12:54:56 INFO - PROCESS | 1651 | -------- Summary: end -------- 12:54:56 INFO - PROCESS | 1651 | 12:54:57 INFO - TEST-INFO | 1651: exit 0 12:54:57 INFO - TEST-OK | kraken | took 57439ms 12:54:57 INFO - SUITE-END | took 1172s 12:54:57 INFO - Completed test suite (00:19:32) 12:54:57 INFO - javascript benchmark 12:54:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3323.800571965682, 3407.1311815487056, 3465.8786942457004, 3471.455202434914, 3512.7892326460415, 5751.65490070596, 5838.41615838416, 5860.560457965654, 5893.440123188301, 5905.822825315242, 5794.130880367937, 5819.476247137757, 5835.883282334351, 5850.180974663551, 5850.88298234035, 5215.217717342391, 5227.9738601307035, 5300.363956325246, 5314.574834013289, 5320.654157479771, 4396.516383197845, 5210.452902445246, 5241.2400201970695, 5351.384590772072, 5358.062339090663, 5276.34045744282, 5283.63014588979, 5292.2061690746505, 5309.33633295838, 5356.223347614594, 5294.49702278281, 5304.336957880265, 5339.733013349317, 5355.223492593591, 5376.569874410038, 5170.6122040847085, 5210.036143313499, 5291.391489978625, 5313.548348390392, 5333.0, 5700.971495142498, 5711.314642242957, 5719.084946408596, 5758.992176369161, 5822.243108395924, 6185.319614842409, 6234.220722409699, 6253.155823963798, 6269.720813196494, 6282.937170628281, 6219.315875253718, 6270.341614130496, 6282.183316168915, 6286.308506064329, 6287.779927702509, 5732.684702341411, 5823.272090988627, 5828.12578113278, 5914.585978981516, 5926.407359264039, 6346.57781590739, 6410.775622853271, 6415.518836087312, 6418.133551970518, 6429.903551446732, 6223.0354295084335, 6225.688715564203, 6229.127922090911, 6236.594621349688, 6239.937600624026, 6126.884121540732, 6151.907721384183, 6167.352427995085, 6196.00863861789, 6208.192934918522, 6227.688615569204, 6255.906161407583, 6270.6864656766975, 6298.055291706189, 6347.0, 6253.093301471352, 6325.873482530324, 6326.4622507087415, 6334.5249106317215, 6348.650824204713, 4932.383452068491, 4992.101421744121, 5001.099802035668, 5024.522670346311, 5063.063333283354, 4434.13534360803, 4500.797464114123, 4510.188166130062, 4512.503624601291, 4566.474855391606, 5697.4587414195585, 5974.9402505974385, 5990.430909063632, 5998.100284957204, 6009.06859436788, 4944.802207911715, 6119.41115851624, 6280.9685951569945, 6285.842853928597, 6315.526335524854, 5829.94170058294, 5898.469137777621, 5910.734016969247, 5925.792597259076, 5939.940600594025, 5529.170624406372, 5540.196671482612, 5544.944550554443, 5548.750306236148, 5580.860478487989, 6490.675466226669, 6518.543701940914, 6528.967355163289, 6535.705893234721, 6541.901871471931, 6065.484433823174, 6201.069839523927, 6227.532935029801, 6250.0, 6310.5898116622275, 6390.840228994312, 6471.579347342407, 6505.739770409131, 6517.217933847968, 6518.9895566187315, 6268.937310627018, 6299.905501417574, 6303.968480157753, 6311.495080393465, 6325.430711236011, 6187.969060154671, 6207.099970504342, 6231.844203894939, 6317.147185130132, 6336.271328797063, 6138.204480310071, 6145.13968044483, 6219.533534984985, 6266.968665156645, 6274.278457977391, 6213.5339849510565, 6222.782202622887, 6241.21984751906, 6250.906236406367, 6251.062340648939, 5913.70431478433, 6066.7269972850445, 6112.694365281629, 6153.938460615515, 6161.4146656067605, 4917.803287868445, 6082.513398928164, 6118.558266176107, 6126.24286675468, 6250.249970003629, 5214.504622060898, 6099.268087829311, 6116.541259405473, 6119.8470038247615, 6124.846878828065], "value": 5774.921743863717, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [446.2792589967203, 498.1481666350543, 544.6160456877901, 547.780887644942, 558.7820749907536, 31860.044198674048, 43171.92070198247, 44649.0, 44710.999999999956, 46857.0, 45757.771211143896, 46238.0, 46272.76863615677, 46285.0, 46353.53646463534, 10022.949885250564, 10226.488675566228, 10235.948820255926, 10239.385636861774, 10239.744006399826, 9332.393394429375, 9565.139137477625, 12327.26036437812, 12576.496940122384, 12594.181378210433, 12398.876011239863, 12524.812127818044, 12526.624201273977, 12536.373181340941, 12541.623751287476, 12508.687282817957, 12610.684732881706, 12614.68463288416, 12620.747585048339, 12646.0, 12121.696957576043, 12321.075919306088, 12388.442520086617, 12405.503779848796, 12405.875941240653, 42368.51710190159, 42671.78664106691, 42742.78628606868, 42771.57228427707, 42783.78608106971, 3381.1885147564653, 3551.2897420516, 3702.5186725725753, 3831.8658846940225, 4117.238310912461, 30343.0, 31023.052809983015, 31031.0, 31437.685623143934, 33764.6623533764, 3393.474011528217, 3430.3996800560053, 3482.2165012872156, 3505.4391297392294, 3553.8578456861696, 499619.0, 502417.0, 502477.0, 503922.0, 504910.99999999633, 35139.0, 35890.461643075374, 35905.82047089748, 66499.66750166315, 66986.33013669899, 37079.4438083429, 37163.25673486569, 37278.06804829847, 37344.81327593345, 37356.25287494235, 15933.840661593467, 16143.919280403523, 16153.919230403773, 16173.0, 16188.838111618734, 12443.751124977449, 12640.0, 13441.193528388329, 13556.11885227457, 13558.254296013616, 7042.471814613822, 8107.067687216046, 8113.350931925432, 8135.430519863671, 8173.918260817316, 3296.4725643896863, 3326.5841769778776, 3330.4837750148768, 3333.6499667535045, 3357.026462325898, 946.9242460603135, 956.2015716876347, 1043.9895601044045, 1066.7813098314828, 1107.7064577886867, 25271.36821579475, 30215.848920755696, 31293.8435307822, 31357.686423135932, 31924.521132183036, 1043.2436483549366, 1110.1119104716356, 1202.2125507792234, 1208.6555331730415, 1221.450347343699, 14047.0, 15633.592976632157, 16440.0, 16447.506574802774, 16577.336906523844, 725374.0, 733968.0, 735219.0, 735865.0, 736301.0, 62227.377726223065, 62739.0, 62819.0, 62821.74356512844, 62857.37142628515, 1224.6693392784077, 1277.9424925878359, 1307.5358247822076, 1398.223985687953, 1436.2244388030347, 31699.366012679155, 31789.04632861018, 32863.342733145684, 33025.66254108081, 33204.0, 52565.211521827965, 53207.0, 53238.20142697785, 53238.73380633072, 53256.2011569819, 585366.0, 586590.0, 588688.0, 589593.0, 820960.0, 21603.135874564843, 24617.0, 27461.725382746718, 28148.577771333035, 29167.416651667274, 49050.75474622604, 49426.25860612022, 49701.25448118353, 49933.0, 50221.74889125677, 39675.404868927566, 40951.7952410236, 42057.61194178197, 42124.57875421329, 42403.0, 40778.0, 40892.79553602213, 40910.9772255696, 41994.37008444937, 42436.36345454759, 39935.0, 42128.0, 42517.14965700607, 42641.36037959495, 42658.14683706371, 33170.50244246387, 36876.0, 37281.81359093187, 37424.064398390256, 37788.24423511569, 26993.59509607397, 27001.86499067492, 27004.86497567578, 27070.72929270682, 27233.0], "value": 20002.94094296218, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.8349509710823, 385.87709764585065, 387.1965671232193, 395.8812356293112, 412.9401236820661, 14835.480758173466, 20614.381568552948, 21206.469838254052, 21818.781812181875, 21857.67213491799, 16848.663026739458, 19181.616367672672, 21307.57384852302, 21349.35951921441, 21453.892730536325, 5855.209546711203, 6200.751969921198, 6205.472534834545, 6208.751649933997, 6213.502919766408, 5856.443637854397, 6110.847228819271, 6128.38716128388, 6181.227346581677, 6199.318075011745, 6210.31686514483, 6217.56477046607, 6221.844453888666, 6227.314995350508, 6231.189945307104, 5477.315335583052, 5593.881223755266, 6181.690915454209, 6187.443130118266, 6197.380261973789, 5783.942160578425, 5940.613830148398, 5977.432143946318, 5985.25184351956, 5990.97004514979, 13296.867031329757, 13357.398917048757, 13582.913366930721, 13601.59195224135, 13604.59186224405, 2236.642137258047, 2314.90740370385, 2395.568797616428, 2614.673165854268, 2655.0176434719083, 8363.372747043995, 9748.31761776676, 10020.198384129251, 10134.797304053951, 10264.281500294983, 1882.2471011595335, 1909.961800763977, 1927.171316333976, 1952.7754308254591, 1961.9313324033733, 114069.0, 119369.40315298455, 121689.39155304167, 121969.78030219673, 122708.0, 11478.704259148204, 11632.695902516123, 11644.3595602241, 11688.70778230551, 11867.76264474723, 14763.704725905422, 14810.259487025605, 14814.777778333333, 14815.629609259855, 14837.406503739945, 6332.841678958063, 8271.13153118926, 8272.33821294295, 8353.33173346131, 8611.181937715906, 7621.161672216052, 7911.564863932424, 8230.8353832923, 8527.275181609633, 8955.820883582292, 4463.352813841975, 4504.369388285642, 4516.548345165457, 4525.004499010212, 4602.746848923274, 1645.9506214813575, 1888.2824526679774, 1935.9612807743765, 1936.0803618281486, 1952.5021119614407, 612.6640101555217, 721.1706537481833, 819.8729196974479, 936.578539657157, 972.2465089555651, 18110.728339074925, 20761.27335543279, 21145.942702864795, 21691.132354705634, 22057.0, 955.5174636808367, 961.5528779117744, 984.1978787288338, 991.7173605522391, 1042.4475028235047, 11249.987501124775, 11579.829515870608, 11582.247153934968, 11708.356040417688, 11711.707207319714, 612637.0, 614491.0, 618968.0, 623215.0, 627914.0, 119153.0, 132129.0, 138714.61285387218, 138987.91518127237, 139698.0, 400.8595545672615, 955.1928620315822, 973.8149751547184, 976.4824642939253, 980.5734505490135, 9993.0, 10863.0, 10956.945215273872, 11153.665390038312, 11727.589534366256, 56912.71543642421, 57125.42874571201, 57528.0, 57707.7114614441, 57961.0, 84405.0, 84864.0, 85298.14701852902, 85703.0, 87846.0, 6992.860142797013, 8112.0, 8148.3888708348295, 8223.506589604644, 8694.434861733967, 11383.943080284545, 11556.728759836244, 12529.310887900889, 13016.674583135118, 13116.950643948652, 11381.601643942422, 11454.026407755435, 11503.079753619522, 11537.88462115368, 11539.21122734056, 11002.614908478165, 11077.889221108007, 11183.832242516206, 11338.829917551078, 11773.058155347722, 11391.0, 11451.25566838153, 11684.591039313584, 11828.940855295668, 11878.46546905374, 7785.493942893694, 8042.597870106354, 8068.7175948841505, 8541.871871921801, 8542.40203185771, 8245.340372770284, 10305.53625086888, 11090.778184436427, 11542.538298467967, 11594.6521604352], "value": 9346.843630916703, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1557.5794535475422, 1586.3495966653672, 1639.8524132828059, 1818.2545156485835, 1965.3219639224462, 7942.245486678764, 9496.38273512223, 9503.904960950389, 9523.952380238106, 9533.998930112342, 8053.234942680436, 8356.289715374185, 8833.867491987625, 8851.159139881702, 8854.203121719043, 2411.7949974252165, 2443.743406942272, 2443.987780061097, 2450.0444826517673, 2450.1179575352858, 2417.4319035026842, 2420.588499955003, 2454.644076608891, 2456.803455723538, 2458.2502336787275, 2157.374361435182, 2429.5626787178303, 2445.6331550267514, 2446.4617784087563, 2447.657327974085, 2411.409204744831, 2414.263649586875, 2423.0671191591186, 2427.07771047001, 2439.695038120235, 2415.915442959488, 2419.9516009679883, 2423.260905423845, 2430.86630235337, 2433.914812981555, 9062.909370906273, 9253.120953509473, 9254.6298148074, 9270.21203197729, 9277.768055798591, 5521.613487055908, 5701.230333904911, 5701.372848986608, 5703.942960570383, 5708.001099807559, 3556.5732112146447, 3632.1827588792576, 3663.9450408243897, 3715.869944551928, 3716.535433070866, 1130.8021096308196, 1143.9885601143965, 1145.0381679389352, 1157.9421028948602, 1838.8161183881639, 12318.753624927542, 12644.304563249018, 12650.240985540897, 12667.556635517712, 12667.93666031664, 4641.301414748856, 4722.716637001791, 4764.595009424169, 4832.661713680079, 4900.093482705711, 9741.123298903132, 9747.707568772948, 9751.658691945748, 9759.707208783748, 9764.462954537426, 5563.248961390242, 5566.721663916788, 5567.053600887859, 5572.359178694421, 5580.246666700024, 4618.769061546909, 4750.904981900343, 4762.857114286577, 5143.794248230029, 5191.6884986900905, 3907.905786379818, 3948.249832531867, 4013.3779264214095, 4039.3335099708806, 4050.736702114412, 1198.1668047886747, 1211.273236058358, 1211.2853416484318, 1221.8961388281919, 1222.144498850808, 922.9953850230706, 923.1138107416955, 924.2698268368049, 926.8563372677246, 943.3773709351794, 5310.92033619496, 5884.9705751470965, 6145.354737752561, 6246.656433896179, 6385.169927909342, 920.7753687595482, 923.4274749655123, 936.6534382278464, 982.7739619887323, 1027.8869324374314, 3595.82020898954, 3924.9803750981064, 3939.763614183158, 3990.780507072139, 4017.8995525112105, 11006.229563930608, 11387.715307117223, 11411.429428528707, 11419.60031398897, 11502.964733174054, 11439.88560114405, 11441.256318339281, 11442.0, 11456.427178641201, 11476.0, 8222.424430289822, 8645.178708022602, 8675.175858293453, 8814.955925220333, 8822.779430514289, 5268.6575372600655, 6054.545909056927, 6183.938160618336, 6190.535709821691, 6215.564910456405, 9815.46014969155, 10267.281290309607, 10477.266591338534, 10527.052565269163, 10566.366018038942, 9526.904405993122, 10354.5340459678, 10580.89419105799, 10711.839322410015, 10716.785664286826, 7228.385587225145, 7390.630468476662, 7439.590822504814, 7444.032275804111, 7997.520148791091, 8200.26197642215, 8280.792980175303, 8286.337093032422, 8505.82988340242, 8688.565571721516, 6483.902741458976, 6729.7644582441335, 7702.4608277422285, 7858.724944627139, 7947.642356093874, 7671.654775535003, 7698.03774528184, 7767.145613982344, 7835.529868207926, 7899.921000789918, 7227.638618068971, 7396.260373962776, 7402.1857595665515, 7410.258974102547, 7419.814504637211, 5079.085764562415, 5120.820771272987, 5129.563987061141, 5237.240600113038, 5370.973145134406, 5100.311457953128, 5209.453007434165, 5384.569234461155, 5418.566514678895, 5446.891062178814], "value": 4752.837913615561, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [307.33155387033213, 311.79421581756037, 319.2274695237526, 323.9433099207638, 327.7083395777757, 5351.598630102739, 5388.147474555692, 5398.732532336418, 5457.808976685817, 5470.167493889542, 4454.554544545544, 4634.374359461472, 5341.30563026806, 5419.458054194579, 5449.555867695064, 3819.2622356827715, 4178.603032711888, 4184.811683474236, 4231.217224813419, 4238.703290769639, 3890.708196885231, 4197.748135111888, 4202.852900148496, 4207.978960105195, 4230.132822771325, 4095.89760255993, 4108.5686002969705, 4111.60939710727, 4139.917201655965, 4153.190127925056, 4112.897177570555, 4116.0, 4123.36087906375, 4125.8968525786795, 4131.483564554431, 3592.604813470516, 3598.946015809765, 3600.459931010343, 3604.981975090108, 3609.657082577151, 4351.630111440531, 4539.957019341309, 5081.974590127063, 5368.3826359968325, 5389.865253368658, 4006.779627120507, 4696.463909488872, 4711.693739906895, 4713.2458806590785, 4747.406574178228, 4395.978020109911, 5265.447128051538, 5642.0, 5695.857603559903, 5733.713314334266, 3136.7176954074016, 3303.339332133559, 3860.7297489175767, 3886.514185726784, 3948.447217389568, 4572.4055872736335, 5656.2929633795775, 5885.970570147122, 5993.760249590011, 6093.573449858467, 3148.449021421242, 3434.759566830298, 3501.964980350164, 3838.8272527736317, 3858.803770831051, 3354.446516324779, 4016.2369149861433, 4017.2367250222364, 4020.3567429211184, 4022.5977402260123, 3914.6085391461197, 4066.877993660195, 4668.439787225487, 4692.6245900327895, 4697.718136911796, 5578.63738856973, 5771.249737534177, 5796.710164491758, 5823.359430462646, 5824.213731146241, 1179.4102948525738, 1342.234926092118, 1346.373936119709, 1370.5477192526441, 1376.7108907129414, 793.7499687598388, 827.7103013945072, 838.5723281126669, 848.7878030492377, 852.3394369363792, 3854.0537028800836, 4022.02920568925, 4556.863294101182, 4588.701734387254, 4604.286335617984, 4075.5109386873764, 4581.594662802056, 4748.477667456577, 4923.621386011922, 5015.623828212826, 3780.640839120279, 4033.6974726895014, 4057.4522439470293, 4592.609628181642, 4619.2378257587125, 2167.5556510915226, 2422.8304018718522, 2486.0677246032737, 2606.2572166932714, 2612.6342312076326, 4748.857534273978, 5030.541143068543, 5124.795008199705, 5140.897182056338, 5187.584993200535, 4342.522322544518, 4803.0, 5003.449620541737, 5043.87390315245, 5072.949270507322, 4571.1543364477675, 4599.448066232074, 4797.856064318076, 5140.331756871583, 5157.767900444489, 4605.953940460552, 4664.906701866012, 4909.729964851825, 4936.593750312273, 4943.209086546135, 4447.577480139382, 4608.9629833287245, 4630.901652037904, 4871.442492691365, 4877.585405240594, 4755.619550436026, 5141.8687888664435, 5169.353830771153, 5770.807093304686, 5913.674747888907, 3317.9548442240616, 3553.7867727935372, 3937.3306537888056, 3956.624120708528, 3962.7027972902724, 5847.502962248256, 5889.293284805851, 5904.763809447746, 5905.763769449174, 5907.85230369227, 5515.586331025109, 5654.794630094349, 5660.097352487185, 5699.150424787606, 5816.21481100063, 5001.24981252815, 5459.962607104638, 5545.417731138334, 5719.656820590778, 5740.827775166752, 4719.905601888012, 5289.57683385336, 5623.465770751772, 5639.746211420414, 5650.971745141248, 4793.352897358812, 5356.651817631841, 5665.49010589049, 5735.598508104559, 5746.9712651436475, 5620.739970816998, 5622.493975542221, 5623.8875222496135, 5637.069883469182, 5650.773969041193], "value": 3949.614687157876, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [608.2943785209156, 724.7427163357008, 746.6901235987066, 761.4517547365898, 790.4624855098531, 15462.226888655565, 16685.33258669655, 16693.415730449437, 16696.332146714118, 16715.749263761038, 15002.699946001101, 15123.243837808093, 15135.848641513581, 15144.924275378607, 15150.090994540307, 724.971001159953, 745.4893398022344, 747.7495039161887, 752.8456666383406, 892.2906289499847, 742.5581778841607, 748.5546100070477, 887.9023307436177, 908.3823000359753, 912.6212621761961, 894.1952242981304, 928.8606708993638, 947.6209516193543, 948.0188005414398, 950.1021534649759, 942.2556180617304, 944.489975413276, 944.7779771753633, 945.8581212818063, 947.2564037230775, 699.9955064482484, 701.5615240474704, 701.8034950213897, 702.5363260248212, 705.3158436316764, 15313.540593782092, 15388.692226155526, 15426.0, 15460.226988650522, 15464.5360639181, 13674.521391751241, 14723.705525889422, 14988.025778324374, 15091.622709432351, 15116.848831511654, 13342.19946803195, 13428.261445620486, 13529.32353382327, 13738.587842364745, 13741.175529468264, 4668.743219122947, 4746.501617330199, 4791.47293797682, 4792.736399498026, 4924.4583095859425, 123660.03745652389, 126031.3698431502, 130939.0, 131558.3422082893, 132392.99999999904, 11089.72275693098, 11194.0, 11323.094152467947, 11390.829137562943, 11590.88409115898, 21536.353909382742, 21718.78281217199, 22039.889800550896, 22069.448263793212, 22129.0, 7742.690292388242, 8063.717769878026, 8106.2299081588335, 8156.5513896735065, 8221.835563288701, 4508.1659892919915, 4513.007138429541, 4558.544145585482, 4593.793279302439, 4644.9767751161025, 3662.9450558241647, 3820.7707537547835, 3823.8279277432584, 3826.330392181357, 3830.904227394282, 675.787127054976, 705.5096707788038, 729.5185177782638, 748.3451979517922, 752.7892190186647, 633.3002032753833, 674.9122614060141, 676.2586340174072, 691.9792406227821, 697.8848489999194, 9201.401908875901, 9470.100340467645, 9567.330286879851, 9653.71038868835, 9843.901560984441, 675.8817206988757, 696.8884978403431, 697.424624684627, 697.5814511293183, 703.8521910398771, 4167.666586673059, 4236.788160591958, 4401.471823381215, 4616.884577885513, 4648.48866624671, 109732.35401468984, 135406.0, 139272.0, 150597.49402506053, 154666.22666886594, 132445.0, 133351.33324333315, 133756.9936450954, 138924.30537847246, 138993.0, 93651.59522607303, 107608.46195768971, 107821.0, 109695.45152274187, 119536.40231798786, 9720.562574684014, 9720.708378748648, 9977.351472154287, 10105.39367637944, 10138.138258247836, 48834.511654884416, 58461.12308315294, 59344.406555933885, 59764.80470390481, 60284.095738564836, 86104.0, 88868.0, 90002.0, 93580.0, 93912.0, 12969.740605188032, 13526.120802147829, 13669.248191349572, 13740.793888091886, 14103.012789104665, 15910.522054634766, 15944.601384965004, 16068.758968615246, 16295.59261018484, 16802.411915582896, 14008.439662413797, 14090.36593353281, 14294.070885392417, 14820.428988953201, 15193.316300766714, 14474.638134046732, 14478.420863165355, 14559.708805824037, 15500.92249538745, 15514.9224253878, 14030.508932187324, 14043.50847720325, 14262.358193881508, 14355.425782968565, 14739.631509211926, 11139.665810025712, 11215.214934954474, 11253.71865703364, 11942.582009629969, 12120.759452071292, 11603.245789023686, 11871.465784039567, 12034.939825300817, 12085.093617978862, 12122.515099395925], "value": 8161.322580954113, "unit": "score"}], "name": "dromaeo_css", "value": 7409.175894932595, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 113.0, 113.0, 113.0, 110.0, 113.0, 112.0, 112.0, 110.0, 112.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 107.0, 106.0, 143.0, 107.0, 107.0, 107.0, 106.0, 135.0, 108.0], "value": 116.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 181.0, 184.0, 184.0, 183.0, 183.0, 186.0, 185.0, 183.0, 185.0], "value": 183.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 61.0, 57.0, 87.0, 59.0, 57.0, 58.0, 58.0, 81.0, 61.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 94.0, 68.0, 68.0, 69.0, 91.0, 68.0, 69.0, 89.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 85.0, 88.0, 86.0, 90.0, 88.0, 89.0, 86.0], "value": 87.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 95.0, 94.0, 94.0, 95.0, 94.0, 93.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 83.0, 84.0, 85.0, 85.0, 86.0, 84.0, 85.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 53.0, 53.0, 55.0, 55.0, 56.0, 57.0, 58.0, 52.0, 55.0], "value": 55.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 67.0, 79.0, 73.0, 72.0, 68.0, 69.0, 69.0, 69.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 83.0, 84.0, 83.0, 83.0, 85.0, 88.0, 88.0, 102.0], "value": 85.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 132.0, 135.0, 134.0, 134.0, 136.0, 132.0, 130.0, 139.0, 152.0], "value": 136.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [204.0, 217.0, 160.0, 160.0, 158.0, 158.0, 212.0, 218.0, 160.0, 159.0], "value": 180.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 68.0, 83.0, 78.0, 66.0, 66.0, 64.0, 66.0, 79.0], "value": 70.0, "unit": "score"}], "name": "kraken", "value": 1419.7, "alertThreshold": 2.0}]} 12:54:57 INFO - Return code: 0 12:54:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:54:57 INFO - # TBPL SUCCESS # 12:54:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:54:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:54:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:54:57 INFO - 2017-01-11 12:54:57.711 screenresolution[1655:10270] starting screenresolution argv=screenresolution get 12:54:57 INFO - 2017-01-11 12:54:57.714 screenresolution[1655:10270] Display 0: 1600x1200x32@60 12:54:57 INFO - 2017-01-11 12:54:57.720 screenresolution[1656:10273] starting screenresolution argv=screenresolution list 12:54:57 INFO - Available Modes on Display 0 12:54:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:54:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:54:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:54:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:54:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:54:57 INFO - Intel Iris: 12:54:57 INFO - Chipset Model: Intel Iris 12:54:57 INFO - Type: GPU 12:54:57 INFO - Bus: Built-In 12:54:57 INFO - VRAM (Dynamic, Max): 1536 MB 12:54:57 INFO - Vendor: Intel (0x8086) 12:54:57 INFO - Device ID: 0x0a2e 12:54:57 INFO - Revision ID: 0x0009 12:54:57 INFO - Displays: 12:54:57 INFO - Display: 12:54:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:54:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:54:57 INFO - Display Serial Number: 1600x1200 60 12:54:57 INFO - Main Display: Yes 12:54:57 INFO - Mirror: Off 12:54:57 INFO - Online: Yes 12:54:57 INFO - Rotation: Supported 12:54:57 INFO - Return code: 0 12:54:57 INFO - Running post-action listener: _resource_record_post_action 12:54:57 INFO - [mozharness: 2017-01-11 20:54:57.957119Z] Finished run-tests step (success) 12:54:57 INFO - Running post-run listener: _resource_record_post_run 12:54:58 INFO - Total resource usage - Wall time: 1195s; CPU: 54.0%; Read bytes: 45118976; Write bytes: 494965248; Read time: 432; Write time: 1882 12:54:58 INFO - TinderboxPrint: CPU usage
53.5% 12:54:58 INFO - TinderboxPrint: I/O read bytes / time
45,118,976 / 432 12:54:58 INFO - TinderboxPrint: I/O write bytes / time
494,965,248 / 1,882 12:54:58 INFO - TinderboxPrint: CPU idle
2,221.4 (46.5%) 12:54:58 INFO - TinderboxPrint: CPU system
954.7 (20.0%) 12:54:58 INFO - TinderboxPrint: CPU user
1,605.6 (33.6%) 12:54:58 INFO - TinderboxPrint: Swap in / out
248,643,584 / 0 12:54:58 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 188502528; Write bytes: 186146816; Read time: 17660; Write time: 330 12:54:58 INFO - run-tests - Wall time: 1174s; CPU: 54.0%; Read bytes: 43361792; Write bytes: 297857536; Read time: 411; Write time: 1513 12:54:58 INFO - Running post-run listener: _upload_blobber_files 12:54:58 INFO - Blob upload gear active. 12:54:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:54:58 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 12:54:58 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'] 12:54:58 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 12:54:58 INFO - (blobuploader) - INFO - Open directory for files ... 12:54:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:54:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:54:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:55:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:55:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:55:00 INFO - (blobuploader) - INFO - Done attempting. 12:55:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:55:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:55:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:55:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:55:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:55:01 INFO - (blobuploader) - INFO - Done attempting. 12:55:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:55:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:55:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:55:04 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:55:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:55:04 INFO - (blobuploader) - INFO - Done attempting. 12:55:04 INFO - (blobuploader) - INFO - Iteration through files over. 12:55:04 INFO - Return code: 0 12:55:04 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:55:04 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:55:04 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fc4576a999844fb5e1e54c1faefb989046724a3005868d0cd8cc7658d32eff9b88e34a287cadb570f6a19ef23774f204fbca9aca6b0c20305ca850895e02ec8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/432549b41758361acc6c6048c982c5dfa9972ecdd7271f7503b12cd5a0d6233a09dbde3b0167e5c38aed70a177d55ac67b77bd9193792221e93565b0355dc2e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f54f0effd4c47148db1ab6fb6a5a1fbd5d9ee91116cecbd68e976db0ef6ffb6b747eb74bf9bacc108f29ffc615bfed0430c32f9218b32e14c2c6178c59e1aed"} 12:55:04 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:55:04 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:55:04 INFO - Contents: 12:55:04 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/fc4576a999844fb5e1e54c1faefb989046724a3005868d0cd8cc7658d32eff9b88e34a287cadb570f6a19ef23774f204fbca9aca6b0c20305ca850895e02ec8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/432549b41758361acc6c6048c982c5dfa9972ecdd7271f7503b12cd5a0d6233a09dbde3b0167e5c38aed70a177d55ac67b77bd9193792221e93565b0355dc2e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f54f0effd4c47148db1ab6fb6a5a1fbd5d9ee91116cecbd68e976db0ef6ffb6b747eb74bf9bacc108f29ffc615bfed0430c32f9218b32e14c2c6178c59e1aed"} 12:55:04 INFO - Running post-run listener: copy_logs_to_upload_dir 12:55:04 INFO - Copying logs to upload dir... 12:55:04 INFO - mkdir: /builds/slave/test/build/upload/logs 12:55:04 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1258.073023 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2017-01-11 12:55:04.651343) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-11 12:55:04.655174) ========= 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.jWPTQq5aFJ/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.TU5bNoLigy/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/fc4576a999844fb5e1e54c1faefb989046724a3005868d0cd8cc7658d32eff9b88e34a287cadb570f6a19ef23774f204fbca9aca6b0c20305ca850895e02ec8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/432549b41758361acc6c6048c982c5dfa9972ecdd7271f7503b12cd5a0d6233a09dbde3b0167e5c38aed70a177d55ac67b77bd9193792221e93565b0355dc2e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f54f0effd4c47148db1ab6fb6a5a1fbd5d9ee91116cecbd68e976db0ef6ffb6b747eb74bf9bacc108f29ffc615bfed0430c32f9218b32e14c2c6178c59e1aed"} build_url:https://queue.taskcluster.net/v1/task/V59AsRtZQ16D-TpRgTLa2g/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011442 build_url: 'https://queue.taskcluster.net/v1/task/V59AsRtZQ16D-TpRgTLa2g/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/fc4576a999844fb5e1e54c1faefb989046724a3005868d0cd8cc7658d32eff9b88e34a287cadb570f6a19ef23774f204fbca9aca6b0c20305ca850895e02ec8c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/432549b41758361acc6c6048c982c5dfa9972ecdd7271f7503b12cd5a0d6233a09dbde3b0167e5c38aed70a177d55ac67b77bd9193792221e93565b0355dc2e1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f54f0effd4c47148db1ab6fb6a5a1fbd5d9ee91116cecbd68e976db0ef6ffb6b747eb74bf9bacc108f29ffc615bfed0430c32f9218b32e14c2c6178c59e1aed"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-11 12:55:04.689514) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 12:55:04.689846) ========= 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.jWPTQq5aFJ/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.TU5bNoLigy/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.005310 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-11 12:55:04.738486) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-11 12:55:04.738789) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-11 12:55:04.739093) ========= ========= Total master_lag: 0.17 =========