builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0286 starttime: 1480395735.09 results: success (0) buildid: 20161128183744 builduid: 4aa742c26e9548cf8c498e706379dff9 revision: 9b84116a5a6849a2cecd975509963b6afd9f11fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-28 21:02:15.090090) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-28 21:02:15.090819) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-28 21:02:15.091261) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-28 21:02:15.118964) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 21:02:15.119477) ========= 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.T4pwo0g117/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.XVXR9ZHBQv/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-28 21:02:15-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 157M=0s 2016-11-28 21:02:15 (157 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.151691 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 21:02:15.295290) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 21:02:15.295604) ========= 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.T4pwo0g117/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.XVXR9ZHBQv/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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.020622 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 21:02:15.344547) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-28 21:02:15.344912) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9b84116a5a6849a2cecd975509963b6afd9f11fa --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 9b84116a5a6849a2cecd975509963b6afd9f11fa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.T4pwo0g117/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.XVXR9ZHBQv/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-28 21:02:15,427 truncating revision to first 12 chars 2016-11-28 21:02:15,427 Setting DEBUG logging. 2016-11-28 21:02:15,427 attempt 1/10 2016-11-28 21:02:15,427 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9b84116a5a68?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-28 21:02:17,638 unpacking tar archive at: mozilla-beta-9b84116a5a68/testing/mozharness/ program finished with exit code 0 elapsedTime=2.480253 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-28 21:02:17.848790) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-28 21:02:17.849107) ========= script_repo_revision: 9b84116a5a6849a2cecd975509963b6afd9f11fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-28 21:02:17.849501) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-28 21:02:17.849778) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-28 21:02:17.869609) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-11-28 21:02:17.869998) ========= /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.T4pwo0g117/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.XVXR9ZHBQv/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 21:02:18 INFO - MultiFileLogger online at 20161128 21:02:18 in /builds/slave/test 21:02:18 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 21:02:18 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:02:18 INFO - {'append_to_log': False, 21:02:18 INFO - 'base_work_dir': '/builds/slave/test', 21:02:18 INFO - 'blob_upload_branch': 'Mozilla-Beta', 21:02:18 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:02:18 INFO - 'branch': 'Mozilla-Beta', 21:02:18 INFO - 'buildbot_json_path': 'buildprops.json', 21:02:18 INFO - 'config_files': ('talos/mac_config.py',), 21:02:18 INFO - 'default_actions': ('clobber', 21:02:18 INFO - 'read-buildbot-config', 21:02:18 INFO - 'download-and-extract', 21:02:18 INFO - 'populate-webroot', 21:02:18 INFO - 'create-virtualenv', 21:02:18 INFO - 'install', 21:02:18 INFO - 'run-tests'), 21:02:18 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:02:18 INFO - 'download_minidump_stackwalk': True, 21:02:18 INFO - 'download_symbols': 'ondemand', 21:02:18 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:02:18 INFO - 'tooltool.py': '/tools/tooltool.py', 21:02:18 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:02:18 INFO - '/tools/misc-python/virtualenv.py')}, 21:02:18 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:02:18 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:02:18 INFO - 'installer_path': 'installer.exe', 21:02:18 INFO - 'log_level': 'info', 21:02:18 INFO - 'log_name': 'talos', 21:02:18 INFO - 'log_to_console': True, 21:02:18 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:02:18 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:02:18 INFO - 'opt_config_files': (), 21:02:18 INFO - 'pip_index': False, 21:02:18 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:02:18 INFO - 'cmd': ('bash', 21:02:18 INFO - '-c', 21:02:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:02:18 INFO - 'enabled': True, 21:02:18 INFO - 'halt_on_failure': False, 21:02:18 INFO - 'name': 'check_screen_resolution'},), 21:02:18 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:02:18 INFO - 'cmd': ('bash', 21:02:18 INFO - '-c', 21:02:18 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:02:18 INFO - 'enabled': True, 21:02:18 INFO - 'halt_on_failure': False, 21:02:18 INFO - 'name': 'check_screen_resolution'},), 21:02:18 INFO - 'run_cmd_checks_enabled': True, 21:02:18 INFO - 'sps_profile': False, 21:02:18 INFO - 'sps_profile_interval': 0, 21:02:18 INFO - 'suite': 'dromaeojs', 21:02:18 INFO - 'system_bits': '32', 21:02:18 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:02:18 INFO - 'title': 't-yosemite-r7-0286', 21:02:18 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:02:18 INFO - 'use_talos_json': True, 21:02:18 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:02:18 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:02:18 INFO - 'work_dir': 'build'} 21:02:18 INFO - [mozharness: 2016-11-29 05:02:18.060295Z] Running clobber step. 21:02:18 INFO - Running pre-action listener: _resource_record_pre_action 21:02:18 INFO - Running main action method: clobber 21:02:18 INFO - rmtree: /builds/slave/test/build 21:02:18 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:02:19 INFO - Running post-action listener: _resource_record_post_action 21:02:19 INFO - [mozharness: 2016-11-29 05:02:19.711908Z] Finished clobber step (success) 21:02:19 INFO - [mozharness: 2016-11-29 05:02:19.712127Z] Running read-buildbot-config step. 21:02:19 INFO - Running pre-action listener: _resource_record_pre_action 21:02:19 INFO - Running main action method: read_buildbot_config 21:02:19 INFO - Using buildbot properties: 21:02:19 INFO - { 21:02:19 INFO - "project": "", 21:02:19 INFO - "product": "firefox", 21:02:19 INFO - "script_repo_revision": "production", 21:02:19 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 21:02:19 INFO - "repository": "", 21:02:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 21:02:19 INFO - "buildid": "20161128183744", 21:02:19 INFO - "pgo_build": "False", 21:02:19 INFO - "basedir": "/builds/slave/test", 21:02:19 INFO - "buildnumber": 30, 21:02:19 INFO - "slavename": "t-yosemite-r7-0286", 21:02:19 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 21:02:19 INFO - "platform": "yosemite_r7", 21:02:19 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 21:02:19 INFO - "branch": "mozilla-beta", 21:02:19 INFO - "repo_path": "releases/mozilla-beta", 21:02:19 INFO - "revision": "9b84116a5a6849a2cecd975509963b6afd9f11fa", 21:02:19 INFO - "stage_platform": "macosx64", 21:02:19 INFO - "builduid": "4aa742c26e9548cf8c498e706379dff9", 21:02:19 INFO - "slavebuilddir": "test" 21:02:19 INFO - } 21:02:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/Za9d_fsnQJyMAVA9n3ktsQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 21:02:19 INFO - Running post-action listener: _resource_record_post_action 21:02:19 INFO - [mozharness: 2016-11-29 05:02:19.716194Z] Finished read-buildbot-config step (success) 21:02:19 INFO - [mozharness: 2016-11-29 05:02:19.716356Z] Running download-and-extract step. 21:02:19 INFO - Running pre-action listener: _resource_record_pre_action 21:02:19 INFO - Running main action method: download_and_extract 21:02:19 INFO - mkdir: /builds/slave/test/build/tests 21:02:19 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')]} 21:02:19 INFO - trying https://queue.taskcluster.net/v1/task/Za9d_fsnQJyMAVA9n3ktsQ/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 21:02:19 INFO - Downloading https://queue.taskcluster.net/v1/task/Za9d_fsnQJyMAVA9n3ktsQ/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 21:02:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Za9d_fsnQJyMAVA9n3ktsQ/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 21:02:21 INFO - Downloaded 1165 bytes. 21:02:21 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 21:02:21 INFO - Using the following test package requirements: 21:02:21 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 21:02:21 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 21:02:21 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 21:02:21 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 21:02:21 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 21:02:21 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 21:02:21 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 21:02:21 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 21:02:21 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 21:02:21 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 21:02:21 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 21:02:21 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 21:02:21 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 21:02:21 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 21:02:21 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 21:02:21 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 21:02:21 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 21:02:21 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 21:02:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Za9d_fsnQJyMAVA9n3ktsQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 21:02:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Za9d_fsnQJyMAVA9n3ktsQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 21:02:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Za9d_fsnQJyMAVA9n3ktsQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 21:02:21 INFO - Expected file size: 16233057 21:02:28 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 21:02:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Za9d_fsnQJyMAVA9n3ktsQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 21:02:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Za9d_fsnQJyMAVA9n3ktsQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 21:02:28 INFO - Fetch https://queue.taskcluster.net/v1/task/Za9d_fsnQJyMAVA9n3ktsQ/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 21:02:29 INFO - Expected file size: 16233057 21:02:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Za9d_fsnQJyMAVA9n3ktsQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 21:02:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Za9d_fsnQJyMAVA9n3ktsQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 21:02:35 INFO - Fetch https://queue.taskcluster.net/v1/task/Za9d_fsnQJyMAVA9n3ktsQ/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 21:02:36 INFO - Expected file size: 14414089 21:02:37 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')]} 21:02:37 INFO - trying https://queue.taskcluster.net/v1/task/Za9d_fsnQJyMAVA9n3ktsQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 21:02:37 INFO - Downloading https://queue.taskcluster.net/v1/task/Za9d_fsnQJyMAVA9n3ktsQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 21:02:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Za9d_fsnQJyMAVA9n3ktsQ/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 21:02:39 INFO - Downloaded 86042617 bytes. 21:02:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Za9d_fsnQJyMAVA9n3ktsQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 21:02:39 INFO - mkdir: /builds/slave/test/properties 21:02:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:02:39 INFO - Writing to file /builds/slave/test/properties/build_url 21:02:39 INFO - Contents: 21:02:39 INFO - build_url:https://queue.taskcluster.net/v1/task/Za9d_fsnQJyMAVA9n3ktsQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg 21:02:40 INFO - Running post-action listener: _resource_record_post_action 21:02:40 INFO - Running post-action listener: set_extra_try_arguments 21:02:40 INFO - [mozharness: 2016-11-29 05:02:40.299399Z] Finished download-and-extract step (success) 21:02:40 INFO - [mozharness: 2016-11-29 05:02:40.299548Z] Running populate-webroot step. 21:02:40 INFO - Running pre-action listener: _resource_record_pre_action 21:02:40 INFO - Running main action method: populate_webroot 21:02:40 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:02:40 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:02:40 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:02:40 INFO - '--tppagecycles', 21:02:40 INFO - '7'], 21:02:40 INFO - 'tests': ['tsvgm']}}, 21:02:40 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:02:40 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:02:40 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:02:40 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:02:40 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:02:40 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:02:40 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:40 INFO - 'talos_options': ['--disable-e10s'], 21:02:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:02:40 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:40 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:02:40 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:40 INFO - 'talos_options': ['--disable-e10s'], 21:02:40 INFO - 'tests': ['damp', 'tps']}, 21:02:40 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:40 INFO - 'tests': ['damp', 'tps']}, 21:02:40 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:02:40 INFO - 'tests': ['dromaeo_dom']}, 21:02:40 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:02:40 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:02:40 INFO - 'tests': ['basic_compositor_video']}, 21:02:40 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:02:40 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:02:40 INFO - 'tests': ['a11yr', 21:02:40 INFO - 'ts_paint', 21:02:40 INFO - 'tpaint', 21:02:40 INFO - 'sessionrestore', 21:02:40 INFO - 'sessionrestore_no_auto_restore', 21:02:40 INFO - 'tabpaint']}, 21:02:40 INFO - 'other-e10s': {'tests': ['a11yr', 21:02:40 INFO - 'ts_paint', 21:02:40 INFO - 'tpaint', 21:02:40 INFO - 'sessionrestore', 21:02:40 INFO - 'sessionrestore_no_auto_restore', 21:02:40 INFO - 'tabpaint']}, 21:02:40 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:02:40 INFO - 'ts_paint', 21:02:40 INFO - 'tpaint', 21:02:40 INFO - 'sessionrestore', 21:02:40 INFO - 'sessionrestore_no_auto_restore', 21:02:40 INFO - 'tabpaint']}, 21:02:40 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:02:40 INFO - 'ts_paint', 21:02:40 INFO - 'tpaint', 21:02:40 INFO - 'sessionrestore', 21:02:40 INFO - 'sessionrestore_no_auto_restore', 21:02:40 INFO - 'tabpaint']}, 21:02:40 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:02:40 INFO - 'tests': ['a11yr', 21:02:40 INFO - 'ts_paint', 21:02:40 INFO - 'tpaint', 21:02:40 INFO - 'sessionrestore', 21:02:40 INFO - 'sessionrestore_no_auto_restore', 21:02:40 INFO - 'tabpaint']}, 21:02:40 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:02:40 INFO - 'tests': ['a11yr', 21:02:40 INFO - 'ts_paint', 21:02:40 INFO - 'tpaint', 21:02:40 INFO - 'sessionrestore', 21:02:40 INFO - 'sessionrestore_no_auto_restore', 21:02:40 INFO - 'tabpaint']}, 21:02:40 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:02:40 INFO - 'tests': ['tsvgx', 21:02:40 INFO - 'tsvgr_opacity', 21:02:40 INFO - 'tart', 21:02:40 INFO - 'tscrollx', 21:02:40 INFO - 'cart']}, 21:02:40 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:02:40 INFO - 'tsvgr_opacity', 21:02:40 INFO - 'tart', 21:02:40 INFO - 'tscrollx', 21:02:40 INFO - 'cart']}, 21:02:40 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:40 INFO - 'talos_options': ['--disable-e10s'], 21:02:40 INFO - 'tests': ['tp5o']}, 21:02:40 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:40 INFO - 'tests': ['tp5o']}, 21:02:40 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:40 INFO - 'talos_options': ['--disable-e10s', 21:02:40 INFO - '--xperf_path', 21:02:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:02:40 INFO - 'tests': ['tp5n']}, 21:02:40 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:02:40 INFO - 'talos_options': ['--xperf_path', 21:02:40 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:02:40 INFO - 'tests': ['tp5n']}}, 21:02:40 INFO - 'talos.zip': {'path': '', 21:02:40 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:02:40 INFO - Running post-action listener: _resource_record_post_action 21:02:40 INFO - [mozharness: 2016-11-29 05:02:40.317988Z] Finished populate-webroot step (success) 21:02:40 INFO - [mozharness: 2016-11-29 05:02:40.318104Z] Running create-virtualenv step. 21:02:40 INFO - Running pre-action listener: _resource_record_pre_action 21:02:40 INFO - Running main action method: create_virtualenv 21:02:40 INFO - Creating virtualenv /builds/slave/test/build/venv 21:02:40 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 21:02:40 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:02:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:02:40 INFO - Using real prefix '/tools/python27' 21:02:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:02:41 INFO - Installing distribute.............................................................................................................................................................................................done. 21:02:44 INFO - Installing pip.................done. 21:02:44 INFO - Return code: 0 21:02:44 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104909490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10487f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4814b9b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10471dd30>, '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 0x104583db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104715b20>, '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.T4pwo0g117/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.XVXR9ZHBQv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 21:02:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 21:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 21:02:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T4pwo0g117/Render', 21:02:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:02:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:02:44 INFO - 'HOME': '/Users/cltbld', 21:02:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:02:44 INFO - 'LOGNAME': 'cltbld', 21:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:44 INFO - 'MOZ_NO_REMOTE': '1', 21:02:44 INFO - 'NO_EM_RESTART': '1', 21:02:44 INFO - 'PAGER': '/bin/cat', 21:02:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:44 INFO - 'PWD': '/builds/slave/test', 21:02:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:02:44 INFO - 'SHELL': '/bin/bash', 21:02:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVXR9ZHBQv/Listeners', 21:02:44 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 21:02:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:02:44 INFO - 'USER': 'cltbld', 21:02:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:02:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:44 INFO - 'XPC_FLAGS': '0x0', 21:02:44 INFO - 'XPC_SERVICE_NAME': '0', 21:02:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:44 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 21:02:44 INFO - Cleaning up... 21:02:44 INFO - Return code: 0 21:02:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104909490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10487f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4814b9b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10471dd30>, '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 0x104583db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104715b20>, '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.T4pwo0g117/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.XVXR9ZHBQv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 21:02:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 21:02:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 21:02:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T4pwo0g117/Render', 21:02:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:02:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:02:44 INFO - 'HOME': '/Users/cltbld', 21:02:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:02:44 INFO - 'LOGNAME': 'cltbld', 21:02:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:44 INFO - 'MOZ_NO_REMOTE': '1', 21:02:44 INFO - 'NO_EM_RESTART': '1', 21:02:44 INFO - 'PAGER': '/bin/cat', 21:02:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:02:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:44 INFO - 'PWD': '/builds/slave/test', 21:02:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:02:44 INFO - 'SHELL': '/bin/bash', 21:02:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVXR9ZHBQv/Listeners', 21:02:44 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 21:02:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:02:44 INFO - 'USER': 'cltbld', 21:02:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:02:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:02:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:44 INFO - 'XPC_FLAGS': '0x0', 21:02:44 INFO - 'XPC_SERVICE_NAME': '0', 21:02:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:02:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:44 INFO - Downloading/unpacking psutil>=3.1.1 21:02: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 21:02: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 21:02: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 21:02: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 21:02: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 21:02: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 21:02:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:02:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:02:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:02:49 INFO - Installing collected packages: psutil 21:02:49 INFO - Running setup.py install for psutil 21:02:49 INFO - building 'psutil._psutil_osx' extension 21:02:49 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 21:02:49 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 21:02:49 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 21:02:49 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 21:02:49 INFO - building 'psutil._psutil_posix' extension 21:02:49 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 21:02:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:02:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:02:49 INFO - ^ 21:02:49 INFO - 1 warning generated. 21:02:49 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 21:02:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:02:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:02:49 INFO - Successfully installed psutil 21:02:49 INFO - Cleaning up... 21:02:50 INFO - Return code: 0 21:02:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:02:50 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')]} 21:02:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:50 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')]} 21:02:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:50 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 0x104909490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10487f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4814b9b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10471dd30>, '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 0x104583db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104715b20>, '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.T4pwo0g117/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.XVXR9ZHBQv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 21:02:50 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 21:02:50 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 21:02:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T4pwo0g117/Render', 21:02:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:02:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:02:50 INFO - 'HOME': '/Users/cltbld', 21:02:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:02:50 INFO - 'LOGNAME': 'cltbld', 21:02:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:50 INFO - 'MOZ_NO_REMOTE': '1', 21:02:50 INFO - 'NO_EM_RESTART': '1', 21:02:50 INFO - 'PAGER': '/bin/cat', 21:02:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:02:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:50 INFO - 'PWD': '/builds/slave/test', 21:02:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:02:50 INFO - 'SHELL': '/bin/bash', 21:02:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVXR9ZHBQv/Listeners', 21:02:50 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 21:02:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:02:50 INFO - 'USER': 'cltbld', 21:02:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:02:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:02:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:50 INFO - 'XPC_FLAGS': '0x0', 21:02:50 INFO - 'XPC_SERVICE_NAME': '0', 21:02:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:02:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:02:50 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 21:02:50 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 21:02:50 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 21:02:50 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 21:02:50 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 21:02:50 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 21:02:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:02:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:02:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:02:53 INFO - Installing collected packages: mozsystemmonitor 21:02:53 INFO - Running setup.py install for mozsystemmonitor 21:02:53 INFO - Successfully installed mozsystemmonitor 21:02:53 INFO - Cleaning up... 21:02:53 INFO - Return code: 0 21:02:53 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:02:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104909490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10487f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4814b9b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10471dd30>, '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 0x104583db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104715b20>, '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.T4pwo0g117/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.XVXR9ZHBQv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 21:02:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 21:02:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 21:02:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T4pwo0g117/Render', 21:02:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:02:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:02:53 INFO - 'HOME': '/Users/cltbld', 21:02:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:02:53 INFO - 'LOGNAME': 'cltbld', 21:02:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:53 INFO - 'MOZ_NO_REMOTE': '1', 21:02:53 INFO - 'NO_EM_RESTART': '1', 21:02:53 INFO - 'PAGER': '/bin/cat', 21:02:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:02:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:53 INFO - 'PWD': '/builds/slave/test', 21:02:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:02:53 INFO - 'SHELL': '/bin/bash', 21:02:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVXR9ZHBQv/Listeners', 21:02:53 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 21:02:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:02:53 INFO - 'USER': 'cltbld', 21:02:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:02:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:02:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:53 INFO - 'XPC_FLAGS': '0x0', 21:02:53 INFO - 'XPC_SERVICE_NAME': '0', 21:02:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:02:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:53 INFO - Downloading/unpacking jsonschema==2.5.1 21:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:02:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:02:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:02:56 INFO - Downloading functools32-3.2.3-2.tar.gz 21:02:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:02:56 INFO - warning: no files found matching '*.txt' 21:02:56 INFO - no previously-included directories found matching 'build' 21:02:56 INFO - no previously-included directories found matching 'dist' 21:02:56 INFO - no previously-included directories found matching '.git*' 21:02:56 INFO - Installing collected packages: jsonschema, functools32 21:02:56 INFO - Running setup.py install for functools32 21:02:56 INFO - warning: no files found matching '*.txt' 21:02:56 INFO - no previously-included directories found matching 'build' 21:02:56 INFO - no previously-included directories found matching 'dist' 21:02:56 INFO - no previously-included directories found matching '.git*' 21:02:56 INFO - Successfully installed jsonschema functools32 21:02:56 INFO - Cleaning up... 21:02:56 INFO - Return code: 0 21:02:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:02:56 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')]} 21:02:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:56 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')]} 21:02:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:56 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 0x104909490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10487f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4814b9b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10471dd30>, '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 0x104583db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104715b20>, '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.T4pwo0g117/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.XVXR9ZHBQv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 21:02:56 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 21:02:56 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 21:02:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T4pwo0g117/Render', 21:02:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:02:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:02:56 INFO - 'HOME': '/Users/cltbld', 21:02:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:02:56 INFO - 'LOGNAME': 'cltbld', 21:02:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:56 INFO - 'MOZ_NO_REMOTE': '1', 21:02:56 INFO - 'NO_EM_RESTART': '1', 21:02:56 INFO - 'PAGER': '/bin/cat', 21:02:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:02:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:56 INFO - 'PWD': '/builds/slave/test', 21:02:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:02:56 INFO - 'SHELL': '/bin/bash', 21:02:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVXR9ZHBQv/Listeners', 21:02:56 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 21:02:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:02:56 INFO - 'USER': 'cltbld', 21:02:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:02:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:02:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:56 INFO - 'XPC_FLAGS': '0x0', 21:02:56 INFO - 'XPC_SERVICE_NAME': '0', 21:02:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:02:57 INFO - Cleaning up... 21:02:57 INFO - Return code: 0 21:02:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:02:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:02:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:02:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:02:57 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 0x104909490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10487f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4814b9b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10471dd30>, '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 0x104583db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104715b20>, '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.T4pwo0g117/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.XVXR9ZHBQv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 21:02:57 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 21:02:57 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 21:02:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T4pwo0g117/Render', 21:02:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:02:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:02:57 INFO - 'HOME': '/Users/cltbld', 21:02:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:02:57 INFO - 'LOGNAME': 'cltbld', 21:02:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:02:57 INFO - 'MOZ_NO_REMOTE': '1', 21:02:57 INFO - 'NO_EM_RESTART': '1', 21:02:57 INFO - 'PAGER': '/bin/cat', 21:02:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:02:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:02:57 INFO - 'PWD': '/builds/slave/test', 21:02:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:02:57 INFO - 'SHELL': '/bin/bash', 21:02:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVXR9ZHBQv/Listeners', 21:02:57 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 21:02:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:02:57 INFO - 'USER': 'cltbld', 21:02:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:02:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:02:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:02:57 INFO - 'XPC_FLAGS': '0x0', 21:02:57 INFO - 'XPC_SERVICE_NAME': '0', 21:02:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:02:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:02:57 INFO - Downloading/unpacking blobuploader==1.2.4 21:02: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 21:02: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 21:02: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 21:02: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 21:02: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 21:02: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 21:02:59 INFO - Downloading blobuploader-1.2.4.tar.gz 21:02:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:03:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:03:00 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 21:03:00 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 21:03:00 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 21:03:00 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 21:03:00 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 21:03:00 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 21:03:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:03:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:03:00 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 21:03:00 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 21:03:00 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 21:03:00 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 21:03:00 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 21:03:00 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 21:03:01 INFO - Downloading docopt-0.6.1.tar.gz 21:03:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:03:01 INFO - Installing collected packages: blobuploader, requests, docopt 21:03:01 INFO - Running setup.py install for blobuploader 21:03:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:03:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:03:01 INFO - Running setup.py install for requests 21:03:01 INFO - Running setup.py install for docopt 21:03:02 INFO - Successfully installed blobuploader requests docopt 21:03:02 INFO - Cleaning up... 21:03:02 INFO - Return code: 0 21:03:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:02 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 0x104909490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10487f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4814b9b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10471dd30>, '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 0x104583db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104715b20>, '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.T4pwo0g117/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.XVXR9ZHBQv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 21:03:02 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 21:03:02 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 21:03:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T4pwo0g117/Render', 21:03:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:03:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:03:02 INFO - 'HOME': '/Users/cltbld', 21:03:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:03:02 INFO - 'LOGNAME': 'cltbld', 21:03:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:02 INFO - 'MOZ_NO_REMOTE': '1', 21:03:02 INFO - 'NO_EM_RESTART': '1', 21:03:02 INFO - 'PAGER': '/bin/cat', 21:03:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:03:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:02 INFO - 'PWD': '/builds/slave/test', 21:03:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:03:02 INFO - 'SHELL': '/bin/bash', 21:03:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVXR9ZHBQv/Listeners', 21:03:02 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 21:03:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:03:02 INFO - 'USER': 'cltbld', 21:03:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:03:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:03:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:02 INFO - 'XPC_FLAGS': '0x0', 21:03:02 INFO - 'XPC_SERVICE_NAME': '0', 21:03:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:03:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:03:02 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-eycMs2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:03:02 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-uohp4O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:03:02 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ViCpiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:03:02 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-rdCefp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:03:02 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-5Oeonf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:03:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:03:02 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-_58g1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:03:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-z4ISyp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:03:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-QumlGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:03:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-Mjcxzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:03:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-hqPKRW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:03:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ipGGWK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:03:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-dKI6Sj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:03:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-O9s4aO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:03:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-V3Myyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:03:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:03:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ZZ95l9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:03:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-nVf5aZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:03:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:03:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-2YI09r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:03:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:03:04 INFO - Running setup.py install for manifestparser 21:03:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:03:04 INFO - Running setup.py install for mozcrash 21:03:04 INFO - Running setup.py install for mozdebug 21:03:04 INFO - Running setup.py install for mozdevice 21:03:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:03:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:03:04 INFO - Running setup.py install for mozfile 21:03:04 INFO - Running setup.py install for mozhttpd 21:03:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:03:05 INFO - Running setup.py install for mozinfo 21:03:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:03:05 INFO - Running setup.py install for mozInstall 21:03:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:03:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:03:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:03:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:03:05 INFO - Running setup.py install for mozleak 21:03:05 INFO - Running setup.py install for mozlog 21:03:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:03:05 INFO - Running setup.py install for moznetwork 21:03:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:03:05 INFO - Running setup.py install for mozprocess 21:03:05 INFO - Running setup.py install for mozprofile 21:03:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:03:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:03:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:03:06 INFO - Running setup.py install for mozrunner 21:03:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:03:06 INFO - Running setup.py install for mozscreenshot 21:03:06 INFO - Running setup.py install for moztest 21:03:06 INFO - Running setup.py install for mozversion 21:03:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:03:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:03:06 INFO - Cleaning up... 21:03:06 INFO - Return code: 0 21:03:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:06 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 0x104909490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10487f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4814b9b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10471dd30>, '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 0x104583db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104715b20>, '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.T4pwo0g117/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.XVXR9ZHBQv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 21:03:06 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 21:03:06 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 21:03:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T4pwo0g117/Render', 21:03:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:03:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:03:06 INFO - 'HOME': '/Users/cltbld', 21:03:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:03:06 INFO - 'LOGNAME': 'cltbld', 21:03:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:06 INFO - 'MOZ_NO_REMOTE': '1', 21:03:06 INFO - 'NO_EM_RESTART': '1', 21:03:06 INFO - 'PAGER': '/bin/cat', 21:03:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:03:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:06 INFO - 'PWD': '/builds/slave/test', 21:03:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:03:06 INFO - 'SHELL': '/bin/bash', 21:03:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVXR9ZHBQv/Listeners', 21:03:06 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 21:03:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:03:06 INFO - 'USER': 'cltbld', 21:03:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:03:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:03:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:06 INFO - 'XPC_FLAGS': '0x0', 21:03:06 INFO - 'XPC_SERVICE_NAME': '0', 21:03:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:03:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:03:07 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-hLzX2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:03:07 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)) 21:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:03:07 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-klQ45T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:03:07 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)) 21:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:03:07 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ML3CJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:03:07 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)) 21:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:03:07 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-SWxcRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:03:07 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)) 21:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:03:07 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-2LDV1P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:03:07 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)) 21:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:03:07 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-kQQV2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:03:07 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)) 21:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:03:07 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-zNSJY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:03:07 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)) 21:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:03:07 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-yXpe7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:03:07 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)) 21:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:03:07 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ZGf0FJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:03:07 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)) 21:03:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:03:08 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-iqJmIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:03:08 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)) 21:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:03:08 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-wJKqOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:03:08 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)) 21:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:03:08 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-fWQ_IQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:03:08 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)) 21:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:03:08 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-QTCTfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:03:08 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)) 21:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:03:08 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-rE3GJl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:03:08 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)) 21:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:03:08 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-zxHgz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:03:08 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)) 21:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:03:08 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-Qpqor0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:03:08 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)) 21:03:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:03:08 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-r4zPXJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:03:08 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)) 21:03:08 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)) 21:03:08 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)) 21:03:08 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)) 21:03:08 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)) 21:03:08 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)) 21:03:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:03:08 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 21:03:08 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 21:03:08 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 21:03:08 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 21:03:08 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 21:03:08 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 21:03:11 INFO - Downloading blessings-1.6.tar.gz 21:03:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:03:11 INFO - Installing collected packages: blessings 21:03:11 INFO - Running setup.py install for blessings 21:03:11 INFO - Successfully installed blessings 21:03:11 INFO - Cleaning up... 21:03:11 INFO - Return code: 0 21:03:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:03:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:03:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:03:12 INFO - Reading from file tmpfile_stdout 21:03:12 INFO - Current package versions: 21:03:12 INFO - blessings == 1.6 21:03:12 INFO - blobuploader == 1.2.4 21:03:12 INFO - docopt == 0.6.1 21:03:12 INFO - functools32 == 3.2.3-2 21:03:12 INFO - jsonschema == 2.5.1 21:03:12 INFO - manifestparser == 1.1 21:03:12 INFO - mozInstall == 1.12 21:03:12 INFO - mozcrash == 0.17 21:03:12 INFO - mozdebug == 0.1 21:03:12 INFO - mozdevice == 0.48 21:03:12 INFO - mozfile == 1.2 21:03:12 INFO - mozhttpd == 0.7 21:03:12 INFO - mozinfo == 0.9 21:03:12 INFO - mozleak == 0.1 21:03:12 INFO - mozlog == 3.4 21:03:12 INFO - moznetwork == 0.27 21:03:12 INFO - mozprocess == 0.23 21:03:12 INFO - mozprofile == 0.28 21:03:12 INFO - mozrunner == 6.12 21:03:12 INFO - mozscreenshot == 0.1 21:03:12 INFO - mozsystemmonitor == 0.3 21:03:12 INFO - moztest == 0.7 21:03:12 INFO - mozversion == 1.4 21:03:12 INFO - psutil == 3.1.1 21:03:12 INFO - requests == 1.2.3 21:03:12 INFO - wsgiref == 0.1.2 21:03:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:12 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 0x104909490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10487f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4814b9b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10471dd30>, '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 0x104583db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104715b20>, '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.T4pwo0g117/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.XVXR9ZHBQv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 21:03:12 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 21:03:12 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 21:03:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T4pwo0g117/Render', 21:03:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:03:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:03:12 INFO - 'HOME': '/Users/cltbld', 21:03:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:03:12 INFO - 'LOGNAME': 'cltbld', 21:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:12 INFO - 'MOZ_NO_REMOTE': '1', 21:03:12 INFO - 'NO_EM_RESTART': '1', 21:03:12 INFO - 'PAGER': '/bin/cat', 21:03:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:12 INFO - 'PWD': '/builds/slave/test', 21:03:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:03:12 INFO - 'SHELL': '/bin/bash', 21:03:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVXR9ZHBQv/Listeners', 21:03:12 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 21:03:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:03:12 INFO - 'USER': 'cltbld', 21:03:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:03:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:12 INFO - 'XPC_FLAGS': '0x0', 21:03:12 INFO - 'XPC_SERVICE_NAME': '0', 21:03:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:12 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)) 21:03:12 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)) 21:03:12 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)) 21:03:12 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)) 21:03:12 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)) 21:03:12 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)) 21:03:12 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)) 21:03:12 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)) 21:03:12 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)) 21:03:12 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)) 21:03:12 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)) 21:03:12 INFO - Cleaning up... 21:03:12 INFO - Return code: 0 21:03:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:03:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:03:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:03:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:03:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104909490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10487f570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4814b9b40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10471dd30>, '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 0x104583db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104715b20>, '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.T4pwo0g117/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.XVXR9ZHBQv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 21:03:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:03:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:03:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T4pwo0g117/Render', 21:03:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:03:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:03:12 INFO - 'HOME': '/Users/cltbld', 21:03:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:03:12 INFO - 'LOGNAME': 'cltbld', 21:03:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:12 INFO - 'MOZ_NO_REMOTE': '1', 21:03:12 INFO - 'NO_EM_RESTART': '1', 21:03:12 INFO - 'PAGER': '/bin/cat', 21:03:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:03:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:12 INFO - 'PWD': '/builds/slave/test', 21:03:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:03:12 INFO - 'SHELL': '/bin/bash', 21:03:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVXR9ZHBQv/Listeners', 21:03:12 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 21:03:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:03:12 INFO - 'USER': 'cltbld', 21:03:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:03:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:03:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:12 INFO - 'XPC_FLAGS': '0x0', 21:03:12 INFO - 'XPC_SERVICE_NAME': '0', 21:03:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:03:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:03:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:03:12 INFO - Cleaning up... 21:03:12 INFO - Return code: 0 21:03:12 INFO - Running post-action listener: _resource_record_post_action 21:03:12 INFO - Running post-action listener: _start_resource_monitoring 21:03:13 INFO - Starting resource monitoring. 21:03:13 INFO - [mozharness: 2016-11-29 05:03:13.016289Z] Finished create-virtualenv step (success) 21:03:13 INFO - [mozharness: 2016-11-29 05:03:13.017287Z] Running install step. 21:03:13 INFO - Running pre-action listener: _resource_record_pre_action 21:03:13 INFO - Running main action method: install 21:03:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:03:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:03:13 INFO - Reading from file tmpfile_stdout 21:03:13 INFO - Detecting whether we're running mozinstall >=1.0... 21:03:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:03:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:03:13 INFO - Reading from file tmpfile_stdout 21:03:13 INFO - Output received: 21:03:13 INFO - Usage: mozinstall [options] installer 21:03:13 INFO - Options: 21:03:13 INFO - -h, --help show this help message and exit 21:03:13 INFO - -d DEST, --destination=DEST 21:03:13 INFO - Directory to install application into. [default: 21:03:13 INFO - "/builds/slave/test"] 21:03:13 INFO - --app=APP Application being installed. [default: firefox] 21:03:13 INFO - mkdir: /builds/slave/test/build/application 21:03:13 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'] 21:03:13 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 21:03:35 INFO - Reading from file tmpfile_stdout 21:03:35 INFO - Output received: 21:03:35 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 21:03:35 INFO - Running post-action listener: _resource_record_post_action 21:03:35 INFO - [mozharness: 2016-11-29 05:03:35.516612Z] Finished install step (success) 21:03:35 INFO - [mozharness: 2016-11-29 05:03:35.516757Z] Running run-tests step. 21:03:35 INFO - Running pre-action listener: _resource_record_pre_action 21:03:35 INFO - Running main action method: run_tests 21:03:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:03:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:03:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:03:35 INFO - 2016-11-28 21:03:35.531 screenresolution[1889:12617] starting screenresolution argv=screenresolution get 21:03:35 INFO - 2016-11-28 21:03:35.533 screenresolution[1889:12617] Display 0: 1600x1200x32@60 21:03:35 INFO - 2016-11-28 21:03:35.539 screenresolution[1890:12620] starting screenresolution argv=screenresolution list 21:03:35 INFO - Available Modes on Display 0 21:03:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:03:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:03:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:03:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:03:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:03:35 INFO - Intel Iris: 21:03:35 INFO - Chipset Model: Intel Iris 21:03:35 INFO - Type: GPU 21:03:35 INFO - Bus: Built-In 21:03:35 INFO - VRAM (Dynamic, Max): 1536 MB 21:03:35 INFO - Vendor: Intel (0x8086) 21:03:35 INFO - Device ID: 0x0a2e 21:03:35 INFO - Revision ID: 0x0009 21:03:35 INFO - Displays: 21:03:35 INFO - Display: 21:03:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:03:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:03:35 INFO - Display Serial Number: 1600x1200 60 21:03:35 INFO - Main Display: Yes 21:03:35 INFO - Mirror: Off 21:03:35 INFO - Online: Yes 21:03:35 INFO - Rotation: Supported 21:03:35 INFO - Return code: 0 21:03:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:03:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:03:35 INFO - Python 2.7.3 21:03:35 INFO - Return code: 0 21:03:35 INFO - grabbing minidump binary from tooltool 21:03:35 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')]} 21:03:35 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 0x10471dd30>, '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 0x104583db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104715b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:03:35 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 21:03:35 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 21:03:35 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 21:03:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:03:35 INFO - Return code: 0 21:03:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:03:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:03:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:03:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:03:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:03:35 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/Za9d_fsnQJyMAVA9n3ktsQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0286', '--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 21:03:35 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/Za9d_fsnQJyMAVA9n3ktsQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0286 --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 21:03:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.T4pwo0g117/Render', 21:03:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:03:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:03:35 INFO - 'HOME': '/Users/cltbld', 21:03:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:03:35 INFO - 'LOGNAME': 'cltbld', 21:03:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:03:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:03:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:03:35 INFO - 'MOZ_NO_REMOTE': '1', 21:03:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:03:35 INFO - 'NO_EM_RESTART': '1', 21:03:35 INFO - 'PAGER': '/bin/cat', 21:03:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:03:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:03:35 INFO - 'PWD': '/builds/slave/test', 21:03:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:03:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:03:35 INFO - 'SHELL': '/bin/bash', 21:03:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.XVXR9ZHBQv/Listeners', 21:03:35 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 21:03:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:03:35 INFO - 'USER': 'cltbld', 21:03:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:03:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:03:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:03:35 INFO - 'XPC_FLAGS': '0x0', 21:03:35 INFO - 'XPC_SERVICE_NAME': '0', 21:03:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:03:35 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/Za9d_fsnQJyMAVA9n3ktsQ/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0286', '--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 21:03:36 INFO - mozversion application_buildid: 20161128183744 21:03:36 INFO - mozversion application_changeset: 9b84116a5a6849a2cecd975509963b6afd9f11fa 21:03:36 INFO - mozversion application_display_name: Firefox 21:03:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:03:36 INFO - mozversion application_name: Firefox 21:03:36 INFO - mozversion application_remotingname: firefox 21:03:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 21:03:36 INFO - mozversion application_vendor: Mozilla 21:03:36 INFO - mozversion application_version: 51.0 21:03:36 INFO - mozversion platform_buildid: 20161128183744 21:03:36 INFO - mozversion platform_changeset: 9b84116a5a6849a2cecd975509963b6afd9f11fa 21:03:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 21:03:36 INFO - mozversion platform_version: 51.0 21:03:36 INFO - using testdate: 1480395816 21:03:36 INFO - actual date: 1480395816 21:03:36 INFO - starting webserver on 'localhost:51267' 21:03:36 INFO - SUITE-START | Running 2 tests 21:03:36 INFO - TEST-START | dromaeo_css 21:03:36 INFO - operating with platform_type : mac_ 21:03:36 INFO - Initialising browser for dromaeo_css test... 21:03:36 INFO - TEST-INFO | started process 1900 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmpvIuRqf/profile http://localhost:51267/getInfo.html) 21:03:38 INFO - PROCESS | 1900 | __metrics Screen width/height:1600/1200 21:03:38 INFO - PROCESS | 1900 | colorDepth:24 21:03:38 INFO - PROCESS | 1900 | Browser inner width/height: 1024/689 21:03:38 INFO - PROCESS | 1900 | __metrics 21:03:38 INFO - PROCESS | 1900 | 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" 21:03:38 INFO - PROCESS | 1900 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:03:39 INFO - TEST-INFO | 1900: exit 0 21:03:39 INFO - Browser initialized. 21:03:39 INFO - Running cycle 1/1 for dromaeo_css test... 21:03:39 INFO - TEST-INFO | started process 1903 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmpvIuRqf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:03:51 INFO - PROCESS | 1903 | RSS: Main: 168976384 21:03:51 INFO - PROCESS | 1903 | 21:04:42 INFO - PROCESS | 1903 | 1480395882284 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] 21:06:53 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:51267/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51267/tests/dromaeo/cssquery-ext.html) 21:06:55 INFO - PROCESS | 1903 | RSS: Main: 323219456 21:06:55 INFO - PROCESS | 1903 | 21:09:57 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:51267/tests/dromaeo/cssquery-ext.html (next: http://localhost:51267/tests/dromaeo/cssquery-jquery.html) 21:09:58 INFO - PROCESS | 1903 | RSS: Main: 303226880 21:09:58 INFO - PROCESS | 1903 | 21:13:00 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:51267/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51267/tests/dromaeo/cssquery-mootools.html) 21:13:01 INFO - PROCESS | 1903 | RSS: Main: 284069888 21:13:01 INFO - PROCESS | 1903 | 21:16:03 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:51267/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51267/tests/dromaeo/cssquery-prototype.html) 21:16:04 INFO - PROCESS | 1903 | RSS: Main: 264138752 21:16:04 INFO - PROCESS | 1903 | 21:19:07 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:51267/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51267/tests/dromaeo/cssquery-yui.html) 21:19:08 INFO - PROCESS | 1903 | RSS: Main: 258338816 21:19:08 INFO - PROCESS | 1903 | 21:22:10 INFO - PROCESS | 1903 | Cycle 1(1): loaded http://localhost:51267/tests/dromaeo/cssquery-yui.html (next: http://localhost:51267/tests/dromaeo/cssquery-dojo.html) 21:22:11 INFO - PROCESS | 1903 | RSS: Main: 317935616 21:22:11 INFO - PROCESS | 1903 | 21:22:11 INFO - PROCESS | 1903 | __start_tp_report 21:22:11 INFO - PROCESS | 1903 | _x_x_mozilla_page_load 21:22:11 INFO - PROCESS | 1903 | _x_x_mozilla_page_load_details 21:22:11 INFO - PROCESS | 1903 | |i|pagename|runs| 21:22:11 INFO - PROCESS | 1903 | |0;dojo.html;3398.116489712674;3403.489476578514;3416.214270717733;3428.725701943845;3475.8262086895666;5589.469000444957;5617.494425501704;5617.9438205617935;5630.859228519289;5696.6866822324755;5529.695866727328;5612.887742245152;5621.634593751413;5636.802711905084;5669.319681638199;5120.8975820483665;5162.896742065156;5164.302819119408;5187.766550505236;5188.429272779991;5074.314967479399;5087.821926232583;5097.3373461449955;5245.029669511134;5295.9672863791575;4496.9325460118125;5201.739913004353;5204.713740744258;5246.632735708502;5253.553447956928;5181.1969144782615;5205.739713014372;5224.346956630421;5264.92102618461;5266.131088370415;5133.409657889316;5199.376074871002;5200.115980283361;5209.426963034063;5218.165093585046;5522.364928033247;5527.309086364205;5572.359178694421;5586.692731899744;5597.244372009808;6084.969575152096;6087.117367981662;6095.268567771852;6149.5080393568405;6205.596636218631;6167.136600875836;6229.37706229378;6232.532560057968;6238;6249.750009999594;5596.188552659883;5628.296462942132;5667.234923285345;5672.092465205547;5687.061634830289;6189.96905015481;6224.906626400608;6233.532485063638;6239.563230573907;6241.594296370812;6068.75724971005;6080.300765411946;6089.939100609025;6099.512039036867;6101.694915254308;6106.339326077157;6112.694365281718;6112.74665817949;6120.386183820636;6163.660998645028;6120.721420533258;6126.35800436956;6135.140940401905;6143.556264277891;6153.600015998945;6097.298810636745;6134.2332208473945;6168.013117901114;6173.444390004921;6184.474319682878;4811.182099043171;4892.363992680928;4900.901981960412;4932.8520144395725;4958.107540642647;4409.757463339547;4453.532379100147;4469;4481.2381895077915;4531.116432295737;5894.410558944071;5914.172015917775;5915.970420147958;5920.911186332209;5939.287285525765;6062.605930614496;6273.498120150377;6274.811755647246;6284.402981716729;6287.59130656515;5750.7987220447085;5774.2782152230975;5833.562482813806;5851.268591426072;5863.67749773758;5382.784688612412;5395.649282796606;5408.2969214002715;5416.9729151353995;5449.100898351807;6036.732286219767;6265.404786545271;6271.153394291712;6274.874502510015;6277.372262773777;4903.5586797188425;6094.7257373417415;6117.736059405574;6133.26400831903;6148.846278843064;6214.2853571838;6276.246850377801;6294.716737746904;6296.33888441707;6296.84257893538;6147.200863887666;6151.477124444294;6164.7842325518395;6166.537509686881;6184.628922264678;6047.365026672312;6134.846628834315;6224.439800417984;6248.812535623939;6262.436380725757;5945.375735547878;5976.731047102804;5990.940090599038;6054.788082417094;6141.324454310112;6067.362926892612;6083.8174854754425;6092.147099405998;6099.176611157614;6099.420555047441;5894.38108998549;5901.262342207224;5933.821985340447;5934.9406505934385;5949.286085669747;5912.408759124053;5941.643501389931;5951.256092988377;5960;5976.940230597638;5855.9121613176685;5866.149408335682;5880.411958804257;5901.232839730979;5934 21:22:11 INFO - PROCESS | 1903 | |1;ext.html;462.6345187302032;537.4759609380852;538.6095081066226;544.9509544141029;549.2585010236181;31881;33486.330273394546;42190.94522636932;43575.78212108943;45551.54448455515;36545.63454365455;44529.554704452945;44982.7750861246;45013.77493112538;45026.32460513087;10000.449975251358;10150.6954791356;10166.339187952759;10181;10181.490925453734;7939.801504962365;9260;9345.439273643604;9362.251019918423;9608.66369677058;11126.38804865732;12391.380430978461;12398.008159347275;12672.556460523883;12693.68265793358;12415.751684966295;12483.937580312131;12525.248485090833;12526.74946501074;12528.436220370106;12222.694432639166;12315.815262771066;12327.876721232762;12329.260244385365;12334.938325308316;42185.94535136616;42499;42517;42558;42568;3589.1206654369585;3593.7304702147444;3658.487811706363;3872.3997780344093;3899.259140763246;31150.532742008887;31561.21096972571;32102.733508920555;32394.6760532394;32604.836975814967;2847.9145625631263;3274.787138835968;3314.419976504102;3407.9318413631836;3458.4639380896;452860;462671;463881;464862;465002;63158.36841631525;63624.36375636185;63684.68157659182;63719.36280637227;63727.6813615929;35948.820255899074;36666.26667466636;36688.44967325492;37600.43599346012;55984.32047038595;17331.306747730203;17583.29666813313;17587.384441544484;17626;17674.204660790296;13307.866921330857;13415.463381464828;13424.926005919502;13445.260510671811;13447.193168409927;16246.619037381719;16815;17881.552961176076;18768.49852011836;19168.52078698016;7338.935854301203;7491.444985637567;8027.678892844221;8210.343172546181;8236.464629799044;868.887044684187;975.1418751498777;995.915347195482;998.256299057207;1012.9493525323704;29484.852575736983;30483;30498;30874.845625771726;31154.532682009787;988.3723835364451;1000.8648832407678;1102.5093833244289;1128.1031579894004;1190.5118901250446;15616.609584760472;15941.601459963595;16284.674306513803;16393.6552921629;16415.343386264656;687792;693923;695479;697485;698991;53065.46934530605;54115.45884541104;59089;60065.69967150224;60487.18538443854;1423.6369725719876;1431.6778724786839;1432.0262221689352;1433.0470237292293;1462.9414823406944;24584.631230531915;30293;31576.894808681587;31734;32849.67150328466;52315.73842130765;52818;52915.470845291056;52927.73536132295;52959;442577;446821;450057;648379;688056;26697.33256668599;26923.92304307884;26984.730152698223;27288.59067113955;27293.863530683015;46366.072678546916;46497.302540462595;46512.767436162605;46805.76597117129;47134.29298560593;39055.2188956225;39079.82760517189;39457.605423946545;39994.800025999684;41318.58681413147;37350.43974340333;38299.04252393601;39705.40441893432;39845.60154398419;41161.58838411578;38694.80652596719;38753.418698718975;43981.900452488946;44627.884302892686;44659;39814.606488772755;43087;43118.56881431145;44458.333125003795;44542.554574455135;31370.84314578504;31702.524462132624;32851.67148328582;32969.67030329666;33496.49755253722 21:22:11 INFO - PROCESS | 1903 | |2;jquery.html;377.7620099337417;378.99052523686913;389.4430963721878;401.21562345614325;408.5607971430711;20517.589648207027;22369.217077402252;22385;22594.66108008379;22915.541689166206;20904.581908361823;21273.68089478655;21596.12213282696;21693.891530542365;21739.3478195654;5635.1828984797285;6062.333143354227;6129.264488261392;6137;6138;3706.814659267039;4312;4481.955180448203;6064.696090340576;6183.536234782387;4455.84404545841;6788.8302792430095;6809.863802723942;6868.244493105754;6885.139357580302;5877.206577112078;6176.258848938156;6220.906686399708;6851.828704282383;6862.828429289283;6097.664628445434;6110.663913484756;6115.969420152871;6118.388161183891;6119.571629985903;13801.654958626115;13893.58319250424;14068.648283792885;14161;14250.714985700331;2197.967030494544;2246.84272100953;2261.185973049701;2268.9546209075725;2971.628546431696;10277.537510811957;10453.15984573709;10689.412082335468;10723.78552428955;10847.891521084766;1513;1748.1696194307729;1844.4927644897625;1893.4265664906175;1900.8574356923286;133035;136680;137367;139572;140049;11017.173711971634;11789.646310610695;11890.76218475643;11903.642890713292;12035.157538972364;14992.925035374972;15000.324985375684;15017.924910375377;15030.473933412497;15044.495550444868;7807.063152421746;8855.778605534784;8856.24721898633;8922.286217102615;8969.820603587892;8898.154675305836;8958.238549723346;8978.730638080868;9074.183323500916;9124.771880703036;4579.015511665008;4587.701799383096;4597.298999370254;4598.287265473857;4647.790849411785;1781.7594624725755;1869.8126689552232;1924.3841970569563;1966.5476940303524;1979.2478858033855;771.6296177834671;884.2572239319003;903.6791938861741;964.9324547281764;980.7646164920368;20309.89845050795;21224.575508489743;22287.77712222857;22316.180880412565;22415.887920560293;920.889493260813;957.9606127351901;960.711786464058;976.2677991506371;1026.9332493387906;11006.889931100746;11843.703907402212;11846.407679616157;11861.406929653484;11862.762744745056;627569;634747;638113;638136;656630;73001;85294;131201;131912;156821.2158939198;1016.364772017489;1045.2996492350144;1059.7827445373835;1062.4183234739658;1068.012088817856;16448.095354755125;18307.718459707692;20444;20496.692549612068;20757;56866.715666421405;57939;58386;60279;60644;81212.5939370323;85522;88298.11701882898;88639.55680221558;91426.54286728789;8224.83550329002;8244.711435099744;8490.957545212234;8559.57202139878;8578.91421085781;12498.125131240726;13472.259025753285;13560.05079644455;13870.514531991332;13911.860881391056;11463;11574.363410012193;11642.301461912313;11732.765344692887;11748.353840538852;11312.377819220023;11418.543258269909;11438.428078596204;11465.713357166138;11716.414179291172;11395.544178232778;11484.88515114838;11485.368304742986;11707.356095414494;11858.940705296418;8277.075140291518;8356.832863342821;8414.326853851555;8451.1548845115;8506.659733610586;8399.160083991552;10421.374717516974;11290.661280161608;11627.302361858316;11699.590514331958 21:22:11 INFO - PROCESS | 1903 | |3;mootools.html;1381.3231516556887;1385.9514916977907;1484.1391992644265;1656.6355401811597;1863.3571417860842;7952.92047079529;8535.57322133894;8702.04277529472;8944.686935957243;8951.239144672694;8749;8846.159614836597;8848;8851.734447966555;8896.510691911943;2404.939876503093;2431.2827715823787;2432.0393444589376;2432.4770174412497;2433.2578563538113;2361.622140457527;2402.411409204747;2407.4462873539096;2408.1932552594812;2409.939751506218;2360.834741568091;2394.0184524345023;2400.5558971590226;2403.4231784371714;2405.6632071510003;2349.306954448442;2375.8812059397046;2386.8806559672034;2388.9641655375185;2391.0316321889663;2330.4639932815376;2366.1954935322074;2367.869767162805;2372.3476044087843;2377.7859992600747;8788.73633790981;8854.247388971946;8930.955345223298;8934.017258101603;8934.86597701035;5268.262443257947;5455.318085239345;5477.096279113942;5519.558435325164;5521.420250873641;3225.7741958062943;3659.432787917877;3671.76133551321;3692.7968961707097;3738.18697931503;1099.3898386395547;1102.9117670586334;1105.535675016495;1129;1134.6369161868206;11727.472263748152;11788.115891308185;11862.169648124634;11883.168178227528;11886.702832429086;4458.665600079942;4519.81920723174;4653.441587009581;4661.743604101807;4712.787924543404;9255.49094799779;9257.028012058772;9259.444433334022;9262.629494820267;9268.212201962908;4569.565891240327;5331.466853314715;5332.760025798849;5333.466653334635;5340.279062326536;4239.766812825263;4518.864434066983;4617.492075871652;4652.837150699777;5024.196128619476;3822.7706337619834;3887.8056097195026;3893.4354518594646;3975.34406822871;3979.2041591681777;1190.1906703441744;1196.6948428150765;1200.6578125234266;1208.9904929383888;1212.2362911365783;817.9918200817916;818.4884447220487;890.2966656341417;916.5737931861717;937.7374335186158;5454.59090568209;5540.63985840919;5549.1676248562235;5861;5885.852853678693;983.8917719050899;1024.6567399920962;1043.6764602973103;1044.6657069737612;1048.821700310949;3792.7345085844277;3810;3811.5426148862316;3925.6270654287796;3929.626685464876;10759.78480430387;10993.945030274797;11074.778504429867;11079.169062320358;11094.44527773608;11040.392778397265;11043.503042362952;11068.225224234226;11068.889311106786;11084.667459976214;8284.420090593721;8291.212334828182;8301.335893128535;8418.747437576883;8450.366222533212;4719.669623126486;5554.91667624994;5713.485786279255;5828.504577110993;5851.502622276984;9881.258905582254;9996.550155242887;10176.949115254673;10284.177265818567;10310;10233.590656373959;10288.845667315147;10323.690289291333;10419.322744021614;10434.321769084985;6306.495480361468;7119.1457025157315;7152.284771522806;7232.963835180791;7262.128544574685;8240.052393974769;8300.294474969694;8358.164183581594;8553.572321383781;8568.314534837322;7534.133574638768;7614.238576142341;7680;7724.806879827825;7818.296353328228;7498.175200728025;7519.097708275042;7523.924760752322;7524.209957954336;7573.053368328959;6900.585964842126;6934.687939042654;7017.473689473208;7018.824529386806;7030.472714546328;4870.439899411613;4904.386951631046;4910.263460480956;4934.654574179773;4949.109160351171;4970.676906001098;4989.376327959005;4997.8750531235555;5101.183810590288;5119.92320115206 21:22:11 INFO - PROCESS | 1903 | |4;prototype.html;305.62255614316325;308.50946994279093;315.24498825313367;320.5384246684774;321;5223.399309079457;5377.946220537793;5412.242286079952;5429.864253393667;5524.972375138123;4710.152172608929;5190.039842629107;5256;5311.1502159654465;5363.942552744937;3701.3522633539155;4115.983168247567;4146.834126634931;4172.70791044627;4175.66594672427;3697.685696715769;3965.762054276738;4119.361498967664;4150.64719498843;4200.3699445083175;4112.930638034118;4116.279651061067;4130.731502452346;4150.3359462486005;4168.583141685837;4101.405296232045;4154.792260386984;4163.10493243951;4176.498820141572;4181.811818468176;3624.2570273094216;3634.5275114235246;3637.5089362936196;3645.325614761278;3647.416413373874;4858.125537403266;5193.221016847466;5308.46915308466;5311.203319502067;5333.439988801198;4198.727082739642;4549.522300158502;4663.60359369454;4700.576948074689;4707.411573553306;4532.728036317799;5704.914426283609;5774.97112514439;5815.9709201453725;5835.5915085944;3774.358359078936;3893.7734613596626;3926.8429262829454;3940.783256920868;3943.704222183319;5954.136650185742;5978.611390259663;5991.430814072656;5998.580099393044;6001.66990815505;4001.3597824347967;4002.8999275017777;4004.439378487014;4014.277430062617;4016;3892.2020985697864;3982.900427489336;3989.501312335958;3996.820143093568;4050.675945924319;4209.821250049991;4621.884452888705;4628.259478483426;4657.045305712389;4681.893148083376;4522.186006518792;5652.463016013472;5661.547076233891;5685.914711279334;5694.857628559319;1223.61456141317;1284.5825106840127;1338.377654390713;1345.5425155447194;1350.7298540291981;756.5763172623239;814.242754238552;835.6824406725527;840.5713086326018;844.2654890245526;4118.876433706993;4492.775361231926;4613.284940834176;4637.3275874997935;4640.489546149921;4093.1404405074672;4881.438634557;4885.438174609894;4890;4931.556159945622;4108.4453598763785;4279.700420970502;4403.669724770655;4436.800343984529;4630.814767409333;2606.4787042591556;2872.482953068468;3044.4519986402215;3103.3172702005522;3122.2662674271983;5357.4106848246665;5891.440313170242;6085.513158947274;6097.75608975636;6098.359672234352;5540.307461567304;6031.487323577545;6058.12157237207;6111.54163437744;6152.907706384408;6222.875542489215;6241.313455519889;6246.718897649525;6251.3123556408755;6277.089821975879;5242.108841496878;5573.944260557342;5974.611650242894;5994.730237139426;6018;4897.46127925935;4997;5134.9486505135965;5199.662021968711;5940.405959404025;4729.881752956204;6143.078538219303;6216.953692690639;6227.314995350417;6265.404786545271;3150.0077475595112;3549.7403116260075;3910.9804450977563;4019.3569028956395;4033.3664865729424;4126.463559737335;5637.041702910433;5730.426957304237;5850.707464626837;5935.970320148372;5374.247605335178;5581.860453488695;5677.517411019944;5715.742791574306;5725.427457254241;5706.629069110494;5712.628679136009;5747.563109222694;5806.303243610793;5826.737796799239;5180.637355385087;5249.343832020997;5507.366652834975;5566.387697353207;5603.523700485504;5721.828345149652;5783.566232532493;5807.651540907559;5811.418858114154;5814.825555233349;5189.483100696084;5429.805442802577;5682;5709.771609135588;5716.142578613241 21:22:11 INFO - PROCESS | 1903 | |5;yui.html;744.3152299884108;757.9621018949053;758.0978635423845;791.8851766493858;827.4538804389105;15509.379624815008;16561.503154905342;16627.501174964742;16653;16664.00015999041;15812.44656437025;16178.595535111628;16234.83765162348;16671.749923751155;16680.83319166808;705.717712914833;724.4023680463612;874.3180319350917;886.0430734806394;888.5779254853958;887.3611000079965;907.2288554728494;909.56340956341;909.6861582753972;911.5943405184662;960.7213907966682;964.1467301438242;964.5900492290783;965.7537327981355;966.9323147379686;957.3394357893031;957.5116690487831;957.5643082397493;957.8275910336137;958.6261358070358;708.4580296073508;708.6846353372752;708.8794904866185;709.0357114324514;709.1277728394052;16436.83563164365;16499.340026399048;16650.417235396704;16688.33246670132;16703.66592668152;14632.268386580628;14716.852831471762;14779.778303325458;14806.185659788707;14833.777493337608;11728.941355293255;11883.821742673867;12024.579139730067;12216.572419965258;12302.384880755926;3838.769673819552;3875.4961854958956;3941.7043721720984;3959;4035.2938235808615;116982;122106.38946805209;126593;126617;130912;9248.907510924939;9292.303077269233;11036.889631103586;11415;11514.481848316678;22685.432864178198;22754;22869.771302286765;22918.65622015671;22975;6965.616891070938;8225.917740822515;8263.669453221924;8324.292435143081;8411.45325553837;4208.36874468826;4517.378168660056;4520.208963431386;4530.07133537624;4583.679142460062;3664.0839790052487;3840.731148819612;3840.9807950960067;3844.2888065707375;3849.1147036181833;640.4236187431349;644.5262731892055;645.9063435801783;651.0429668387463;664.7806223946086;657.3926749098408;660.7951535024158;685.6914388525183;686.6463771157858;709.9716011359591;9713.514324283757;9818;9854.802903941882;10029.348092373972;10069.697909062594;638.9744410223539;647.9870402591922;683.825624465768;685.9211190713032;707.5542408282749;4443.244648409778;4812.590929770939;4818.614510839125;4827.703344023822;4835.226363781778;156373;158735.41264587437;162768;164136;164470;142450;143446;144154.27922860318;145190;145244;116029;123153;123443;124481;125963;8446.957765211135;8611.440256383315;8869.334799889904;9393.154616084312;9442.38624489406;60836.783264335354;66580.33419665741;66695;67213;69733.30266697268;78081.60959195168;86383;90797.54601226952;99223;105607;11544.59593914209;11740.41297935117;11858.822117668069;11923.642290731292;12356.567520136752;12345.753084938071;12939.805902911276;13150.75067868551;13401.932990335376;13974.79037814454;12208.32854193028;12318.630441086782;12446.564370246997;12482.251064936132;12595.559155429515;12836.935815321238;12930.870691293343;12932.159409638343;12954.870451295366;13149.40062966145;12081.758364832478;12137.150399471951;12310.076744244396;12325.137240393446;12808.74382512326;10140.188784897044;10159.390436573534;10403.895961040293;10715;10874.184436167478;9974.451405172786;10142.898571014195;10179.796404071729;10238.283320167517;10238.897611024093 21:22:11 INFO - PROCESS | 1903 | __end_tp_report 21:22:11 INFO - PROCESS | 1903 | __start_cc_report 21:22:11 INFO - PROCESS | 1903 | _x_x_mozilla_cycle_collect,1408 21:22:11 INFO - PROCESS | 1903 | __end_cc_report 21:22:11 INFO - PROCESS | 1903 | __startTimestamp1480396931037__endTimestamp 21:22:11 INFO - PROCESS | 1903 | 21:22:11 INFO - PROCESS | 1903 | ------- Summary: start ------- 21:22:11 INFO - PROCESS | 1903 | Number of tests: 6 21:22:11 INFO - PROCESS | 1903 | 21:22:11 INFO - PROCESS | 1903 | [#0] dojo.html Cycles:165 Average:5700.66 Median:5933.82 stddev:619.04 (10.4%) stddev-sans-first:594.01 21:22:11 INFO - PROCESS | 1903 | Values: 3398.1 3403.5 3416.2 3428.7 3475.8 5589.5 5617.5 5617.9 5630.9 5696.7 5529.7 5612.9 5621.6 5636.8 5669.3 5120.9 5162.9 5164.3 5187.8 5188.4 5074.3 5087.8 5097.3 5245.0 5296.0 4496.9 5201.7 5204.7 5246.6 5253.6 5181.2 5205.7 5224.3 5264.9 5266.1 5133.4 5199.4 5200.1 5209.4 5218.2 5522.4 5527.3 5572.4 5586.7 5597.2 6085.0 6087.1 6095.3 6149.5 6205.6 6167.1 6229.4 6232.5 6238.0 6249.8 5596.2 5628.3 5667.2 5672.1 5687.1 6190.0 6224.9 6233.5 6239.6 6241.6 6068.8 6080.3 6089.9 6099.5 6101.7 6106.3 6112.7 6112.7 6120.4 6163.7 6120.7 6126.4 6135.1 6143.6 6153.6 6097.3 6134.2 6168.0 6173.4 6184.5 4811.2 4892.4 4900.9 4932.9 4958.1 4409.8 4453.5 4469.0 4481.2 4531.1 5894.4 5914.2 5916.0 5920.9 5939.3 6062.6 6273.5 6274.8 6284.4 6287.6 5750.8 5774.3 5833.6 5851.3 5863.7 5382.8 5395.6 5408.3 5417.0 5449.1 6036.7 6265.4 6271.2 6274.9 6277.4 4903.6 6094.7 6117.7 6133.3 6148.8 6214.3 6276.2 6294.7 6296.3 6296.8 6147.2 6151.5 6164.8 6166.5 6184.6 6047.4 6134.8 6224.4 6248.8 6262.4 5945.4 5976.7 5990.9 6054.8 6141.3 6067.4 6083.8 6092.1 6099.2 6099.4 5894.4 5901.3 5933.8 5934.9 5949.3 5912.4 5941.6 5951.3 5960.0 5976.9 5855.9 5866.1 5880.4 5901.2 5934.0 21:22:11 INFO - PROCESS | 1903 | 21:22:11 INFO - PROCESS | 1903 | [#1] ext.html Cycles:180 Average:70394.01 Median:37949.74 stddev:153950.49 (405.7%) stddev-sans-first:154292.83 21:22:11 INFO - PROCESS | 1903 | Values: 462.6 537.5 538.6 545.0 549.3 31881.0 33486.3 42190.9 43575.8 45551.5 36545.6 44529.6 44982.8 45013.8 45026.3 10000.4 10150.7 10166.3 10181.0 10181.5 7939.8 9260.0 9345.4 9362.3 9608.7 11126.4 12391.4 12398.0 12672.6 12693.7 12415.8 12483.9 12525.2 12526.7 12528.4 12222.7 12315.8 12327.9 12329.3 12334.9 42185.9 42499.0 42517.0 42558.0 42568.0 3589.1 3593.7 3658.5 3872.4 3899.3 31150.5 31561.2 32102.7 32394.7 32604.8 2847.9 3274.8 3314.4 3407.9 3458.5 452860.0 462671.0 463881.0 464862.0 465002.0 63158.4 63624.4 63684.7 63719.4 63727.7 35948.8 36666.3 36688.4 37600.4 55984.3 17331.3 17583.3 17587.4 17626.0 17674.2 13307.9 13415.5 13424.9 13445.3 13447.2 16246.6 16815.0 17881.6 18768.5 19168.5 7338.9 7491.4 8027.7 8210.3 8236.5 868.9 975.1 995.9 998.3 1012.9 29484.9 30483.0 30498.0 30874.8 31154.5 988.4 1000.9 1102.5 1128.1 1190.5 15616.6 15941.6 16284.7 16393.7 16415.3 687792.0 693923.0 695479.0 697485.0 698991.0 53065.5 54115.5 59089.0 60065.7 60487.2 1423.6 1431.7 1432.0 1433.0 1462.9 24584.6 30293.0 31576.9 31734.0 32849.7 52315.7 52818.0 52915.5 52927.7 52959.0 442577.0 446821.0 450057.0 648379.0 688056.0 26697.3 26923.9 26984.7 27288.6 27293.9 46366.1 46497.3 46512.8 46805.8 47134.3 39055.2 39079.8 39457.6 39994.8 41318.6 37350.4 38299.0 39705.4 39845.6 41161.6 38694.8 38753.4 43981.9 44627.9 44659.0 39814.6 43087.0 43118.6 44458.3 44542.6 31370.8 31702.5 32851.7 32969.7 33496.5 21:22:11 INFO - PROCESS | 1903 | 21:22:11 INFO - PROCESS | 1903 | [#2] jquery.html Cycles:180 Average:36741.88 Median:22400.44 stddev:106750.44 (476.6%) stddev-sans-first:107014.98 21:22:11 INFO - PROCESS | 1903 | Values: 377.8 379.0 389.4 401.2 408.6 20517.6 22369.2 22385.0 22594.7 22915.5 20904.6 21273.7 21596.1 21693.9 21739.3 5635.2 6062.3 6129.3 6137.0 6138.0 3706.8 4312.0 4482.0 6064.7 6183.5 4455.8 6788.8 6809.9 6868.2 6885.1 5877.2 6176.3 6220.9 6851.8 6862.8 6097.7 6110.7 6116.0 6118.4 6119.6 13801.7 13893.6 14068.6 14161.0 14250.7 2198.0 2246.8 2261.2 2269.0 2971.6 10277.5 10453.2 10689.4 10723.8 10847.9 1513.0 1748.2 1844.5 1893.4 1900.9 133035.0 136680.0 137367.0 139572.0 140049.0 11017.2 11789.6 11890.8 11903.6 12035.2 14992.9 15000.3 15017.9 15030.5 15044.5 7807.1 8855.8 8856.2 8922.3 8969.8 8898.2 8958.2 8978.7 9074.2 9124.8 4579.0 4587.7 4597.3 4598.3 4647.8 1781.8 1869.8 1924.4 1966.5 1979.2 771.6 884.3 903.7 964.9 980.8 20309.9 21224.6 22287.8 22316.2 22415.9 920.9 958.0 960.7 976.3 1026.9 11006.9 11843.7 11846.4 11861.4 11862.8 627569.0 634747.0 638113.0 638136.0 656630.0 73001.0 85294.0 131201.0 131912.0 156821.2 1016.4 1045.3 1059.8 1062.4 1068.0 16448.1 18307.7 20444.0 20496.7 20757.0 56866.7 57939.0 58386.0 60279.0 60644.0 81212.6 85522.0 88298.1 88639.6 91426.5 8224.8 8244.7 8491.0 8559.6 8578.9 12498.1 13472.3 13560.1 13870.5 13911.9 11463.0 11574.4 11642.3 11732.8 11748.4 11312.4 11418.5 11438.4 11465.7 11716.4 11395.5 11484.9 11485.4 11707.4 11858.9 8277.1 8356.8 8414.3 8451.2 8506.7 8399.2 10421.4 11290.7 11627.3 11699.6 21:22:11 INFO - PROCESS | 1903 | 21:22:11 INFO - PROCESS | 1903 | [#3] mootools.html Cycles:180 Average:5722.14 Median:4687.27 stddev:3239.12 (69.1%) stddev-sans-first:3231.77 21:22:11 INFO - PROCESS | 1903 | Values: 1381.3 1386.0 1484.1 1656.6 1863.4 7952.9 8535.6 8702.0 8944.7 8951.2 8749.0 8846.2 8848.0 8851.7 8896.5 2404.9 2431.3 2432.0 2432.5 2433.3 2361.6 2402.4 2407.4 2408.2 2409.9 2360.8 2394.0 2400.6 2403.4 2405.7 2349.3 2375.9 2386.9 2389.0 2391.0 2330.5 2366.2 2367.9 2372.3 2377.8 8788.7 8854.2 8931.0 8934.0 8934.9 5268.3 5455.3 5477.1 5519.6 5521.4 3225.8 3659.4 3671.8 3692.8 3738.2 1099.4 1102.9 1105.5 1129.0 1134.6 11727.5 11788.1 11862.2 11883.2 11886.7 4458.7 4519.8 4653.4 4661.7 4712.8 9255.5 9257.0 9259.4 9262.6 9268.2 4569.6 5331.5 5332.8 5333.5 5340.3 4239.8 4518.9 4617.5 4652.8 5024.2 3822.8 3887.8 3893.4 3975.3 3979.2 1190.2 1196.7 1200.7 1209.0 1212.2 818.0 818.5 890.3 916.6 937.7 5454.6 5540.6 5549.2 5861.0 5885.9 983.9 1024.7 1043.7 1044.7 1048.8 3792.7 3810.0 3811.5 3925.6 3929.6 10759.8 10993.9 11074.8 11079.2 11094.4 11040.4 11043.5 11068.2 11068.9 11084.7 8284.4 8291.2 8301.3 8418.7 8450.4 4719.7 5554.9 5713.5 5828.5 5851.5 9881.3 9996.6 10176.9 10284.2 10310.0 10233.6 10288.8 10323.7 10419.3 10434.3 6306.5 7119.1 7152.3 7233.0 7262.1 8240.1 8300.3 8358.2 8553.6 8568.3 7534.1 7614.2 7680.0 7724.8 7818.3 7498.2 7519.1 7523.9 7524.2 7573.1 6900.6 6934.7 7017.5 7018.8 7030.5 4870.4 4904.4 4910.3 4934.7 4949.1 4970.7 4989.4 4997.9 5101.2 5119.9 21:22:11 INFO - PROCESS | 1903 | 21:22:11 INFO - PROCESS | 1903 | [#4] prototype.html Cycles:180 Average:4586.45 Median:4914.51 stddev:1430.29 (29.1%) stddev-sans-first:1397.75 21:22:11 INFO - PROCESS | 1903 | Values: 305.6 308.5 315.2 320.5 321.0 5223.4 5377.9 5412.2 5429.9 5525.0 4710.2 5190.0 5256.0 5311.2 5363.9 3701.4 4116.0 4146.8 4172.7 4175.7 3697.7 3965.8 4119.4 4150.6 4200.4 4112.9 4116.3 4130.7 4150.3 4168.6 4101.4 4154.8 4163.1 4176.5 4181.8 3624.3 3634.5 3637.5 3645.3 3647.4 4858.1 5193.2 5308.5 5311.2 5333.4 4198.7 4549.5 4663.6 4700.6 4707.4 4532.7 5704.9 5775.0 5816.0 5835.6 3774.4 3893.8 3926.8 3940.8 3943.7 5954.1 5978.6 5991.4 5998.6 6001.7 4001.4 4002.9 4004.4 4014.3 4016.0 3892.2 3982.9 3989.5 3996.8 4050.7 4209.8 4621.9 4628.3 4657.0 4681.9 4522.2 5652.5 5661.5 5685.9 5694.9 1223.6 1284.6 1338.4 1345.5 1350.7 756.6 814.2 835.7 840.6 844.3 4118.9 4492.8 4613.3 4637.3 4640.5 4093.1 4881.4 4885.4 4890.0 4931.6 4108.4 4279.7 4403.7 4436.8 4630.8 2606.5 2872.5 3044.5 3103.3 3122.3 5357.4 5891.4 6085.5 6097.8 6098.4 5540.3 6031.5 6058.1 6111.5 6152.9 6222.9 6241.3 6246.7 6251.3 6277.1 5242.1 5573.9 5974.6 5994.7 6018.0 4897.5 4997.0 5134.9 5199.7 5940.4 4729.9 6143.1 6217.0 6227.3 6265.4 3150.0 3549.7 3911.0 4019.4 4033.4 4126.5 5637.0 5730.4 5850.7 5936.0 5374.2 5581.9 5677.5 5715.7 5725.4 5706.6 5712.6 5747.6 5806.3 5826.7 5180.6 5249.3 5507.4 5566.4 5603.5 5721.8 5783.6 5807.7 5811.4 5814.8 5189.5 5429.8 5682.0 5709.8 5716.1 21:22:11 INFO - PROCESS | 1903 | 21:22:11 INFO - PROCESS | 1903 | [#5] yui.html Cycles:180 Average:26518.36 Median:3751.43 stddev:43634.52 (1163.1%) stddev-sans-first:43714.01 21:22:11 INFO - PROCESS | 1903 | Values: 744.3 758.0 758.1 791.9 827.5 15509.4 16561.5 16627.5 16653.0 16664.0 15812.4 16178.6 16234.8 16671.7 16680.8 705.7 724.4 874.3 886.0 888.6 887.4 907.2 909.6 909.7 911.6 960.7 964.1 964.6 965.8 966.9 957.3 957.5 957.6 957.8 958.6 708.5 708.7 708.9 709.0 709.1 16436.8 16499.3 16650.4 16688.3 16703.7 14632.3 14716.9 14779.8 14806.2 14833.8 11728.9 11883.8 12024.6 12216.6 12302.4 3838.8 3875.5 3941.7 3959.0 4035.3 116982.0 122106.4 126593.0 126617.0 130912.0 9248.9 9292.3 11036.9 11415.0 11514.5 22685.4 22754.0 22869.8 22918.7 22975.0 6965.6 8225.9 8263.7 8324.3 8411.5 4208.4 4517.4 4520.2 4530.1 4583.7 3664.1 3840.7 3841.0 3844.3 3849.1 640.4 644.5 645.9 651.0 664.8 657.4 660.8 685.7 686.6 710.0 9713.5 9818.0 9854.8 10029.3 10069.7 639.0 648.0 683.8 685.9 707.6 4443.2 4812.6 4818.6 4827.7 4835.2 156373.0 158735.4 162768.0 164136.0 164470.0 142450.0 143446.0 144154.3 145190.0 145244.0 116029.0 123153.0 123443.0 124481.0 125963.0 8447.0 8611.4 8869.3 9393.2 9442.4 60836.8 66580.3 66695.0 67213.0 69733.3 78081.6 86383.0 90797.5 99223.0 105607.0 11544.6 11740.4 11858.8 11923.6 12356.6 12345.8 12939.8 13150.8 13401.9 13974.8 12208.3 12318.6 12446.6 12482.3 12595.6 12836.9 12930.9 12932.2 12954.9 13149.4 12081.8 12137.2 12310.1 12325.1 12808.7 10140.2 10159.4 10403.9 10715.0 10874.2 9974.5 10142.9 10179.8 10238.3 10238.9 21:22:11 INFO - PROCESS | 1903 | -------- Summary: end -------- 21:22:11 INFO - PROCESS | 1903 | 21:22:11 INFO - TEST-INFO | 1903: exit 0 21:22:11 INFO - TEST-OK | dromaeo_css | took 1115562ms 21:22:11 INFO - TEST-START | kraken 21:22:11 INFO - operating with platform_type : mac_ 21:22:11 INFO - Initialising browser for kraken test... 21:22:11 INFO - TEST-INFO | started process 1908 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmp4AqmUO/profile http://localhost:51267/getInfo.html) 21:22:13 INFO - PROCESS | 1908 | __metrics Screen width/height:1600/1200 21:22:13 INFO - PROCESS | 1908 | colorDepth:24 21:22:13 INFO - PROCESS | 1908 | Browser inner width/height: 1024/689 21:22:13 INFO - PROCESS | 1908 | __metrics 21:22:13 INFO - PROCESS | 1908 | 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" 21:22:13 INFO - PROCESS | 1908 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:22:14 INFO - TEST-INFO | 1908: exit 0 21:22:14 INFO - Browser initialized. 21:22:14 INFO - Running cycle 1/1 for kraken test... 21:22:14 INFO - TEST-INFO | started process 1910 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmp4AqmUO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:22:26 INFO - PROCESS | 1910 | RSS: Main: 168984576 21:22:26 INFO - PROCESS | 1910 | 21:22:29 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:51267/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51267/tests/kraken/driver.html?testName=audio-beat-detection) 21:22:30 INFO - PROCESS | 1910 | RSS: Main: 218783744 21:22:30 INFO - PROCESS | 1910 | 21:22:32 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:51267/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51267/tests/kraken/driver.html?testName=audio-dft) 21:22:33 INFO - PROCESS | 1910 | RSS: Main: 232681472 21:22:33 INFO - PROCESS | 1910 | 21:22:36 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:51267/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51267/tests/kraken/driver.html?testName=audio-fft) 21:22:36 INFO - PROCESS | 1910 | RSS: Main: 330469376 21:22:36 INFO - PROCESS | 1910 | 21:22:38 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:51267/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51267/tests/kraken/driver.html?testName=audio-oscillator) 21:22:39 INFO - PROCESS | 1910 | RSS: Main: 228855808 21:22:39 INFO - PROCESS | 1910 | 21:22:41 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:51267/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51267/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:22:42 INFO - PROCESS | 1910 | RSS: Main: 229457920 21:22:42 INFO - PROCESS | 1910 | 21:22:44 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:51267/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51267/tests/kraken/driver.html?testName=imaging-darkroom) 21:22:45 INFO - PROCESS | 1910 | RSS: Main: 268713984 21:22:45 INFO - PROCESS | 1910 | 21:22:48 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:51267/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51267/tests/kraken/driver.html?testName=imaging-desaturate) 21:22:48 INFO - PROCESS | 1910 | RSS: Main: 268505088 21:22:48 INFO - PROCESS | 1910 | 21:22:51 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:51267/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51267/tests/kraken/driver.html?testName=json-parse-financial) 21:22:52 INFO - PROCESS | 1910 | RSS: Main: 268218368 21:22:52 INFO - PROCESS | 1910 | 21:22:53 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:51267/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51267/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:22:54 INFO - PROCESS | 1910 | RSS: Main: 240726016 21:22:54 INFO - PROCESS | 1910 | 21:22:56 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:51267/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51267/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:22:56 INFO - PROCESS | 1910 | RSS: Main: 245768192 21:22:56 INFO - PROCESS | 1910 | 21:22:59 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:51267/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51267/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:22:59 INFO - PROCESS | 1910 | RSS: Main: 252796928 21:22:59 INFO - PROCESS | 1910 | 21:23:02 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:51267/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:23:03 INFO - PROCESS | 1910 | RSS: Main: 258768896 21:23:03 INFO - PROCESS | 1910 | 21:23:06 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:51267/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:23:06 INFO - PROCESS | 1910 | RSS: Main: 258830336 21:23:06 INFO - PROCESS | 1910 | 21:23:08 INFO - PROCESS | 1910 | Cycle 1(1): loaded http://localhost:51267/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51267/tests/kraken/driver.html?testName=ai-astar) 21:23:08 INFO - PROCESS | 1910 | RSS: Main: 302419968 21:23:08 INFO - PROCESS | 1910 | 21:23:08 INFO - PROCESS | 1910 | __start_tp_report 21:23:08 INFO - PROCESS | 1910 | _x_x_mozilla_page_load 21:23:08 INFO - PROCESS | 1910 | _x_x_mozilla_page_load_details 21:23:08 INFO - PROCESS | 1910 | |i|pagename|runs| 21:23:08 INFO - PROCESS | 1910 | |0;ai-astar;113;112;112;111;110;111;112;112;111;111 21:23:08 INFO - PROCESS | 1910 | |1;audio-beat-detection;142;108;109;165;137;115;106;105;138;107 21:23:08 INFO - PROCESS | 1910 | |2;audio-dft;185;184;184;184;184;184;179;183;184;185 21:23:08 INFO - PROCESS | 1910 | |3;audio-fft;81;57;60;89;61;58;58;58;80;56 21:23:08 INFO - PROCESS | 1910 | |4;audio-oscillator;87;69;94;70;67;68;93;68;68;89 21:23:08 INFO - PROCESS | 1910 | |5;imaging-gaussian-blur;89;87;91;87;89;86;90;87;90;86 21:23:08 INFO - PROCESS | 1910 | |6;imaging-darkroom;94;93;93;93;95;93;119;148;111;94 21:23:08 INFO - PROCESS | 1910 | |7;imaging-desaturate;84;84;86;86;87;86;84;86;85;84 21:23:08 INFO - PROCESS | 1910 | |8;json-parse-financial;56;55;53;52;53;56;56;55;56;56 21:23:08 INFO - PROCESS | 1910 | |9;json-stringify-tinderbox;63;74;69;74;71;68;69;72;71;71 21:23:08 INFO - PROCESS | 1910 | |10;stanford-crypto-aes;84;84;79;82;78;80;81;83;81;87 21:23:08 INFO - PROCESS | 1910 | |11;stanford-crypto-ccm;134;135;137;175;122;141;144;149;168;147 21:23:08 INFO - PROCESS | 1910 | |12;stanford-crypto-pbkdf2;161;163;162;162;162;161;161;162;166;218 21:23:08 INFO - PROCESS | 1910 | |13;stanford-crypto-sha256-iterative;66;65;67;65;64;65;65;65;62;75 21:23:08 INFO - PROCESS | 1910 | __end_tp_report 21:23:08 INFO - PROCESS | 1910 | __start_cc_report 21:23:08 INFO - PROCESS | 1910 | _x_x_mozilla_cycle_collect,1876 21:23:08 INFO - PROCESS | 1910 | __end_cc_report 21:23:08 INFO - PROCESS | 1910 | __startTimestamp1480396988631__endTimestamp 21:23:08 INFO - PROCESS | 1910 | 21:23:08 INFO - PROCESS | 1910 | ------- Summary: start ------- 21:23:08 INFO - PROCESS | 1910 | Number of tests: 14 21:23:08 INFO - PROCESS | 1910 | 21:23:08 INFO - PROCESS | 1910 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:0.85 (0.8%) stddev-sans-first:0.71 21:23:08 INFO - PROCESS | 1910 | Values: 113.0 112.0 112.0 111.0 110.0 111.0 112.0 112.0 111.0 111.0 21:23:08 INFO - PROCESS | 1910 | 21:23:08 INFO - PROCESS | 1910 | [#1] audio-beat-detection Cycles:10 Average:123.20 Median:126.00 stddev:20.82 (16.5%) stddev-sans-first:20.94 21:23:08 INFO - PROCESS | 1910 | Values: 142.0 108.0 109.0 165.0 137.0 115.0 106.0 105.0 138.0 107.0 21:23:08 INFO - PROCESS | 1910 | 21:23:08 INFO - PROCESS | 1910 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.00 stddev:1.71 (0.9%) stddev-sans-first:1.74 21:23:08 INFO - PROCESS | 1910 | Values: 185.0 184.0 184.0 184.0 184.0 184.0 179.0 183.0 184.0 185.0 21:23:08 INFO - PROCESS | 1910 | 21:23:08 INFO - PROCESS | 1910 | [#3] audio-fft Cycles:10 Average:65.80 Median:60.50 stddev:12.40 (20.5%) stddev-sans-first:11.87 21:23:08 INFO - PROCESS | 1910 | Values: 81.0 57.0 60.0 89.0 61.0 58.0 58.0 58.0 80.0 56.0 21:23:08 INFO - PROCESS | 1910 | 21:23:08 INFO - PROCESS | 1910 | [#4] audio-oscillator Cycles:10 Average:77.30 Median:78.50 stddev:11.76 (15.0%) stddev-sans-first:11.94 21:23:08 INFO - PROCESS | 1910 | Values: 87.0 69.0 94.0 70.0 67.0 68.0 93.0 68.0 68.0 89.0 21:23:08 INFO - PROCESS | 1910 | 21:23:08 INFO - PROCESS | 1910 | [#5] imaging-gaussian-blur Cycles:10 Average:88.20 Median:89.00 stddev:1.81 (2.0%) stddev-sans-first:1.90 21:23:08 INFO - PROCESS | 1910 | Values: 89.0 87.0 91.0 87.0 89.0 86.0 90.0 87.0 90.0 86.0 21:23:08 INFO - PROCESS | 1910 | 21:23:08 INFO - PROCESS | 1910 | [#6] imaging-darkroom Cycles:10 Average:103.30 Median:93.00 stddev:18.17 (19.5%) stddev-sans-first:18.95 21:23:08 INFO - PROCESS | 1910 | Values: 94.0 93.0 93.0 93.0 95.0 93.0 119.0 148.0 111.0 94.0 21:23:08 INFO - PROCESS | 1910 | 21:23:08 INFO - PROCESS | 1910 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:86.00 stddev:1.14 (1.3%) stddev-sans-first:1.12 21:23:08 INFO - PROCESS | 1910 | Values: 84.0 84.0 86.0 86.0 87.0 86.0 84.0 86.0 85.0 84.0 21:23:08 INFO - PROCESS | 1910 | 21:23:08 INFO - PROCESS | 1910 | [#8] json-parse-financial Cycles:10 Average:54.80 Median:56.00 stddev:1.55 (2.8%) stddev-sans-first:1.58 21:23:08 INFO - PROCESS | 1910 | Values: 56.0 55.0 53.0 52.0 53.0 56.0 56.0 55.0 56.0 56.0 21:23:08 INFO - PROCESS | 1910 | 21:23:08 INFO - PROCESS | 1910 | [#9] json-stringify-tinderbox Cycles:10 Average:70.20 Median:71.00 stddev:3.22 (4.5%) stddev-sans-first:2.12 21:23:08 INFO - PROCESS | 1910 | Values: 63.0 74.0 69.0 74.0 71.0 68.0 69.0 72.0 71.0 71.0 21:23:08 INFO - PROCESS | 1910 | 21:23:08 INFO - PROCESS | 1910 | [#10] stanford-crypto-aes Cycles:10 Average:81.90 Median:82.50 stddev:2.69 (3.3%) stddev-sans-first:2.74 21:23:08 INFO - PROCESS | 1910 | Values: 84.0 84.0 79.0 82.0 78.0 80.0 81.0 83.0 81.0 87.0 21:23:08 INFO - PROCESS | 1910 | 21:23:08 INFO - PROCESS | 1910 | [#11] stanford-crypto-ccm Cycles:10 Average:145.20 Median:145.50 stddev:15.92 (10.9%) stddev-sans-first:16.36 21:23:08 INFO - PROCESS | 1910 | Values: 134.0 135.0 137.0 175.0 122.0 141.0 144.0 149.0 168.0 147.0 21:23:08 INFO - PROCESS | 1910 | 21:23:08 INFO - PROCESS | 1910 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.80 Median:162.00 stddev:17.70 (10.9%) stddev-sans-first:18.60 21:23:08 INFO - PROCESS | 1910 | Values: 161.0 163.0 162.0 162.0 162.0 161.0 161.0 162.0 166.0 218.0 21:23:08 INFO - PROCESS | 1910 | 21:23:08 INFO - PROCESS | 1910 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:65.00 stddev:3.45 (5.3%) stddev-sans-first:3.66 21:23:08 INFO - PROCESS | 1910 | Values: 66.0 65.0 67.0 65.0 64.0 65.0 65.0 65.0 62.0 75.0 21:23:08 INFO - PROCESS | 1910 | -------- Summary: end -------- 21:23:08 INFO - PROCESS | 1910 | 21:23:09 INFO - TEST-INFO | 1910: exit 0 21:23:09 INFO - TEST-OK | kraken | took 57780ms 21:23:09 INFO - SUITE-END | took 1173s 21:23:09 INFO - Completed test suite (00:19:33) 21:23:09 INFO - javascript benchmark 21:23:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3398.116489712674, 3403.489476578514, 3416.214270717733, 3428.725701943845, 3475.8262086895666, 5589.469000444957, 5617.494425501704, 5617.9438205617935, 5630.859228519289, 5696.6866822324755, 5529.695866727328, 5612.887742245152, 5621.634593751413, 5636.802711905084, 5669.319681638199, 5120.8975820483665, 5162.896742065156, 5164.302819119408, 5187.766550505236, 5188.429272779991, 5074.314967479399, 5087.821926232583, 5097.3373461449955, 5245.029669511134, 5295.9672863791575, 4496.9325460118125, 5201.739913004353, 5204.713740744258, 5246.632735708502, 5253.553447956928, 5181.1969144782615, 5205.739713014372, 5224.346956630421, 5264.92102618461, 5266.131088370415, 5133.409657889316, 5199.376074871002, 5200.115980283361, 5209.426963034063, 5218.165093585046, 5522.364928033247, 5527.309086364205, 5572.359178694421, 5586.692731899744, 5597.244372009808, 6084.969575152096, 6087.117367981662, 6095.268567771852, 6149.5080393568405, 6205.596636218631, 6167.136600875836, 6229.37706229378, 6232.532560057968, 6238.0, 6249.750009999594, 5596.188552659883, 5628.296462942132, 5667.234923285345, 5672.092465205547, 5687.061634830289, 6189.96905015481, 6224.906626400608, 6233.532485063638, 6239.563230573907, 6241.594296370812, 6068.75724971005, 6080.300765411946, 6089.939100609025, 6099.512039036867, 6101.694915254308, 6106.339326077157, 6112.694365281718, 6112.74665817949, 6120.386183820636, 6163.660998645028, 6120.721420533258, 6126.35800436956, 6135.140940401905, 6143.556264277891, 6153.600015998945, 6097.298810636745, 6134.2332208473945, 6168.013117901114, 6173.444390004921, 6184.474319682878, 4811.182099043171, 4892.363992680928, 4900.901981960412, 4932.8520144395725, 4958.107540642647, 4409.757463339547, 4453.532379100147, 4469.0, 4481.2381895077915, 4531.116432295737, 5894.410558944071, 5914.172015917775, 5915.970420147958, 5920.911186332209, 5939.287285525765, 6062.605930614496, 6273.498120150377, 6274.811755647246, 6284.402981716729, 6287.59130656515, 5750.7987220447085, 5774.2782152230975, 5833.562482813806, 5851.268591426072, 5863.67749773758, 5382.784688612412, 5395.649282796606, 5408.2969214002715, 5416.9729151353995, 5449.100898351807, 6036.732286219767, 6265.404786545271, 6271.153394291712, 6274.874502510015, 6277.372262773777, 4903.5586797188425, 6094.7257373417415, 6117.736059405574, 6133.26400831903, 6148.846278843064, 6214.2853571838, 6276.246850377801, 6294.716737746904, 6296.33888441707, 6296.84257893538, 6147.200863887666, 6151.477124444294, 6164.7842325518395, 6166.537509686881, 6184.628922264678, 6047.365026672312, 6134.846628834315, 6224.439800417984, 6248.812535623939, 6262.436380725757, 5945.375735547878, 5976.731047102804, 5990.940090599038, 6054.788082417094, 6141.324454310112, 6067.362926892612, 6083.8174854754425, 6092.147099405998, 6099.176611157614, 6099.420555047441, 5894.38108998549, 5901.262342207224, 5933.821985340447, 5934.9406505934385, 5949.286085669747, 5912.408759124053, 5941.643501389931, 5951.256092988377, 5960.0, 5976.940230597638, 5855.9121613176685, 5866.149408335682, 5880.411958804257, 5901.232839730979, 5934.0], "value": 5662.410486007788, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [462.6345187302032, 537.4759609380852, 538.6095081066226, 544.9509544141029, 549.2585010236181, 31881.0, 33486.330273394546, 42190.94522636932, 43575.78212108943, 45551.54448455515, 36545.63454365455, 44529.554704452945, 44982.7750861246, 45013.77493112538, 45026.32460513087, 10000.449975251358, 10150.6954791356, 10166.339187952759, 10181.0, 10181.490925453734, 7939.801504962365, 9260.0, 9345.439273643604, 9362.251019918423, 9608.66369677058, 11126.38804865732, 12391.380430978461, 12398.008159347275, 12672.556460523883, 12693.68265793358, 12415.751684966295, 12483.937580312131, 12525.248485090833, 12526.74946501074, 12528.436220370106, 12222.694432639166, 12315.815262771066, 12327.876721232762, 12329.260244385365, 12334.938325308316, 42185.94535136616, 42499.0, 42517.0, 42558.0, 42568.0, 3589.1206654369585, 3593.7304702147444, 3658.487811706363, 3872.3997780344093, 3899.259140763246, 31150.532742008887, 31561.21096972571, 32102.733508920555, 32394.6760532394, 32604.836975814967, 2847.9145625631263, 3274.787138835968, 3314.419976504102, 3407.9318413631836, 3458.4639380896, 452860.0, 462671.0, 463881.0, 464862.0, 465002.0, 63158.36841631525, 63624.36375636185, 63684.68157659182, 63719.36280637227, 63727.6813615929, 35948.820255899074, 36666.26667466636, 36688.44967325492, 37600.43599346012, 55984.32047038595, 17331.306747730203, 17583.29666813313, 17587.384441544484, 17626.0, 17674.204660790296, 13307.866921330857, 13415.463381464828, 13424.926005919502, 13445.260510671811, 13447.193168409927, 16246.619037381719, 16815.0, 17881.552961176076, 18768.49852011836, 19168.52078698016, 7338.935854301203, 7491.444985637567, 8027.678892844221, 8210.343172546181, 8236.464629799044, 868.887044684187, 975.1418751498777, 995.915347195482, 998.256299057207, 1012.9493525323704, 29484.852575736983, 30483.0, 30498.0, 30874.845625771726, 31154.532682009787, 988.3723835364451, 1000.8648832407678, 1102.5093833244289, 1128.1031579894004, 1190.5118901250446, 15616.609584760472, 15941.601459963595, 16284.674306513803, 16393.6552921629, 16415.343386264656, 687792.0, 693923.0, 695479.0, 697485.0, 698991.0, 53065.46934530605, 54115.45884541104, 59089.0, 60065.69967150224, 60487.18538443854, 1423.6369725719876, 1431.6778724786839, 1432.0262221689352, 1433.0470237292293, 1462.9414823406944, 24584.631230531915, 30293.0, 31576.894808681587, 31734.0, 32849.67150328466, 52315.73842130765, 52818.0, 52915.470845291056, 52927.73536132295, 52959.0, 442577.0, 446821.0, 450057.0, 648379.0, 688056.0, 26697.33256668599, 26923.92304307884, 26984.730152698223, 27288.59067113955, 27293.863530683015, 46366.072678546916, 46497.302540462595, 46512.767436162605, 46805.76597117129, 47134.29298560593, 39055.2188956225, 39079.82760517189, 39457.605423946545, 39994.800025999684, 41318.58681413147, 37350.43974340333, 38299.04252393601, 39705.40441893432, 39845.60154398419, 41161.58838411578, 38694.80652596719, 38753.418698718975, 43981.900452488946, 44627.884302892686, 44659.0, 39814.606488772755, 43087.0, 43118.56881431145, 44458.333125003795, 44542.554574455135, 31370.84314578504, 31702.524462132624, 32851.67148328582, 32969.67030329666, 33496.49755253722], "value": 20827.648924479723, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.7620099337417, 378.99052523686913, 389.4430963721878, 401.21562345614325, 408.5607971430711, 20517.589648207027, 22369.217077402252, 22385.0, 22594.66108008379, 22915.541689166206, 20904.581908361823, 21273.68089478655, 21596.12213282696, 21693.891530542365, 21739.3478195654, 5635.1828984797285, 6062.333143354227, 6129.264488261392, 6137.0, 6138.0, 3706.814659267039, 4312.0, 4481.955180448203, 6064.696090340576, 6183.536234782387, 4455.84404545841, 6788.8302792430095, 6809.863802723942, 6868.244493105754, 6885.139357580302, 5877.206577112078, 6176.258848938156, 6220.906686399708, 6851.828704282383, 6862.828429289283, 6097.664628445434, 6110.663913484756, 6115.969420152871, 6118.388161183891, 6119.571629985903, 13801.654958626115, 13893.58319250424, 14068.648283792885, 14161.0, 14250.714985700331, 2197.967030494544, 2246.84272100953, 2261.185973049701, 2268.9546209075725, 2971.628546431696, 10277.537510811957, 10453.15984573709, 10689.412082335468, 10723.78552428955, 10847.891521084766, 1513.0, 1748.1696194307729, 1844.4927644897625, 1893.4265664906175, 1900.8574356923286, 133035.0, 136680.0, 137367.0, 139572.0, 140049.0, 11017.173711971634, 11789.646310610695, 11890.76218475643, 11903.642890713292, 12035.157538972364, 14992.925035374972, 15000.324985375684, 15017.924910375377, 15030.473933412497, 15044.495550444868, 7807.063152421746, 8855.778605534784, 8856.24721898633, 8922.286217102615, 8969.820603587892, 8898.154675305836, 8958.238549723346, 8978.730638080868, 9074.183323500916, 9124.771880703036, 4579.015511665008, 4587.701799383096, 4597.298999370254, 4598.287265473857, 4647.790849411785, 1781.7594624725755, 1869.8126689552232, 1924.3841970569563, 1966.5476940303524, 1979.2478858033855, 771.6296177834671, 884.2572239319003, 903.6791938861741, 964.9324547281764, 980.7646164920368, 20309.89845050795, 21224.575508489743, 22287.77712222857, 22316.180880412565, 22415.887920560293, 920.889493260813, 957.9606127351901, 960.711786464058, 976.2677991506371, 1026.9332493387906, 11006.889931100746, 11843.703907402212, 11846.407679616157, 11861.406929653484, 11862.762744745056, 627569.0, 634747.0, 638113.0, 638136.0, 656630.0, 73001.0, 85294.0, 131201.0, 131912.0, 156821.2158939198, 1016.364772017489, 1045.2996492350144, 1059.7827445373835, 1062.4183234739658, 1068.012088817856, 16448.095354755125, 18307.718459707692, 20444.0, 20496.692549612068, 20757.0, 56866.715666421405, 57939.0, 58386.0, 60279.0, 60644.0, 81212.5939370323, 85522.0, 88298.11701882898, 88639.55680221558, 91426.54286728789, 8224.83550329002, 8244.711435099744, 8490.957545212234, 8559.57202139878, 8578.91421085781, 12498.125131240726, 13472.259025753285, 13560.05079644455, 13870.514531991332, 13911.860881391056, 11463.0, 11574.363410012193, 11642.301461912313, 11732.765344692887, 11748.353840538852, 11312.377819220023, 11418.543258269909, 11438.428078596204, 11465.713357166138, 11716.414179291172, 11395.544178232778, 11484.88515114838, 11485.368304742986, 11707.356095414494, 11858.940705296418, 8277.075140291518, 8356.832863342821, 8414.326853851555, 8451.1548845115, 8506.659733610586, 8399.160083991552, 10421.374717516974, 11290.661280161608, 11627.302361858316, 11699.590514331958], "value": 9740.501211079125, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1381.3231516556887, 1385.9514916977907, 1484.1391992644265, 1656.6355401811597, 1863.3571417860842, 7952.92047079529, 8535.57322133894, 8702.04277529472, 8944.686935957243, 8951.239144672694, 8749.0, 8846.159614836597, 8848.0, 8851.734447966555, 8896.510691911943, 2404.939876503093, 2431.2827715823787, 2432.0393444589376, 2432.4770174412497, 2433.2578563538113, 2361.622140457527, 2402.411409204747, 2407.4462873539096, 2408.1932552594812, 2409.939751506218, 2360.834741568091, 2394.0184524345023, 2400.5558971590226, 2403.4231784371714, 2405.6632071510003, 2349.306954448442, 2375.8812059397046, 2386.8806559672034, 2388.9641655375185, 2391.0316321889663, 2330.4639932815376, 2366.1954935322074, 2367.869767162805, 2372.3476044087843, 2377.7859992600747, 8788.73633790981, 8854.247388971946, 8930.955345223298, 8934.017258101603, 8934.86597701035, 5268.262443257947, 5455.318085239345, 5477.096279113942, 5519.558435325164, 5521.420250873641, 3225.7741958062943, 3659.432787917877, 3671.76133551321, 3692.7968961707097, 3738.18697931503, 1099.3898386395547, 1102.9117670586334, 1105.535675016495, 1129.0, 1134.6369161868206, 11727.472263748152, 11788.115891308185, 11862.169648124634, 11883.168178227528, 11886.702832429086, 4458.665600079942, 4519.81920723174, 4653.441587009581, 4661.743604101807, 4712.787924543404, 9255.49094799779, 9257.028012058772, 9259.444433334022, 9262.629494820267, 9268.212201962908, 4569.565891240327, 5331.466853314715, 5332.760025798849, 5333.466653334635, 5340.279062326536, 4239.766812825263, 4518.864434066983, 4617.492075871652, 4652.837150699777, 5024.196128619476, 3822.7706337619834, 3887.8056097195026, 3893.4354518594646, 3975.34406822871, 3979.2041591681777, 1190.1906703441744, 1196.6948428150765, 1200.6578125234266, 1208.9904929383888, 1212.2362911365783, 817.9918200817916, 818.4884447220487, 890.2966656341417, 916.5737931861717, 937.7374335186158, 5454.59090568209, 5540.63985840919, 5549.1676248562235, 5861.0, 5885.852853678693, 983.8917719050899, 1024.6567399920962, 1043.6764602973103, 1044.6657069737612, 1048.821700310949, 3792.7345085844277, 3810.0, 3811.5426148862316, 3925.6270654287796, 3929.626685464876, 10759.78480430387, 10993.945030274797, 11074.778504429867, 11079.169062320358, 11094.44527773608, 11040.392778397265, 11043.503042362952, 11068.225224234226, 11068.889311106786, 11084.667459976214, 8284.420090593721, 8291.212334828182, 8301.335893128535, 8418.747437576883, 8450.366222533212, 4719.669623126486, 5554.91667624994, 5713.485786279255, 5828.504577110993, 5851.502622276984, 9881.258905582254, 9996.550155242887, 10176.949115254673, 10284.177265818567, 10310.0, 10233.590656373959, 10288.845667315147, 10323.690289291333, 10419.322744021614, 10434.321769084985, 6306.495480361468, 7119.1457025157315, 7152.284771522806, 7232.963835180791, 7262.128544574685, 8240.052393974769, 8300.294474969694, 8358.164183581594, 8553.572321383781, 8568.314534837322, 7534.133574638768, 7614.238576142341, 7680.0, 7724.806879827825, 7818.296353328228, 7498.175200728025, 7519.097708275042, 7523.924760752322, 7524.209957954336, 7573.053368328959, 6900.585964842126, 6934.687939042654, 7017.473689473208, 7018.824529386806, 7030.472714546328, 4870.439899411613, 4904.386951631046, 4910.263460480956, 4934.654574179773, 4949.109160351171, 4970.676906001098, 4989.376327959005, 4997.8750531235555, 5101.183810590288, 5119.92320115206], "value": 4594.982656689106, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.62255614316325, 308.50946994279093, 315.24498825313367, 320.5384246684774, 321.0, 5223.399309079457, 5377.946220537793, 5412.242286079952, 5429.864253393667, 5524.972375138123, 4710.152172608929, 5190.039842629107, 5256.0, 5311.1502159654465, 5363.942552744937, 3701.3522633539155, 4115.983168247567, 4146.834126634931, 4172.70791044627, 4175.66594672427, 3697.685696715769, 3965.762054276738, 4119.361498967664, 4150.64719498843, 4200.3699445083175, 4112.930638034118, 4116.279651061067, 4130.731502452346, 4150.3359462486005, 4168.583141685837, 4101.405296232045, 4154.792260386984, 4163.10493243951, 4176.498820141572, 4181.811818468176, 3624.2570273094216, 3634.5275114235246, 3637.5089362936196, 3645.325614761278, 3647.416413373874, 4858.125537403266, 5193.221016847466, 5308.46915308466, 5311.203319502067, 5333.439988801198, 4198.727082739642, 4549.522300158502, 4663.60359369454, 4700.576948074689, 4707.411573553306, 4532.728036317799, 5704.914426283609, 5774.97112514439, 5815.9709201453725, 5835.5915085944, 3774.358359078936, 3893.7734613596626, 3926.8429262829454, 3940.783256920868, 3943.704222183319, 5954.136650185742, 5978.611390259663, 5991.430814072656, 5998.580099393044, 6001.66990815505, 4001.3597824347967, 4002.8999275017777, 4004.439378487014, 4014.277430062617, 4016.0, 3892.2020985697864, 3982.900427489336, 3989.501312335958, 3996.820143093568, 4050.675945924319, 4209.821250049991, 4621.884452888705, 4628.259478483426, 4657.045305712389, 4681.893148083376, 4522.186006518792, 5652.463016013472, 5661.547076233891, 5685.914711279334, 5694.857628559319, 1223.61456141317, 1284.5825106840127, 1338.377654390713, 1345.5425155447194, 1350.7298540291981, 756.5763172623239, 814.242754238552, 835.6824406725527, 840.5713086326018, 844.2654890245526, 4118.876433706993, 4492.775361231926, 4613.284940834176, 4637.3275874997935, 4640.489546149921, 4093.1404405074672, 4881.438634557, 4885.438174609894, 4890.0, 4931.556159945622, 4108.4453598763785, 4279.700420970502, 4403.669724770655, 4436.800343984529, 4630.814767409333, 2606.4787042591556, 2872.482953068468, 3044.4519986402215, 3103.3172702005522, 3122.2662674271983, 5357.4106848246665, 5891.440313170242, 6085.513158947274, 6097.75608975636, 6098.359672234352, 5540.307461567304, 6031.487323577545, 6058.12157237207, 6111.54163437744, 6152.907706384408, 6222.875542489215, 6241.313455519889, 6246.718897649525, 6251.3123556408755, 6277.089821975879, 5242.108841496878, 5573.944260557342, 5974.611650242894, 5994.730237139426, 6018.0, 4897.46127925935, 4997.0, 5134.9486505135965, 5199.662021968711, 5940.405959404025, 4729.881752956204, 6143.078538219303, 6216.953692690639, 6227.314995350417, 6265.404786545271, 3150.0077475595112, 3549.7403116260075, 3910.9804450977563, 4019.3569028956395, 4033.3664865729424, 4126.463559737335, 5637.041702910433, 5730.426957304237, 5850.707464626837, 5935.970320148372, 5374.247605335178, 5581.860453488695, 5677.517411019944, 5715.742791574306, 5725.427457254241, 5706.629069110494, 5712.628679136009, 5747.563109222694, 5806.303243610793, 5826.737796799239, 5180.637355385087, 5249.343832020997, 5507.366652834975, 5566.387697353207, 5603.523700485504, 5721.828345149652, 5783.566232532493, 5807.651540907559, 5811.418858114154, 5814.825555233349, 5189.483100696084, 5429.805442802577, 5682.0, 5709.771609135588, 5716.142578613241], "value": 4126.380296343047, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [744.3152299884108, 757.9621018949053, 758.0978635423845, 791.8851766493858, 827.4538804389105, 15509.379624815008, 16561.503154905342, 16627.501174964742, 16653.0, 16664.00015999041, 15812.44656437025, 16178.595535111628, 16234.83765162348, 16671.749923751155, 16680.83319166808, 705.717712914833, 724.4023680463612, 874.3180319350917, 886.0430734806394, 888.5779254853958, 887.3611000079965, 907.2288554728494, 909.56340956341, 909.6861582753972, 911.5943405184662, 960.7213907966682, 964.1467301438242, 964.5900492290783, 965.7537327981355, 966.9323147379686, 957.3394357893031, 957.5116690487831, 957.5643082397493, 957.8275910336137, 958.6261358070358, 708.4580296073508, 708.6846353372752, 708.8794904866185, 709.0357114324514, 709.1277728394052, 16436.83563164365, 16499.340026399048, 16650.417235396704, 16688.33246670132, 16703.66592668152, 14632.268386580628, 14716.852831471762, 14779.778303325458, 14806.185659788707, 14833.777493337608, 11728.941355293255, 11883.821742673867, 12024.579139730067, 12216.572419965258, 12302.384880755926, 3838.769673819552, 3875.4961854958956, 3941.7043721720984, 3959.0, 4035.2938235808615, 116982.0, 122106.38946805209, 126593.0, 126617.0, 130912.0, 9248.907510924939, 9292.303077269233, 11036.889631103586, 11415.0, 11514.481848316678, 22685.432864178198, 22754.0, 22869.771302286765, 22918.65622015671, 22975.0, 6965.616891070938, 8225.917740822515, 8263.669453221924, 8324.292435143081, 8411.45325553837, 4208.36874468826, 4517.378168660056, 4520.208963431386, 4530.07133537624, 4583.679142460062, 3664.0839790052487, 3840.731148819612, 3840.9807950960067, 3844.2888065707375, 3849.1147036181833, 640.4236187431349, 644.5262731892055, 645.9063435801783, 651.0429668387463, 664.7806223946086, 657.3926749098408, 660.7951535024158, 685.6914388525183, 686.6463771157858, 709.9716011359591, 9713.514324283757, 9818.0, 9854.802903941882, 10029.348092373972, 10069.697909062594, 638.9744410223539, 647.9870402591922, 683.825624465768, 685.9211190713032, 707.5542408282749, 4443.244648409778, 4812.590929770939, 4818.614510839125, 4827.703344023822, 4835.226363781778, 156373.0, 158735.41264587437, 162768.0, 164136.0, 164470.0, 142450.0, 143446.0, 144154.27922860318, 145190.0, 145244.0, 116029.0, 123153.0, 123443.0, 124481.0, 125963.0, 8446.957765211135, 8611.440256383315, 8869.334799889904, 9393.154616084312, 9442.38624489406, 60836.783264335354, 66580.33419665741, 66695.0, 67213.0, 69733.30266697268, 78081.60959195168, 86383.0, 90797.54601226952, 99223.0, 105607.0, 11544.59593914209, 11740.41297935117, 11858.822117668069, 11923.642290731292, 12356.567520136752, 12345.753084938071, 12939.805902911276, 13150.75067868551, 13401.932990335376, 13974.79037814454, 12208.32854193028, 12318.630441086782, 12446.564370246997, 12482.251064936132, 12595.559155429515, 12836.935815321238, 12930.870691293343, 12932.159409638343, 12954.870451295366, 13149.40062966145, 12081.758364832478, 12137.150399471951, 12310.076744244396, 12325.137240393446, 12808.74382512326, 10140.188784897044, 10159.390436573534, 10403.895961040293, 10715.0, 10874.184436167478, 9974.451405172786, 10142.898571014195, 10179.796404071729, 10238.283320167517, 10238.897611024093], "value": 8012.616687230936, "unit": "score"}], "name": "dromaeo_css", "value": 7475.661929342787, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 112.0, 112.0, 111.0, 110.0, 111.0, 112.0, 112.0, 111.0, 111.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 109.0, 165.0, 137.0, 115.0, 106.0, 105.0, 138.0, 107.0], "value": 123.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 184.0, 184.0, 184.0, 184.0, 184.0, 179.0, 183.0, 184.0, 185.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 57.0, 60.0, 89.0, 61.0, 58.0, 58.0, 58.0, 80.0, 56.0], "value": 65.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 69.0, 94.0, 70.0, 67.0, 68.0, 93.0, 68.0, 68.0, 89.0], "value": 77.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 91.0, 87.0, 89.0, 86.0, 90.0, 87.0, 90.0, 86.0], "value": 88.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 93.0, 93.0, 95.0, 93.0, 119.0, 148.0, 111.0, 94.0], "value": 103.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 86.0, 86.0, 87.0, 86.0, 84.0, 86.0, 85.0, 84.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 55.0, 53.0, 52.0, 53.0, 56.0, 56.0, 55.0, 56.0, 56.0], "value": 54.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 74.0, 69.0, 74.0, 71.0, 68.0, 69.0, 72.0, 71.0, 71.0], "value": 70.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 79.0, 82.0, 78.0, 80.0, 81.0, 83.0, 81.0, 87.0], "value": 81.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 135.0, 137.0, 175.0, 122.0, 141.0, 144.0, 149.0, 168.0, 147.0], "value": 145.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 162.0, 162.0, 162.0, 161.0, 161.0, 162.0, 166.0, 218.0], "value": 167.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 67.0, 65.0, 64.0, 65.0, 65.0, 65.0, 62.0, 75.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1423.9, "alertThreshold": 2.0}]} 21:23:09 INFO - Return code: 0 21:23:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:23:09 INFO - # TBPL SUCCESS # 21:23:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:23:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:23:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:23:09 INFO - 2016-11-28 21:23:09.948 screenresolution[1914:14735] starting screenresolution argv=screenresolution get 21:23:09 INFO - 2016-11-28 21:23:09.950 screenresolution[1914:14735] Display 0: 1600x1200x32@60 21:23:09 INFO - 2016-11-28 21:23:09.956 screenresolution[1915:14738] starting screenresolution argv=screenresolution list 21:23:09 INFO - Available Modes on Display 0 21:23:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:23:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:23:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:23:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:23:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:23:10 INFO - Intel Iris: 21:23:10 INFO - Chipset Model: Intel Iris 21:23:10 INFO - Type: GPU 21:23:10 INFO - Bus: Built-In 21:23:10 INFO - VRAM (Dynamic, Max): 1536 MB 21:23:10 INFO - Vendor: Intel (0x8086) 21:23:10 INFO - Device ID: 0x0a2e 21:23:10 INFO - Revision ID: 0x0009 21:23:10 INFO - Displays: 21:23:10 INFO - Display: 21:23:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:23:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:23:10 INFO - Display Serial Number: 1600x1200 60 21:23:10 INFO - Main Display: Yes 21:23:10 INFO - Mirror: Off 21:23:10 INFO - Online: Yes 21:23:10 INFO - Rotation: Supported 21:23:10 INFO - Return code: 0 21:23:10 INFO - Running post-action listener: _resource_record_post_action 21:23:10 INFO - [mozharness: 2016-11-29 05:23:10.194501Z] Finished run-tests step (success) 21:23:10 INFO - Running post-run listener: _resource_record_post_run 21:23:10 INFO - Total resource usage - Wall time: 1196s; CPU: 53.0%; Read bytes: 1630208; Write bytes: 495611392; Read time: 12; Write time: 1556 21:23:10 INFO - TinderboxPrint: CPU usage
53.3% 21:23:10 INFO - TinderboxPrint: I/O read bytes / time
1,630,208 / 12 21:23:10 INFO - TinderboxPrint: I/O write bytes / time
495,611,392 / 1,556 21:23:10 INFO - TinderboxPrint: CPU idle
2,233.0 (46.7%) 21:23:10 INFO - TinderboxPrint: CPU system
958.0 (20.0%) 21:23:10 INFO - TinderboxPrint: CPU user
1,594.8 (33.3%) 21:23:10 INFO - TinderboxPrint: Swap in / out
197,402,624 / 0 21:23:10 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 190036480; Write bytes: 188975104; Read time: 17704; Write time: 407 21:23:10 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 794624; Write bytes: 295609856; Read time: 9; Write time: 1111 21:23:10 INFO - Running post-run listener: _upload_blobber_files 21:23:10 INFO - Blob upload gear active. 21:23:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:23:10 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 21:23:10 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'] 21:23:10 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 21:23:11 INFO - (blobuploader) - INFO - Open directory for files ... 21:23:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:23:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:23:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:23:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:23:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:23:11 INFO - (blobuploader) - INFO - Done attempting. 21:23:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:23:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:23:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:23:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:23:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:23:12 INFO - (blobuploader) - INFO - Done attempting. 21:23:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:23:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:23:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:23:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:23:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:23:15 INFO - (blobuploader) - INFO - Done attempting. 21:23:15 INFO - (blobuploader) - INFO - Iteration through files over. 21:23:15 INFO - Return code: 0 21:23:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:23:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:23:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dbff13c9601030b300d26c0b9e2efbce33ae015fd598db0fcb7c37ce1cdfad73f672360d55d8449c22d9629b1a791f87d71ff7e674f0a0f8a3638639b0b1bc53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f47c809868b7b7230a4d7f81746e8550e21bd41b21af21de8dd06bd9bba54bc8b709cfac865c4ef87b63839033ddcf6c2b1708f8397e2bcccbcec2d32ca2f3c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1a9297a91eb511ca75e458fbb53eb3ee810f24c6a5a116c85710f3c9221b48ab1b2a422c72389d7fbde1aa32baf90cf6a16c9bd5ffe977a50b2e2c14899fdd39"} 21:23:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:23:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:23:15 INFO - Contents: 21:23:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/dbff13c9601030b300d26c0b9e2efbce33ae015fd598db0fcb7c37ce1cdfad73f672360d55d8449c22d9629b1a791f87d71ff7e674f0a0f8a3638639b0b1bc53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f47c809868b7b7230a4d7f81746e8550e21bd41b21af21de8dd06bd9bba54bc8b709cfac865c4ef87b63839033ddcf6c2b1708f8397e2bcccbcec2d32ca2f3c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1a9297a91eb511ca75e458fbb53eb3ee810f24c6a5a116c85710f3c9221b48ab1b2a422c72389d7fbde1aa32baf90cf6a16c9bd5ffe977a50b2e2c14899fdd39"} 21:23:15 INFO - Running post-run listener: copy_logs_to_upload_dir 21:23:15 INFO - Copying logs to upload dir... 21:23:15 INFO - mkdir: /builds/slave/test/build/upload/logs 21:23:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1257.443377 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 57 secs) (at 2016-11-28 21:23:15.351558) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-28 21:23:15.355142) ========= 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.T4pwo0g117/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.XVXR9ZHBQv/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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/dbff13c9601030b300d26c0b9e2efbce33ae015fd598db0fcb7c37ce1cdfad73f672360d55d8449c22d9629b1a791f87d71ff7e674f0a0f8a3638639b0b1bc53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f47c809868b7b7230a4d7f81746e8550e21bd41b21af21de8dd06bd9bba54bc8b709cfac865c4ef87b63839033ddcf6c2b1708f8397e2bcccbcec2d32ca2f3c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1a9297a91eb511ca75e458fbb53eb3ee810f24c6a5a116c85710f3c9221b48ab1b2a422c72389d7fbde1aa32baf90cf6a16c9bd5ffe977a50b2e2c14899fdd39"} build_url:https://queue.taskcluster.net/v1/task/Za9d_fsnQJyMAVA9n3ktsQ/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010483 build_url: 'https://queue.taskcluster.net/v1/task/Za9d_fsnQJyMAVA9n3ktsQ/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/dbff13c9601030b300d26c0b9e2efbce33ae015fd598db0fcb7c37ce1cdfad73f672360d55d8449c22d9629b1a791f87d71ff7e674f0a0f8a3638639b0b1bc53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f47c809868b7b7230a4d7f81746e8550e21bd41b21af21de8dd06bd9bba54bc8b709cfac865c4ef87b63839033ddcf6c2b1708f8397e2bcccbcec2d32ca2f3c4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1a9297a91eb511ca75e458fbb53eb3ee810f24c6a5a116c85710f3c9221b48ab1b2a422c72389d7fbde1aa32baf90cf6a16c9bd5ffe977a50b2e2c14899fdd39"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-28 21:23:15.389040) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 21:23:15.389371) ========= 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.T4pwo0g117/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.XVXR9ZHBQv/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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.005127 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-28 21:23:15.437305) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-28 21:23:15.437597) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-28 21:23:15.437913) ========= ========= Total master_lag: 0.18 =========