builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0310 starttime: 1483579842.16 results: success (0) buildid: 20170104154438 builduid: 737776a35cfc41b6b03edd2a8802c33f revision: 10eb6b8c37f12d0d970774e3b5fae360fe57d856 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-04 17:30:42.161638) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-04 17:30:42.162051) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-04 17:30:42.162320) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-04 17:30:42.186633) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 17:30:42.186890) ========= 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.Ybr1dkZ7Ug/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.oMH5HnfIii/Listeners TMPDIR=/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-04 17:30:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.25M=0.001s 2017-01-04 17:30:42 (8.25 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.176471 ========= master_lag: 0.30 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 17:30:42.661403) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 17:30:42.661737) ========= 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.Ybr1dkZ7Ug/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.oMH5HnfIii/Listeners TMPDIR=/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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.019398 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 17:30:42.702693) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 17:30:42.703023) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 10eb6b8c37f12d0d970774e3b5fae360fe57d856 --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 10eb6b8c37f12d0d970774e3b5fae360fe57d856 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Ybr1dkZ7Ug/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.oMH5HnfIii/Listeners TMPDIR=/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-04 17:30:42,785 truncating revision to first 12 chars 2017-01-04 17:30:42,785 Setting DEBUG logging. 2017-01-04 17:30:42,785 attempt 1/10 2017-01-04 17:30:42,786 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/10eb6b8c37f1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-04 17:30:43,497 unpacking tar archive at: mozilla-beta-10eb6b8c37f1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.972259 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 17:30:43.698383) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-04 17:30:43.698678) ========= script_repo_revision: 10eb6b8c37f12d0d970774e3b5fae360fe57d856 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-04 17:30:43.702140) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-04 17:30:43.702419) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-04 17:30:43.720374) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-01-04 17:30:43.720656) ========= /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.Ybr1dkZ7Ug/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.oMH5HnfIii/Listeners TMPDIR=/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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 17:30:43 INFO - MultiFileLogger online at 20170104 17:30:43 in /builds/slave/test 17:30:43 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 17:30:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:30:43 INFO - {'append_to_log': False, 17:30:43 INFO - 'base_work_dir': '/builds/slave/test', 17:30:43 INFO - 'blob_upload_branch': 'Mozilla-Beta', 17:30:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:30:43 INFO - 'branch': 'Mozilla-Beta', 17:30:43 INFO - 'buildbot_json_path': 'buildprops.json', 17:30:43 INFO - 'config_files': ('talos/mac_config.py',), 17:30:43 INFO - 'default_actions': ('clobber', 17:30:43 INFO - 'read-buildbot-config', 17:30:43 INFO - 'download-and-extract', 17:30:43 INFO - 'populate-webroot', 17:30:43 INFO - 'create-virtualenv', 17:30:43 INFO - 'install', 17:30:43 INFO - 'run-tests'), 17:30:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:30:43 INFO - 'download_minidump_stackwalk': True, 17:30:43 INFO - 'download_symbols': 'ondemand', 17:30:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:30:43 INFO - 'tooltool.py': '/tools/tooltool.py', 17:30:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:30:43 INFO - '/tools/misc-python/virtualenv.py')}, 17:30:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:30:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:30:43 INFO - 'installer_path': 'installer.exe', 17:30:43 INFO - 'log_level': 'info', 17:30:43 INFO - 'log_name': 'talos', 17:30:43 INFO - 'log_to_console': True, 17:30:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:30:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:30:43 INFO - 'opt_config_files': (), 17:30:43 INFO - 'pip_index': False, 17:30:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:30:43 INFO - 'cmd': ('bash', 17:30:43 INFO - '-c', 17:30:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:30:43 INFO - 'enabled': True, 17:30:43 INFO - 'halt_on_failure': False, 17:30:43 INFO - 'name': 'check_screen_resolution'},), 17:30:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:30:43 INFO - 'cmd': ('bash', 17:30:43 INFO - '-c', 17:30:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:30:43 INFO - 'enabled': True, 17:30:43 INFO - 'halt_on_failure': False, 17:30:43 INFO - 'name': 'check_screen_resolution'},), 17:30:43 INFO - 'run_cmd_checks_enabled': True, 17:30:43 INFO - 'sps_profile': False, 17:30:43 INFO - 'sps_profile_interval': 0, 17:30:43 INFO - 'suite': 'dromaeojs', 17:30:43 INFO - 'system_bits': '32', 17:30:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:30:43 INFO - 'title': 't-yosemite-r7-0310', 17:30:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:30:43 INFO - 'use_talos_json': True, 17:30:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:30:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:30:43 INFO - 'work_dir': 'build'} 17:30:43 INFO - [mozharness: 2017-01-05 01:30:43.914440Z] Running clobber step. 17:30:43 INFO - Running pre-action listener: _resource_record_pre_action 17:30:43 INFO - Running main action method: clobber 17:30:43 INFO - rmtree: /builds/slave/test/build 17:30:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:30:45 INFO - Running post-action listener: _resource_record_post_action 17:30:45 INFO - [mozharness: 2017-01-05 01:30:45.414394Z] Finished clobber step (success) 17:30:45 INFO - [mozharness: 2017-01-05 01:30:45.414523Z] Running read-buildbot-config step. 17:30:45 INFO - Running pre-action listener: _resource_record_pre_action 17:30:45 INFO - Running main action method: read_buildbot_config 17:30:45 INFO - Using buildbot properties: 17:30:45 INFO - { 17:30:45 INFO - "project": "", 17:30:45 INFO - "product": "firefox", 17:30:45 INFO - "script_repo_revision": "production", 17:30:45 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 17:30:45 INFO - "repository": "", 17:30:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 17:30:45 INFO - "buildid": "20170104154438", 17:30:45 INFO - "pgo_build": "False", 17:30:45 INFO - "basedir": "/builds/slave/test", 17:30:45 INFO - "buildnumber": 3, 17:30:45 INFO - "slavename": "t-yosemite-r7-0310", 17:30:45 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 17:30:45 INFO - "platform": "yosemite_r7", 17:30:45 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 17:30:45 INFO - "branch": "mozilla-beta", 17:30:45 INFO - "repo_path": "releases/mozilla-beta", 17:30:45 INFO - "revision": "10eb6b8c37f12d0d970774e3b5fae360fe57d856", 17:30:45 INFO - "stage_platform": "macosx64", 17:30:45 INFO - "builduid": "737776a35cfc41b6b03edd2a8802c33f", 17:30:45 INFO - "slavebuilddir": "test" 17:30:45 INFO - } 17:30:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/D7mLt4T6TSOIcQueEhD0LA/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 17:30:45 INFO - Running post-action listener: _resource_record_post_action 17:30:45 INFO - [mozharness: 2017-01-05 01:30:45.417730Z] Finished read-buildbot-config step (success) 17:30:45 INFO - [mozharness: 2017-01-05 01:30:45.417835Z] Running download-and-extract step. 17:30:45 INFO - Running pre-action listener: _resource_record_pre_action 17:30:45 INFO - Running main action method: download_and_extract 17:30:45 INFO - mkdir: /builds/slave/test/build/tests 17:30:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:45 INFO - trying https://queue.taskcluster.net/v1/task/D7mLt4T6TSOIcQueEhD0LA/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 17:30:45 INFO - Downloading https://queue.taskcluster.net/v1/task/D7mLt4T6TSOIcQueEhD0LA/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 17:30:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D7mLt4T6TSOIcQueEhD0LA/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 17:30:46 INFO - Downloaded 1165 bytes. 17:30:46 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 17:30:46 INFO - Using the following test package requirements: 17:30:46 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 17:30:46 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:30:46 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 17:30:46 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:30:46 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 17:30:46 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 17:30:46 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:30:46 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 17:30:46 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 17:30:46 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:30:46 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 17:30:46 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:30:46 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 17:30:46 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:30:46 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 17:30:46 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 17:30:46 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 17:30:46 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 17:30:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D7mLt4T6TSOIcQueEhD0LA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 17:30:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D7mLt4T6TSOIcQueEhD0LA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 17:30:46 INFO - Fetch https://queue.taskcluster.net/v1/task/D7mLt4T6TSOIcQueEhD0LA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 17:30:47 INFO - Expected file size: 16234488 17:30:53 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 17:30:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D7mLt4T6TSOIcQueEhD0LA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 17:30:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D7mLt4T6TSOIcQueEhD0LA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 17:30:53 INFO - Fetch https://queue.taskcluster.net/v1/task/D7mLt4T6TSOIcQueEhD0LA/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 17:30:54 INFO - Expected file size: 16234488 17:31:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/D7mLt4T6TSOIcQueEhD0LA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 17:31:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/D7mLt4T6TSOIcQueEhD0LA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 17:31:01 INFO - Fetch https://queue.taskcluster.net/v1/task/D7mLt4T6TSOIcQueEhD0LA/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 17:31:02 INFO - Expected file size: 14414089 17:31:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:03 INFO - trying https://queue.taskcluster.net/v1/task/D7mLt4T6TSOIcQueEhD0LA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 17:31:03 INFO - Downloading https://queue.taskcluster.net/v1/task/D7mLt4T6TSOIcQueEhD0LA/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 17:31:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/D7mLt4T6TSOIcQueEhD0LA/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 17:31:05 INFO - Downloaded 86103148 bytes. 17:31:05 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/D7mLt4T6TSOIcQueEhD0LA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 17:31:05 INFO - mkdir: /builds/slave/test/properties 17:31:05 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:31:05 INFO - Writing to file /builds/slave/test/properties/build_url 17:31:05 INFO - Contents: 17:31:05 INFO - build_url:https://queue.taskcluster.net/v1/task/D7mLt4T6TSOIcQueEhD0LA/artifacts/public/build/firefox-51.0.en-US.mac.dmg 17:31:06 INFO - Running post-action listener: _resource_record_post_action 17:31:06 INFO - Running post-action listener: set_extra_try_arguments 17:31:06 INFO - [mozharness: 2017-01-05 01:31:06.245808Z] Finished download-and-extract step (success) 17:31:06 INFO - [mozharness: 2017-01-05 01:31:06.245923Z] Running populate-webroot step. 17:31:06 INFO - Running pre-action listener: _resource_record_pre_action 17:31:06 INFO - Running main action method: populate_webroot 17:31:06 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:31:06 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:31:06 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:31:06 INFO - '--tppagecycles', 17:31:06 INFO - '7'], 17:31:06 INFO - 'tests': ['tsvgm']}}, 17:31:06 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:31:06 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:31:06 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:31:06 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:31:06 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:31:06 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:31:06 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:06 INFO - 'talos_options': ['--disable-e10s'], 17:31:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:31:06 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:06 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:31:06 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:06 INFO - 'talos_options': ['--disable-e10s'], 17:31:06 INFO - 'tests': ['damp', 'tps']}, 17:31:06 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:06 INFO - 'tests': ['damp', 'tps']}, 17:31:06 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:31:06 INFO - 'tests': ['dromaeo_dom']}, 17:31:06 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:31:06 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:31:06 INFO - 'tests': ['basic_compositor_video']}, 17:31:06 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:31:06 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:31:06 INFO - 'tests': ['a11yr', 17:31:06 INFO - 'ts_paint', 17:31:06 INFO - 'tpaint', 17:31:06 INFO - 'sessionrestore', 17:31:06 INFO - 'sessionrestore_no_auto_restore', 17:31:06 INFO - 'tabpaint']}, 17:31:06 INFO - 'other-e10s': {'tests': ['a11yr', 17:31:06 INFO - 'ts_paint', 17:31:06 INFO - 'tpaint', 17:31:06 INFO - 'sessionrestore', 17:31:06 INFO - 'sessionrestore_no_auto_restore', 17:31:06 INFO - 'tabpaint']}, 17:31:06 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:31:06 INFO - 'ts_paint', 17:31:06 INFO - 'tpaint', 17:31:06 INFO - 'sessionrestore', 17:31:06 INFO - 'sessionrestore_no_auto_restore', 17:31:06 INFO - 'tabpaint']}, 17:31:06 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:31:06 INFO - 'ts_paint', 17:31:06 INFO - 'tpaint', 17:31:06 INFO - 'sessionrestore', 17:31:06 INFO - 'sessionrestore_no_auto_restore', 17:31:06 INFO - 'tabpaint']}, 17:31:06 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:31:06 INFO - 'tests': ['a11yr', 17:31:06 INFO - 'ts_paint', 17:31:06 INFO - 'tpaint', 17:31:06 INFO - 'sessionrestore', 17:31:06 INFO - 'sessionrestore_no_auto_restore', 17:31:06 INFO - 'tabpaint']}, 17:31:06 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:31:06 INFO - 'tests': ['a11yr', 17:31:06 INFO - 'ts_paint', 17:31:06 INFO - 'tpaint', 17:31:06 INFO - 'sessionrestore', 17:31:06 INFO - 'sessionrestore_no_auto_restore', 17:31:06 INFO - 'tabpaint']}, 17:31:06 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:31:06 INFO - 'tests': ['tsvgx', 17:31:06 INFO - 'tsvgr_opacity', 17:31:06 INFO - 'tart', 17:31:06 INFO - 'tscrollx', 17:31:06 INFO - 'cart']}, 17:31:06 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:31:06 INFO - 'tsvgr_opacity', 17:31:06 INFO - 'tart', 17:31:06 INFO - 'tscrollx', 17:31:06 INFO - 'cart']}, 17:31:06 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:06 INFO - 'talos_options': ['--disable-e10s'], 17:31:06 INFO - 'tests': ['tp5o']}, 17:31:06 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:06 INFO - 'tests': ['tp5o']}, 17:31:06 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:06 INFO - 'talos_options': ['--disable-e10s', 17:31:06 INFO - '--xperf_path', 17:31:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:31:06 INFO - 'tests': ['tp5n']}, 17:31:06 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:31:06 INFO - 'talos_options': ['--xperf_path', 17:31:06 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:31:06 INFO - 'tests': ['tp5n']}}, 17:31:06 INFO - 'talos.zip': {'path': '', 17:31:06 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:31:06 INFO - Running post-action listener: _resource_record_post_action 17:31:06 INFO - [mozharness: 2017-01-05 01:31:06.264557Z] Finished populate-webroot step (success) 17:31:06 INFO - [mozharness: 2017-01-05 01:31:06.264681Z] Running create-virtualenv step. 17:31:06 INFO - Running pre-action listener: _resource_record_pre_action 17:31:06 INFO - Running main action method: create_virtualenv 17:31:06 INFO - Creating virtualenv /builds/slave/test/build/venv 17:31:06 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 17:31:06 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:31:06 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:31:06 INFO - Using real prefix '/tools/python27' 17:31:06 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:31:07 INFO - Installing distribute.............................................................................................................................................................................................done. 17:31:09 INFO - Installing pip.................done. 17:31:09 INFO - Return code: 0 17:31:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1070b6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10702c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6385bbb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ecad30>, '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 0x106d30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ec2b20>, '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.Ybr1dkZ7Ug/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.oMH5HnfIii/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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 17:31:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:31:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:31:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ybr1dkZ7Ug/Render', 17:31:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:09 INFO - 'HOME': '/Users/cltbld', 17:31:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:09 INFO - 'LOGNAME': 'cltbld', 17:31:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:09 INFO - 'MOZ_NO_REMOTE': '1', 17:31:09 INFO - 'NO_EM_RESTART': '1', 17:31:09 INFO - 'PAGER': '/bin/cat', 17:31:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:09 INFO - 'PWD': '/builds/slave/test', 17:31:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:09 INFO - 'SHELL': '/bin/bash', 17:31:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oMH5HnfIii/Listeners', 17:31:09 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 17:31:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:09 INFO - 'USER': 'cltbld', 17:31:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:09 INFO - 'XPC_FLAGS': '0x0', 17:31:09 INFO - 'XPC_SERVICE_NAME': '0', 17:31:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:10 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 17:31:10 INFO - Cleaning up... 17:31:10 INFO - Return code: 0 17:31:10 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1070b6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10702c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6385bbb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ecad30>, '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 0x106d30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ec2b20>, '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.Ybr1dkZ7Ug/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.oMH5HnfIii/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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 17:31:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:31:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:31:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ybr1dkZ7Ug/Render', 17:31:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:10 INFO - 'HOME': '/Users/cltbld', 17:31:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:10 INFO - 'LOGNAME': 'cltbld', 17:31:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:10 INFO - 'MOZ_NO_REMOTE': '1', 17:31:10 INFO - 'NO_EM_RESTART': '1', 17:31:10 INFO - 'PAGER': '/bin/cat', 17:31:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:10 INFO - 'PWD': '/builds/slave/test', 17:31:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:10 INFO - 'SHELL': '/bin/bash', 17:31:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oMH5HnfIii/Listeners', 17:31:10 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 17:31:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:10 INFO - 'USER': 'cltbld', 17:31:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:10 INFO - 'XPC_FLAGS': '0x0', 17:31:10 INFO - 'XPC_SERVICE_NAME': '0', 17:31:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:10 INFO - Downloading/unpacking psutil>=3.1.1 17:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:31:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:31:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:31:13 INFO - Installing collected packages: psutil 17:31:13 INFO - Running setup.py install for psutil 17:31:13 INFO - building 'psutil._psutil_osx' extension 17:31:13 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 17:31:13 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 17:31:14 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 17:31:14 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 17:31:14 INFO - building 'psutil._psutil_posix' extension 17:31:14 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 17:31:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:31:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:31:14 INFO - ^ 17:31:14 INFO - 1 warning generated. 17:31:14 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 17:31:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:31:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:31:14 INFO - Successfully installed psutil 17:31:14 INFO - Cleaning up... 17:31:14 INFO - Return code: 0 17:31:14 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:14 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 0x1070b6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10702c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6385bbb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ecad30>, '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 0x106d30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ec2b20>, '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.Ybr1dkZ7Ug/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.oMH5HnfIii/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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 17:31:14 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 17:31:14 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 17:31:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ybr1dkZ7Ug/Render', 17:31:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:14 INFO - 'HOME': '/Users/cltbld', 17:31:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:14 INFO - 'LOGNAME': 'cltbld', 17:31:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:14 INFO - 'MOZ_NO_REMOTE': '1', 17:31:14 INFO - 'NO_EM_RESTART': '1', 17:31:14 INFO - 'PAGER': '/bin/cat', 17:31:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:14 INFO - 'PWD': '/builds/slave/test', 17:31:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:14 INFO - 'SHELL': '/bin/bash', 17:31:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oMH5HnfIii/Listeners', 17:31:14 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 17:31:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:14 INFO - 'USER': 'cltbld', 17:31:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:14 INFO - 'XPC_FLAGS': '0x0', 17:31:14 INFO - 'XPC_SERVICE_NAME': '0', 17:31:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:14 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:31:14 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 17:31:14 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 17:31:14 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 17:31:14 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 17:31:14 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 17:31:14 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 17:31:17 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:31:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:31:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:31:17 INFO - Installing collected packages: mozsystemmonitor 17:31:17 INFO - Running setup.py install for mozsystemmonitor 17:31:17 INFO - Successfully installed mozsystemmonitor 17:31:17 INFO - Cleaning up... 17:31:17 INFO - Return code: 0 17:31:17 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1070b6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10702c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6385bbb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ecad30>, '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 0x106d30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ec2b20>, '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.Ybr1dkZ7Ug/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.oMH5HnfIii/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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 17:31:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:31:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:31:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ybr1dkZ7Ug/Render', 17:31:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:17 INFO - 'HOME': '/Users/cltbld', 17:31:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:17 INFO - 'LOGNAME': 'cltbld', 17:31:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:17 INFO - 'MOZ_NO_REMOTE': '1', 17:31:17 INFO - 'NO_EM_RESTART': '1', 17:31:17 INFO - 'PAGER': '/bin/cat', 17:31:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:17 INFO - 'PWD': '/builds/slave/test', 17:31:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:17 INFO - 'SHELL': '/bin/bash', 17:31:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oMH5HnfIii/Listeners', 17:31:17 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 17:31:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:17 INFO - 'USER': 'cltbld', 17:31:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:17 INFO - 'XPC_FLAGS': '0x0', 17:31:17 INFO - 'XPC_SERVICE_NAME': '0', 17:31:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:17 INFO - Downloading/unpacking jsonschema==2.5.1 17:31:17 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 17:31:17 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 17:31:17 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 17:31:17 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 17:31:17 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 17:31:17 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 17:31:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:31:20 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:31:20 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 17:31:20 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 17:31:20 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 17:31:20 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 17:31:20 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 17:31:20 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 17:31:20 INFO - Downloading functools32-3.2.3-2.tar.gz 17:31:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:31:21 INFO - warning: no files found matching '*.txt' 17:31:21 INFO - no previously-included directories found matching 'build' 17:31:21 INFO - no previously-included directories found matching 'dist' 17:31:21 INFO - no previously-included directories found matching '.git*' 17:31:21 INFO - Installing collected packages: jsonschema, functools32 17:31:21 INFO - Running setup.py install for functools32 17:31:21 INFO - warning: no files found matching '*.txt' 17:31:21 INFO - no previously-included directories found matching 'build' 17:31:21 INFO - no previously-included directories found matching 'dist' 17:31:21 INFO - no previously-included directories found matching '.git*' 17:31:21 INFO - Successfully installed jsonschema functools32 17:31:21 INFO - Cleaning up... 17:31:21 INFO - Return code: 0 17:31:21 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1070b6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10702c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6385bbb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ecad30>, '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 0x106d30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ec2b20>, '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.Ybr1dkZ7Ug/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.oMH5HnfIii/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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 17:31:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 17:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 17:31:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ybr1dkZ7Ug/Render', 17:31:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:21 INFO - 'HOME': '/Users/cltbld', 17:31:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:21 INFO - 'LOGNAME': 'cltbld', 17:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:21 INFO - 'MOZ_NO_REMOTE': '1', 17:31:21 INFO - 'NO_EM_RESTART': '1', 17:31:21 INFO - 'PAGER': '/bin/cat', 17:31:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:21 INFO - 'PWD': '/builds/slave/test', 17:31:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:21 INFO - 'SHELL': '/bin/bash', 17:31:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oMH5HnfIii/Listeners', 17:31:21 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 17:31:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:21 INFO - 'USER': 'cltbld', 17:31:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:21 INFO - 'XPC_FLAGS': '0x0', 17:31:21 INFO - 'XPC_SERVICE_NAME': '0', 17:31:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:21 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:31:21 INFO - Cleaning up... 17:31:21 INFO - Return code: 0 17:31:21 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1070b6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10702c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6385bbb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ecad30>, '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 0x106d30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ec2b20>, '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.Ybr1dkZ7Ug/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.oMH5HnfIii/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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 17:31:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 17:31:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 17:31:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ybr1dkZ7Ug/Render', 17:31:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:21 INFO - 'HOME': '/Users/cltbld', 17:31:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:21 INFO - 'LOGNAME': 'cltbld', 17:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:21 INFO - 'MOZ_NO_REMOTE': '1', 17:31:21 INFO - 'NO_EM_RESTART': '1', 17:31:21 INFO - 'PAGER': '/bin/cat', 17:31:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:21 INFO - 'PWD': '/builds/slave/test', 17:31:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:21 INFO - 'SHELL': '/bin/bash', 17:31:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oMH5HnfIii/Listeners', 17:31:21 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 17:31:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:21 INFO - 'USER': 'cltbld', 17:31:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:21 INFO - 'XPC_FLAGS': '0x0', 17:31:21 INFO - 'XPC_SERVICE_NAME': '0', 17:31:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:21 INFO - Downloading/unpacking blobuploader==1.2.4 17:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:24 INFO - Downloading blobuploader-1.2.4.tar.gz 17:31:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:31:24 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:31:24 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 17:31:24 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 17:31:24 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 17:31:24 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 17:31:24 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 17:31:24 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 17:31:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:31:25 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:25 INFO - Downloading docopt-0.6.1.tar.gz 17:31:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:31:25 INFO - Installing collected packages: blobuploader, requests, docopt 17:31:25 INFO - Running setup.py install for blobuploader 17:31:25 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:31:25 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:31:25 INFO - Running setup.py install for requests 17:31:26 INFO - Running setup.py install for docopt 17:31:26 INFO - Successfully installed blobuploader requests docopt 17:31:26 INFO - Cleaning up... 17:31:26 INFO - Return code: 0 17:31:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:26 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 0x1070b6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10702c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6385bbb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ecad30>, '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 0x106d30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ec2b20>, '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.Ybr1dkZ7Ug/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.oMH5HnfIii/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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 17:31:26 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 17:31:26 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 17:31:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ybr1dkZ7Ug/Render', 17:31:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:26 INFO - 'HOME': '/Users/cltbld', 17:31:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:26 INFO - 'LOGNAME': 'cltbld', 17:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:26 INFO - 'MOZ_NO_REMOTE': '1', 17:31:26 INFO - 'NO_EM_RESTART': '1', 17:31:26 INFO - 'PAGER': '/bin/cat', 17:31:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:26 INFO - 'PWD': '/builds/slave/test', 17:31:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:26 INFO - 'SHELL': '/bin/bash', 17:31:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oMH5HnfIii/Listeners', 17:31:26 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 17:31:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:26 INFO - 'USER': 'cltbld', 17:31:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:26 INFO - 'XPC_FLAGS': '0x0', 17:31:26 INFO - 'XPC_SERVICE_NAME': '0', 17:31:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:31:26 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-QOgi8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:31:27 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-fkbDKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:31:27 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-IwbthG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:31:27 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-AVssZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:31:27 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-jZQkIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:31:27 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-7JXefd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:31:27 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-MNbh0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:31:27 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-tZ_X0a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:31:27 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-ga0vIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:31:27 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-xgXRcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:31:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:31:27 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-RdSnt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:31:28 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-GkGOzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:31:28 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-t4NACY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:31:28 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-jzXHdb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:31:28 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-leu44E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:31:28 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-bM4S1L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:31:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:31:28 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-UEuIBt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:31:28 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:31:28 INFO - Running setup.py install for manifestparser 17:31:28 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:31:28 INFO - Running setup.py install for mozcrash 17:31:28 INFO - Running setup.py install for mozdebug 17:31:29 INFO - Running setup.py install for mozdevice 17:31:29 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:31:29 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:31:29 INFO - Running setup.py install for mozfile 17:31:29 INFO - Running setup.py install for mozhttpd 17:31:29 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:31:29 INFO - Running setup.py install for mozinfo 17:31:29 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:31:29 INFO - Running setup.py install for mozInstall 17:31:29 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:31:29 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:31:29 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:31:29 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:31:29 INFO - Running setup.py install for mozleak 17:31:29 INFO - Running setup.py install for mozlog 17:31:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:31:30 INFO - Running setup.py install for moznetwork 17:31:30 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:31:30 INFO - Running setup.py install for mozprocess 17:31:30 INFO - Running setup.py install for mozprofile 17:31:30 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:31:30 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:31:30 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:31:30 INFO - Running setup.py install for mozrunner 17:31:30 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:31:30 INFO - Running setup.py install for mozscreenshot 17:31:30 INFO - Running setup.py install for moztest 17:31:31 INFO - Running setup.py install for mozversion 17:31:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:31:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:31:31 INFO - Cleaning up... 17:31:31 INFO - Return code: 0 17:31:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:31:31 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')]} 17:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:31 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')]} 17:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:31 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 0x1070b6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10702c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6385bbb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ecad30>, '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 0x106d30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ec2b20>, '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.Ybr1dkZ7Ug/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.oMH5HnfIii/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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 17:31:31 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 17:31:31 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 17:31:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ybr1dkZ7Ug/Render', 17:31:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:31 INFO - 'HOME': '/Users/cltbld', 17:31:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:31 INFO - 'LOGNAME': 'cltbld', 17:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:31 INFO - 'MOZ_NO_REMOTE': '1', 17:31:31 INFO - 'NO_EM_RESTART': '1', 17:31:31 INFO - 'PAGER': '/bin/cat', 17:31:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:31 INFO - 'PWD': '/builds/slave/test', 17:31:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:31 INFO - 'SHELL': '/bin/bash', 17:31:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oMH5HnfIii/Listeners', 17:31:31 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 17:31:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:31 INFO - 'USER': 'cltbld', 17:31:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:31 INFO - 'XPC_FLAGS': '0x0', 17:31:31 INFO - 'XPC_SERVICE_NAME': '0', 17:31:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:31:31 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-hHRK_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:31:31 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)) 17:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:31:31 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-w92M8y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:31:31 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)) 17:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:31:31 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-3SofJx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:31:31 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)) 17:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:31:31 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-Yq2c8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:31:31 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)) 17:31:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:31:31 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-GI7Q3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:31:32 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)) 17:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:31:32 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-g9UACH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:31:32 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)) 17:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:31:32 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-ewVscM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:31:32 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)) 17:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:31:32 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-Rcir5i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:31:32 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)) 17:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:31:32 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-1ybQCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:31:32 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)) 17:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:31:32 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-R8hH3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:31:32 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)) 17:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:31:32 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-pNJQ3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:31:32 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)) 17:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:31:32 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-MsOCkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:31:32 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)) 17:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:31:32 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-mINR3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:31:32 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)) 17:31:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:31:32 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-hBcXk7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:31:33 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)) 17:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:31:33 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-1qrV8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:31:33 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)) 17:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:31:33 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-X20bRd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:31:33 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)) 17:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:31:33 INFO - Running setup.py (path:/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/pip-ehwzFD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:31:33 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)) 17:31:33 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)) 17:31:33 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)) 17:31:33 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)) 17:31:33 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)) 17:31:33 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)) 17:31:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:31:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:31:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:31:35 INFO - Downloading blessings-1.6.tar.gz 17:31:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:31:36 INFO - Installing collected packages: blessings 17:31:36 INFO - Running setup.py install for blessings 17:31:36 INFO - Successfully installed blessings 17:31:36 INFO - Cleaning up... 17:31:36 INFO - Return code: 0 17:31:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:31:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:31:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:31:36 INFO - Reading from file tmpfile_stdout 17:31:36 INFO - Current package versions: 17:31:36 INFO - blessings == 1.6 17:31:36 INFO - blobuploader == 1.2.4 17:31:36 INFO - docopt == 0.6.1 17:31:36 INFO - functools32 == 3.2.3-2 17:31:36 INFO - jsonschema == 2.5.1 17:31:36 INFO - manifestparser == 1.1 17:31:36 INFO - mozInstall == 1.12 17:31:36 INFO - mozcrash == 0.17 17:31:36 INFO - mozdebug == 0.1 17:31:36 INFO - mozdevice == 0.48 17:31:36 INFO - mozfile == 1.2 17:31:36 INFO - mozhttpd == 0.7 17:31:36 INFO - mozinfo == 0.9 17:31:36 INFO - mozleak == 0.1 17:31:36 INFO - mozlog == 3.4 17:31:36 INFO - moznetwork == 0.27 17:31:36 INFO - mozprocess == 0.23 17:31:36 INFO - mozprofile == 0.28 17:31:36 INFO - mozrunner == 6.12 17:31:36 INFO - mozscreenshot == 0.1 17:31:36 INFO - mozsystemmonitor == 0.3 17:31:36 INFO - moztest == 0.7 17:31:36 INFO - mozversion == 1.4 17:31:36 INFO - psutil == 3.1.1 17:31:36 INFO - requests == 1.2.3 17:31:36 INFO - wsgiref == 0.1.2 17:31:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:31:36 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')]} 17:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:36 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')]} 17:31:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:36 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 0x1070b6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10702c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6385bbb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ecad30>, '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 0x106d30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ec2b20>, '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.Ybr1dkZ7Ug/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.oMH5HnfIii/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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 17:31:36 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 17:31:36 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 17:31:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ybr1dkZ7Ug/Render', 17:31:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:36 INFO - 'HOME': '/Users/cltbld', 17:31:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:36 INFO - 'LOGNAME': 'cltbld', 17:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:36 INFO - 'MOZ_NO_REMOTE': '1', 17:31:36 INFO - 'NO_EM_RESTART': '1', 17:31:36 INFO - 'PAGER': '/bin/cat', 17:31:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:36 INFO - 'PWD': '/builds/slave/test', 17:31:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:36 INFO - 'SHELL': '/bin/bash', 17:31:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oMH5HnfIii/Listeners', 17:31:36 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 17:31:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:36 INFO - 'USER': 'cltbld', 17:31:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:36 INFO - 'XPC_FLAGS': '0x0', 17:31:36 INFO - 'XPC_SERVICE_NAME': '0', 17:31:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:37 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)) 17:31:37 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)) 17:31:37 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)) 17:31:37 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)) 17:31:37 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)) 17:31:37 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)) 17:31:37 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)) 17:31:37 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)) 17:31:37 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)) 17:31:37 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)) 17:31:37 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)) 17:31:37 INFO - Cleaning up... 17:31:37 INFO - Return code: 0 17:31:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:31: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')]} 17:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:31:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31: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')]} 17:31:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:31:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:31:37 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 0x1070b6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10702c570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6385bbb40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106ecad30>, '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 0x106d30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ec2b20>, '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.Ybr1dkZ7Ug/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.oMH5HnfIii/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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 17:31:37 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 17:31:37 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 17:31:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ybr1dkZ7Ug/Render', 17:31:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:37 INFO - 'HOME': '/Users/cltbld', 17:31:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:37 INFO - 'LOGNAME': 'cltbld', 17:31:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:37 INFO - 'MOZ_NO_REMOTE': '1', 17:31:37 INFO - 'NO_EM_RESTART': '1', 17:31:37 INFO - 'PAGER': '/bin/cat', 17:31:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:37 INFO - 'PWD': '/builds/slave/test', 17:31:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:37 INFO - 'SHELL': '/bin/bash', 17:31:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oMH5HnfIii/Listeners', 17:31:37 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 17:31:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:37 INFO - 'USER': 'cltbld', 17:31:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:37 INFO - 'XPC_FLAGS': '0x0', 17:31:37 INFO - 'XPC_SERVICE_NAME': '0', 17:31:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:31:37 INFO - Cleaning up... 17:31:37 INFO - Return code: 0 17:31:37 INFO - Running post-action listener: _resource_record_post_action 17:31:37 INFO - Running post-action listener: _start_resource_monitoring 17:31:37 INFO - Starting resource monitoring. 17:31:37 INFO - [mozharness: 2017-01-05 01:31:37.461707Z] Finished create-virtualenv step (success) 17:31:37 INFO - [mozharness: 2017-01-05 01:31:37.462501Z] Running install step. 17:31:37 INFO - Running pre-action listener: _resource_record_pre_action 17:31:37 INFO - Running main action method: install 17:31:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:31:37 INFO - Reading from file tmpfile_stdout 17:31:37 INFO - Detecting whether we're running mozinstall >=1.0... 17:31:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:31:37 INFO - Reading from file tmpfile_stdout 17:31:37 INFO - Output received: 17:31:37 INFO - Usage: mozinstall [options] installer 17:31:37 INFO - Options: 17:31:37 INFO - -h, --help show this help message and exit 17:31:37 INFO - -d DEST, --destination=DEST 17:31:37 INFO - Directory to install application into. [default: 17:31:37 INFO - "/builds/slave/test"] 17:31:37 INFO - --app=APP Application being installed. [default: firefox] 17:31:37 INFO - mkdir: /builds/slave/test/build/application 17:31:37 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'] 17:31:37 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 17:31:59 INFO - Reading from file tmpfile_stdout 17:31:59 INFO - Output received: 17:31:59 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 17:31:59 INFO - Running post-action listener: _resource_record_post_action 17:31:59 INFO - [mozharness: 2017-01-05 01:31:59.583350Z] Finished install step (success) 17:31:59 INFO - [mozharness: 2017-01-05 01:31:59.583489Z] Running run-tests step. 17:31:59 INFO - Running pre-action listener: _resource_record_pre_action 17:31:59 INFO - Running main action method: run_tests 17:31:59 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:31:59 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:31:59 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:31:59 INFO - 2017-01-04 17:31:59.598 screenresolution[1903:14140] starting screenresolution argv=screenresolution get 17:31:59 INFO - 2017-01-04 17:31:59.600 screenresolution[1903:14140] Display 0: 1600x1200x32@60 17:31:59 INFO - 2017-01-04 17:31:59.606 screenresolution[1904:14143] starting screenresolution argv=screenresolution list 17:31:59 INFO - Available Modes on Display 0 17:31:59 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:31:59 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:31:59 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:31:59 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:31:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:31:59 INFO - Intel Iris: 17:31:59 INFO - Chipset Model: Intel Iris 17:31:59 INFO - Type: GPU 17:31:59 INFO - Bus: Built-In 17:31:59 INFO - VRAM (Dynamic, Max): 1536 MB 17:31:59 INFO - Vendor: Intel (0x8086) 17:31:59 INFO - Device ID: 0x0a2e 17:31:59 INFO - Revision ID: 0x0009 17:31:59 INFO - Displays: 17:31:59 INFO - Display: 17:31:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:31:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:31:59 INFO - Display Serial Number: 1600x1200 60 17:31:59 INFO - Main Display: Yes 17:31:59 INFO - Mirror: Off 17:31:59 INFO - Online: Yes 17:31:59 INFO - Rotation: Supported 17:31:59 INFO - Return code: 0 17:31:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:31:59 INFO - Python 2.7.3 17:31:59 INFO - Return code: 0 17:31:59 INFO - grabbing minidump binary from tooltool 17:31:59 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')]} 17:31:59 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 0x106ecad30>, '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 0x106d30db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106ec2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:31:59 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 17:31:59 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 17:31:59 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 17:31:59 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:31:59 INFO - Return code: 0 17:31:59 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:31:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:31:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:31:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:31:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:31:59 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/D7mLt4T6TSOIcQueEhD0LA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0310', '--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 17:31:59 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/D7mLt4T6TSOIcQueEhD0LA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0310 --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 17:31:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Ybr1dkZ7Ug/Render', 17:31:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:31:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:31:59 INFO - 'HOME': '/Users/cltbld', 17:31:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:31:59 INFO - 'LOGNAME': 'cltbld', 17:31:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:31:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:31:59 INFO - 'MOZ_NO_REMOTE': '1', 17:31:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:31:59 INFO - 'NO_EM_RESTART': '1', 17:31:59 INFO - 'PAGER': '/bin/cat', 17:31:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:31:59 INFO - 'PWD': '/builds/slave/test', 17:31:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:31:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:31:59 INFO - 'SHELL': '/bin/bash', 17:31:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oMH5HnfIii/Listeners', 17:31:59 INFO - 'TMPDIR': '/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/', 17:31:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:31:59 INFO - 'USER': 'cltbld', 17:31:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:31:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:31:59 INFO - 'XPC_FLAGS': '0x0', 17:31:59 INFO - 'XPC_SERVICE_NAME': '0', 17:31:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:31:59 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/D7mLt4T6TSOIcQueEhD0LA/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0310', '--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 17:32:00 INFO - mozversion application_buildid: 20170104154438 17:32:00 INFO - mozversion application_changeset: 10eb6b8c37f12d0d970774e3b5fae360fe57d856 17:32:00 INFO - mozversion application_display_name: Firefox 17:32:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:32:00 INFO - mozversion application_name: Firefox 17:32:00 INFO - mozversion application_remotingname: firefox 17:32:00 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 17:32:00 INFO - mozversion application_vendor: Mozilla 17:32:00 INFO - mozversion application_version: 51.0 17:32:00 INFO - mozversion platform_buildid: 20170104154438 17:32:00 INFO - mozversion platform_changeset: 10eb6b8c37f12d0d970774e3b5fae360fe57d856 17:32:00 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 17:32:00 INFO - mozversion platform_version: 51.0 17:32:00 INFO - using testdate: 1483579920 17:32:00 INFO - actual date: 1483579920 17:32:00 INFO - starting webserver on 'localhost:51725' 17:32:00 INFO - SUITE-START | Running 2 tests 17:32:00 INFO - TEST-START | dromaeo_css 17:32:00 INFO - operating with platform_type : mac_ 17:32:00 INFO - Initialising browser for dromaeo_css test... 17:32:00 INFO - TEST-INFO | started process 1914 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/tmp55evXN/profile http://localhost:51725/getInfo.html) 17:32:02 INFO - PROCESS | 1914 | __metrics Screen width/height:1600/1200 17:32:02 INFO - PROCESS | 1914 | colorDepth:24 17:32:02 INFO - PROCESS | 1914 | Browser inner width/height: 1024/689 17:32:02 INFO - PROCESS | 1914 | __metrics 17:32:02 INFO - PROCESS | 1914 | 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" 17:32:02 INFO - PROCESS | 1914 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:32:03 INFO - TEST-INFO | 1914: exit 0 17:32:03 INFO - Browser initialized. 17:32:03 INFO - Running cycle 1/1 for dromaeo_css test... 17:32:03 INFO - TEST-INFO | started process 1917 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/tmp55evXN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:32:15 INFO - PROCESS | 1917 | RSS: Main: 168939520 17:32:15 INFO - PROCESS | 1917 | 17:35:17 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:51725/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51725/tests/dromaeo/cssquery-ext.html) 17:35:18 INFO - PROCESS | 1917 | RSS: Main: 295485440 17:35:18 INFO - PROCESS | 1917 | 17:38:21 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:51725/tests/dromaeo/cssquery-ext.html (next: http://localhost:51725/tests/dromaeo/cssquery-jquery.html) 17:38:22 INFO - PROCESS | 1917 | RSS: Main: 302067712 17:38:22 INFO - PROCESS | 1917 | 17:41:24 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:51725/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51725/tests/dromaeo/cssquery-mootools.html) 17:41:25 INFO - PROCESS | 1917 | RSS: Main: 265101312 17:41:25 INFO - PROCESS | 1917 | 17:44:27 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:51725/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51725/tests/dromaeo/cssquery-prototype.html) 17:44:27 INFO - PROCESS | 1917 | RSS: Main: 271814656 17:44:27 INFO - PROCESS | 1917 | 17:47:31 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:51725/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51725/tests/dromaeo/cssquery-yui.html) 17:47:31 INFO - PROCESS | 1917 | RSS: Main: 261189632 17:47:31 INFO - PROCESS | 1917 | 17:50:34 INFO - PROCESS | 1917 | Cycle 1(1): loaded http://localhost:51725/tests/dromaeo/cssquery-yui.html (next: http://localhost:51725/tests/dromaeo/cssquery-dojo.html) 17:50:34 INFO - PROCESS | 1917 | RSS: Main: 306540544 17:50:34 INFO - PROCESS | 1917 | 17:50:34 INFO - PROCESS | 1917 | __start_tp_report 17:50:34 INFO - PROCESS | 1917 | _x_x_mozilla_page_load 17:50:34 INFO - PROCESS | 1917 | _x_x_mozilla_page_load_details 17:50:34 INFO - PROCESS | 1917 | |i|pagename|runs| 17:50:34 INFO - PROCESS | 1917 | |0;dojo.html;2794.790390720696;3424.1953141011873;3448.4310088835327;3468.3236768830075;3492.0746002309393;5766.740496677649;5889.0871914853215;5893.941060589393;5905.055191169414;5928.525717942565;5948.078047902572;5992.400759924006;5999.940000600003;6015.368386319439;6017.879642407149;5298.125809241471;5321.893562128756;5385.030694474993;5398.244245805571;5413.918791218135;5284.260203571503;5304.469553044684;5317.813876514303;5407.080796264625;5415.729213539307;5393.352797664266;5394.757235924373;5403.2165336026255;5406.08096623575;5409.729513524328;5230.320058392404;5331.760070796823;5345.198220266952;5348.064088784486;5365.222042803791;5248.763805628756;5295.364556253236;5309.044372013036;5353.705546194958;5378.1663842104535;5706.600537962344;5923.822285331404;5936.762529498858;5983.252093488314;6057.3336932937345;6172.444479996777;6186.783462578788;6198.4731297839735;6241;6253.843653908643;5957.523398128183;6265.373462653743;6301.338359472281;6302.55882088254;6329.4619957303685;5979.491743201789;5980.893534696095;5989.191459153002;6003.129546215774;6018.368071352533;6238.908191066545;6276.184096067574;6289.371062893765;6312.5581209314905;6328.050792381179;6227.657478838707;6229.813105606839;6231.844203894848;6242.75028998844;6269.874602508015;6184.690765461709;6263.279722831932;6290.496760259169;6319.8104056878365;6320.083587879732;6144.477719393813;6191.752329906843;6193.535484838655;6205.069239614094;6261.060840873905;6203.2245969253845;6261.68691565429;6262.060690896402;6263.248410190807;6272.874542509216;5031.169856973558;5035.899282014412;5042.168042272984;5053.166227572483;5058.291839142523;4374.387585737999;4421.270490369117;4460.397846290774;4510.233260345749;4523.163214805271;5780.16187652788;5784.4504772046585;5801.970990145022;5821.068629019336;5854.443827836349;6224.595401298901;6225.750969961241;6232.252129744369;6238.812835614939;6246.593971391845;5790;5810.767569297265;5861.501772349313;5884.7940322088525;5934.703264836741;5509.641873278224;5513.8345849624575;5514.145307477347;5516.475934786269;5522.171674248814;6295.244570651551;6396.328385519547;6413.0380442933;6415.390537898892;6431.774887878902;6287.2140982377205;6309.432151106423;6312;6317.842053948504;6325.715342809676;6461.870762584628;6466.579672321284;6474.384933431316;6478.967605161944;6486.962086066207;6150.415710507495;6167.506599472121;6210.223722034746;6213.875722485615;6219.222597175353;6225.439710425902;6293.748250069946;6299.874002519832;6323.988161894074;6335.65153916539;5661.971690141523;6252.9062064069985;6275.843103922439;6284.4972402206795;6303.936960630335;6083.6349819011;6149.7847575334645;6247.937520624736;6251.968740156452;6264.561480696308;6030.095485677183;6044.123602077586;6075.908861366995;6126.571140020156;6150.04674275488;6262.1546091278915;6277.1525844010475;6284.183056202664;6294.685265736786;6295.433410993032;6036.396360363929;6104.725287362168;6125.908111378244;6140.017597184429;6161.845953851011 17:50:34 INFO - PROCESS | 1917 | |1;ext.html;463.1894185175942;478.76001157003367;483.44645381038714;541.6208653942241;541.7399648168881;32441.351172976556;41930.95172620686;43336.3499547507;43461.91345216367;45696;45334.31998520016;45723.77138114313;45774.771126144406;45864.3120353195;45983;9950.900490995069;10128.987101289886;10129.594816207344;10135.341202821794;10144.188464922825;9307.813843723121;9559.091886270828;9918.156956658693;12519.43662535188;12544.24734515932;12520.499180032788;12580.81128783069;12584.993200543935;12592.118551701384;12600.81098783519;12483.750324993494;12562.37188140594;12567.434465449076;12570.68573285666;12586.559470418491;12314.630561083182;12393.690157746038;12402.627921162379;12403.503859845596;12416.627501174979;36688;42004.1599168018;42736.78631606853;43020.56979430197;43117.78441107806;3374.240795820945;3550.7869527828157;3558.3772839753196;3867.1105645701364;4387.978060109679;32076;32386.676133238838;32415.351692966007;32599.26360831919;33028.50457243143;3318.8008719476907;3358.4458564336855;3407.267437500949;3437.2781715839456;3448.896533104011;384044;385470;386832.0658396718;386846;387278;35604.64395356013;63988.68005660035;64336.678316608115;64359;64467;36259;37520.62479375226;37838.24323513569;37848.62151378506;37896.43155352617;15863.841361586467;16067.598310042109;16088.276027578788;16090.919545402197;16104;12228.816567751492;12445.004399648007;13433.66415839612;13602.115862468909;13610.979176561797;8003.759887203393;8231.259186673227;8255;8294.751157465285;8382.329413646894;3357.2446199605383;3406.0803583032443;3413.5050417689795;3419.093940105874;3439.914002149916;817.8119032622411;954.9474778887228;1022.8414595737672;1121.5962253588864;1157.479134389528;31269.843650782055;31414.371712565622;31774.682253177172;32106.518402223985;32179.51730724041;1016.4765145949842;1064.9787004259872;1066.4081434803759;1079.865016872891;1117.1342209787317;15860.365585376456;16019;16034.518964431085;16064.598385040468;16374.754378684329;747596;751777.2411138018;756029;757136;757586.2120689361;57354;57527;59391;59582;59776.402235977956;1292.7737645911927;1333.1401246196149;1406.4303956897472;1458.3656109592362;1460.7662773956329;31435;31611.84194079015;32506.02481925546;32601;32992.525560583534;60165.09752353806;61006.08490872552;61071;61123.38876611177;61145;597067;600137;607084;610913;890703;45467.54532454765;46090.308645369674;46230.38193663205;47458.28812567745;47562.76218618885;50536.494635053175;50927.49072509228;51109;51273;51778;40957;41496;42030.789846050575;42555.7233283002;43709.78145109254;42055.36916946187;42156.57843421526;42433.36349954691;43275.56724432841;43612;39965;40397.394039090024;40654.59345406508;41387.379189312785;42517.57482425136;33049.68652194324;35938.10154746152;36632.26735465223;36827;36908.81545592255;21810.345689629336;24549.77251137472;24782.876085619457;26732.465350693266;26800.329991749582 17:50:34 INFO - PROCESS | 1917 | |2;jquery.html;377.38297882961365;383.92705385976666;391.244897348118;401.1555675303488;410.5094412177449;15383;20772.480687982807;21812.345629631138;21852.781472185274;21992;16286.784696967432;19367.51581210467;21102;21408.785912140873;21625.3512394628;5937.139114828358;6251.3123556408755;6252.843678908041;6257.780977665782;6265.718042688067;5625.746841392127;5855.238818953551;5942.316633587128;6122.265328160627;6198.132261483396;6130.2643682758135;6133.631982081067;6139.6009259398215;6139.938600613981;6148.415900489469;5711.543076553866;5851.122331650244;5856.945749765041;6114.633122012671;6137.693115344237;5846.736896839652;6059;6073.878522429527;6078.544109191828;6080.2399700037495;13542;13883.028188026843;13886.722265554734;13931;16120.919395403065;2216.3240211735415;2250.6511490718963;2355.199232261022;2382.7855493005713;2942.2791416102978;10222.539985700661;10512.789744205073;10657.626983055634;14200;14357.56927292183;1802.8107048759953;1958.9706154407695;1961.892095934723;1970.9901450492798;2118.480972161815;116566;118312.90122592586;121574.39212803968;128841;130179.34910325576;11237.494312755945;11375.146863985234;11461.025812805838;11536.59621913229;11893;14945.953783235287;14961.177135257665;14979.176145312113;14996.550103496913;14998.850011499964;7910.5649189295145;8328.625211865481;8335.66657333712;8519.95740021296;8609.870851937227;8868.911310886937;8979.595918183697;8993.325500587482;8996.910030899608;9131.954340228256;4621.745803980813;4622.722636641813;4632;4635.6986795858165;4695.107929493385;1797.58655509231;1817.2053077374203;1826.7030408409912;1882.5764203054202;1900.3348827910397;893.13366034946;923.6536298887917;991.8363470027509;1037.258360272409;1063.3726101599939;21206;21341.573168536543;21360.35918922435;21376.57246855054;21445.927703614758;856.302113777282;955.1260596554214;962.6149540183983;992.2508506077864;1007.4183531854917;10151.131127457036;10835.51240194193;11501.42492875353;11502.884971150348;11512.712182195512;664016;667060;671138;671327;672016;84401;88744.11255887487;127303.09045364326;152406.23796881168;155304;1026.6971243483042;1027.5632856036154;1040.0431602925175;1043.2853495355705;1051.400701600096;18844.6231075375;19332.8066719331;19822.405327840188;19836.20655173777;19892.70160947616;57431.13853292287;57803.4219657798;59481.810363791614;61644.38355616386;61670;77781.61109194419;86935.56532217299;87139.56430218062;87990.56004719935;89348;6891.207511136083;8103.230193131643;8355.331573474228;8402.159784021793;8467.745967620982;12150;13090;13218.735625287249;13600;13652.97602679823;11580.262960555983;11882.82175767347;11921;12093.637190884288;12109;11142.498587563741;11329.830052549383;11355.602553910574;11523.193376463567;11844.881551184379;4861.927071094007;10707.393890916113;11624.302541847515;11776.293422394341;12076.03391728642;7330.79041958071;8124.918750812416;8227.917720822716;8343.2908202801;8378.455400398954;10012.349197302443;11686.88313116892;11790.351530665552;11941.52233910634;12157.08821838348 17:50:34 INFO - PROCESS | 1917 | |3;mootools.html;1538.7691846223065;1559.0100286318188;1764.2237415537163;1901.8668693191482;1921.2987259650215;8639.179277968591;9166.40418372807;9177.31170162238;9180.586873590688;9191.080891910813;8058.5567793771315;8345.374096942724;8682.782930426742;8901.376903616749;8917.063708310632;1869.9995502406216;2423.466837295792;2438.244144315268;2438.439158993424;2439.4755127647554;2405.675233843435;2410.7950824179966;2446.4006318451916;2447.645091461737;2449.106076282162;2417.3110663460916;2425.1511970810166;2436.049940523197;2442.9877850610724;2449.3876530867283;2335.43949452132;2345.483993521431;2354.976450235493;2357.3635118518077;2358.6108292131776;2381.7261014983324;2407.3500154958065;2407.8073754099805;2411.385096800322;2414.2153800015067;8911.866322005175;9107.36248462608;9112.8633070504;9116.680916167903;9118.224950879183;5371.033214021474;5536.889262214773;5537.1140617501005;5542.418046105141;5543.667379957175;3538.3454060998542;3635.054885729703;3666.7799932004164;3705.2959937611768;3710.5732840723394;1095.3646884806792;1102.0247081333077;1111.5331560744507;1123.7640095579939;1134.257061624629;11807.051836446975;11829.645110646694;11939.761204775856;11941.94029029858;11946.522139114424;3749.6812770914776;4541.523140070245;4722.220833562493;4727.149113159596;4732.337472753818;9365.157135857806;9403.43579385239;9405;9430.58541218809;9441.858372124423;5382.67703937765;5386.407495175527;5389.299391079135;5391.191321301836;5396.9730151348995;4522.547745225517;4627.30590411441;4910.140725373046;5010.473900240495;5061.417936937226;3849.7882616455804;3876.8643097491454;3949.4865667463046;3979.164375481181;3980.7014473914574;1170.8185231289165;1179.6578992092197;1183.260462211118;1192.8270400791837;1195.8505186851644;870.3994243971639;896.5786080542135;912.648630277348;914.8719179314901;933.1974501928336;5759.136129580513;5885.646861188342;6025.879482410327;6170.5372097092895;6200.906986395207;438.1652951128106;461.6929741721785;461.88452886778305;461.92147334953137;468.4425533614987;3820.9235815283537;3843.135294558702;3861.3821788514265;3863.768173909574;4005.5794141615293;10828.512716927757;11089.55641774336;11190;11206.607768728218;11213.663590092146;10738.302010369458;10923.563057477611;11116.277441966246;11133.441318215457;11143.108551315876;8016.438849280611;8386.329093672492;8436.987561492537;8464.57677116154;8473.618687158969;5992.400759923973;6023;6092.969535152296;6107.816765497042;6313.800377928179;10087.949560252151;10403.94798026005;10407.843882341922;10410.635627752992;10419.374837509773;10094.444805535471;10200.3369780964;10401.791964160826;10536.78926421452;10602.310849794738;7031.683574239274;7262.9273707262255;7565.319121279112;7598.278163574451;7796.064472263138;8639.222469977733;8872.157145071207;8873.378863479495;8874.866876996979;8889;7722.884156737766;7807.9219207809465;7869.48848324857;7993.120756716873;8015.438919275594;7559.697612095674;7685.193054729173;7687.807804804925;7699.615019248903;7739.496932699357;7162.46281528877;7244.529105608119;7250.673719682522;7250.984862119413;7261.3101755333155;4962.478939711423;4982.302477653059;5031.245313203049;5145.176771716508;5300.178472336794;5052.873678158076;5093.627724985896;5134.717590532557;5171.586273098068;5318.282031925795 17:50:34 INFO - PROCESS | 1917 | |4;prototype.html;304.69073890001647;307.36835802426003;313.4702353023391;318.79437762643096;320.65689712008134;4322.719023263489;5087.847364579059;5263.473652634734;5312.521873031426;5339.50262578012;4336.200476802123;4737.834175803848;5112.667676601019;5181.445566330105;5305.336832895888;3360.9327813443715;3668.504751858505;3875.953492557015;4080.795960201993;4096.262672718909;3389.830508474579;3595.8381872815658;3797.3924172132465;4108.219438306727;4136.4415803866395;3527.9118022049397;4003.179348233605;4017.4375587417785;4040.4141399497057;4050.736702114353;4012.498437695288;4031.4154447605224;4034.4553485279553;4044.777537235451;4048.8582899598373;3507.8421471033867;3527.400341941876;3528.3648943190215;3531.2584357285;3545.9716682162143;4239.7668128252935;4846.7818948147415;4978.303037574742;5196.272521846944;5220.556252718524;3905.628965248297;4629.305604159403;4644.373009643688;4663.463701674283;4677.462091859412;4777.784999674988;4994.725290109042;5093.9490605094215;5617.297837770278;5737.827865164052;3729.5151630287887;3858.575556688762;3862.7296089273764;3863.4784304118866;3878.612138786127;4990.030931595695;5744.368119506893;5857.70711464425;5883.23517942669;5923.17075609415;3826.8660596878976;3876.7013050627793;3900.1419687669236;3903.785291808978;3929.5088113985753;3603.801790901473;3748.025513366544;3877.2827027000094;4014.759114453142;4030.6170913763144;4576.878664727164;4580.427446569179;4590.632749380042;4596.575061730874;4622.6301895848255;5175.249588809676;5305.389880163831;5584.799268157366;5588.189712491666;5600.879824035128;1145.6219447582278;1272.5609664665676;1312.3569450968957;1328.734253149374;1329.5944736855158;884.6549845560237;904.1500989070253;912.5665308978182;918.2195134136065;920.447731361178;5094.61790365724;5279.524842764093;5336.706481143575;5375.9462405376225;5416.781224224596;4862.635302352338;5112.233165025276;5675;5824.6796426196115;5839.043920286666;4543.772811359485;5116.462771409023;5237.8428647140645;5272.994393195841;5316.149416093406;2009.9598008039757;2510.422602801366;2544.7455254474403;2565.7690807827385;2580.367809886552;3849.4995650565806;4501.498501498501;4890.413150421972;4936.186373766918;5073.923891141636;3928.3125453045604;4570.0751519027845;4575.924657705436;4816.4220293564995;4825.565699087099;4011.358182690697;4874.807001414079;4878.9512104878495;4889.608831293559;4935.728534930541;4048.8785336439955;4682.508336624742;4703.153432382204;4718.433787945469;4952.851414457572;5691.637970242303;5784.8553786154;5863.677497737665;5876.853078673067;5878.2064421302575;5322.441143679858;5911.349751527243;6048.818535443944;6070.939290607214;6114.327423983447;3297.4394352959575;3393.643667414886;3654.287413954253;3981.581933897015;4000.3599424092004;5122.924185920999;5815.720541480868;5824.184614154106;5856.619319744203;5868.2664666916635;4674.953250467452;5561.165825126263;5798.75269848886;5801.680907550125;5804.21643078179;5181.3005244293045;5285.097364948692;5565.972170139124;5590.245316882331;5601.551875850004;4812.735299558558;4931.309616653743;5275.973620131875;5340.798320377884;5555.972220138873;5281.630285879952;5494.642848214853;5622.718864056699;5633.155026746021;5637;4514.932276015928;5300.787968481218;5494.890102198014;5495.818399044225;5503.3120859892515 17:50:34 INFO - PROCESS | 1917 | |5;yui.html;723.7792473295646;726.6257877193243;744.1999850161077;785.2540086917427;844.7676888855564;12786.872131278684;16479.67040659186;16531.91734041328;16665.750013749803;16709.41517046902;14813.777793333109;14961.850381496182;14971.925140374284;14982;15022.624434389145;702.3012102957564;722.0072400449382;829.6515463505312;909.5815924674657;916.4226537281503;896.3322324867983;896.394933419939;899.6041741633693;900.9279257659405;903.439867282286;946.7254496196094;949.4920217683541;952.6141912525403;953.2659851914023;953.9236861051133;946.1720994130136;946.7301818981591;947.1759569174793;949.7720547068723;951.8952915179325;699.618707804248;700.8142842146835;701.0955866931652;702.68379229347;703.4969996452561;15790.131542765143;15823.683526329523;15834.841651583452;15839.683206335923;15852.841471585252;12324.014078873668;14914.403423863032;15035.398584056624;15076.773848392282;15121.395144194219;11677.591284305008;11686.707832304175;12054.517819287217;12305.50076703922;12307.076969227253;3886.436466712311;3942.467766851467;4000.079981604247;4066.7966601670096;4098.4876890388705;113167;121345;121405.78594214033;122681;125533;9730.513474326255;11586.826197607043;11894.643160705193;12066.336351500751;12083.214591051554;24555;24791;24803.379915501897;24818.751812482005;24847.378815529755;8380.832383352421;8422.115677853859;8470.280026197719;8500.914990850013;8517.574121294034;4425.343517539834;4502.414686090788;4644.373009643722;4778.378810754649;4792.640551958547;3724.640506215212;3816.5038544988975;3852.9229415412096;3854.5181852268465;4020.8793736187963;706.7738323736457;713.9286071392924;729.7810656802938;742.0501757750088;747.0437839565365;579.7622974580402;614.8647297594522;645.4739387399254;674.1126830479027;739.0798455922411;8385.329173666092;9737.812859466083;10082.81243779106;10103.747406314755;10208.795824083476;462.5212904643678;577.7948828166025;701.3932947999944;716.2658275267892;717.433227750082;3990.3016972029777;4668;4840.7337596432535;4853.781579828917;4938.58022068121;117353.23970140454;144530.27734861258;153499;153694;157341;128827;129921.35039324932;133892;133954;135547.32226339003;84344;103836.48081759542;106900.93099069066;111591;111965.88034119555;8140.389470789596;9291.814163716552;9434.669786557437;9440.197583205505;9487.478188699688;56434.43565564292;58134.4186558129;58157.83684326205;59442;64795.67602161959;86466;86543.56728216319;88233.55883220542;89518.10481895097;90684.5465772667;13378.397972091085;13462.124961877447;13868.514601988882;14049.36777844979;14070.155790652594;14859;14995.17526536051;15159.772603410736;15445.691086178438;15645.530634080997;14090.36593353281;14552;14597.416103355747;14659.70680586361;15255.160966146968;13788.448462061406;14384.568462946128;14646.780298295322;15152.772708409602;15165.696686066438;13457.798133027816;13583.320833958065;14022.22877741734;14514.637134071732;14542.346434232835;11377.431128443379;11851.24032704081;12109.75780484403;12227.816582751087;12371.566995155126;8843.395306733606;11903;12060.698482537655;12138.75722485563;12162.75674486523 17:50:34 INFO - PROCESS | 1917 | __end_tp_report 17:50:34 INFO - PROCESS | 1917 | __start_cc_report 17:50:34 INFO - PROCESS | 1917 | _x_x_mozilla_cycle_collect,1176 17:50:34 INFO - PROCESS | 1917 | __end_cc_report 17:50:34 INFO - PROCESS | 1917 | __startTimestamp1483581034780__endTimestamp 17:50:34 INFO - PROCESS | 1917 | 17:50:34 INFO - PROCESS | 1917 | ------- Summary: start ------- 17:50:34 INFO - PROCESS | 1917 | Number of tests: 6 17:50:34 INFO - PROCESS | 1917 | 17:50:34 INFO - PROCESS | 1917 | [#0] dojo.html Cycles:165 Average:5847.84 Median:6104.73 stddev:642.73 (10.5%) stddev-sans-first:598.42 17:50:34 INFO - PROCESS | 1917 | Values: 2794.8 3424.2 3448.4 3468.3 3492.1 5766.7 5889.1 5893.9 5905.1 5928.5 5948.1 5992.4 5999.9 6015.4 6017.9 5298.1 5321.9 5385.0 5398.2 5413.9 5284.3 5304.5 5317.8 5407.1 5415.7 5393.4 5394.8 5403.2 5406.1 5409.7 5230.3 5331.8 5345.2 5348.1 5365.2 5248.8 5295.4 5309.0 5353.7 5378.2 5706.6 5923.8 5936.8 5983.3 6057.3 6172.4 6186.8 6198.5 6241.0 6253.8 5957.5 6265.4 6301.3 6302.6 6329.5 5979.5 5980.9 5989.2 6003.1 6018.4 6238.9 6276.2 6289.4 6312.6 6328.1 6227.7 6229.8 6231.8 6242.8 6269.9 6184.7 6263.3 6290.5 6319.8 6320.1 6144.5 6191.8 6193.5 6205.1 6261.1 6203.2 6261.7 6262.1 6263.2 6272.9 5031.2 5035.9 5042.2 5053.2 5058.3 4374.4 4421.3 4460.4 4510.2 4523.2 5780.2 5784.5 5802.0 5821.1 5854.4 6224.6 6225.8 6232.3 6238.8 6246.6 5790.0 5810.8 5861.5 5884.8 5934.7 5509.6 5513.8 5514.1 5516.5 5522.2 6295.2 6396.3 6413.0 6415.4 6431.8 6287.2 6309.4 6312.0 6317.8 6325.7 6461.9 6466.6 6474.4 6479.0 6487.0 6150.4 6167.5 6210.2 6213.9 6219.2 6225.4 6293.7 6299.9 6324.0 6335.7 5662.0 6252.9 6275.8 6284.5 6303.9 6083.6 6149.8 6247.9 6252.0 6264.6 6030.1 6044.1 6075.9 6126.6 6150.0 6262.2 6277.2 6284.2 6294.7 6295.4 6036.4 6104.7 6125.9 6140.0 6161.8 17:50:34 INFO - PROCESS | 1917 | 17:50:34 INFO - PROCESS | 1917 | [#1] ext.html Cycles:180 Average:73686.32 Median:37214.72 stddev:167696.34 (450.6%) stddev-sans-first:168076.65 17:50:34 INFO - PROCESS | 1917 | Values: 463.2 478.8 483.4 541.6 541.7 32441.4 41931.0 43336.3 43461.9 45696.0 45334.3 45723.8 45774.8 45864.3 45983.0 9950.9 10129.0 10129.6 10135.3 10144.2 9307.8 9559.1 9918.2 12519.4 12544.2 12520.5 12580.8 12585.0 12592.1 12600.8 12483.8 12562.4 12567.4 12570.7 12586.6 12314.6 12393.7 12402.6 12403.5 12416.6 36688.0 42004.2 42736.8 43020.6 43117.8 3374.2 3550.8 3558.4 3867.1 4388.0 32076.0 32386.7 32415.4 32599.3 33028.5 3318.8 3358.4 3407.3 3437.3 3448.9 384044.0 385470.0 386832.1 386846.0 387278.0 35604.6 63988.7 64336.7 64359.0 64467.0 36259.0 37520.6 37838.2 37848.6 37896.4 15863.8 16067.6 16088.3 16090.9 16104.0 12228.8 12445.0 13433.7 13602.1 13611.0 8003.8 8231.3 8255.0 8294.8 8382.3 3357.2 3406.1 3413.5 3419.1 3439.9 817.8 954.9 1022.8 1121.6 1157.5 31269.8 31414.4 31774.7 32106.5 32179.5 1016.5 1065.0 1066.4 1079.9 1117.1 15860.4 16019.0 16034.5 16064.6 16374.8 747596.0 751777.2 756029.0 757136.0 757586.2 57354.0 57527.0 59391.0 59582.0 59776.4 1292.8 1333.1 1406.4 1458.4 1460.8 31435.0 31611.8 32506.0 32601.0 32992.5 60165.1 61006.1 61071.0 61123.4 61145.0 597067.0 600137.0 607084.0 610913.0 890703.0 45467.5 46090.3 46230.4 47458.3 47562.8 50536.5 50927.5 51109.0 51273.0 51778.0 40957.0 41496.0 42030.8 42555.7 43709.8 42055.4 42156.6 42433.4 43275.6 43612.0 39965.0 40397.4 40654.6 41387.4 42517.6 33049.7 35938.1 36632.3 36827.0 36908.8 21810.3 24549.8 24782.9 26732.5 26800.3 17:50:34 INFO - PROCESS | 1917 | 17:50:34 INFO - PROCESS | 1917 | [#2] jquery.html Cycles:180 Average:37236.38 Median:21535.64 stddev:111280.55 (516.7%) stddev-sans-first:111558.30 17:50:34 INFO - PROCESS | 1917 | Values: 377.4 383.9 391.2 401.2 410.5 15383.0 20772.5 21812.3 21852.8 21992.0 16286.8 19367.5 21102.0 21408.8 21625.4 5937.1 6251.3 6252.8 6257.8 6265.7 5625.7 5855.2 5942.3 6122.3 6198.1 6130.3 6133.6 6139.6 6139.9 6148.4 5711.5 5851.1 5856.9 6114.6 6137.7 5846.7 6059.0 6073.9 6078.5 6080.2 13542.0 13883.0 13886.7 13931.0 16120.9 2216.3 2250.7 2355.2 2382.8 2942.3 10222.5 10512.8 10657.6 14200.0 14357.6 1802.8 1959.0 1961.9 1971.0 2118.5 116566.0 118312.9 121574.4 128841.0 130179.3 11237.5 11375.1 11461.0 11536.6 11893.0 14946.0 14961.2 14979.2 14996.6 14998.9 7910.6 8328.6 8335.7 8520.0 8609.9 8868.9 8979.6 8993.3 8996.9 9132.0 4621.7 4622.7 4632.0 4635.7 4695.1 1797.6 1817.2 1826.7 1882.6 1900.3 893.1 923.7 991.8 1037.3 1063.4 21206.0 21341.6 21360.4 21376.6 21445.9 856.3 955.1 962.6 992.3 1007.4 10151.1 10835.5 11501.4 11502.9 11512.7 664016.0 667060.0 671138.0 671327.0 672016.0 84401.0 88744.1 127303.1 152406.2 155304.0 1026.7 1027.6 1040.0 1043.3 1051.4 18844.6 19332.8 19822.4 19836.2 19892.7 57431.1 57803.4 59481.8 61644.4 61670.0 77781.6 86935.6 87139.6 87990.6 89348.0 6891.2 8103.2 8355.3 8402.2 8467.7 12150.0 13090.0 13218.7 13600.0 13653.0 11580.3 11882.8 11921.0 12093.6 12109.0 11142.5 11329.8 11355.6 11523.2 11844.9 4861.9 10707.4 11624.3 11776.3 12076.0 7330.8 8124.9 8227.9 8343.3 8378.5 10012.3 11686.9 11790.4 11941.5 12157.1 17:50:34 INFO - PROCESS | 1917 | 17:50:34 INFO - PROCESS | 1917 | [#3] mootools.html Cycles:180 Average:5823.67 Median:4729.74 stddev:3306.69 (69.9%) stddev-sans-first:3300.29 17:50:34 INFO - PROCESS | 1917 | Values: 1538.8 1559.0 1764.2 1901.9 1921.3 8639.2 9166.4 9177.3 9180.6 9191.1 8058.6 8345.4 8682.8 8901.4 8917.1 1870.0 2423.5 2438.2 2438.4 2439.5 2405.7 2410.8 2446.4 2447.6 2449.1 2417.3 2425.2 2436.0 2443.0 2449.4 2335.4 2345.5 2355.0 2357.4 2358.6 2381.7 2407.4 2407.8 2411.4 2414.2 8911.9 9107.4 9112.9 9116.7 9118.2 5371.0 5536.9 5537.1 5542.4 5543.7 3538.3 3635.1 3666.8 3705.3 3710.6 1095.4 1102.0 1111.5 1123.8 1134.3 11807.1 11829.6 11939.8 11941.9 11946.5 3749.7 4541.5 4722.2 4727.1 4732.3 9365.2 9403.4 9405.0 9430.6 9441.9 5382.7 5386.4 5389.3 5391.2 5397.0 4522.5 4627.3 4910.1 5010.5 5061.4 3849.8 3876.9 3949.5 3979.2 3980.7 1170.8 1179.7 1183.3 1192.8 1195.9 870.4 896.6 912.6 914.9 933.2 5759.1 5885.6 6025.9 6170.5 6200.9 438.2 461.7 461.9 461.9 468.4 3820.9 3843.1 3861.4 3863.8 4005.6 10828.5 11089.6 11190.0 11206.6 11213.7 10738.3 10923.6 11116.3 11133.4 11143.1 8016.4 8386.3 8437.0 8464.6 8473.6 5992.4 6023.0 6093.0 6107.8 6313.8 10087.9 10403.9 10407.8 10410.6 10419.4 10094.4 10200.3 10401.8 10536.8 10602.3 7031.7 7262.9 7565.3 7598.3 7796.1 8639.2 8872.2 8873.4 8874.9 8889.0 7722.9 7807.9 7869.5 7993.1 8015.4 7559.7 7685.2 7687.8 7699.6 7739.5 7162.5 7244.5 7250.7 7251.0 7261.3 4962.5 4982.3 5031.2 5145.2 5300.2 5052.9 5093.6 5134.7 5171.6 5318.3 17:50:34 INFO - PROCESS | 1917 | 17:50:34 INFO - PROCESS | 1917 | [#4] prototype.html Cycles:180 Average:4400.68 Median:4836.17 stddev:1361.19 (28.1%) stddev-sans-first:1329.84 17:50:34 INFO - PROCESS | 1917 | Values: 304.7 307.4 313.5 318.8 320.7 4322.7 5087.8 5263.5 5312.5 5339.5 4336.2 4737.8 5112.7 5181.4 5305.3 3360.9 3668.5 3876.0 4080.8 4096.3 3389.8 3595.8 3797.4 4108.2 4136.4 3527.9 4003.2 4017.4 4040.4 4050.7 4012.5 4031.4 4034.5 4044.8 4048.9 3507.8 3527.4 3528.4 3531.3 3546.0 4239.8 4846.8 4978.3 5196.3 5220.6 3905.6 4629.3 4644.4 4663.5 4677.5 4777.8 4994.7 5093.9 5617.3 5737.8 3729.5 3858.6 3862.7 3863.5 3878.6 4990.0 5744.4 5857.7 5883.2 5923.2 3826.9 3876.7 3900.1 3903.8 3929.5 3603.8 3748.0 3877.3 4014.8 4030.6 4576.9 4580.4 4590.6 4596.6 4622.6 5175.2 5305.4 5584.8 5588.2 5600.9 1145.6 1272.6 1312.4 1328.7 1329.6 884.7 904.2 912.6 918.2 920.4 5094.6 5279.5 5336.7 5375.9 5416.8 4862.6 5112.2 5675.0 5824.7 5839.0 4543.8 5116.5 5237.8 5273.0 5316.1 2010.0 2510.4 2544.7 2565.8 2580.4 3849.5 4501.5 4890.4 4936.2 5073.9 3928.3 4570.1 4575.9 4816.4 4825.6 4011.4 4874.8 4879.0 4889.6 4935.7 4048.9 4682.5 4703.2 4718.4 4952.9 5691.6 5784.9 5863.7 5876.9 5878.2 5322.4 5911.3 6048.8 6070.9 6114.3 3297.4 3393.6 3654.3 3981.6 4000.4 5122.9 5815.7 5824.2 5856.6 5868.3 4675.0 5561.2 5798.8 5801.7 5804.2 5181.3 5285.1 5566.0 5590.2 5601.6 4812.7 4931.3 5276.0 5340.8 5556.0 5281.6 5494.6 5622.7 5633.2 5637.0 4514.9 5300.8 5494.9 5495.8 5503.3 17:50:34 INFO - PROCESS | 1917 | 17:50:34 INFO - PROCESS | 1917 | [#5] yui.html Cycles:180 Average:25181.44 Median:3770.57 stddev:39666.66 (1052.0%) stddev-sans-first:39735.43 17:50:34 INFO - PROCESS | 1917 | Values: 723.8 726.6 744.2 785.3 844.8 12786.9 16479.7 16531.9 16665.8 16709.4 14813.8 14961.9 14971.9 14982.0 15022.6 702.3 722.0 829.7 909.6 916.4 896.3 896.4 899.6 900.9 903.4 946.7 949.5 952.6 953.3 953.9 946.2 946.7 947.2 949.8 951.9 699.6 700.8 701.1 702.7 703.5 15790.1 15823.7 15834.8 15839.7 15852.8 12324.0 14914.4 15035.4 15076.8 15121.4 11677.6 11686.7 12054.5 12305.5 12307.1 3886.4 3942.5 4000.1 4066.8 4098.5 113167.0 121345.0 121405.8 122681.0 125533.0 9730.5 11586.8 11894.6 12066.3 12083.2 24555.0 24791.0 24803.4 24818.8 24847.4 8380.8 8422.1 8470.3 8500.9 8517.6 4425.3 4502.4 4644.4 4778.4 4792.6 3724.6 3816.5 3852.9 3854.5 4020.9 706.8 713.9 729.8 742.1 747.0 579.8 614.9 645.5 674.1 739.1 8385.3 9737.8 10082.8 10103.7 10208.8 462.5 577.8 701.4 716.3 717.4 3990.3 4668.0 4840.7 4853.8 4938.6 117353.2 144530.3 153499.0 153694.0 157341.0 128827.0 129921.4 133892.0 133954.0 135547.3 84344.0 103836.5 106900.9 111591.0 111965.9 8140.4 9291.8 9434.7 9440.2 9487.5 56434.4 58134.4 58157.8 59442.0 64795.7 86466.0 86543.6 88233.6 89518.1 90684.5 13378.4 13462.1 13868.5 14049.4 14070.2 14859.0 14995.2 15159.8 15445.7 15645.5 14090.4 14552.0 14597.4 14659.7 15255.2 13788.4 14384.6 14646.8 15152.8 15165.7 13457.8 13583.3 14022.2 14514.6 14542.3 11377.4 11851.2 12109.8 12227.8 12371.6 8843.4 11903.0 12060.7 12138.8 12162.8 17:50:34 INFO - PROCESS | 1917 | -------- Summary: end -------- 17:50:34 INFO - PROCESS | 1917 | 17:50:35 INFO - TEST-INFO | 1917: exit 0 17:50:35 INFO - TEST-OK | dromaeo_css | took 1115245ms 17:50:35 INFO - TEST-START | kraken 17:50:35 INFO - operating with platform_type : mac_ 17:50:35 INFO - Initialising browser for kraken test... 17:50:35 INFO - TEST-INFO | started process 1921 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/tmpV364Nv/profile http://localhost:51725/getInfo.html) 17:50:37 INFO - PROCESS | 1921 | __metrics Screen width/height:1600/1200 17:50:37 INFO - PROCESS | 1921 | colorDepth:24 17:50:37 INFO - PROCESS | 1921 | Browser inner width/height: 1024/689 17:50:37 INFO - PROCESS | 1921 | __metrics 17:50:37 INFO - PROCESS | 1921 | 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" 17:50:37 INFO - PROCESS | 1921 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:50:38 INFO - TEST-INFO | 1921: exit 0 17:50:38 INFO - Browser initialized. 17:50:38 INFO - Running cycle 1/1 for kraken test... 17:50:38 INFO - TEST-INFO | started process 1923 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/T/tmpV364Nv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:50:50 INFO - PROCESS | 1923 | RSS: Main: 169418752 17:50:50 INFO - PROCESS | 1923 | 17:50:52 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51725/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51725/tests/kraken/driver.html?testName=audio-beat-detection) 17:50:53 INFO - PROCESS | 1923 | RSS: Main: 219594752 17:50:53 INFO - PROCESS | 1923 | 17:50:56 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51725/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51725/tests/kraken/driver.html?testName=audio-dft) 17:50:56 INFO - PROCESS | 1923 | RSS: Main: 232816640 17:50:56 INFO - PROCESS | 1923 | 17:51:00 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51725/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51725/tests/kraken/driver.html?testName=audio-fft) 17:51:00 INFO - PROCESS | 1923 | RSS: Main: 331001856 17:51:00 INFO - PROCESS | 1923 | 17:51:02 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51725/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51725/tests/kraken/driver.html?testName=audio-oscillator) 17:51:03 INFO - PROCESS | 1923 | RSS: Main: 228298752 17:51:03 INFO - PROCESS | 1923 | 17:51:05 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51725/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51725/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:51:06 INFO - PROCESS | 1923 | RSS: Main: 230608896 17:51:06 INFO - PROCESS | 1923 | 17:51:08 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51725/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51725/tests/kraken/driver.html?testName=imaging-darkroom) 17:51:09 INFO - PROCESS | 1923 | RSS: Main: 267063296 17:51:09 INFO - PROCESS | 1923 | 17:51:12 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51725/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51725/tests/kraken/driver.html?testName=imaging-desaturate) 17:51:13 INFO - PROCESS | 1923 | RSS: Main: 268369920 17:51:13 INFO - PROCESS | 1923 | 17:51:15 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51725/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51725/tests/kraken/driver.html?testName=json-parse-financial) 17:51:16 INFO - PROCESS | 1923 | RSS: Main: 266797056 17:51:16 INFO - PROCESS | 1923 | 17:51:17 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51725/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51725/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:51:18 INFO - PROCESS | 1923 | RSS: Main: 240267264 17:51:18 INFO - PROCESS | 1923 | 17:51:20 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51725/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51725/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:51:20 INFO - PROCESS | 1923 | RSS: Main: 247160832 17:51:20 INFO - PROCESS | 1923 | 17:51:22 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51725/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51725/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:51:23 INFO - PROCESS | 1923 | RSS: Main: 254636032 17:51:23 INFO - PROCESS | 1923 | 17:51:26 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51725/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51725/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:51:27 INFO - PROCESS | 1923 | RSS: Main: 267636736 17:51:27 INFO - PROCESS | 1923 | 17:51:29 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51725/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51725/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:51:30 INFO - PROCESS | 1923 | RSS: Main: 261877760 17:51:30 INFO - PROCESS | 1923 | 17:51:32 INFO - PROCESS | 1923 | Cycle 1(1): loaded http://localhost:51725/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51725/tests/kraken/driver.html?testName=ai-astar) 17:51:32 INFO - PROCESS | 1923 | RSS: Main: 305672192 17:51:32 INFO - PROCESS | 1923 | 17:51:32 INFO - PROCESS | 1923 | __start_tp_report 17:51:32 INFO - PROCESS | 1923 | _x_x_mozilla_page_load 17:51:32 INFO - PROCESS | 1923 | _x_x_mozilla_page_load_details 17:51:32 INFO - PROCESS | 1923 | |i|pagename|runs| 17:51:32 INFO - PROCESS | 1923 | |0;ai-astar;113;115;115;114;132;164;165;114;114;113 17:51:32 INFO - PROCESS | 1923 | |1;audio-beat-detection;144;123;108;138;108;107;108;106;140;107 17:51:32 INFO - PROCESS | 1923 | |2;audio-dft;181;183;183;184;182;181;195;259;205;180 17:51:32 INFO - PROCESS | 1923 | |3;audio-fft;80;59;58;88;62;61;69;55;81;57 17:51:32 INFO - PROCESS | 1923 | |4;audio-oscillator;88;70;93;68;69;69;92;90;99;121 17:51:32 INFO - PROCESS | 1923 | |5;imaging-gaussian-blur;89;76;110;128;135;86;89;86;88;86 17:51:32 INFO - PROCESS | 1923 | |6;imaging-darkroom;93;95;94;94;94;103;150;94;116;92 17:51:32 INFO - PROCESS | 1923 | |7;imaging-desaturate;85;83;85;86;84;83;86;86;90;85 17:51:32 INFO - PROCESS | 1923 | |8;json-parse-financial;56;54;56;55;55;58;58;58;56;56 17:51:32 INFO - PROCESS | 1923 | |9;json-stringify-tinderbox;64;70;80;75;71;67;70;69;69;70 17:51:32 INFO - PROCESS | 1923 | |10;stanford-crypto-aes;82;84;81;83;80;82;80;86;83;82 17:51:32 INFO - PROCESS | 1923 | |11;stanford-crypto-ccm;134;136;135;133;134;135;136;137;164;146 17:51:32 INFO - PROCESS | 1923 | |12;stanford-crypto-pbkdf2;160;163;161;158;160;158;159;158;167;172 17:51:32 INFO - PROCESS | 1923 | |13;stanford-crypto-sha256-iterative;64;65;65;65;65;65;64;67;64;64 17:51:32 INFO - PROCESS | 1923 | __end_tp_report 17:51:32 INFO - PROCESS | 1923 | __start_cc_report 17:51:32 INFO - PROCESS | 1923 | _x_x_mozilla_cycle_collect,1846 17:51:32 INFO - PROCESS | 1923 | __end_cc_report 17:51:32 INFO - PROCESS | 1923 | __startTimestamp1483581092363__endTimestamp 17:51:32 INFO - PROCESS | 1923 | 17:51:32 INFO - PROCESS | 1923 | ------- Summary: start ------- 17:51:32 INFO - PROCESS | 1923 | Number of tests: 14 17:51:32 INFO - PROCESS | 1923 | 17:51:32 INFO - PROCESS | 1923 | [#0] ai-astar Cycles:10 Average:125.90 Median:115.00 stddev:21.12 (18.4%) stddev-sans-first:21.87 17:51:32 INFO - PROCESS | 1923 | Values: 113.0 115.0 115.0 114.0 132.0 164.0 165.0 114.0 114.0 113.0 17:51:32 INFO - PROCESS | 1923 | 17:51:32 INFO - PROCESS | 1923 | [#1] audio-beat-detection Cycles:10 Average:118.90 Median:115.50 stddev:15.86 (13.7%) stddev-sans-first:13.98 17:51:32 INFO - PROCESS | 1923 | Values: 144.0 123.0 108.0 138.0 108.0 107.0 108.0 106.0 140.0 107.0 17:51:32 INFO - PROCESS | 1923 | 17:51:32 INFO - PROCESS | 1923 | [#2] audio-dft Cycles:10 Average:193.30 Median:183.50 stddev:24.41 (13.3%) stddev-sans-first:25.48 17:51:32 INFO - PROCESS | 1923 | Values: 181.0 183.0 183.0 184.0 182.0 181.0 195.0 259.0 205.0 180.0 17:51:32 INFO - PROCESS | 1923 | 17:51:32 INFO - PROCESS | 1923 | [#3] audio-fft Cycles:10 Average:67.00 Median:65.50 stddev:11.83 (18.1%) stddev-sans-first:11.58 17:51:32 INFO - PROCESS | 1923 | Values: 80.0 59.0 58.0 88.0 62.0 61.0 69.0 55.0 81.0 57.0 17:51:32 INFO - PROCESS | 1923 | 17:51:32 INFO - PROCESS | 1923 | [#4] audio-oscillator Cycles:10 Average:85.90 Median:89.00 stddev:17.18 (19.3%) stddev-sans-first:18.21 17:51:32 INFO - PROCESS | 1923 | Values: 88.0 70.0 93.0 68.0 69.0 69.0 92.0 90.0 99.0 121.0 17:51:32 INFO - PROCESS | 1923 | 17:51:32 INFO - PROCESS | 1923 | [#5] imaging-gaussian-blur Cycles:10 Average:97.30 Median:86.00 stddev:19.96 (23.2%) stddev-sans-first:20.95 17:51:32 INFO - PROCESS | 1923 | Values: 89.0 76.0 110.0 128.0 135.0 86.0 89.0 86.0 88.0 86.0 17:51:32 INFO - PROCESS | 1923 | 17:51:32 INFO - PROCESS | 1923 | [#6] imaging-darkroom Cycles:10 Average:102.50 Median:94.00 stddev:18.21 (19.4%) stddev-sans-first:18.99 17:51:32 INFO - PROCESS | 1923 | Values: 93.0 95.0 94.0 94.0 94.0 103.0 150.0 94.0 116.0 92.0 17:51:32 INFO - PROCESS | 1923 | 17:51:32 INFO - PROCESS | 1923 | [#7] imaging-desaturate Cycles:10 Average:85.30 Median:85.50 stddev:2.00 (2.3%) stddev-sans-first:2.12 17:51:32 INFO - PROCESS | 1923 | Values: 85.0 83.0 85.0 86.0 84.0 83.0 86.0 86.0 90.0 85.0 17:51:32 INFO - PROCESS | 1923 | 17:51:32 INFO - PROCESS | 1923 | [#8] json-parse-financial Cycles:10 Average:56.20 Median:56.00 stddev:1.40 (2.5%) stddev-sans-first:1.48 17:51:32 INFO - PROCESS | 1923 | Values: 56.0 54.0 56.0 55.0 55.0 58.0 58.0 58.0 56.0 56.0 17:51:32 INFO - PROCESS | 1923 | 17:51:32 INFO - PROCESS | 1923 | [#9] json-stringify-tinderbox Cycles:10 Average:70.50 Median:70.00 stddev:4.35 (6.2%) stddev-sans-first:3.93 17:51:32 INFO - PROCESS | 1923 | Values: 64.0 70.0 80.0 75.0 71.0 67.0 70.0 69.0 69.0 70.0 17:51:32 INFO - PROCESS | 1923 | 17:51:32 INFO - PROCESS | 1923 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.50 stddev:1.83 (2.2%) stddev-sans-first:1.94 17:51:32 INFO - PROCESS | 1923 | Values: 82.0 84.0 81.0 83.0 80.0 82.0 80.0 86.0 83.0 82.0 17:51:32 INFO - PROCESS | 1923 | 17:51:32 INFO - PROCESS | 1923 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:136.00 stddev:9.51 (7.0%) stddev-sans-first:9.91 17:51:32 INFO - PROCESS | 1923 | Values: 134.0 136.0 135.0 133.0 134.0 135.0 136.0 137.0 164.0 146.0 17:51:32 INFO - PROCESS | 1923 | 17:51:32 INFO - PROCESS | 1923 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.60 Median:160.50 stddev:4.60 (2.9%) stddev-sans-first:4.84 17:51:32 INFO - PROCESS | 1923 | Values: 160.0 163.0 161.0 158.0 160.0 158.0 159.0 158.0 167.0 172.0 17:51:32 INFO - PROCESS | 1923 | 17:51:32 INFO - PROCESS | 1923 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.80 Median:65.00 stddev:0.92 (1.4%) stddev-sans-first:0.93 17:51:32 INFO - PROCESS | 1923 | Values: 64.0 65.0 65.0 65.0 65.0 65.0 64.0 67.0 64.0 64.0 17:51:32 INFO - PROCESS | 1923 | -------- Summary: end -------- 17:51:32 INFO - PROCESS | 1923 | 17:51:33 INFO - TEST-INFO | 1923: exit 0 17:51:33 INFO - TEST-OK | kraken | took 57700ms 17:51:33 INFO - SUITE-END | took 1172s 17:51:33 INFO - Completed test suite (00:19:33) 17:51:33 INFO - javascript benchmark 17:51:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2794.790390720696, 3424.1953141011873, 3448.4310088835327, 3468.3236768830075, 3492.0746002309393, 5766.740496677649, 5889.0871914853215, 5893.941060589393, 5905.055191169414, 5928.525717942565, 5948.078047902572, 5992.400759924006, 5999.940000600003, 6015.368386319439, 6017.879642407149, 5298.125809241471, 5321.893562128756, 5385.030694474993, 5398.244245805571, 5413.918791218135, 5284.260203571503, 5304.469553044684, 5317.813876514303, 5407.080796264625, 5415.729213539307, 5393.352797664266, 5394.757235924373, 5403.2165336026255, 5406.08096623575, 5409.729513524328, 5230.320058392404, 5331.760070796823, 5345.198220266952, 5348.064088784486, 5365.222042803791, 5248.763805628756, 5295.364556253236, 5309.044372013036, 5353.705546194958, 5378.1663842104535, 5706.600537962344, 5923.822285331404, 5936.762529498858, 5983.252093488314, 6057.3336932937345, 6172.444479996777, 6186.783462578788, 6198.4731297839735, 6241.0, 6253.843653908643, 5957.523398128183, 6265.373462653743, 6301.338359472281, 6302.55882088254, 6329.4619957303685, 5979.491743201789, 5980.893534696095, 5989.191459153002, 6003.129546215774, 6018.368071352533, 6238.908191066545, 6276.184096067574, 6289.371062893765, 6312.5581209314905, 6328.050792381179, 6227.657478838707, 6229.813105606839, 6231.844203894848, 6242.75028998844, 6269.874602508015, 6184.690765461709, 6263.279722831932, 6290.496760259169, 6319.8104056878365, 6320.083587879732, 6144.477719393813, 6191.752329906843, 6193.535484838655, 6205.069239614094, 6261.060840873905, 6203.2245969253845, 6261.68691565429, 6262.060690896402, 6263.248410190807, 6272.874542509216, 5031.169856973558, 5035.899282014412, 5042.168042272984, 5053.166227572483, 5058.291839142523, 4374.387585737999, 4421.270490369117, 4460.397846290774, 4510.233260345749, 4523.163214805271, 5780.16187652788, 5784.4504772046585, 5801.970990145022, 5821.068629019336, 5854.443827836349, 6224.595401298901, 6225.750969961241, 6232.252129744369, 6238.812835614939, 6246.593971391845, 5790.0, 5810.767569297265, 5861.501772349313, 5884.7940322088525, 5934.703264836741, 5509.641873278224, 5513.8345849624575, 5514.145307477347, 5516.475934786269, 5522.171674248814, 6295.244570651551, 6396.328385519547, 6413.0380442933, 6415.390537898892, 6431.774887878902, 6287.2140982377205, 6309.432151106423, 6312.0, 6317.842053948504, 6325.715342809676, 6461.870762584628, 6466.579672321284, 6474.384933431316, 6478.967605161944, 6486.962086066207, 6150.415710507495, 6167.506599472121, 6210.223722034746, 6213.875722485615, 6219.222597175353, 6225.439710425902, 6293.748250069946, 6299.874002519832, 6323.988161894074, 6335.65153916539, 5661.971690141523, 6252.9062064069985, 6275.843103922439, 6284.4972402206795, 6303.936960630335, 6083.6349819011, 6149.7847575334645, 6247.937520624736, 6251.968740156452, 6264.561480696308, 6030.095485677183, 6044.123602077586, 6075.908861366995, 6126.571140020156, 6150.04674275488, 6262.1546091278915, 6277.1525844010475, 6284.183056202664, 6294.685265736786, 6295.433410993032, 6036.396360363929, 6104.725287362168, 6125.908111378244, 6140.017597184429, 6161.845953851011], "value": 5805.346804260919, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [463.1894185175942, 478.76001157003367, 483.44645381038714, 541.6208653942241, 541.7399648168881, 32441.351172976556, 41930.95172620686, 43336.3499547507, 43461.91345216367, 45696.0, 45334.31998520016, 45723.77138114313, 45774.771126144406, 45864.3120353195, 45983.0, 9950.900490995069, 10128.987101289886, 10129.594816207344, 10135.341202821794, 10144.188464922825, 9307.813843723121, 9559.091886270828, 9918.156956658693, 12519.43662535188, 12544.24734515932, 12520.499180032788, 12580.81128783069, 12584.993200543935, 12592.118551701384, 12600.81098783519, 12483.750324993494, 12562.37188140594, 12567.434465449076, 12570.68573285666, 12586.559470418491, 12314.630561083182, 12393.690157746038, 12402.627921162379, 12403.503859845596, 12416.627501174979, 36688.0, 42004.1599168018, 42736.78631606853, 43020.56979430197, 43117.78441107806, 3374.240795820945, 3550.7869527828157, 3558.3772839753196, 3867.1105645701364, 4387.978060109679, 32076.0, 32386.676133238838, 32415.351692966007, 32599.26360831919, 33028.50457243143, 3318.8008719476907, 3358.4458564336855, 3407.267437500949, 3437.2781715839456, 3448.896533104011, 384044.0, 385470.0, 386832.0658396718, 386846.0, 387278.0, 35604.64395356013, 63988.68005660035, 64336.678316608115, 64359.0, 64467.0, 36259.0, 37520.62479375226, 37838.24323513569, 37848.62151378506, 37896.43155352617, 15863.841361586467, 16067.598310042109, 16088.276027578788, 16090.919545402197, 16104.0, 12228.816567751492, 12445.004399648007, 13433.66415839612, 13602.115862468909, 13610.979176561797, 8003.759887203393, 8231.259186673227, 8255.0, 8294.751157465285, 8382.329413646894, 3357.2446199605383, 3406.0803583032443, 3413.5050417689795, 3419.093940105874, 3439.914002149916, 817.8119032622411, 954.9474778887228, 1022.8414595737672, 1121.5962253588864, 1157.479134389528, 31269.843650782055, 31414.371712565622, 31774.682253177172, 32106.518402223985, 32179.51730724041, 1016.4765145949842, 1064.9787004259872, 1066.4081434803759, 1079.865016872891, 1117.1342209787317, 15860.365585376456, 16019.0, 16034.518964431085, 16064.598385040468, 16374.754378684329, 747596.0, 751777.2411138018, 756029.0, 757136.0, 757586.2120689361, 57354.0, 57527.0, 59391.0, 59582.0, 59776.402235977956, 1292.7737645911927, 1333.1401246196149, 1406.4303956897472, 1458.3656109592362, 1460.7662773956329, 31435.0, 31611.84194079015, 32506.02481925546, 32601.0, 32992.525560583534, 60165.09752353806, 61006.08490872552, 61071.0, 61123.38876611177, 61145.0, 597067.0, 600137.0, 607084.0, 610913.0, 890703.0, 45467.54532454765, 46090.308645369674, 46230.38193663205, 47458.28812567745, 47562.76218618885, 50536.494635053175, 50927.49072509228, 51109.0, 51273.0, 51778.0, 40957.0, 41496.0, 42030.789846050575, 42555.7233283002, 43709.78145109254, 42055.36916946187, 42156.57843421526, 42433.36349954691, 43275.56724432841, 43612.0, 39965.0, 40397.394039090024, 40654.59345406508, 41387.379189312785, 42517.57482425136, 33049.68652194324, 35938.10154746152, 36632.26735465223, 36827.0, 36908.81545592255, 21810.345689629336, 24549.77251137472, 24782.876085619457, 26732.465350693266, 26800.329991749582], "value": 20314.43955541789, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.38297882961365, 383.92705385976666, 391.244897348118, 401.1555675303488, 410.5094412177449, 15383.0, 20772.480687982807, 21812.345629631138, 21852.781472185274, 21992.0, 16286.784696967432, 19367.51581210467, 21102.0, 21408.785912140873, 21625.3512394628, 5937.139114828358, 6251.3123556408755, 6252.843678908041, 6257.780977665782, 6265.718042688067, 5625.746841392127, 5855.238818953551, 5942.316633587128, 6122.265328160627, 6198.132261483396, 6130.2643682758135, 6133.631982081067, 6139.6009259398215, 6139.938600613981, 6148.415900489469, 5711.543076553866, 5851.122331650244, 5856.945749765041, 6114.633122012671, 6137.693115344237, 5846.736896839652, 6059.0, 6073.878522429527, 6078.544109191828, 6080.2399700037495, 13542.0, 13883.028188026843, 13886.722265554734, 13931.0, 16120.919395403065, 2216.3240211735415, 2250.6511490718963, 2355.199232261022, 2382.7855493005713, 2942.2791416102978, 10222.539985700661, 10512.789744205073, 10657.626983055634, 14200.0, 14357.56927292183, 1802.8107048759953, 1958.9706154407695, 1961.892095934723, 1970.9901450492798, 2118.480972161815, 116566.0, 118312.90122592586, 121574.39212803968, 128841.0, 130179.34910325576, 11237.494312755945, 11375.146863985234, 11461.025812805838, 11536.59621913229, 11893.0, 14945.953783235287, 14961.177135257665, 14979.176145312113, 14996.550103496913, 14998.850011499964, 7910.5649189295145, 8328.625211865481, 8335.66657333712, 8519.95740021296, 8609.870851937227, 8868.911310886937, 8979.595918183697, 8993.325500587482, 8996.910030899608, 9131.954340228256, 4621.745803980813, 4622.722636641813, 4632.0, 4635.6986795858165, 4695.107929493385, 1797.58655509231, 1817.2053077374203, 1826.7030408409912, 1882.5764203054202, 1900.3348827910397, 893.13366034946, 923.6536298887917, 991.8363470027509, 1037.258360272409, 1063.3726101599939, 21206.0, 21341.573168536543, 21360.35918922435, 21376.57246855054, 21445.927703614758, 856.302113777282, 955.1260596554214, 962.6149540183983, 992.2508506077864, 1007.4183531854917, 10151.131127457036, 10835.51240194193, 11501.42492875353, 11502.884971150348, 11512.712182195512, 664016.0, 667060.0, 671138.0, 671327.0, 672016.0, 84401.0, 88744.11255887487, 127303.09045364326, 152406.23796881168, 155304.0, 1026.6971243483042, 1027.5632856036154, 1040.0431602925175, 1043.2853495355705, 1051.400701600096, 18844.6231075375, 19332.8066719331, 19822.405327840188, 19836.20655173777, 19892.70160947616, 57431.13853292287, 57803.4219657798, 59481.810363791614, 61644.38355616386, 61670.0, 77781.61109194419, 86935.56532217299, 87139.56430218062, 87990.56004719935, 89348.0, 6891.207511136083, 8103.230193131643, 8355.331573474228, 8402.159784021793, 8467.745967620982, 12150.0, 13090.0, 13218.735625287249, 13600.0, 13652.97602679823, 11580.262960555983, 11882.82175767347, 11921.0, 12093.637190884288, 12109.0, 11142.498587563741, 11329.830052549383, 11355.602553910574, 11523.193376463567, 11844.881551184379, 4861.927071094007, 10707.393890916113, 11624.302541847515, 11776.293422394341, 12076.03391728642, 7330.79041958071, 8124.918750812416, 8227.917720822716, 8343.2908202801, 8378.455400398954, 10012.349197302443, 11686.88313116892, 11790.351530665552, 11941.52233910634, 12157.08821838348], "value": 9728.291070168536, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1538.7691846223065, 1559.0100286318188, 1764.2237415537163, 1901.8668693191482, 1921.2987259650215, 8639.179277968591, 9166.40418372807, 9177.31170162238, 9180.586873590688, 9191.080891910813, 8058.5567793771315, 8345.374096942724, 8682.782930426742, 8901.376903616749, 8917.063708310632, 1869.9995502406216, 2423.466837295792, 2438.244144315268, 2438.439158993424, 2439.4755127647554, 2405.675233843435, 2410.7950824179966, 2446.4006318451916, 2447.645091461737, 2449.106076282162, 2417.3110663460916, 2425.1511970810166, 2436.049940523197, 2442.9877850610724, 2449.3876530867283, 2335.43949452132, 2345.483993521431, 2354.976450235493, 2357.3635118518077, 2358.6108292131776, 2381.7261014983324, 2407.3500154958065, 2407.8073754099805, 2411.385096800322, 2414.2153800015067, 8911.866322005175, 9107.36248462608, 9112.8633070504, 9116.680916167903, 9118.224950879183, 5371.033214021474, 5536.889262214773, 5537.1140617501005, 5542.418046105141, 5543.667379957175, 3538.3454060998542, 3635.054885729703, 3666.7799932004164, 3705.2959937611768, 3710.5732840723394, 1095.3646884806792, 1102.0247081333077, 1111.5331560744507, 1123.7640095579939, 1134.257061624629, 11807.051836446975, 11829.645110646694, 11939.761204775856, 11941.94029029858, 11946.522139114424, 3749.6812770914776, 4541.523140070245, 4722.220833562493, 4727.149113159596, 4732.337472753818, 9365.157135857806, 9403.43579385239, 9405.0, 9430.58541218809, 9441.858372124423, 5382.67703937765, 5386.407495175527, 5389.299391079135, 5391.191321301836, 5396.9730151348995, 4522.547745225517, 4627.30590411441, 4910.140725373046, 5010.473900240495, 5061.417936937226, 3849.7882616455804, 3876.8643097491454, 3949.4865667463046, 3979.164375481181, 3980.7014473914574, 1170.8185231289165, 1179.6578992092197, 1183.260462211118, 1192.8270400791837, 1195.8505186851644, 870.3994243971639, 896.5786080542135, 912.648630277348, 914.8719179314901, 933.1974501928336, 5759.136129580513, 5885.646861188342, 6025.879482410327, 6170.5372097092895, 6200.906986395207, 438.1652951128106, 461.6929741721785, 461.88452886778305, 461.92147334953137, 468.4425533614987, 3820.9235815283537, 3843.135294558702, 3861.3821788514265, 3863.768173909574, 4005.5794141615293, 10828.512716927757, 11089.55641774336, 11190.0, 11206.607768728218, 11213.663590092146, 10738.302010369458, 10923.563057477611, 11116.277441966246, 11133.441318215457, 11143.108551315876, 8016.438849280611, 8386.329093672492, 8436.987561492537, 8464.57677116154, 8473.618687158969, 5992.400759923973, 6023.0, 6092.969535152296, 6107.816765497042, 6313.800377928179, 10087.949560252151, 10403.94798026005, 10407.843882341922, 10410.635627752992, 10419.374837509773, 10094.444805535471, 10200.3369780964, 10401.791964160826, 10536.78926421452, 10602.310849794738, 7031.683574239274, 7262.9273707262255, 7565.319121279112, 7598.278163574451, 7796.064472263138, 8639.222469977733, 8872.157145071207, 8873.378863479495, 8874.866876996979, 8889.0, 7722.884156737766, 7807.9219207809465, 7869.48848324857, 7993.120756716873, 8015.438919275594, 7559.697612095674, 7685.193054729173, 7687.807804804925, 7699.615019248903, 7739.496932699357, 7162.46281528877, 7244.529105608119, 7250.673719682522, 7250.984862119413, 7261.3101755333155, 4962.478939711423, 4982.302477653059, 5031.245313203049, 5145.176771716508, 5300.178472336794, 5052.873678158076, 5093.627724985896, 5134.717590532557, 5171.586273098068, 5318.282031925795], "value": 4583.687544619432, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.69073890001647, 307.36835802426003, 313.4702353023391, 318.79437762643096, 320.65689712008134, 4322.719023263489, 5087.847364579059, 5263.473652634734, 5312.521873031426, 5339.50262578012, 4336.200476802123, 4737.834175803848, 5112.667676601019, 5181.445566330105, 5305.336832895888, 3360.9327813443715, 3668.504751858505, 3875.953492557015, 4080.795960201993, 4096.262672718909, 3389.830508474579, 3595.8381872815658, 3797.3924172132465, 4108.219438306727, 4136.4415803866395, 3527.9118022049397, 4003.179348233605, 4017.4375587417785, 4040.4141399497057, 4050.736702114353, 4012.498437695288, 4031.4154447605224, 4034.4553485279553, 4044.777537235451, 4048.8582899598373, 3507.8421471033867, 3527.400341941876, 3528.3648943190215, 3531.2584357285, 3545.9716682162143, 4239.7668128252935, 4846.7818948147415, 4978.303037574742, 5196.272521846944, 5220.556252718524, 3905.628965248297, 4629.305604159403, 4644.373009643688, 4663.463701674283, 4677.462091859412, 4777.784999674988, 4994.725290109042, 5093.9490605094215, 5617.297837770278, 5737.827865164052, 3729.5151630287887, 3858.575556688762, 3862.7296089273764, 3863.4784304118866, 3878.612138786127, 4990.030931595695, 5744.368119506893, 5857.70711464425, 5883.23517942669, 5923.17075609415, 3826.8660596878976, 3876.7013050627793, 3900.1419687669236, 3903.785291808978, 3929.5088113985753, 3603.801790901473, 3748.025513366544, 3877.2827027000094, 4014.759114453142, 4030.6170913763144, 4576.878664727164, 4580.427446569179, 4590.632749380042, 4596.575061730874, 4622.6301895848255, 5175.249588809676, 5305.389880163831, 5584.799268157366, 5588.189712491666, 5600.879824035128, 1145.6219447582278, 1272.5609664665676, 1312.3569450968957, 1328.734253149374, 1329.5944736855158, 884.6549845560237, 904.1500989070253, 912.5665308978182, 918.2195134136065, 920.447731361178, 5094.61790365724, 5279.524842764093, 5336.706481143575, 5375.9462405376225, 5416.781224224596, 4862.635302352338, 5112.233165025276, 5675.0, 5824.6796426196115, 5839.043920286666, 4543.772811359485, 5116.462771409023, 5237.8428647140645, 5272.994393195841, 5316.149416093406, 2009.9598008039757, 2510.422602801366, 2544.7455254474403, 2565.7690807827385, 2580.367809886552, 3849.4995650565806, 4501.498501498501, 4890.413150421972, 4936.186373766918, 5073.923891141636, 3928.3125453045604, 4570.0751519027845, 4575.924657705436, 4816.4220293564995, 4825.565699087099, 4011.358182690697, 4874.807001414079, 4878.9512104878495, 4889.608831293559, 4935.728534930541, 4048.8785336439955, 4682.508336624742, 4703.153432382204, 4718.433787945469, 4952.851414457572, 5691.637970242303, 5784.8553786154, 5863.677497737665, 5876.853078673067, 5878.2064421302575, 5322.441143679858, 5911.349751527243, 6048.818535443944, 6070.939290607214, 6114.327423983447, 3297.4394352959575, 3393.643667414886, 3654.287413954253, 3981.581933897015, 4000.3599424092004, 5122.924185920999, 5815.720541480868, 5824.184614154106, 5856.619319744203, 5868.2664666916635, 4674.953250467452, 5561.165825126263, 5798.75269848886, 5801.680907550125, 5804.21643078179, 5181.3005244293045, 5285.097364948692, 5565.972170139124, 5590.245316882331, 5601.551875850004, 4812.735299558558, 4931.309616653743, 5275.973620131875, 5340.798320377884, 5555.972220138873, 5281.630285879952, 5494.642848214853, 5622.718864056699, 5633.155026746021, 5637.0, 4514.932276015928, 5300.787968481218, 5494.890102198014, 5495.818399044225, 5503.3120859892515], "value": 3975.35033546812, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.7792473295646, 726.6257877193243, 744.1999850161077, 785.2540086917427, 844.7676888855564, 12786.872131278684, 16479.67040659186, 16531.91734041328, 16665.750013749803, 16709.41517046902, 14813.777793333109, 14961.850381496182, 14971.925140374284, 14982.0, 15022.624434389145, 702.3012102957564, 722.0072400449382, 829.6515463505312, 909.5815924674657, 916.4226537281503, 896.3322324867983, 896.394933419939, 899.6041741633693, 900.9279257659405, 903.439867282286, 946.7254496196094, 949.4920217683541, 952.6141912525403, 953.2659851914023, 953.9236861051133, 946.1720994130136, 946.7301818981591, 947.1759569174793, 949.7720547068723, 951.8952915179325, 699.618707804248, 700.8142842146835, 701.0955866931652, 702.68379229347, 703.4969996452561, 15790.131542765143, 15823.683526329523, 15834.841651583452, 15839.683206335923, 15852.841471585252, 12324.014078873668, 14914.403423863032, 15035.398584056624, 15076.773848392282, 15121.395144194219, 11677.591284305008, 11686.707832304175, 12054.517819287217, 12305.50076703922, 12307.076969227253, 3886.436466712311, 3942.467766851467, 4000.079981604247, 4066.7966601670096, 4098.4876890388705, 113167.0, 121345.0, 121405.78594214033, 122681.0, 125533.0, 9730.513474326255, 11586.826197607043, 11894.643160705193, 12066.336351500751, 12083.214591051554, 24555.0, 24791.0, 24803.379915501897, 24818.751812482005, 24847.378815529755, 8380.832383352421, 8422.115677853859, 8470.280026197719, 8500.914990850013, 8517.574121294034, 4425.343517539834, 4502.414686090788, 4644.373009643722, 4778.378810754649, 4792.640551958547, 3724.640506215212, 3816.5038544988975, 3852.9229415412096, 3854.5181852268465, 4020.8793736187963, 706.7738323736457, 713.9286071392924, 729.7810656802938, 742.0501757750088, 747.0437839565365, 579.7622974580402, 614.8647297594522, 645.4739387399254, 674.1126830479027, 739.0798455922411, 8385.329173666092, 9737.812859466083, 10082.81243779106, 10103.747406314755, 10208.795824083476, 462.5212904643678, 577.7948828166025, 701.3932947999944, 716.2658275267892, 717.433227750082, 3990.3016972029777, 4668.0, 4840.7337596432535, 4853.781579828917, 4938.58022068121, 117353.23970140454, 144530.27734861258, 153499.0, 153694.0, 157341.0, 128827.0, 129921.35039324932, 133892.0, 133954.0, 135547.32226339003, 84344.0, 103836.48081759542, 106900.93099069066, 111591.0, 111965.88034119555, 8140.389470789596, 9291.814163716552, 9434.669786557437, 9440.197583205505, 9487.478188699688, 56434.43565564292, 58134.4186558129, 58157.83684326205, 59442.0, 64795.67602161959, 86466.0, 86543.56728216319, 88233.55883220542, 89518.10481895097, 90684.5465772667, 13378.397972091085, 13462.124961877447, 13868.514601988882, 14049.36777844979, 14070.155790652594, 14859.0, 14995.17526536051, 15159.772603410736, 15445.691086178438, 15645.530634080997, 14090.36593353281, 14552.0, 14597.416103355747, 14659.70680586361, 15255.160966146968, 13788.448462061406, 14384.568462946128, 14646.780298295322, 15152.772708409602, 15165.696686066438, 13457.798133027816, 13583.320833958065, 14022.22877741734, 14514.637134071732, 14542.346434232835, 11377.431128443379, 11851.24032704081, 12109.75780484403, 12227.816582751087, 12371.566995155126, 8843.395306733606, 11903.0, 12060.698482537655, 12138.75722485563, 12162.75674486523], "value": 8115.418648829888, "unit": "score"}], "name": "dromaeo_css", "value": 7440.517988795475, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 115.0, 115.0, 114.0, 132.0, 164.0, 165.0, 114.0, 114.0, 113.0], "value": 125.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 123.0, 108.0, 138.0, 108.0, 107.0, 108.0, 106.0, 140.0, 107.0], "value": 118.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 183.0, 183.0, 184.0, 182.0, 181.0, 195.0, 259.0, 205.0, 180.0], "value": 193.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 59.0, 58.0, 88.0, 62.0, 61.0, 69.0, 55.0, 81.0, 57.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 93.0, 68.0, 69.0, 69.0, 92.0, 90.0, 99.0, 121.0], "value": 85.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 76.0, 110.0, 128.0, 135.0, 86.0, 89.0, 86.0, 88.0, 86.0], "value": 97.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 95.0, 94.0, 94.0, 94.0, 103.0, 150.0, 94.0, 116.0, 92.0], "value": 102.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 85.0, 86.0, 84.0, 83.0, 86.0, 86.0, 90.0, 85.0], "value": 85.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 54.0, 56.0, 55.0, 55.0, 58.0, 58.0, 58.0, 56.0, 56.0], "value": 56.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 80.0, 75.0, 71.0, 67.0, 70.0, 69.0, 69.0, 70.0], "value": 70.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 84.0, 81.0, 83.0, 80.0, 82.0, 80.0, 86.0, 83.0, 82.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 136.0, 135.0, 133.0, 134.0, 135.0, 136.0, 137.0, 164.0, 146.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 163.0, 161.0, 158.0, 160.0, 158.0, 159.0, 158.0, 167.0, 172.0], "value": 161.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 65.0, 64.0, 67.0, 64.0, 64.0], "value": 64.8, "unit": "score"}], "name": "kraken", "value": 1450.4999999999998, "alertThreshold": 2.0}]} 17:51:33 INFO - Return code: 0 17:51:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:51:33 INFO - # TBPL SUCCESS # 17:51:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:51:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:51:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:51:33 INFO - 2017-01-04 17:51:33.680 screenresolution[1927:16199] starting screenresolution argv=screenresolution get 17:51:33 INFO - 2017-01-04 17:51:33.683 screenresolution[1927:16199] Display 0: 1600x1200x32@60 17:51:33 INFO - 2017-01-04 17:51:33.689 screenresolution[1928:16202] starting screenresolution argv=screenresolution list 17:51:33 INFO - Available Modes on Display 0 17:51:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:51:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:51:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:51:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:51:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:51:33 INFO - Intel Iris: 17:51:33 INFO - Chipset Model: Intel Iris 17:51:33 INFO - Type: GPU 17:51:33 INFO - Bus: Built-In 17:51:33 INFO - VRAM (Dynamic, Max): 1536 MB 17:51:33 INFO - Vendor: Intel (0x8086) 17:51:33 INFO - Device ID: 0x0a2e 17:51:33 INFO - Revision ID: 0x0009 17:51:33 INFO - Displays: 17:51:33 INFO - Display: 17:51:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:51:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:51:33 INFO - Display Serial Number: 1600x1200 60 17:51:33 INFO - Main Display: Yes 17:51:33 INFO - Mirror: Off 17:51:33 INFO - Online: Yes 17:51:33 INFO - Rotation: Supported 17:51:33 INFO - Return code: 0 17:51:33 INFO - Running post-action listener: _resource_record_post_action 17:51:33 INFO - [mozharness: 2017-01-05 01:51:33.913488Z] Finished run-tests step (success) 17:51:33 INFO - Running post-run listener: _resource_record_post_run 17:51:34 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 2715648; Write bytes: 491268608; Read time: 15; Write time: 1551 17:51:34 INFO - TinderboxPrint: CPU usage
53.3% 17:51:34 INFO - TinderboxPrint: I/O read bytes / time
2,715,648 / 15 17:51:34 INFO - TinderboxPrint: I/O write bytes / time
491,268,608 / 1,551 17:51:34 INFO - TinderboxPrint: CPU idle
2,232.5 (46.7%) 17:51:34 INFO - TinderboxPrint: CPU system
955.4 (20.0%) 17:51:34 INFO - TinderboxPrint: CPU user
1,593.8 (33.3%) 17:51:34 INFO - TinderboxPrint: Swap in / out
198,291,456 / 0 17:51:34 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 196088320; Write bytes: 196022272; Read time: 17813; Write time: 443 17:51:34 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 630784; Write bytes: 293747200; Read time: 8; Write time: 1099 17:51:34 INFO - Running post-run listener: _upload_blobber_files 17:51:34 INFO - Blob upload gear active. 17:51:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:51:34 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 17:51:34 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'] 17:51:34 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 17:51:34 INFO - (blobuploader) - INFO - Open directory for files ... 17:51:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:51:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:51:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:51:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:51:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:51:35 INFO - (blobuploader) - INFO - Done attempting. 17:51:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:51:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:51:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:51:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:51:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:51:36 INFO - (blobuploader) - INFO - Done attempting. 17:51:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:51:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:51:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:51:38 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:51:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:51:38 INFO - (blobuploader) - INFO - Done attempting. 17:51:38 INFO - (blobuploader) - INFO - Iteration through files over. 17:51:38 INFO - Return code: 0 17:51:38 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:51:38 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:51:38 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/98515d07a8e0464d97e395c341bc13067690075dfb4b44e1a1ae3abbb7e5db0fa6eb5884592cc136c39f5a6ef3151bbf2999ffc0a30bc1f8214c9e4e6cc1c5bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1a39b22f2cb57dd008bb2ccc45afb4da5b3f1877a2e7869df8eb48dd13a4d3e0ef77f63f2a6eed58f487bfa46a673ee48032f1d2f4d93a8f0ca3166bdadaa945", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/84c80d9f7fc7910ba4a5fbc06932f0726d38d9569e03506f494993abfe573d8e0db2d4caff6ed2a530f89778a4016ea8f8537c109f70b457dcbd9a8c95e07e24"} 17:51:38 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:51:38 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:51:38 INFO - Contents: 17:51:38 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/98515d07a8e0464d97e395c341bc13067690075dfb4b44e1a1ae3abbb7e5db0fa6eb5884592cc136c39f5a6ef3151bbf2999ffc0a30bc1f8214c9e4e6cc1c5bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1a39b22f2cb57dd008bb2ccc45afb4da5b3f1877a2e7869df8eb48dd13a4d3e0ef77f63f2a6eed58f487bfa46a673ee48032f1d2f4d93a8f0ca3166bdadaa945", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/84c80d9f7fc7910ba4a5fbc06932f0726d38d9569e03506f494993abfe573d8e0db2d4caff6ed2a530f89778a4016ea8f8537c109f70b457dcbd9a8c95e07e24"} 17:51:38 INFO - Running post-run listener: copy_logs_to_upload_dir 17:51:38 INFO - Copying logs to upload dir... 17:51:38 INFO - mkdir: /builds/slave/test/build/upload/logs 17:51:38 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.271432 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-01-04 17:51:39.031519) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-04 17:51:39.035558) ========= 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.Ybr1dkZ7Ug/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.oMH5HnfIii/Listeners TMPDIR=/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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/98515d07a8e0464d97e395c341bc13067690075dfb4b44e1a1ae3abbb7e5db0fa6eb5884592cc136c39f5a6ef3151bbf2999ffc0a30bc1f8214c9e4e6cc1c5bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1a39b22f2cb57dd008bb2ccc45afb4da5b3f1877a2e7869df8eb48dd13a4d3e0ef77f63f2a6eed58f487bfa46a673ee48032f1d2f4d93a8f0ca3166bdadaa945", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/84c80d9f7fc7910ba4a5fbc06932f0726d38d9569e03506f494993abfe573d8e0db2d4caff6ed2a530f89778a4016ea8f8537c109f70b457dcbd9a8c95e07e24"} build_url:https://queue.taskcluster.net/v1/task/D7mLt4T6TSOIcQueEhD0LA/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011112 build_url: 'https://queue.taskcluster.net/v1/task/D7mLt4T6TSOIcQueEhD0LA/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/98515d07a8e0464d97e395c341bc13067690075dfb4b44e1a1ae3abbb7e5db0fa6eb5884592cc136c39f5a6ef3151bbf2999ffc0a30bc1f8214c9e4e6cc1c5bb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1a39b22f2cb57dd008bb2ccc45afb4da5b3f1877a2e7869df8eb48dd13a4d3e0ef77f63f2a6eed58f487bfa46a673ee48032f1d2f4d93a8f0ca3166bdadaa945", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/84c80d9f7fc7910ba4a5fbc06932f0726d38d9569e03506f494993abfe573d8e0db2d4caff6ed2a530f89778a4016ea8f8537c109f70b457dcbd9a8c95e07e24"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-04 17:51:39.073557) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 17:51:39.073930) ========= 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.Ybr1dkZ7Ug/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.oMH5HnfIii/Listeners TMPDIR=/var/folders/hn/w94h68yd1wv9002y06t8rc5r00000w/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.005249 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-04 17:51:39.122967) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-04 17:51:39.123304) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-04 17:51:39.123637) ========= ========= Total master_lag: 0.45 =========