builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0354 starttime: 1479477158.1 results: success (0) buildid: 20161118030828 builduid: 77f3fb3fb2b64cd9bf62da20ea989b57 revision: 9c19af220675497140cd32e6ad421f12e27e8d58 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 05:52:38.097076) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-18 05:52:38.097517) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 05:52:38.097802) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-18 05:52:38.121142) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 05:52:38.121438) ========= 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.CT9cLCvQaT/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.mqJYdtI8GW/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-11-18 05:52:38-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 74.9M=0s 2016-11-18 05:52:38 (74.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.165235 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 05:52:38.308749) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 05:52:38.309071) ========= 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.CT9cLCvQaT/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.mqJYdtI8GW/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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.019721 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 05:52:38.357404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-18 05:52:38.357756) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9c19af220675497140cd32e6ad421f12e27e8d58 --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 9c19af220675497140cd32e6ad421f12e27e8d58 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.CT9cLCvQaT/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.mqJYdtI8GW/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-11-18 05:52:38,439 truncating revision to first 12 chars 2016-11-18 05:52:38,439 Setting DEBUG logging. 2016-11-18 05:52:38,440 attempt 1/10 2016-11-18 05:52:38,440 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9c19af220675?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-18 05:52:40,630 unpacking tar archive at: mozilla-beta-9c19af220675/testing/mozharness/ program finished with exit code 0 elapsedTime=2.461577 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-11-18 05:52:40.841362) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 05:52:40.841663) ========= script_repo_revision: 9c19af220675497140cd32e6ad421f12e27e8d58 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-18 05:52:40.842093) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 05:52:40.842359) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-18 05:52:40.860701) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-11-18 05:52:40.861030) ========= /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.CT9cLCvQaT/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.mqJYdtI8GW/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:52:41 INFO - MultiFileLogger online at 20161118 05:52:41 in /builds/slave/test 05:52:41 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 05:52:41 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:52:41 INFO - {'append_to_log': False, 05:52:41 INFO - 'base_work_dir': '/builds/slave/test', 05:52:41 INFO - 'blob_upload_branch': 'Mozilla-Beta', 05:52:41 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:52:41 INFO - 'branch': 'Mozilla-Beta', 05:52:41 INFO - 'buildbot_json_path': 'buildprops.json', 05:52:41 INFO - 'config_files': ('talos/mac_config.py',), 05:52:41 INFO - 'default_actions': ('clobber', 05:52:41 INFO - 'read-buildbot-config', 05:52:41 INFO - 'download-and-extract', 05:52:41 INFO - 'populate-webroot', 05:52:41 INFO - 'create-virtualenv', 05:52:41 INFO - 'install', 05:52:41 INFO - 'run-tests'), 05:52:41 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:52:41 INFO - 'download_minidump_stackwalk': True, 05:52:41 INFO - 'download_symbols': 'ondemand', 05:52:41 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:52:41 INFO - 'tooltool.py': '/tools/tooltool.py', 05:52:41 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:52:41 INFO - '/tools/misc-python/virtualenv.py')}, 05:52:41 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:52:41 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:52:41 INFO - 'installer_path': 'installer.exe', 05:52:41 INFO - 'log_level': 'info', 05:52:41 INFO - 'log_name': 'talos', 05:52:41 INFO - 'log_to_console': True, 05:52:41 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:52:41 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:52:41 INFO - 'opt_config_files': (), 05:52:41 INFO - 'pip_index': False, 05:52:41 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:52:41 INFO - 'cmd': ('bash', 05:52:41 INFO - '-c', 05:52:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:52:41 INFO - 'enabled': True, 05:52:41 INFO - 'halt_on_failure': False, 05:52:41 INFO - 'name': 'check_screen_resolution'},), 05:52:41 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:52:41 INFO - 'cmd': ('bash', 05:52:41 INFO - '-c', 05:52:41 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:52:41 INFO - 'enabled': True, 05:52:41 INFO - 'halt_on_failure': False, 05:52:41 INFO - 'name': 'check_screen_resolution'},), 05:52:41 INFO - 'run_cmd_checks_enabled': True, 05:52:41 INFO - 'sps_profile': False, 05:52:41 INFO - 'sps_profile_interval': 0, 05:52:41 INFO - 'suite': 'dromaeojs', 05:52:41 INFO - 'system_bits': '32', 05:52:41 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:52:41 INFO - 'title': 't-yosemite-r7-0354', 05:52:41 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:52:41 INFO - 'use_talos_json': True, 05:52:41 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:52:41 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:52:41 INFO - 'work_dir': 'build'} 05:52:41 INFO - [mozharness: 2016-11-18 13:52:41.057167Z] Running clobber step. 05:52:41 INFO - Running pre-action listener: _resource_record_pre_action 05:52:41 INFO - Running main action method: clobber 05:52:41 INFO - rmtree: /builds/slave/test/build 05:52:41 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:52:42 INFO - Running post-action listener: _resource_record_post_action 05:52:42 INFO - [mozharness: 2016-11-18 13:52:42.554291Z] Finished clobber step (success) 05:52:42 INFO - [mozharness: 2016-11-18 13:52:42.554451Z] Running read-buildbot-config step. 05:52:42 INFO - Running pre-action listener: _resource_record_pre_action 05:52:42 INFO - Running main action method: read_buildbot_config 05:52:42 INFO - Using buildbot properties: 05:52:42 INFO - { 05:52:42 INFO - "project": "", 05:52:42 INFO - "product": "firefox", 05:52:42 INFO - "script_repo_revision": "production", 05:52:42 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 05:52:42 INFO - "repository": "", 05:52:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 05:52:42 INFO - "buildid": "20161118030828", 05:52:42 INFO - "pgo_build": "False", 05:52:42 INFO - "basedir": "/builds/slave/test", 05:52:42 INFO - "buildnumber": 2, 05:52:42 INFO - "slavename": "t-yosemite-r7-0354", 05:52:42 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 05:52:42 INFO - "platform": "yosemite_r7", 05:52:42 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 05:52:42 INFO - "branch": "mozilla-beta", 05:52:42 INFO - "repo_path": "releases/mozilla-beta", 05:52:42 INFO - "revision": "9c19af220675497140cd32e6ad421f12e27e8d58", 05:52:42 INFO - "stage_platform": "macosx64", 05:52:42 INFO - "builduid": "77f3fb3fb2b64cd9bf62da20ea989b57", 05:52:42 INFO - "slavebuilddir": "test" 05:52:42 INFO - } 05:52:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/Zgfp4fGVQmKCJ5O3_cKp9A/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 05:52:42 INFO - Running post-action listener: _resource_record_post_action 05:52:42 INFO - [mozharness: 2016-11-18 13:52:42.557651Z] Finished read-buildbot-config step (success) 05:52:42 INFO - [mozharness: 2016-11-18 13:52:42.557782Z] Running download-and-extract step. 05:52:42 INFO - Running pre-action listener: _resource_record_pre_action 05:52:42 INFO - Running main action method: download_and_extract 05:52:42 INFO - mkdir: /builds/slave/test/build/tests 05:52:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:52:42 INFO - trying https://queue.taskcluster.net/v1/task/Zgfp4fGVQmKCJ5O3_cKp9A/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 05:52:42 INFO - Downloading https://queue.taskcluster.net/v1/task/Zgfp4fGVQmKCJ5O3_cKp9A/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 05:52:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zgfp4fGVQmKCJ5O3_cKp9A/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 05:52:43 INFO - Downloaded 1165 bytes. 05:52:43 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 05:52:43 INFO - Using the following test package requirements: 05:52:43 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 05:52:43 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:52:43 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 05:52:43 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:52:43 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 05:52:43 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 05:52:43 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:52:43 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 05:52:43 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 05:52:43 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:52:43 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 05:52:43 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:52:43 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 05:52:43 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:52:43 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 05:52:43 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 05:52:43 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 05:52:43 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 05:52:43 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zgfp4fGVQmKCJ5O3_cKp9A/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 05:52:43 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zgfp4fGVQmKCJ5O3_cKp9A/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 05:52:43 INFO - Fetch https://queue.taskcluster.net/v1/task/Zgfp4fGVQmKCJ5O3_cKp9A/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 05:52:44 INFO - Expected file size: 16231338 05:52:50 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 05:52:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zgfp4fGVQmKCJ5O3_cKp9A/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 05:52:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zgfp4fGVQmKCJ5O3_cKp9A/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 05:52:50 INFO - Fetch https://queue.taskcluster.net/v1/task/Zgfp4fGVQmKCJ5O3_cKp9A/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 05:52:51 INFO - Expected file size: 16231338 05:52:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Zgfp4fGVQmKCJ5O3_cKp9A/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 05:52:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Zgfp4fGVQmKCJ5O3_cKp9A/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 05:52:57 INFO - Fetch https://queue.taskcluster.net/v1/task/Zgfp4fGVQmKCJ5O3_cKp9A/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 05:52:58 INFO - Expected file size: 14414089 05:52: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')]} 05:52:59 INFO - trying https://queue.taskcluster.net/v1/task/Zgfp4fGVQmKCJ5O3_cKp9A/artifacts/public/build/firefox-51.0.en-US.mac.dmg 05:52:59 INFO - Downloading https://queue.taskcluster.net/v1/task/Zgfp4fGVQmKCJ5O3_cKp9A/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 05:52:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Zgfp4fGVQmKCJ5O3_cKp9A/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 05:53:01 INFO - Downloaded 86011913 bytes. 05:53:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Zgfp4fGVQmKCJ5O3_cKp9A/artifacts/public/build/firefox-51.0.en-US.mac.dmg 05:53:01 INFO - mkdir: /builds/slave/test/properties 05:53:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:53:01 INFO - Writing to file /builds/slave/test/properties/build_url 05:53:01 INFO - Contents: 05:53:01 INFO - build_url:https://queue.taskcluster.net/v1/task/Zgfp4fGVQmKCJ5O3_cKp9A/artifacts/public/build/firefox-51.0.en-US.mac.dmg 05:53:02 INFO - Running post-action listener: _resource_record_post_action 05:53:02 INFO - Running post-action listener: set_extra_try_arguments 05:53:02 INFO - [mozharness: 2016-11-18 13:53:02.376772Z] Finished download-and-extract step (success) 05:53:02 INFO - [mozharness: 2016-11-18 13:53:02.376880Z] Running populate-webroot step. 05:53:02 INFO - Running pre-action listener: _resource_record_pre_action 05:53:02 INFO - Running main action method: populate_webroot 05:53:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:53:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:53:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:53:02 INFO - '--tppagecycles', 05:53:02 INFO - '7'], 05:53:02 INFO - 'tests': ['tsvgm']}}, 05:53:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:53:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:53:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:53:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:53:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:53:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:53:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:02 INFO - 'talos_options': ['--disable-e10s'], 05:53:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:53:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:53:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:02 INFO - 'talos_options': ['--disable-e10s'], 05:53:02 INFO - 'tests': ['damp', 'tps']}, 05:53:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:02 INFO - 'tests': ['damp', 'tps']}, 05:53:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:53:02 INFO - 'tests': ['dromaeo_dom']}, 05:53:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:53:02 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:53:02 INFO - 'tests': ['basic_compositor_video']}, 05:53:02 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:53:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:53:02 INFO - 'tests': ['a11yr', 05:53:02 INFO - 'ts_paint', 05:53:02 INFO - 'tpaint', 05:53:02 INFO - 'sessionrestore', 05:53:02 INFO - 'sessionrestore_no_auto_restore', 05:53:02 INFO - 'tabpaint']}, 05:53:02 INFO - 'other-e10s': {'tests': ['a11yr', 05:53:02 INFO - 'ts_paint', 05:53:02 INFO - 'tpaint', 05:53:02 INFO - 'sessionrestore', 05:53:02 INFO - 'sessionrestore_no_auto_restore', 05:53:02 INFO - 'tabpaint']}, 05:53:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:53:02 INFO - 'ts_paint', 05:53:02 INFO - 'tpaint', 05:53:02 INFO - 'sessionrestore', 05:53:02 INFO - 'sessionrestore_no_auto_restore', 05:53:02 INFO - 'tabpaint']}, 05:53:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:53:02 INFO - 'ts_paint', 05:53:02 INFO - 'tpaint', 05:53:02 INFO - 'sessionrestore', 05:53:02 INFO - 'sessionrestore_no_auto_restore', 05:53:02 INFO - 'tabpaint']}, 05:53:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:53:02 INFO - 'tests': ['a11yr', 05:53:02 INFO - 'ts_paint', 05:53:02 INFO - 'tpaint', 05:53:02 INFO - 'sessionrestore', 05:53:02 INFO - 'sessionrestore_no_auto_restore', 05:53:02 INFO - 'tabpaint']}, 05:53:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:53:02 INFO - 'tests': ['a11yr', 05:53:02 INFO - 'ts_paint', 05:53:02 INFO - 'tpaint', 05:53:02 INFO - 'sessionrestore', 05:53:02 INFO - 'sessionrestore_no_auto_restore', 05:53:02 INFO - 'tabpaint']}, 05:53:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:53:02 INFO - 'tests': ['tsvgx', 05:53:02 INFO - 'tsvgr_opacity', 05:53:02 INFO - 'tart', 05:53:02 INFO - 'tscrollx', 05:53:02 INFO - 'cart']}, 05:53:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:53:02 INFO - 'tsvgr_opacity', 05:53:02 INFO - 'tart', 05:53:02 INFO - 'tscrollx', 05:53:02 INFO - 'cart']}, 05:53:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:02 INFO - 'talos_options': ['--disable-e10s'], 05:53:02 INFO - 'tests': ['tp5o']}, 05:53:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:02 INFO - 'tests': ['tp5o']}, 05:53:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:02 INFO - 'talos_options': ['--disable-e10s', 05:53:02 INFO - '--xperf_path', 05:53:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:53:02 INFO - 'tests': ['tp5n']}, 05:53:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:53:02 INFO - 'talos_options': ['--xperf_path', 05:53:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:53:02 INFO - 'tests': ['tp5n']}}, 05:53:02 INFO - 'talos.zip': {'path': '', 05:53:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:53:02 INFO - Running post-action listener: _resource_record_post_action 05:53:02 INFO - [mozharness: 2016-11-18 13:53:02.395583Z] Finished populate-webroot step (success) 05:53:02 INFO - [mozharness: 2016-11-18 13:53:02.395722Z] Running create-virtualenv step. 05:53:02 INFO - Running pre-action listener: _resource_record_pre_action 05:53:02 INFO - Running main action method: create_virtualenv 05:53:02 INFO - Creating virtualenv /builds/slave/test/build/venv 05:53:02 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:53:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:53:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:53:02 INFO - Using real prefix '/tools/python27' 05:53:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:53:03 INFO - Installing distribute.............................................................................................................................................................................................done. 05:53:06 INFO - Installing pip.................done. 05:53:06 INFO - Return code: 0 05:53:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:06 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 0x10c907490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c87d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff783575a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c71bd30>, '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 0x10c581db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c713b20>, '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.CT9cLCvQaT/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.mqJYdtI8GW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:53:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:53:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CT9cLCvQaT/Render', 05:53:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:06 INFO - 'HOME': '/Users/cltbld', 05:53:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:06 INFO - 'LOGNAME': 'cltbld', 05:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:06 INFO - 'MOZ_NO_REMOTE': '1', 05:53:06 INFO - 'NO_EM_RESTART': '1', 05:53:06 INFO - 'PAGER': '/bin/cat', 05:53:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:06 INFO - 'PWD': '/builds/slave/test', 05:53:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:06 INFO - 'SHELL': '/bin/bash', 05:53:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqJYdtI8GW/Listeners', 05:53:06 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 05:53:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:06 INFO - 'USER': 'cltbld', 05:53:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:06 INFO - 'XPC_FLAGS': '0x0', 05:53:06 INFO - 'XPC_SERVICE_NAME': '0', 05:53:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:06 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:53:06 INFO - Cleaning up... 05:53:06 INFO - Return code: 0 05:53:06 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:06 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 0x10c907490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c87d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff783575a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c71bd30>, '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 0x10c581db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c713b20>, '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.CT9cLCvQaT/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.mqJYdtI8GW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:53:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:53:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CT9cLCvQaT/Render', 05:53:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:06 INFO - 'HOME': '/Users/cltbld', 05:53:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:06 INFO - 'LOGNAME': 'cltbld', 05:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:06 INFO - 'MOZ_NO_REMOTE': '1', 05:53:06 INFO - 'NO_EM_RESTART': '1', 05:53:06 INFO - 'PAGER': '/bin/cat', 05:53:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:06 INFO - 'PWD': '/builds/slave/test', 05:53:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:06 INFO - 'SHELL': '/bin/bash', 05:53:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqJYdtI8GW/Listeners', 05:53:06 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 05:53:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:06 INFO - 'USER': 'cltbld', 05:53:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:06 INFO - 'XPC_FLAGS': '0x0', 05:53:06 INFO - 'XPC_SERVICE_NAME': '0', 05:53:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:06 INFO - Downloading/unpacking psutil>=3.1.1 05:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:53:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:53:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:53:09 INFO - Installing collected packages: psutil 05:53:09 INFO - Running setup.py install for psutil 05:53:10 INFO - building 'psutil._psutil_osx' extension 05:53:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:53:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:53:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:53:10 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:53:10 INFO - building 'psutil._psutil_posix' extension 05:53:10 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:53:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:53:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:53:10 INFO - ^ 05:53:10 INFO - 1 warning generated. 05:53:10 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:53:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:53:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:53:10 INFO - Successfully installed psutil 05:53:10 INFO - Cleaning up... 05:53:10 INFO - Return code: 0 05:53:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:53: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')]} 05:53:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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')]} 05:53:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c907490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c87d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff783575a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c71bd30>, '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 0x10c581db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c713b20>, '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.CT9cLCvQaT/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.mqJYdtI8GW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:53: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 mozsystemmonitor==0.3 05:53:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CT9cLCvQaT/Render', 05:53:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:10 INFO - 'HOME': '/Users/cltbld', 05:53:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:10 INFO - 'LOGNAME': 'cltbld', 05:53:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:10 INFO - 'MOZ_NO_REMOTE': '1', 05:53:10 INFO - 'NO_EM_RESTART': '1', 05:53:10 INFO - 'PAGER': '/bin/cat', 05:53:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:10 INFO - 'PWD': '/builds/slave/test', 05:53:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:10 INFO - 'SHELL': '/bin/bash', 05:53:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqJYdtI8GW/Listeners', 05:53:10 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 05:53:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:10 INFO - 'USER': 'cltbld', 05:53:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:10 INFO - 'XPC_FLAGS': '0x0', 05:53:10 INFO - 'XPC_SERVICE_NAME': '0', 05:53:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:53:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:53:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:53:13 INFO - Installing collected packages: mozsystemmonitor 05:53:13 INFO - Running setup.py install for mozsystemmonitor 05:53:13 INFO - Successfully installed mozsystemmonitor 05:53:13 INFO - Cleaning up... 05:53:13 INFO - Return code: 0 05:53:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:13 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 0x10c907490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c87d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff783575a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c71bd30>, '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 0x10c581db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c713b20>, '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.CT9cLCvQaT/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.mqJYdtI8GW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:53:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:53:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CT9cLCvQaT/Render', 05:53:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:13 INFO - 'HOME': '/Users/cltbld', 05:53:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:13 INFO - 'LOGNAME': 'cltbld', 05:53:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:13 INFO - 'MOZ_NO_REMOTE': '1', 05:53:13 INFO - 'NO_EM_RESTART': '1', 05:53:13 INFO - 'PAGER': '/bin/cat', 05:53:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:13 INFO - 'PWD': '/builds/slave/test', 05:53:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:13 INFO - 'SHELL': '/bin/bash', 05:53:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqJYdtI8GW/Listeners', 05:53:13 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 05:53:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:13 INFO - 'USER': 'cltbld', 05:53:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:13 INFO - 'XPC_FLAGS': '0x0', 05:53:13 INFO - 'XPC_SERVICE_NAME': '0', 05:53:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:14 INFO - Downloading/unpacking jsonschema==2.5.1 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53:16 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:53:16 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:17 INFO - Downloading functools32-3.2.3-2.tar.gz 05:53:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:53:17 INFO - warning: no files found matching '*.txt' 05:53:17 INFO - no previously-included directories found matching 'build' 05:53:17 INFO - no previously-included directories found matching 'dist' 05:53:17 INFO - no previously-included directories found matching '.git*' 05:53:17 INFO - Installing collected packages: jsonschema, functools32 05:53:17 INFO - Running setup.py install for functools32 05:53:17 INFO - warning: no files found matching '*.txt' 05:53:17 INFO - no previously-included directories found matching 'build' 05:53:17 INFO - no previously-included directories found matching 'dist' 05:53:17 INFO - no previously-included directories found matching '.git*' 05:53:17 INFO - Successfully installed jsonschema functools32 05:53:17 INFO - Cleaning up... 05:53:17 INFO - Return code: 0 05:53:17 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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', '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 0x10c907490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c87d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff783575a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c71bd30>, '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 0x10c581db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c713b20>, '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.CT9cLCvQaT/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.mqJYdtI8GW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:53: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 functools32==3.2.3-2 05:53:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CT9cLCvQaT/Render', 05:53:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:17 INFO - 'HOME': '/Users/cltbld', 05:53:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:17 INFO - 'LOGNAME': 'cltbld', 05:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:17 INFO - 'MOZ_NO_REMOTE': '1', 05:53:17 INFO - 'NO_EM_RESTART': '1', 05:53:17 INFO - 'PAGER': '/bin/cat', 05:53:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:17 INFO - 'PWD': '/builds/slave/test', 05:53:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:17 INFO - 'SHELL': '/bin/bash', 05:53:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqJYdtI8GW/Listeners', 05:53:17 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 05:53:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:17 INFO - 'USER': 'cltbld', 05:53:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:17 INFO - 'XPC_FLAGS': '0x0', 05:53:17 INFO - 'XPC_SERVICE_NAME': '0', 05:53:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:17 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:53:17 INFO - Cleaning up... 05:53:17 INFO - Return code: 0 05:53:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53: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', '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 0x10c907490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c87d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff783575a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c71bd30>, '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 0x10c581db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c713b20>, '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.CT9cLCvQaT/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.mqJYdtI8GW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:53: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 blobuploader==1.2.4 05:53:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CT9cLCvQaT/Render', 05:53:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:17 INFO - 'HOME': '/Users/cltbld', 05:53:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:17 INFO - 'LOGNAME': 'cltbld', 05:53:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:17 INFO - 'MOZ_NO_REMOTE': '1', 05:53:17 INFO - 'NO_EM_RESTART': '1', 05:53:17 INFO - 'PAGER': '/bin/cat', 05:53:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:17 INFO - 'PWD': '/builds/slave/test', 05:53:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:17 INFO - 'SHELL': '/bin/bash', 05:53:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqJYdtI8GW/Listeners', 05:53:17 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 05:53:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:17 INFO - 'USER': 'cltbld', 05:53:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:17 INFO - 'XPC_FLAGS': '0x0', 05:53:17 INFO - 'XPC_SERVICE_NAME': '0', 05:53:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:17 INFO - Downloading/unpacking blobuploader==1.2.4 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53:20 INFO - Downloading blobuploader-1.2.4.tar.gz 05:53:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:53:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53: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 05:53:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:53:21 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:21 INFO - Downloading docopt-0.6.1.tar.gz 05:53:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:53:21 INFO - Installing collected packages: blobuploader, requests, docopt 05:53:21 INFO - Running setup.py install for blobuploader 05:53:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:53:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:53:21 INFO - Running setup.py install for requests 05:53:22 INFO - Running setup.py install for docopt 05:53:22 INFO - Successfully installed blobuploader requests docopt 05:53:22 INFO - Cleaning up... 05:53:22 INFO - Return code: 0 05:53:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:22 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 0x10c907490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c87d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff783575a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c71bd30>, '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 0x10c581db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c713b20>, '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.CT9cLCvQaT/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.mqJYdtI8GW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:53:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:53:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CT9cLCvQaT/Render', 05:53:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:22 INFO - 'HOME': '/Users/cltbld', 05:53:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:22 INFO - 'LOGNAME': 'cltbld', 05:53:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:22 INFO - 'MOZ_NO_REMOTE': '1', 05:53:22 INFO - 'NO_EM_RESTART': '1', 05:53:22 INFO - 'PAGER': '/bin/cat', 05:53:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:22 INFO - 'PWD': '/builds/slave/test', 05:53:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:22 INFO - 'SHELL': '/bin/bash', 05:53:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqJYdtI8GW/Listeners', 05:53:22 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 05:53:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:22 INFO - 'USER': 'cltbld', 05:53:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:22 INFO - 'XPC_FLAGS': '0x0', 05:53:22 INFO - 'XPC_SERVICE_NAME': '0', 05:53:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:53:22 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-Y4HMAO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:53:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:53:22 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-V7SRSF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:53:23 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-WWgygK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:53:23 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-4UPRWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:53:23 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-fax01D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:53:23 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-TvWIgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:53:23 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-PtLeNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:53:23 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-tkKAVn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:53:23 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-KFc3_E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:53:23 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-1OoY5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:53:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:53:23 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-AYPiuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:53:24 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-zStv7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:53:24 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-ThCazZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:53:24 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-UCOy_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:24 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-xWBSVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:53:24 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-uzlnJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:53:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:53:24 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-RnpoZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:53:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:53:24 INFO - Running setup.py install for manifestparser 05:53:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:53:24 INFO - Running setup.py install for mozcrash 05:53:24 INFO - Running setup.py install for mozdebug 05:53:25 INFO - Running setup.py install for mozdevice 05:53:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:53:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:53:25 INFO - Running setup.py install for mozfile 05:53:25 INFO - Running setup.py install for mozhttpd 05:53:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:53:25 INFO - Running setup.py install for mozinfo 05:53:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:53:25 INFO - Running setup.py install for mozInstall 05:53:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:53:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:53:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:53:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:53:25 INFO - Running setup.py install for mozleak 05:53:25 INFO - Running setup.py install for mozlog 05:53:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:53:26 INFO - Running setup.py install for moznetwork 05:53:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:53:26 INFO - Running setup.py install for mozprocess 05:53:26 INFO - Running setup.py install for mozprofile 05:53:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:53:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:53:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:53:26 INFO - Running setup.py install for mozrunner 05:53:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:53:26 INFO - Running setup.py install for mozscreenshot 05:53:26 INFO - Running setup.py install for moztest 05:53:27 INFO - Running setup.py install for mozversion 05:53:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:53:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:53:27 INFO - Cleaning up... 05:53:27 INFO - Return code: 0 05:53:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:27 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 0x10c907490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c87d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff783575a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c71bd30>, '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 0x10c581db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c713b20>, '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.CT9cLCvQaT/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.mqJYdtI8GW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:53:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:53:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CT9cLCvQaT/Render', 05:53:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:27 INFO - 'HOME': '/Users/cltbld', 05:53:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:27 INFO - 'LOGNAME': 'cltbld', 05:53:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:27 INFO - 'MOZ_NO_REMOTE': '1', 05:53:27 INFO - 'NO_EM_RESTART': '1', 05:53:27 INFO - 'PAGER': '/bin/cat', 05:53:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:27 INFO - 'PWD': '/builds/slave/test', 05:53:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:27 INFO - 'SHELL': '/bin/bash', 05:53:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqJYdtI8GW/Listeners', 05:53:27 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 05:53:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:27 INFO - 'USER': 'cltbld', 05:53:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:27 INFO - 'XPC_FLAGS': '0x0', 05:53:27 INFO - 'XPC_SERVICE_NAME': '0', 05:53:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:53:27 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-wWHW8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:53:27 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-aIMwCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:53:27 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-BER6v5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:53:27 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-4_ZORy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:53:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:53:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:53:27 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-0W4K6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:53:28 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-4NY3ei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:53:28 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-QM3MB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:53:28 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-1No23P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:53:28 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-XAxBN4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:53:28 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-6x5AMK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:53:28 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-sWrmrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:53:28 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-bLinVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:53:28 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-uXAtZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:53:28 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-sKwAnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:53:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:53:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:28 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-uhKwTw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:53:29 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-Mc6zJz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:53:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:53:29 INFO - Running setup.py (path:/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/pip-n_g9lU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:53:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:53:29 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:53:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:53:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:53:31 INFO - Downloading blessings-1.6.tar.gz 05:53:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:53:31 INFO - Installing collected packages: blessings 05:53:31 INFO - Running setup.py install for blessings 05:53:32 INFO - Successfully installed blessings 05:53:32 INFO - Cleaning up... 05:53:32 INFO - Return code: 0 05:53:32 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:53:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:53:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:53:32 INFO - Reading from file tmpfile_stdout 05:53:32 INFO - Current package versions: 05:53:32 INFO - blessings == 1.6 05:53:32 INFO - blobuploader == 1.2.4 05:53:32 INFO - docopt == 0.6.1 05:53:32 INFO - functools32 == 3.2.3-2 05:53:32 INFO - jsonschema == 2.5.1 05:53:32 INFO - manifestparser == 1.1 05:53:32 INFO - mozInstall == 1.12 05:53:32 INFO - mozcrash == 0.17 05:53:32 INFO - mozdebug == 0.1 05:53:32 INFO - mozdevice == 0.48 05:53:32 INFO - mozfile == 1.2 05:53:32 INFO - mozhttpd == 0.7 05:53:32 INFO - mozinfo == 0.9 05:53:32 INFO - mozleak == 0.1 05:53:32 INFO - mozlog == 3.4 05:53:32 INFO - moznetwork == 0.27 05:53:32 INFO - mozprocess == 0.23 05:53:32 INFO - mozprofile == 0.28 05:53:32 INFO - mozrunner == 6.12 05:53:32 INFO - mozscreenshot == 0.1 05:53:32 INFO - mozsystemmonitor == 0.3 05:53:32 INFO - moztest == 0.7 05:53:32 INFO - mozversion == 1.4 05:53:32 INFO - psutil == 3.1.1 05:53:32 INFO - requests == 1.2.3 05:53:32 INFO - wsgiref == 0.1.2 05:53:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:32 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 0x10c907490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c87d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff783575a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c71bd30>, '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 0x10c581db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c713b20>, '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.CT9cLCvQaT/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.mqJYdtI8GW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:53:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:53:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CT9cLCvQaT/Render', 05:53:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:32 INFO - 'HOME': '/Users/cltbld', 05:53:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:32 INFO - 'LOGNAME': 'cltbld', 05:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:32 INFO - 'MOZ_NO_REMOTE': '1', 05:53:32 INFO - 'NO_EM_RESTART': '1', 05:53:32 INFO - 'PAGER': '/bin/cat', 05:53:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:32 INFO - 'PWD': '/builds/slave/test', 05:53:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:32 INFO - 'SHELL': '/bin/bash', 05:53:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqJYdtI8GW/Listeners', 05:53:32 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 05:53:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:32 INFO - 'USER': 'cltbld', 05:53:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:32 INFO - 'XPC_FLAGS': '0x0', 05:53:32 INFO - 'XPC_SERVICE_NAME': '0', 05:53:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:53:32 INFO - Cleaning up... 05:53:32 INFO - Return code: 0 05:53:32 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:53:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:53:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:53:32 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 0x10c907490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c87d570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff783575a30>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c71bd30>, '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 0x10c581db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c713b20>, '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.CT9cLCvQaT/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.mqJYdtI8GW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:53:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:53:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:53:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CT9cLCvQaT/Render', 05:53:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:32 INFO - 'HOME': '/Users/cltbld', 05:53:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:32 INFO - 'LOGNAME': 'cltbld', 05:53:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:32 INFO - 'MOZ_NO_REMOTE': '1', 05:53:32 INFO - 'NO_EM_RESTART': '1', 05:53:32 INFO - 'PAGER': '/bin/cat', 05:53:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:32 INFO - 'PWD': '/builds/slave/test', 05:53:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:32 INFO - 'SHELL': '/bin/bash', 05:53:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqJYdtI8GW/Listeners', 05:53:32 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 05:53:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:32 INFO - 'USER': 'cltbld', 05:53:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:32 INFO - 'XPC_FLAGS': '0x0', 05:53:32 INFO - 'XPC_SERVICE_NAME': '0', 05:53:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:53:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:53:32 INFO - Cleaning up... 05:53:32 INFO - Return code: 0 05:53:32 INFO - Running post-action listener: _resource_record_post_action 05:53:32 INFO - Running post-action listener: _start_resource_monitoring 05:53:33 INFO - Starting resource monitoring. 05:53:33 INFO - [mozharness: 2016-11-18 13:53:33.004396Z] Finished create-virtualenv step (success) 05:53:33 INFO - [mozharness: 2016-11-18 13:53:33.005388Z] Running install step. 05:53:33 INFO - Running pre-action listener: _resource_record_pre_action 05:53:33 INFO - Running main action method: install 05:53:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:53:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:53:33 INFO - Reading from file tmpfile_stdout 05:53:33 INFO - Detecting whether we're running mozinstall >=1.0... 05:53:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:53:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:53:33 INFO - Reading from file tmpfile_stdout 05:53:33 INFO - Output received: 05:53:33 INFO - Usage: mozinstall [options] installer 05:53:33 INFO - Options: 05:53:33 INFO - -h, --help show this help message and exit 05:53:33 INFO - -d DEST, --destination=DEST 05:53:33 INFO - Directory to install application into. [default: 05:53:33 INFO - "/builds/slave/test"] 05:53:33 INFO - --app=APP Application being installed. [default: firefox] 05:53:33 INFO - mkdir: /builds/slave/test/build/application 05:53:33 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'] 05:53:33 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 05:53:55 INFO - Reading from file tmpfile_stdout 05:53:55 INFO - Output received: 05:53:55 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 05:53:55 INFO - Running post-action listener: _resource_record_post_action 05:53:55 INFO - [mozharness: 2016-11-18 13:53:55.763624Z] Finished install step (success) 05:53:55 INFO - [mozharness: 2016-11-18 13:53:55.763752Z] Running run-tests step. 05:53:55 INFO - Running pre-action listener: _resource_record_pre_action 05:53:55 INFO - Running main action method: run_tests 05:53:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:53:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:53:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:53:55 INFO - 2016-11-18 05:53:55.777 screenresolution[1900:15320] starting screenresolution argv=screenresolution get 05:53:55 INFO - 2016-11-18 05:53:55.780 screenresolution[1900:15320] Display 0: 1600x1200x32@60 05:53:55 INFO - 2016-11-18 05:53:55.786 screenresolution[1901:15322] starting screenresolution argv=screenresolution list 05:53:55 INFO - Available Modes on Display 0 05:53:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:53:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:53:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:53:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:53:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:53:56 INFO - Intel Iris: 05:53:56 INFO - Chipset Model: Intel Iris 05:53:56 INFO - Type: GPU 05:53:56 INFO - Bus: Built-In 05:53:56 INFO - VRAM (Dynamic, Max): 1536 MB 05:53:56 INFO - Vendor: Intel (0x8086) 05:53:56 INFO - Device ID: 0x0a2e 05:53:56 INFO - Revision ID: 0x0009 05:53:56 INFO - Displays: 05:53:56 INFO - Display: 05:53:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:53:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:53:56 INFO - Display Serial Number: 1600x1200 60 05:53:56 INFO - Main Display: Yes 05:53:56 INFO - Mirror: Off 05:53:56 INFO - Online: Yes 05:53:56 INFO - Rotation: Supported 05:53:56 INFO - Return code: 0 05:53:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:53:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:53:56 INFO - Python 2.7.3 05:53:56 INFO - Return code: 0 05:53:56 INFO - grabbing minidump binary from tooltool 05:53:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:53:56 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 0x10c71bd30>, '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 0x10c581db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c713b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:53:56 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:53:56 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:53:56 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:53:56 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:53:56 INFO - Return code: 0 05:53:56 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:53:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:53:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:53:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:53:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:53:56 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/Zgfp4fGVQmKCJ5O3_cKp9A/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0354', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:53:56 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/Zgfp4fGVQmKCJ5O3_cKp9A/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0354 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:53:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.CT9cLCvQaT/Render', 05:53:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:53:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:53:56 INFO - 'HOME': '/Users/cltbld', 05:53:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:53:56 INFO - 'LOGNAME': 'cltbld', 05:53:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:53:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:53:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:53:56 INFO - 'MOZ_NO_REMOTE': '1', 05:53:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:53:56 INFO - 'NO_EM_RESTART': '1', 05:53:56 INFO - 'PAGER': '/bin/cat', 05:53:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:53:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:53:56 INFO - 'PWD': '/builds/slave/test', 05:53:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:53:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:53:56 INFO - 'SHELL': '/bin/bash', 05:53:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mqJYdtI8GW/Listeners', 05:53:56 INFO - 'TMPDIR': '/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/', 05:53:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:53:56 INFO - 'USER': 'cltbld', 05:53:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:53:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:53:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:53:56 INFO - 'XPC_FLAGS': '0x0', 05:53:56 INFO - 'XPC_SERVICE_NAME': '0', 05:53:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:53:56 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/Zgfp4fGVQmKCJ5O3_cKp9A/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0354', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:53:56 INFO - mozversion application_buildid: 20161118030828 05:53:56 INFO - mozversion application_changeset: 9c19af220675497140cd32e6ad421f12e27e8d58 05:53:56 INFO - mozversion application_display_name: Firefox 05:53:56 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:53:56 INFO - mozversion application_name: Firefox 05:53:56 INFO - mozversion application_remotingname: firefox 05:53:56 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 05:53:56 INFO - mozversion application_vendor: Mozilla 05:53:56 INFO - mozversion application_version: 51.0 05:53:56 INFO - mozversion platform_buildid: 20161118030828 05:53:56 INFO - mozversion platform_changeset: 9c19af220675497140cd32e6ad421f12e27e8d58 05:53:56 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 05:53:56 INFO - mozversion platform_version: 51.0 05:53:56 INFO - using testdate: 1479477236 05:53:56 INFO - actual date: 1479477236 05:53:56 INFO - starting webserver on 'localhost:51611' 05:53:56 INFO - SUITE-START | Running 2 tests 05:53:56 INFO - TEST-START | dromaeo_css 05:53:56 INFO - operating with platform_type : mac_ 05:53:56 INFO - Initialising browser for dromaeo_css test... 05:53:56 INFO - TEST-INFO | started process 1911 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmpfefavS/profile http://localhost:51611/getInfo.html) 05:53:58 INFO - PROCESS | 1911 | __metrics Screen width/height:1600/1200 05:53:58 INFO - PROCESS | 1911 | colorDepth:24 05:53:58 INFO - PROCESS | 1911 | Browser inner width/height: 1024/689 05:53:58 INFO - PROCESS | 1911 | __metrics 05:53:58 INFO - PROCESS | 1911 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:53:58 INFO - PROCESS | 1911 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:53:59 INFO - TEST-INFO | 1911: exit 0 05:53:59 INFO - Browser initialized. 05:53:59 INFO - Running cycle 1/1 for dromaeo_css test... 05:53:59 INFO - TEST-INFO | started process 1914 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmpfefavS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:54:11 INFO - PROCESS | 1914 | RSS: Main: 168783872 05:54:11 INFO - PROCESS | 1914 | 05:55:03 INFO - PROCESS | 1914 | 1479477303247 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:57:13 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:51611/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51611/tests/dromaeo/cssquery-ext.html) 05:57:15 INFO - PROCESS | 1914 | RSS: Main: 327610368 05:57:15 INFO - PROCESS | 1914 | 06:00:17 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:51611/tests/dromaeo/cssquery-ext.html (next: http://localhost:51611/tests/dromaeo/cssquery-jquery.html) 06:00:18 INFO - PROCESS | 1914 | RSS: Main: 298622976 06:00:18 INFO - PROCESS | 1914 | 06:03:20 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:51611/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51611/tests/dromaeo/cssquery-mootools.html) 06:03:21 INFO - PROCESS | 1914 | RSS: Main: 296869888 06:03:21 INFO - PROCESS | 1914 | 06:06:23 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:51611/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51611/tests/dromaeo/cssquery-prototype.html) 06:06:23 INFO - PROCESS | 1914 | RSS: Main: 267845632 06:06:23 INFO - PROCESS | 1914 | 06:09:27 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:51611/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51611/tests/dromaeo/cssquery-yui.html) 06:09:27 INFO - PROCESS | 1914 | RSS: Main: 267407360 06:09:27 INFO - PROCESS | 1914 | 06:12:30 INFO - PROCESS | 1914 | Cycle 1(1): loaded http://localhost:51611/tests/dromaeo/cssquery-yui.html (next: http://localhost:51611/tests/dromaeo/cssquery-dojo.html) 06:12:30 INFO - PROCESS | 1914 | RSS: Main: 423305216 06:12:30 INFO - PROCESS | 1914 | 06:12:30 INFO - PROCESS | 1914 | __start_tp_report 06:12:30 INFO - PROCESS | 1914 | _x_x_mozilla_page_load 06:12:30 INFO - PROCESS | 1914 | _x_x_mozilla_page_load_details 06:12:30 INFO - PROCESS | 1914 | |i|pagename|runs| 06:12:30 INFO - PROCESS | 1914 | |0;dojo.html;3479.895603131906;3497.6852083312497;3514.7188224942006;3528.3296173726976;3582.6238244984274;5778.6243894146955;5928.703564821763;6008.669523176234;6015.639061656304;6018.458338749517;5882.411758824115;5921.881562368761;5995.580309378345;5998.310194327653;6025.517958563315;4555.521670224628;5331.786728530854;5340.91988620171;5350.866228344284;5387.542058924976;5323.068463018956;5323.281357016811;5333.866653333659;5458.4541545845295;5478.986387518322;5360.973195134019;5367.677939323634;5376.758045887925;5378.112611419111;5398.271233383502;5377.166539186413;5396;5443.537299329522;5443.673379597237;5469.042917489423;5287.07476191665;5374.677519348852;5379.919301210485;5387.649802762808;5412.539934105605;5769.278840144982;5790.392008839053;5801.390853960315;5817.592768506206;5836.503897168745;6138.602983404986;6207.875842483125;6215.658138802364;6223.346548612376;6233.189685340922;6358.523110766665;6360.745570177188;6390.233172019341;6393.712282947232;6396.136521569575;5714.771409143587;5832.62087964281;5979.103134529855;6055.031195008865;6094.847628809271;6463.7091330890225;6510.804675859732;6522.282548919615;6525.673716314261;6544.705488252945;6186.659733714599;6196.628202307876;6204.162438070803;6205.689715514206;6211.81364559064;6124.136831511551;6153.230846144232;6194.938050619527;6232.065190221503;6317.905231421532;5155.407128180233;6130.034976025674;6178.011518157163;6240.126382306481;6315.778947736807;6184.536159788034;6195.628262304276;6195.907061394083;6198.752049918043;6209.844753881099;5028.572571331405;5071.2139618359215;5151.974240128776;5156.097682905476;5156.587473002151;4544.863654090383;4566.908661826811;4607;4612.0545288215835;4636.049609829976;6062.242219722535;6072.332043475214;6081.391860813972;6093.238345206849;6106.45041946227;6308.621482711052;6335.873282534323;6339.5562310637815;6355.904661430082;6365.904511432333;5906.940930590725;5935.703214839241;5960.37416071315;6004.459598636056;6008.849778755479;5589.860253493695;5605.859853503695;5639.661620302713;5655.1517272409465;5678.403767604342;6495.317991610813;6546.9345306547275;6556.246031706415;6568.704408301734;6609.438197753245;6167.290761562478;6197.318294987638;6318.84202894913;6391.808245752635;6409.359064093554;6415.037744338387;6478.352164783484;6511.902321465087;6582.901256481253;6587.308332625005;6227.252729672468;6299.496040316855;6311.715972781144;6315.5894866833505;6316.62100273985;5843.678597676999;6124.418180272867;6164.229471316085;6329.082283068838;6348.936510634834;6184;6192.938070619236;6236.126942228182;6319.3364696706185;6332.683365831782;6327.683615819098;6339.080833279241;6343;6363.840903977438;6370.490360771035;6166.691665416801;6254.061890716429;6265.530085243534;6279.152314437492;6284.088807123033;6168.784092556739;6179.876402472015;6217.191765070512;6234.376562343729;6281.59169653971;6243.687815609111;6246.968765156145;6260.40526150015;6263.6241825490615;6268.341824108403 06:12:30 INFO - PROCESS | 1914 | |1;ext.html;473.6116384564658;484.7866938547039;534.4174849414138;534.692551782725;557.8521691751687;32515.67484325156;35729.64270357292;41721.539746108894;42333.36499952496;42607.573924260745;44660.776696116554;44935.10129797402;44961.87595310119;44989.10021799562;45040.87397815048;10018.899811001887;10189.949050254776;10191.999999999964;10197.592096316175;10209.183265338756;9358.625654973794;9585.760355991086;12420.130590858644;12670.176438531465;12673.493060277578;12598.685032874206;12683.936580317131;12686.682832929158;12695.17481363713;12699.682507937283;12564.497420103186;12660.620181394574;12665.620031399072;12670.619881403572;12679.619611411672;12459.813102803466;12550.68623284416;12560.560380386734;12562.874371256263;12573.308468034254;34575.308493830235;42369.364459533135;42646;42651;42762.57237427617;3332.766706330558;3378.814165220912;3543.6102028776813;3607.783532988029;3883.728139030269;32922.67077329244;33118.50322245168;33250.16874578131;33285.50071748926;33807.492887606706;3234.450143475615;3296.587926509186;3394.389009978203;3413.8805141820167;3503.054175372635;543367;546877;549489;550120.2493987544;550185;61979;62359.6882015587;62436.37563624397;62506;62545.68727156335;35771.4634280486;36303.91088267356;36556.63443365532;37313.62686373156;66343.33656663468;18373;18579.535511612317;18603;18620.813791861907;18621.627567448577;12804.679883003;13056.21662700241;14061;14155.716885662228;14177.432902683984;17030;19825.900870495556;20246.088925998367;20286.782793032464;20465.897670511553;6781.525293229427;8123.268905798506;8178.672853085929;8219.219174178443;8231.818568079463;856.541750163672;894.7449976756593;1004.1063453526367;1016.7813920007234;1059.3379138038727;30111.397772044438;31076.533851992237;31191.22021949424;31375.686243137276;31844.840775795972;666.7897765555501;1075.7955988362187;1101.5593762494907;1105.2870898270571;1144.2905398652888;15601.531954041397;16147.919260403858;16184.271707773178;16266.21624322876;16297.83702162987;748661;755836;756786;756890;758492;62756.05865912015;63401.68299158475;63410.414739630956;63472;63587.68206159032;1313.9211647301192;1339.6048165791115;1422.0401229170268;1456.9562913112622;1459.9051061680957;28489.43021139607;31518.896838610537;32364.35271294514;32611.836940815145;32668.649553850195;50828.745856270485;51333.893288537576;51988.74005629947;52017.479825202776;52082.47917520928;509137;509600;509983;510373;510701;24480;24987.375315617253;45965.850853727585;48399.51600484091;48644.27033594428;48613.5138648609;52623.94752105013;53073.203901942274;53075;53432.465675344305;40846.9788255296;43457.34813977856;43708.12583748244;43982.56017439785;44828.32757508705;43229.56770432255;43460.913477163325;43752.78123609489;44340.778296108314;44956;41439.37840932328;42227.57772422359;42390.57609423866;42455;42463.150736985706;35819.64180358163;36991.630083698816;37733.81133094317;37844.810775945945;37904.62095379011;23266.418339541648;27412.72587274102;27748.86125569359;27883.44233115367;27922.581161283004 06:12:30 INFO - PROCESS | 1914 | |2;jquery.html;321.7972677213355;380.19398874386286;384.96920246380284;388.50465656288213;409.2183928696189;17806.020668863206;17951;20645.793542064574;21402.46493837655;21578.784212157872;20941;21102.683459748117;21621.35135945924;21951.890240548815;22281.331560053182;4949.8020079196785;5364.758585863636;6224.533160012995;6275.68621568922;6304.085907543404;6240.344763799803;6282.434580887719;6293.087502312162;6294.3705629437145;6297.622142671432;6064.787732429366;6159;6221.813345599639;6229.439350458458;6239.65681887496;5696.658200507983;5944.316403613553;6186.505079593621;6241.687915604201;6245.531585131111;5352.571794256489;5362.329708786402;5363.275957745733;5365;5368.1679339702405;26764.661766911577;27329;27388;27400.90396384162;27620.723792762215;2303.4586872085047;2311.6707892961613;2518.8866501007315;2673.919782406531;2821.463921854841;15844.841551584452;16160.353585856552;16200.918995404947;16378.344866205338;16441.1779411029;1896.7154926761095;1924.114907142716;1927.9756255931215;1992.9701054484194;2000.21991423345;111874;112969;113202.99999999917;114531.42734286358;115284;10755.83866242007;11024.779504410028;11102.333859968428;11361.54553817838;11380.374079425546;14273;14309.427622895177;14311.57065288043;14311.78532322016;14320.785188222186;8254.917450825415;8391.328693704489;8398.202170793766;8501.914980850235;8517.872231916526;8155.306798922158;8174.427790054639;8176.754697359089;8320.625571849281;8337.374696897758;5575.275214222206;6741.191057073084;6850.623215723083;6883.242843287235;6913.89629155563;1577.3217516468028;1863.8136186381525;1874.2690350763214;1900.4393703857395;1905.8380037696675;788.5308241596241;971.0774763974252;984.9414723228343;1016.6645007147623;1084.3493903657743;17613.295468181386;21603.56792864134;23212.60724356544;23428.882855585613;23501.41246468852;1010.7725761703558;1010.8231059564547;1027.8715160604925;1045.289203341735;1047.4134484688445;11446.599369022044;12267.93866030682;12377;12493.937530312473;12523;644290;646977;654556;658695;659766;95229.52385238168;128018.35990820173;128124.78135276405;132073;133216.335673286;1043.5773511727762;1059.7191744187796;1081.3728037738092;1082.4046774274275;1082.4479515447179;19896;20304.89847550812;20442.28452004173;20535;20566.897165514674;53201.73399133134;53677.73161134325;53805.73097134489;53817.730911346756;54828;74946.62526687332;75962.62018689871;76435;76842.84735728857;77787.22212778026;6087.4521293083835;7158.498905076594;7364.079490063742;7436.107667079985;7656.3874890007555;9044.638214471348;13115.540956066492;13176.275304858325;13186.604401867959;13589.45642174302;11281.132591873542;11511.30932144074;11783.823242651539;11791.764164716486;11880.287182769061;7816.53100813953;9552.567114932815;10431.791364172826;10893.673189804318;11411.486483108114;11195.216334856483;11572.59495917639;11747.647570572897;11871.584494542649;11998.40007999614;7226.819329516804;7259.891365498812;7439.144498382755;7597.734079307198;7644.235576442311;9492.193163581172;10753;10864.859189785275;11291.774164516828;11593.536258549564 06:12:30 INFO - PROCESS | 1914 | |3;mootools.html;1402.8356464134756;1567.192895658736;1600.4158482154014;1821.2805941653048;1959.4905324615604;7325.230850760667;8833.20501154896;9075.319351048673;9352.392094513852;9379;9255.305852061088;9348.39235449697;9351.345405821578;9365.11031452011;9375.765605859857;2444.5477586646484;2474.307193985687;2474.604063349864;2477.306354220821;2477.764612361832;2407.2296865003204;2491.9252422427357;2493.6384224287467;2494.4761600064007;2497.5504409206337;2143.9356819295367;2423.7881059470265;2430.0158435833514;2464.223769512607;2480.913168039119;2421.067888862783;2434.1237154624323;2444.6821913151266;2445.2053082748;2456.2017344362976;2405.6271277951946;2420.1408499982604;2424.3454267347893;2430.052279610953;2435.038159926819;9310.627574896997;9354.625814967394;9433.481158536279;9456.479893605849;9457.33798634096;5494.230807686927;5687.630304030225;5692.57305702074;5747.166660834156;5757.68332741699;3772.2266935278476;3791.9241615167816;3817.141143242776;3857.8842634721004;3858.614138586147;1130.2992144870234;1130.7568872692411;1131.6774719205068;1148.402830528129;1151.424287856072;12503;12540.8118878216;12617.684557886034;12618.305993170372;12643.936780316131;4442.111577684412;4565.360849481075;4674.859754207379;4757.3577567028005;4758.048390321949;9706.272029597809;9708.271879609058;9714.659986900424;9716.902830971741;9719.805603887882;5408.080626293539;5413.675179489243;5421.132618780976;5421.295231619864;5422.0511410503;4528.682992190581;4669.112868554964;4820.4456487503685;4841.830535931225;5080.110980578384;3933;3971.702122340836;4024.2756303865;4065.59344065597;4069.8168582413864;1033.2405681823852;1187.0681515010674;1199.1006744941294;1199.382318106176;1209.2502648358075;877.8463768840427;948.7343543807744;953.1993125774383;969.7672558585889;975.8487434447673;6104.145419641254;6140.631562106288;6161.106639537242;6280.246370435577;6358.1734374531015;369.6396013886493;438.0516182464991;445.6813378434435;448.21785983459074;452.30119465426;3404.761666683358;4121.9587804122175;4151.543330233671;4161.52142503616;4260.147970405931;11101.722456938642;11640.185187036996;11648.184627076193;11652.475638596283;11671.241369310968;11577.421128943519;11653.708657283636;11656;11658.06735461178;11663.066954643607;7939.722109726247;8706.564671766386;8760.4305720128;8788.2529984952;8797.912020879709;5978.940210597838;6036.0644100164545;6063.302720187235;6137.324894261538;6284.183056202664;8769.824603507766;10371.222158338305;10762.246642734934;10767.246292759432;10989;9829.606815727577;9964.900350996397;10516.631917882838;10813.729656758644;11022.614208502984;7805.14143444232;8055.677772889018;8157.510549367057;8165.632546535539;8169.387295952709;8731.607077681647;8731.825363492568;8825.293976481738;8833.205011548991;8843.425177363451;7809.023872015998;7928.445008849556;7969.561674107747;8054;8112.553809540532;7712.498687585514;7778.416618753503;7813.882791758015;7835.451518393657;7965.044194696674;7357.301056399633;7509.324160825552;7512.474126811071;7513.286237807618;7520.661570229462;5193.818216362409;5230.450802665818;5239.29269548606;5335.306410166653;5471.151971444432;4285.978570107254;5140.997505486544;5239.528442440199;5323.893522129459;5365.302510673588 06:12:30 INFO - PROCESS | 1914 | |4;prototype.html;273.3862478735239;298.13540731877555;304.9573059771632;308.3355369179419;311.2669662943766;5019.623528235388;5128.794848206072;5132.4867513248655;5160.406553246377;5185.974070129644;4603.7237765734;4999.375078115236;5065.544101030907;5122.6926384416965;5123.718195499246;3954.7231693781446;3972.3842804365368;3973.3642617181185;3973.543042550115;3988.6410223079915;3458.8270586470703;3706.555213374399;3986.2027594481074;3986.2625414298304;3993.3011722948513;3907.98046009771;3913.5303763548413;3917.315554311645;3952.3281042222893;3962.5641179470235;3892.065904183004;3905.9804700976456;3906.4726261954697;3919.1377896862928;3939.3893946438347;2785.470760555488;3395.862386100659;3396.4735466002808;3400.693937545608;3401.234722187513;4283.764392958386;4788.490976374572;5047.671901326402;5056.62075344347;5248.373004368658;4482.341533632577;4486.4840543337605;4496.685232033759;4510.594046535794;4516.841910533149;5444.727763611803;5456.372517160537;5473.917891231635;5473.932583146288;5476.4249753775675;3312.7681062325646;3470.022087410152;3703.2223233121076;3763;3777.9398687063567;4617.2612382018715;5558.666480011172;5596.692181929992;5615.410381909923;5616.9157462638095;3470.6182319944787;3677.485152078711;3721.627837216311;3731.1231860512758;3732.309522738302;3812.7331086823656;3817.4655548223272;3821.3885778275344;3822.235552889433;3838.213166300902;3668.559772827278;4277.786110694453;4367.563243675607;4396.626286765597;4422.933655995163;4386.8025938832825;5243.872567397952;5340.813071542478;5349.679019258857;5351.474829673524;1233.660743295583;1263.7977923532192;1269.774667445919;1273.5924504158581;1282.7306265684124;732.0008188822219;823.0452674897091;850.6257246811507;853.38129855854;882.8455020371409;4278.593533614302;5173.715445650525;5175.275461435402;5186.585073194211;5284.762185701653;4407.581279778416;4956.950430495649;5442.727863606804;5570.220169176318;5617.848341090067;5110.28456016158;5116.002379535955;5121.436641969381;5130.948690513122;5141.357330333708;2899.884004639833;2913.577531257998;2915.7375836174847;2921.9853900730786;2943.7939344245697;5521.613487055948;5732.369439361667;5735.770569177186;5744.454276843693;5817.992792486585;4910.435299940481;5661.094224923992;5661.659620823733;5668.149777533403;5688.23208866806;5468.277492589821;5515.338159420895;5696.088625819849;5763.394843541451;5817.38917413674;4939.234418664969;5238.333166783344;5545.556355491632;5574.86062848432;5598.692071936082;5132.255822905583;5481.397046324981;5487.368952570346;5498.917516237179;5502.504774570308;5044.695724300589;5056.533605254435;5535.446455354593;5579.523438592306;5744.281964754406;3300.851461684278;3330.0176447948397;3763.4542991266662;3786.091338078896;3793.9430908536947;5042.571381432619;5483.890322193454;5516.834494965157;5519.39286678473;5586.921547270434;4594.2419500782;5092.784638682185;5395.973020134874;5420.807422367073;5423.810166644306;4374.650027997816;4566.589006989387;5289.693941286696;5572.052751032254;5576.944230557642;4829.764058081024;5293.550048245942;5383.40782513931;5412;5473.972630136824;4688.812447502061;5487.890242195213;5500.394956554695;5546.694931778629;5591.440855914376;4588.931166032579;5464.617476776588;5472.962505809314;5473.644213126293;5485.890282194254 06:12:30 INFO - PROCESS | 1914 | |5;yui.html;750.2460027672192;768.7885831396366;801.6272433318508;809.2029351089172;879.1604018162656;16311;17125.82874171258;17204.967701937894;17252.309907603696;17259;15315.693686126271;15437.768433473479;15515.689686206297;15520.30158642861;15883.285252163652;878.2929741558044;912.1015799437548;914.2503147419086;915.3501014279869;916.8853893263342;737.1964558631091;760.6044856674525;762.9427792915553;917.9908200918005;923.6536298887917;775.6160700453255;802.4743792815685;806.6571707024491;973.5570315506427;979.0894468144622;966.8888077870994;969.1181025267008;969.2536746705033;972.2999440402899;972.3048020665187;710.9857802843966;714.9821254468628;715.6064164709389;716.0977168767339;717.6626985316892;15711.842881571267;15745.291461884128;15769.211539422982;15770;15788.763168552481;14544.981851270415;14638.560843174615;14674.853251467455;14711.705765884622;14732.3370448329;12996.090273680846;13191.802122968164;13250.112348329678;13416.46334146633;13678.384472698654;3985.481887354654;4616.538346165356;4691.929621055687;4738.1708201064675;4843.612510999112;105057.8988420235;108869;109106.45446772715;131273;136642;11042.061424778823;11187.160962927814;11572.56182921148;11808.291502509877;11840.230385025117;22149.44626384321;22456;22464.887675561517;22477.213297534836;22488.662670059963;7285.7814265572115;7899.170587088388;8118.553479558681;8218.21926916942;8466.915330846736;4703.905921881543;4793.592544633675;4796.736179510091;4797.592204662573;5024.799008039638;3748.475213470116;3900.5124359455067;3907.5506316773935;3920.5295364556437;4052.392141178788;634.2294112653149;750.0474397515126;758.6623952341265;759.9544027358377;772.5017363800317;612.2836281550597;631.4664108828033;660.0495286787011;669.621663759974;710.3251910684767;9061.320400969953;10068.345557538736;10130.138938190335;10407.271490995558;10449.477526123816;583.6381443505054;626.4330780643525;681.6898311268361;686.3136863136863;718.0736849464133;4577.542245775396;4968.503149685075;4970.3538539990295;4970.652054356233;5002.424721157041;122547;147447;177293;180100;184639.15360846487;141132;150863.2456837709;152598;153360;156990;107001;127518;128416.3579182098;130012;132228.33885830702;7898;8875.955620221857;9162.770930726785;9595.664151754934;9622.470764107762;70526.94209586758;71261;71380;71831.64084179755;73357.63321183574;103044.93910121906;107416;107599.46200269261;110402.89597103927;111729;12139.696507587381;12242.938785306016;12411.565595204125;12502.687432814253;12641.747165056831;13712.17726936387;13909.513167039106;13954.923130503843;14143.717125657635;14194.219317937612;14135.64660883486;14204.715905681622;14278.928605356907;14402.42390304418;14441.422343106158;13823.032387732763;14014.859851401356;14078.788818167532;14932;15258.31337589789;12916.514600821027;13668.111572747739;14664;14722.705545889237;14809.481668141563;11298;11865.347405892759;12271.69320766988;12283.877161228273;12479.251244925334;10554.947225263824;11904.393680124742;11968.880311196777;12123.272603643809;12212.633620991384 06:12:30 INFO - PROCESS | 1914 | __end_tp_report 06:12:30 INFO - PROCESS | 1914 | __start_cc_report 06:12:30 INFO - PROCESS | 1914 | _x_x_mozilla_cycle_collect,1396 06:12:30 INFO - PROCESS | 1914 | __end_cc_report 06:12:30 INFO - PROCESS | 1914 | __startTimestamp1479478350721__endTimestamp 06:12:30 INFO - PROCESS | 1914 | 06:12:30 INFO - PROCESS | 1914 | ------- Summary: start ------- 06:12:30 INFO - PROCESS | 1914 | Number of tests: 6 06:12:30 INFO - PROCESS | 1914 | 06:12:30 INFO - PROCESS | 1914 | [#0] dojo.html Cycles:165 Average:5893.95 Median:6164.23 stddev:631.97 (10.3%) stddev-sans-first:604.86 06:12:30 INFO - PROCESS | 1914 | Values: 3479.9 3497.7 3514.7 3528.3 3582.6 5778.6 5928.7 6008.7 6015.6 6018.5 5882.4 5921.9 5995.6 5998.3 6025.5 4555.5 5331.8 5340.9 5350.9 5387.5 5323.1 5323.3 5333.9 5458.5 5479.0 5361.0 5367.7 5376.8 5378.1 5398.3 5377.2 5396.0 5443.5 5443.7 5469.0 5287.1 5374.7 5379.9 5387.6 5412.5 5769.3 5790.4 5801.4 5817.6 5836.5 6138.6 6207.9 6215.7 6223.3 6233.2 6358.5 6360.7 6390.2 6393.7 6396.1 5714.8 5832.6 5979.1 6055.0 6094.8 6463.7 6510.8 6522.3 6525.7 6544.7 6186.7 6196.6 6204.2 6205.7 6211.8 6124.1 6153.2 6194.9 6232.1 6317.9 5155.4 6130.0 6178.0 6240.1 6315.8 6184.5 6195.6 6195.9 6198.8 6209.8 5028.6 5071.2 5152.0 5156.1 5156.6 4544.9 4566.9 4607.0 4612.1 4636.0 6062.2 6072.3 6081.4 6093.2 6106.5 6308.6 6335.9 6339.6 6355.9 6365.9 5906.9 5935.7 5960.4 6004.5 6008.8 5589.9 5605.9 5639.7 5655.2 5678.4 6495.3 6546.9 6556.2 6568.7 6609.4 6167.3 6197.3 6318.8 6391.8 6409.4 6415.0 6478.4 6511.9 6582.9 6587.3 6227.3 6299.5 6311.7 6315.6 6316.6 5843.7 6124.4 6164.2 6329.1 6348.9 6184.0 6192.9 6236.1 6319.3 6332.7 6327.7 6339.1 6343.0 6363.8 6370.5 6166.7 6254.1 6265.5 6279.2 6284.1 6168.8 6179.9 6217.2 6234.4 6281.6 6243.7 6247.0 6260.4 6263.6 6268.3 06:12:30 INFO - PROCESS | 1914 | 06:12:30 INFO - PROCESS | 1914 | [#1] ext.html Cycles:180 Average:74560.29 Median:19955.85 stddev:164234.76 (823.0%) stddev-sans-first:164601.28 06:12:30 INFO - PROCESS | 1914 | Values: 473.6 484.8 534.4 534.7 557.9 32515.7 35729.6 41721.5 42333.4 42607.6 44660.8 44935.1 44961.9 44989.1 45040.9 10018.9 10189.9 10192.0 10197.6 10209.2 9358.6 9585.8 12420.1 12670.2 12673.5 12598.7 12683.9 12686.7 12695.2 12699.7 12564.5 12660.6 12665.6 12670.6 12679.6 12459.8 12550.7 12560.6 12562.9 12573.3 34575.3 42369.4 42646.0 42651.0 42762.6 3332.8 3378.8 3543.6 3607.8 3883.7 32922.7 33118.5 33250.2 33285.5 33807.5 3234.5 3296.6 3394.4 3413.9 3503.1 543367.0 546877.0 549489.0 550120.2 550185.0 61979.0 62359.7 62436.4 62506.0 62545.7 35771.5 36303.9 36556.6 37313.6 66343.3 18373.0 18579.5 18603.0 18620.8 18621.6 12804.7 13056.2 14061.0 14155.7 14177.4 17030.0 19825.9 20246.1 20286.8 20465.9 6781.5 8123.3 8178.7 8219.2 8231.8 856.5 894.7 1004.1 1016.8 1059.3 30111.4 31076.5 31191.2 31375.7 31844.8 666.8 1075.8 1101.6 1105.3 1144.3 15601.5 16147.9 16184.3 16266.2 16297.8 748661.0 755836.0 756786.0 756890.0 758492.0 62756.1 63401.7 63410.4 63472.0 63587.7 1313.9 1339.6 1422.0 1457.0 1459.9 28489.4 31518.9 32364.4 32611.8 32668.6 50828.7 51333.9 51988.7 52017.5 52082.5 509137.0 509600.0 509983.0 510373.0 510701.0 24480.0 24987.4 45965.9 48399.5 48644.3 48613.5 52623.9 53073.2 53075.0 53432.5 40847.0 43457.3 43708.1 43982.6 44828.3 43229.6 43460.9 43752.8 44340.8 44956.0 41439.4 42227.6 42390.6 42455.0 42463.2 35819.6 36991.6 37733.8 37844.8 37904.6 23266.4 27412.7 27748.9 27883.4 27922.6 06:12:30 INFO - PROCESS | 1914 | 06:12:30 INFO - PROCESS | 1914 | [#2] jquery.html Cycles:180 Average:36630.46 Median:12762.14 stddev:108234.55 (848.1%) stddev-sans-first:108503.84 06:12:30 INFO - PROCESS | 1914 | Values: 321.8 380.2 385.0 388.5 409.2 17806.0 17951.0 20645.8 21402.5 21578.8 20941.0 21102.7 21621.4 21951.9 22281.3 4949.8 5364.8 6224.5 6275.7 6304.1 6240.3 6282.4 6293.1 6294.4 6297.6 6064.8 6159.0 6221.8 6229.4 6239.7 5696.7 5944.3 6186.5 6241.7 6245.5 5352.6 5362.3 5363.3 5365.0 5368.2 26764.7 27329.0 27388.0 27400.9 27620.7 2303.5 2311.7 2518.9 2673.9 2821.5 15844.8 16160.4 16200.9 16378.3 16441.2 1896.7 1924.1 1928.0 1993.0 2000.2 111874.0 112969.0 113203.0 114531.4 115284.0 10755.8 11024.8 11102.3 11361.5 11380.4 14273.0 14309.4 14311.6 14311.8 14320.8 8254.9 8391.3 8398.2 8501.9 8517.9 8155.3 8174.4 8176.8 8320.6 8337.4 5575.3 6741.2 6850.6 6883.2 6913.9 1577.3 1863.8 1874.3 1900.4 1905.8 788.5 971.1 984.9 1016.7 1084.3 17613.3 21603.6 23212.6 23428.9 23501.4 1010.8 1010.8 1027.9 1045.3 1047.4 11446.6 12267.9 12377.0 12493.9 12523.0 644290.0 646977.0 654556.0 658695.0 659766.0 95229.5 128018.4 128124.8 132073.0 133216.3 1043.6 1059.7 1081.4 1082.4 1082.4 19896.0 20304.9 20442.3 20535.0 20566.9 53201.7 53677.7 53805.7 53817.7 54828.0 74946.6 75962.6 76435.0 76842.8 77787.2 6087.5 7158.5 7364.1 7436.1 7656.4 9044.6 13115.5 13176.3 13186.6 13589.5 11281.1 11511.3 11783.8 11791.8 11880.3 7816.5 9552.6 10431.8 10893.7 11411.5 11195.2 11572.6 11747.6 11871.6 11998.4 7226.8 7259.9 7439.1 7597.7 7644.2 9492.2 10753.0 10864.9 11291.8 11593.5 06:12:30 INFO - PROCESS | 1914 | 06:12:30 INFO - PROCESS | 1914 | [#3] mootools.html Cycles:180 Average:5975.42 Median:4831.14 stddev:3435.03 (71.1%) stddev-sans-first:3427.47 06:12:30 INFO - PROCESS | 1914 | Values: 1402.8 1567.2 1600.4 1821.3 1959.5 7325.2 8833.2 9075.3 9352.4 9379.0 9255.3 9348.4 9351.3 9365.1 9375.8 2444.5 2474.3 2474.6 2477.3 2477.8 2407.2 2491.9 2493.6 2494.5 2497.6 2143.9 2423.8 2430.0 2464.2 2480.9 2421.1 2434.1 2444.7 2445.2 2456.2 2405.6 2420.1 2424.3 2430.1 2435.0 9310.6 9354.6 9433.5 9456.5 9457.3 5494.2 5687.6 5692.6 5747.2 5757.7 3772.2 3791.9 3817.1 3857.9 3858.6 1130.3 1130.8 1131.7 1148.4 1151.4 12503.0 12540.8 12617.7 12618.3 12643.9 4442.1 4565.4 4674.9 4757.4 4758.0 9706.3 9708.3 9714.7 9716.9 9719.8 5408.1 5413.7 5421.1 5421.3 5422.1 4528.7 4669.1 4820.4 4841.8 5080.1 3933.0 3971.7 4024.3 4065.6 4069.8 1033.2 1187.1 1199.1 1199.4 1209.3 877.8 948.7 953.2 969.8 975.8 6104.1 6140.6 6161.1 6280.2 6358.2 369.6 438.1 445.7 448.2 452.3 3404.8 4122.0 4151.5 4161.5 4260.1 11101.7 11640.2 11648.2 11652.5 11671.2 11577.4 11653.7 11656.0 11658.1 11663.1 7939.7 8706.6 8760.4 8788.3 8797.9 5978.9 6036.1 6063.3 6137.3 6284.2 8769.8 10371.2 10762.2 10767.2 10989.0 9829.6 9964.9 10516.6 10813.7 11022.6 7805.1 8055.7 8157.5 8165.6 8169.4 8731.6 8731.8 8825.3 8833.2 8843.4 7809.0 7928.4 7969.6 8054.0 8112.6 7712.5 7778.4 7813.9 7835.5 7965.0 7357.3 7509.3 7512.5 7513.3 7520.7 5193.8 5230.5 5239.3 5335.3 5471.2 4286.0 5141.0 5239.5 5323.9 5365.3 06:12:30 INFO - PROCESS | 1914 | 06:12:30 INFO - PROCESS | 1914 | [#4] prototype.html Cycles:180 Average:4407.87 Median:5052.10 stddev:1353.36 (26.8%) stddev-sans-first:1321.10 06:12:30 INFO - PROCESS | 1914 | Values: 273.4 298.1 305.0 308.3 311.3 5019.6 5128.8 5132.5 5160.4 5186.0 4603.7 4999.4 5065.5 5122.7 5123.7 3954.7 3972.4 3973.4 3973.5 3988.6 3458.8 3706.6 3986.2 3986.3 3993.3 3908.0 3913.5 3917.3 3952.3 3962.6 3892.1 3906.0 3906.5 3919.1 3939.4 2785.5 3395.9 3396.5 3400.7 3401.2 4283.8 4788.5 5047.7 5056.6 5248.4 4482.3 4486.5 4496.7 4510.6 4516.8 5444.7 5456.4 5473.9 5473.9 5476.4 3312.8 3470.0 3703.2 3763.0 3777.9 4617.3 5558.7 5596.7 5615.4 5616.9 3470.6 3677.5 3721.6 3731.1 3732.3 3812.7 3817.5 3821.4 3822.2 3838.2 3668.6 4277.8 4367.6 4396.6 4422.9 4386.8 5243.9 5340.8 5349.7 5351.5 1233.7 1263.8 1269.8 1273.6 1282.7 732.0 823.0 850.6 853.4 882.8 4278.6 5173.7 5175.3 5186.6 5284.8 4407.6 4957.0 5442.7 5570.2 5617.8 5110.3 5116.0 5121.4 5130.9 5141.4 2899.9 2913.6 2915.7 2922.0 2943.8 5521.6 5732.4 5735.8 5744.5 5818.0 4910.4 5661.1 5661.7 5668.1 5688.2 5468.3 5515.3 5696.1 5763.4 5817.4 4939.2 5238.3 5545.6 5574.9 5598.7 5132.3 5481.4 5487.4 5498.9 5502.5 5044.7 5056.5 5535.4 5579.5 5744.3 3300.9 3330.0 3763.5 3786.1 3793.9 5042.6 5483.9 5516.8 5519.4 5586.9 4594.2 5092.8 5396.0 5420.8 5423.8 4374.7 4566.6 5289.7 5572.1 5576.9 4829.8 5293.6 5383.4 5412.0 5474.0 4688.8 5487.9 5500.4 5546.7 5591.4 4588.9 5464.6 5473.0 5473.6 5485.9 06:12:30 INFO - PROCESS | 1914 | 06:12:30 INFO - PROCESS | 1914 | [#5] yui.html Cycles:180 Average:27553.78 Median:97276.00 stddev:45002.35 (46.3%) stddev-sans-first:45083.60 06:12:30 INFO - PROCESS | 1914 | Values: 750.2 768.8 801.6 809.2 879.2 16311.0 17125.8 17205.0 17252.3 17259.0 15315.7 15437.8 15515.7 15520.3 15883.3 878.3 912.1 914.3 915.4 916.9 737.2 760.6 762.9 918.0 923.7 775.6 802.5 806.7 973.6 979.1 966.9 969.1 969.3 972.3 972.3 711.0 715.0 715.6 716.1 717.7 15711.8 15745.3 15769.2 15770.0 15788.8 14545.0 14638.6 14674.9 14711.7 14732.3 12996.1 13191.8 13250.1 13416.5 13678.4 3985.5 4616.5 4691.9 4738.2 4843.6 105057.9 108869.0 109106.5 131273.0 136642.0 11042.1 11187.2 11572.6 11808.3 11840.2 22149.4 22456.0 22464.9 22477.2 22488.7 7285.8 7899.2 8118.6 8218.2 8466.9 4703.9 4793.6 4796.7 4797.6 5024.8 3748.5 3900.5 3907.6 3920.5 4052.4 634.2 750.0 758.7 760.0 772.5 612.3 631.5 660.0 669.6 710.3 9061.3 10068.3 10130.1 10407.3 10449.5 583.6 626.4 681.7 686.3 718.1 4577.5 4968.5 4970.4 4970.7 5002.4 122547.0 147447.0 177293.0 180100.0 184639.2 141132.0 150863.2 152598.0 153360.0 156990.0 107001.0 127518.0 128416.4 130012.0 132228.3 7898.0 8876.0 9162.8 9595.7 9622.5 70526.9 71261.0 71380.0 71831.6 73357.6 103044.9 107416.0 107599.5 110402.9 111729.0 12139.7 12242.9 12411.6 12502.7 12641.7 13712.2 13909.5 13954.9 14143.7 14194.2 14135.6 14204.7 14278.9 14402.4 14441.4 13823.0 14014.9 14078.8 14932.0 15258.3 12916.5 13668.1 14664.0 14722.7 14809.5 11298.0 11865.3 12271.7 12283.9 12479.3 10554.9 11904.4 11968.9 12123.3 12212.6 06:12:30 INFO - PROCESS | 1914 | -------- Summary: end -------- 06:12:30 INFO - PROCESS | 1914 | 06:12:31 INFO - TEST-INFO | 1914: exit 0 06:12:31 INFO - TEST-OK | dromaeo_css | took 1115000ms 06:12:31 INFO - TEST-START | kraken 06:12:31 INFO - operating with platform_type : mac_ 06:12:31 INFO - Initialising browser for kraken test... 06:12:31 INFO - TEST-INFO | started process 1918 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmp6rt3EX/profile http://localhost:51611/getInfo.html) 06:12:33 INFO - PROCESS | 1918 | __metrics Screen width/height:1600/1200 06:12:33 INFO - PROCESS | 1918 | colorDepth:24 06:12:33 INFO - PROCESS | 1918 | Browser inner width/height: 1024/689 06:12:33 INFO - PROCESS | 1918 | __metrics 06:12:33 INFO - PROCESS | 1918 | 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" 06:12:33 INFO - PROCESS | 1918 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 06:12:34 INFO - TEST-INFO | 1918: exit 0 06:12:34 INFO - Browser initialized. 06:12:34 INFO - Running cycle 1/1 for kraken test... 06:12:34 INFO - TEST-INFO | started process 1920 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/T/tmp6rt3EX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:12:46 INFO - PROCESS | 1920 | RSS: Main: 168300544 06:12:46 INFO - PROCESS | 1920 | 06:12:49 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51611/tests/kraken/driver.html?testName=audio-beat-detection) 06:12:49 INFO - PROCESS | 1920 | RSS: Main: 217776128 06:12:49 INFO - PROCESS | 1920 | 06:12:52 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51611/tests/kraken/driver.html?testName=audio-dft) 06:12:53 INFO - PROCESS | 1920 | RSS: Main: 229019648 06:12:53 INFO - PROCESS | 1920 | 06:12:56 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51611/tests/kraken/driver.html?testName=audio-fft) 06:12:56 INFO - PROCESS | 1920 | RSS: Main: 326823936 06:12:56 INFO - PROCESS | 1920 | 06:12:58 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51611/tests/kraken/driver.html?testName=audio-oscillator) 06:12:59 INFO - PROCESS | 1920 | RSS: Main: 227422208 06:12:59 INFO - PROCESS | 1920 | 06:13:01 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51611/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:13:02 INFO - PROCESS | 1920 | RSS: Main: 227770368 06:13:02 INFO - PROCESS | 1920 | 06:13:04 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51611/tests/kraken/driver.html?testName=imaging-darkroom) 06:13:05 INFO - PROCESS | 1920 | RSS: Main: 267841536 06:13:05 INFO - PROCESS | 1920 | 06:13:08 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51611/tests/kraken/driver.html?testName=imaging-desaturate) 06:13:09 INFO - PROCESS | 1920 | RSS: Main: 266899456 06:13:09 INFO - PROCESS | 1920 | 06:13:12 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51611/tests/kraken/driver.html?testName=json-parse-financial) 06:13:12 INFO - PROCESS | 1920 | RSS: Main: 264261632 06:13:12 INFO - PROCESS | 1920 | 06:13:14 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51611/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:13:14 INFO - PROCESS | 1920 | RSS: Main: 239763456 06:13:14 INFO - PROCESS | 1920 | 06:13:16 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51611/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:13:17 INFO - PROCESS | 1920 | RSS: Main: 244383744 06:13:17 INFO - PROCESS | 1920 | 06:13:19 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51611/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:13:20 INFO - PROCESS | 1920 | RSS: Main: 250703872 06:13:20 INFO - PROCESS | 1920 | 06:13:22 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51611/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:13:23 INFO - PROCESS | 1920 | RSS: Main: 258658304 06:13:23 INFO - PROCESS | 1920 | 06:13:26 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51611/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:13:26 INFO - PROCESS | 1920 | RSS: Main: 258973696 06:13:26 INFO - PROCESS | 1920 | 06:13:28 INFO - PROCESS | 1920 | Cycle 1(1): loaded http://localhost:51611/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51611/tests/kraken/driver.html?testName=ai-astar) 06:13:28 INFO - PROCESS | 1920 | RSS: Main: 302960640 06:13:28 INFO - PROCESS | 1920 | 06:13:28 INFO - PROCESS | 1920 | __start_tp_report 06:13:28 INFO - PROCESS | 1920 | _x_x_mozilla_page_load 06:13:28 INFO - PROCESS | 1920 | _x_x_mozilla_page_load_details 06:13:28 INFO - PROCESS | 1920 | |i|pagename|runs| 06:13:28 INFO - PROCESS | 1920 | |0;ai-astar;115;113;112;112;111;121;165;160;113;113 06:13:28 INFO - PROCESS | 1920 | |1;audio-beat-detection;175;136;109;142;107;108;110;102;140;109 06:13:28 INFO - PROCESS | 1920 | |2;audio-dft;185;183;182;183;183;185;182;182;185;181 06:13:28 INFO - PROCESS | 1920 | |3;audio-fft;81;59;62;89;62;59;59;58;83;58 06:13:28 INFO - PROCESS | 1920 | |4;audio-oscillator;88;72;95;70;68;70;91;67;70;114 06:13:28 INFO - PROCESS | 1920 | |5;imaging-gaussian-blur;89;85;88;86;87;85;79;130;134;129 06:13:28 INFO - PROCESS | 1920 | |6;imaging-darkroom;118;167;96;98;97;95;97;97;96;128 06:13:28 INFO - PROCESS | 1920 | |7;imaging-desaturate;86;128;140;131;84;85;85;92;86;84 06:13:28 INFO - PROCESS | 1920 | |8;json-parse-financial;55;52;53;52;56;54;55;56;56;55 06:13:28 INFO - PROCESS | 1920 | |9;json-stringify-tinderbox;63;70;75;71;71;71;68;70;69;70 06:13:28 INFO - PROCESS | 1920 | |10;stanford-crypto-aes;81;84;83;84;84;83;88;88;99;87 06:13:28 INFO - PROCESS | 1920 | |11;stanford-crypto-ccm;145;149;126;135;134;134;135;134;148;150 06:13:28 INFO - PROCESS | 1920 | |12;stanford-crypto-pbkdf2;160;160;160;163;165;161;161;159;158;160 06:13:28 INFO - PROCESS | 1920 | |13;stanford-crypto-sha256-iterative;65;67;66;66;65;65;63;64;65;67 06:13:28 INFO - PROCESS | 1920 | __end_tp_report 06:13:28 INFO - PROCESS | 1920 | __start_cc_report 06:13:28 INFO - PROCESS | 1920 | _x_x_mozilla_cycle_collect,1902 06:13:28 INFO - PROCESS | 1920 | __end_cc_report 06:13:28 INFO - PROCESS | 1920 | __startTimestamp1479478408907__endTimestamp 06:13:28 INFO - PROCESS | 1920 | 06:13:28 INFO - PROCESS | 1920 | ------- Summary: start ------- 06:13:28 INFO - PROCESS | 1920 | Number of tests: 14 06:13:28 INFO - PROCESS | 1920 | 06:13:28 INFO - PROCESS | 1920 | [#0] ai-astar Cycles:10 Average:123.50 Median:114.00 stddev:20.78 (18.2%) stddev-sans-first:21.81 06:13:28 INFO - PROCESS | 1920 | Values: 115.0 113.0 112.0 112.0 111.0 121.0 165.0 160.0 113.0 113.0 06:13:28 INFO - PROCESS | 1920 | 06:13:28 INFO - PROCESS | 1920 | [#1] audio-beat-detection Cycles:10 Average:123.80 Median:123.00 stddev:23.57 (19.2%) stddev-sans-first:16.15 06:13:28 INFO - PROCESS | 1920 | Values: 175.0 136.0 109.0 142.0 107.0 108.0 110.0 102.0 140.0 109.0 06:13:28 INFO - PROCESS | 1920 | 06:13:28 INFO - PROCESS | 1920 | [#2] audio-dft Cycles:10 Average:183.10 Median:183.00 stddev:1.45 (0.8%) stddev-sans-first:1.36 06:13:28 INFO - PROCESS | 1920 | Values: 185.0 183.0 182.0 183.0 183.0 185.0 182.0 182.0 185.0 181.0 06:13:28 INFO - PROCESS | 1920 | 06:13:28 INFO - PROCESS | 1920 | [#3] audio-fft Cycles:10 Average:67.00 Median:62.00 stddev:12.20 (19.7%) stddev-sans-first:11.84 06:13:28 INFO - PROCESS | 1920 | Values: 81.0 59.0 62.0 89.0 62.0 59.0 59.0 58.0 83.0 58.0 06:13:28 INFO - PROCESS | 1920 | 06:13:28 INFO - PROCESS | 1920 | [#4] audio-oscillator Cycles:10 Average:80.50 Median:71.00 stddev:15.78 (22.2%) stddev-sans-first:16.50 06:13:28 INFO - PROCESS | 1920 | Values: 88.0 72.0 95.0 70.0 68.0 70.0 91.0 67.0 70.0 114.0 06:13:28 INFO - PROCESS | 1920 | 06:13:28 INFO - PROCESS | 1920 | [#5] imaging-gaussian-blur Cycles:10 Average:99.20 Median:85.50 stddev:22.14 (25.9%) stddev-sans-first:23.17 06:13:28 INFO - PROCESS | 1920 | Values: 89.0 85.0 88.0 86.0 87.0 85.0 79.0 130.0 134.0 129.0 06:13:28 INFO - PROCESS | 1920 | 06:13:28 INFO - PROCESS | 1920 | [#6] imaging-darkroom Cycles:10 Average:108.90 Median:96.50 stddev:23.32 (24.2%) stddev-sans-first:24.50 06:13:28 INFO - PROCESS | 1920 | Values: 118.0 167.0 96.0 98.0 97.0 95.0 97.0 97.0 96.0 128.0 06:13:28 INFO - PROCESS | 1920 | 06:13:28 INFO - PROCESS | 1920 | [#7] imaging-desaturate Cycles:10 Average:100.10 Median:85.00 stddev:23.00 (27.1%) stddev-sans-first:23.83 06:13:28 INFO - PROCESS | 1920 | Values: 86.0 128.0 140.0 131.0 84.0 85.0 85.0 92.0 86.0 84.0 06:13:28 INFO - PROCESS | 1920 | 06:13:28 INFO - PROCESS | 1920 | [#8] json-parse-financial Cycles:10 Average:54.40 Median:55.00 stddev:1.58 (2.9%) stddev-sans-first:1.66 06:13:28 INFO - PROCESS | 1920 | Values: 55.0 52.0 53.0 52.0 56.0 54.0 55.0 56.0 56.0 55.0 06:13:28 INFO - PROCESS | 1920 | 06:13:28 INFO - PROCESS | 1920 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:70.50 stddev:3.01 (4.3%) stddev-sans-first:1.94 06:13:28 INFO - PROCESS | 1920 | Values: 63.0 70.0 75.0 71.0 71.0 71.0 68.0 70.0 69.0 70.0 06:13:28 INFO - PROCESS | 1920 | 06:13:28 INFO - PROCESS | 1920 | [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:85.50 stddev:5.09 (5.9%) stddev-sans-first:5.05 06:13:28 INFO - PROCESS | 1920 | Values: 81.0 84.0 83.0 84.0 84.0 83.0 88.0 88.0 99.0 87.0 06:13:28 INFO - PROCESS | 1920 | 06:13:28 INFO - PROCESS | 1920 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:140.00 stddev:8.26 (5.9%) stddev-sans-first:8.47 06:13:28 INFO - PROCESS | 1920 | Values: 145.0 149.0 126.0 135.0 134.0 134.0 135.0 134.0 148.0 150.0 06:13:28 INFO - PROCESS | 1920 | 06:13:28 INFO - PROCESS | 1920 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.70 Median:160.50 stddev:2.00 (1.2%) stddev-sans-first:2.11 06:13:28 INFO - PROCESS | 1920 | Values: 160.0 160.0 160.0 163.0 165.0 161.0 161.0 159.0 158.0 160.0 06:13:28 INFO - PROCESS | 1920 | 06:13:28 INFO - PROCESS | 1920 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.30 Median:65.50 stddev:1.25 (1.9%) stddev-sans-first:1.32 06:13:28 INFO - PROCESS | 1920 | Values: 65.0 67.0 66.0 66.0 65.0 65.0 63.0 64.0 65.0 67.0 06:13:28 INFO - PROCESS | 1920 | -------- Summary: end -------- 06:13:28 INFO - PROCESS | 1920 | 06:13:29 INFO - TEST-INFO | 1920: exit 0 06:13:29 INFO - TEST-OK | kraken | took 58400ms 06:13:29 INFO - SUITE-END | took 1173s 06:13:30 INFO - Completed test suite (00:19:33) 06:13:30 INFO - javascript benchmark 06:13:30 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3479.895603131906, 3497.6852083312497, 3514.7188224942006, 3528.3296173726976, 3582.6238244984274, 5778.6243894146955, 5928.703564821763, 6008.669523176234, 6015.639061656304, 6018.458338749517, 5882.411758824115, 5921.881562368761, 5995.580309378345, 5998.310194327653, 6025.517958563315, 4555.521670224628, 5331.786728530854, 5340.91988620171, 5350.866228344284, 5387.542058924976, 5323.068463018956, 5323.281357016811, 5333.866653333659, 5458.4541545845295, 5478.986387518322, 5360.973195134019, 5367.677939323634, 5376.758045887925, 5378.112611419111, 5398.271233383502, 5377.166539186413, 5396.0, 5443.537299329522, 5443.673379597237, 5469.042917489423, 5287.07476191665, 5374.677519348852, 5379.919301210485, 5387.649802762808, 5412.539934105605, 5769.278840144982, 5790.392008839053, 5801.390853960315, 5817.592768506206, 5836.503897168745, 6138.602983404986, 6207.875842483125, 6215.658138802364, 6223.346548612376, 6233.189685340922, 6358.523110766665, 6360.745570177188, 6390.233172019341, 6393.712282947232, 6396.136521569575, 5714.771409143587, 5832.62087964281, 5979.103134529855, 6055.031195008865, 6094.847628809271, 6463.7091330890225, 6510.804675859732, 6522.282548919615, 6525.673716314261, 6544.705488252945, 6186.659733714599, 6196.628202307876, 6204.162438070803, 6205.689715514206, 6211.81364559064, 6124.136831511551, 6153.230846144232, 6194.938050619527, 6232.065190221503, 6317.905231421532, 5155.407128180233, 6130.034976025674, 6178.011518157163, 6240.126382306481, 6315.778947736807, 6184.536159788034, 6195.628262304276, 6195.907061394083, 6198.752049918043, 6209.844753881099, 5028.572571331405, 5071.2139618359215, 5151.974240128776, 5156.097682905476, 5156.587473002151, 4544.863654090383, 4566.908661826811, 4607.0, 4612.0545288215835, 4636.049609829976, 6062.242219722535, 6072.332043475214, 6081.391860813972, 6093.238345206849, 6106.45041946227, 6308.621482711052, 6335.873282534323, 6339.5562310637815, 6355.904661430082, 6365.904511432333, 5906.940930590725, 5935.703214839241, 5960.37416071315, 6004.459598636056, 6008.849778755479, 5589.860253493695, 5605.859853503695, 5639.661620302713, 5655.1517272409465, 5678.403767604342, 6495.317991610813, 6546.9345306547275, 6556.246031706415, 6568.704408301734, 6609.438197753245, 6167.290761562478, 6197.318294987638, 6318.84202894913, 6391.808245752635, 6409.359064093554, 6415.037744338387, 6478.352164783484, 6511.902321465087, 6582.901256481253, 6587.308332625005, 6227.252729672468, 6299.496040316855, 6311.715972781144, 6315.5894866833505, 6316.62100273985, 5843.678597676999, 6124.418180272867, 6164.229471316085, 6329.082283068838, 6348.936510634834, 6184.0, 6192.938070619236, 6236.126942228182, 6319.3364696706185, 6332.683365831782, 6327.683615819098, 6339.080833279241, 6343.0, 6363.840903977438, 6370.490360771035, 6166.691665416801, 6254.061890716429, 6265.530085243534, 6279.152314437492, 6284.088807123033, 6168.784092556739, 6179.876402472015, 6217.191765070512, 6234.376562343729, 6281.59169653971, 6243.687815609111, 6246.968765156145, 6260.40526150015, 6263.6241825490615, 6268.341824108403], "value": 5855.0166091721685, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [473.6116384564658, 484.7866938547039, 534.4174849414138, 534.692551782725, 557.8521691751687, 32515.67484325156, 35729.64270357292, 41721.539746108894, 42333.36499952496, 42607.573924260745, 44660.776696116554, 44935.10129797402, 44961.87595310119, 44989.10021799562, 45040.87397815048, 10018.899811001887, 10189.949050254776, 10191.999999999964, 10197.592096316175, 10209.183265338756, 9358.625654973794, 9585.760355991086, 12420.130590858644, 12670.176438531465, 12673.493060277578, 12598.685032874206, 12683.936580317131, 12686.682832929158, 12695.17481363713, 12699.682507937283, 12564.497420103186, 12660.620181394574, 12665.620031399072, 12670.619881403572, 12679.619611411672, 12459.813102803466, 12550.68623284416, 12560.560380386734, 12562.874371256263, 12573.308468034254, 34575.308493830235, 42369.364459533135, 42646.0, 42651.0, 42762.57237427617, 3332.766706330558, 3378.814165220912, 3543.6102028776813, 3607.783532988029, 3883.728139030269, 32922.67077329244, 33118.50322245168, 33250.16874578131, 33285.50071748926, 33807.492887606706, 3234.450143475615, 3296.587926509186, 3394.389009978203, 3413.8805141820167, 3503.054175372635, 543367.0, 546877.0, 549489.0, 550120.2493987544, 550185.0, 61979.0, 62359.6882015587, 62436.37563624397, 62506.0, 62545.68727156335, 35771.4634280486, 36303.91088267356, 36556.63443365532, 37313.62686373156, 66343.33656663468, 18373.0, 18579.535511612317, 18603.0, 18620.813791861907, 18621.627567448577, 12804.679883003, 13056.21662700241, 14061.0, 14155.716885662228, 14177.432902683984, 17030.0, 19825.900870495556, 20246.088925998367, 20286.782793032464, 20465.897670511553, 6781.525293229427, 8123.268905798506, 8178.672853085929, 8219.219174178443, 8231.818568079463, 856.541750163672, 894.7449976756593, 1004.1063453526367, 1016.7813920007234, 1059.3379138038727, 30111.397772044438, 31076.533851992237, 31191.22021949424, 31375.686243137276, 31844.840775795972, 666.7897765555501, 1075.7955988362187, 1101.5593762494907, 1105.2870898270571, 1144.2905398652888, 15601.531954041397, 16147.919260403858, 16184.271707773178, 16266.21624322876, 16297.83702162987, 748661.0, 755836.0, 756786.0, 756890.0, 758492.0, 62756.05865912015, 63401.68299158475, 63410.414739630956, 63472.0, 63587.68206159032, 1313.9211647301192, 1339.6048165791115, 1422.0401229170268, 1456.9562913112622, 1459.9051061680957, 28489.43021139607, 31518.896838610537, 32364.35271294514, 32611.836940815145, 32668.649553850195, 50828.745856270485, 51333.893288537576, 51988.74005629947, 52017.479825202776, 52082.47917520928, 509137.0, 509600.0, 509983.0, 510373.0, 510701.0, 24480.0, 24987.375315617253, 45965.850853727585, 48399.51600484091, 48644.27033594428, 48613.5138648609, 52623.94752105013, 53073.203901942274, 53075.0, 53432.465675344305, 40846.9788255296, 43457.34813977856, 43708.12583748244, 43982.56017439785, 44828.32757508705, 43229.56770432255, 43460.913477163325, 43752.78123609489, 44340.778296108314, 44956.0, 41439.37840932328, 42227.57772422359, 42390.57609423866, 42455.0, 42463.150736985706, 35819.64180358163, 36991.630083698816, 37733.81133094317, 37844.810775945945, 37904.62095379011, 23266.418339541648, 27412.72587274102, 27748.86125569359, 27883.44233115367, 27922.581161283004], "value": 21458.153753284274, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [321.7972677213355, 380.19398874386286, 384.96920246380284, 388.50465656288213, 409.2183928696189, 17806.020668863206, 17951.0, 20645.793542064574, 21402.46493837655, 21578.784212157872, 20941.0, 21102.683459748117, 21621.35135945924, 21951.890240548815, 22281.331560053182, 4949.8020079196785, 5364.758585863636, 6224.533160012995, 6275.68621568922, 6304.085907543404, 6240.344763799803, 6282.434580887719, 6293.087502312162, 6294.3705629437145, 6297.622142671432, 6064.787732429366, 6159.0, 6221.813345599639, 6229.439350458458, 6239.65681887496, 5696.658200507983, 5944.316403613553, 6186.505079593621, 6241.687915604201, 6245.531585131111, 5352.571794256489, 5362.329708786402, 5363.275957745733, 5365.0, 5368.1679339702405, 26764.661766911577, 27329.0, 27388.0, 27400.90396384162, 27620.723792762215, 2303.4586872085047, 2311.6707892961613, 2518.8866501007315, 2673.919782406531, 2821.463921854841, 15844.841551584452, 16160.353585856552, 16200.918995404947, 16378.344866205338, 16441.1779411029, 1896.7154926761095, 1924.114907142716, 1927.9756255931215, 1992.9701054484194, 2000.21991423345, 111874.0, 112969.0, 113202.99999999917, 114531.42734286358, 115284.0, 10755.83866242007, 11024.779504410028, 11102.333859968428, 11361.54553817838, 11380.374079425546, 14273.0, 14309.427622895177, 14311.57065288043, 14311.78532322016, 14320.785188222186, 8254.917450825415, 8391.328693704489, 8398.202170793766, 8501.914980850235, 8517.872231916526, 8155.306798922158, 8174.427790054639, 8176.754697359089, 8320.625571849281, 8337.374696897758, 5575.275214222206, 6741.191057073084, 6850.623215723083, 6883.242843287235, 6913.89629155563, 1577.3217516468028, 1863.8136186381525, 1874.2690350763214, 1900.4393703857395, 1905.8380037696675, 788.5308241596241, 971.0774763974252, 984.9414723228343, 1016.6645007147623, 1084.3493903657743, 17613.295468181386, 21603.56792864134, 23212.60724356544, 23428.882855585613, 23501.41246468852, 1010.7725761703558, 1010.8231059564547, 1027.8715160604925, 1045.289203341735, 1047.4134484688445, 11446.599369022044, 12267.93866030682, 12377.0, 12493.937530312473, 12523.0, 644290.0, 646977.0, 654556.0, 658695.0, 659766.0, 95229.52385238168, 128018.35990820173, 128124.78135276405, 132073.0, 133216.335673286, 1043.5773511727762, 1059.7191744187796, 1081.3728037738092, 1082.4046774274275, 1082.4479515447179, 19896.0, 20304.89847550812, 20442.28452004173, 20535.0, 20566.897165514674, 53201.73399133134, 53677.73161134325, 53805.73097134489, 53817.730911346756, 54828.0, 74946.62526687332, 75962.62018689871, 76435.0, 76842.84735728857, 77787.22212778026, 6087.4521293083835, 7158.498905076594, 7364.079490063742, 7436.107667079985, 7656.3874890007555, 9044.638214471348, 13115.540956066492, 13176.275304858325, 13186.604401867959, 13589.45642174302, 11281.132591873542, 11511.30932144074, 11783.823242651539, 11791.764164716486, 11880.287182769061, 7816.53100813953, 9552.567114932815, 10431.791364172826, 10893.673189804318, 11411.486483108114, 11195.216334856483, 11572.59495917639, 11747.647570572897, 11871.584494542649, 11998.40007999614, 7226.819329516804, 7259.891365498812, 7439.144498382755, 7597.734079307198, 7644.235576442311, 9492.193163581172, 10753.0, 10864.859189785275, 11291.774164516828, 11593.536258549564], "value": 9913.533209339852, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1402.8356464134756, 1567.192895658736, 1600.4158482154014, 1821.2805941653048, 1959.4905324615604, 7325.230850760667, 8833.20501154896, 9075.319351048673, 9352.392094513852, 9379.0, 9255.305852061088, 9348.39235449697, 9351.345405821578, 9365.11031452011, 9375.765605859857, 2444.5477586646484, 2474.307193985687, 2474.604063349864, 2477.306354220821, 2477.764612361832, 2407.2296865003204, 2491.9252422427357, 2493.6384224287467, 2494.4761600064007, 2497.5504409206337, 2143.9356819295367, 2423.7881059470265, 2430.0158435833514, 2464.223769512607, 2480.913168039119, 2421.067888862783, 2434.1237154624323, 2444.6821913151266, 2445.2053082748, 2456.2017344362976, 2405.6271277951946, 2420.1408499982604, 2424.3454267347893, 2430.052279610953, 2435.038159926819, 9310.627574896997, 9354.625814967394, 9433.481158536279, 9456.479893605849, 9457.33798634096, 5494.230807686927, 5687.630304030225, 5692.57305702074, 5747.166660834156, 5757.68332741699, 3772.2266935278476, 3791.9241615167816, 3817.141143242776, 3857.8842634721004, 3858.614138586147, 1130.2992144870234, 1130.7568872692411, 1131.6774719205068, 1148.402830528129, 1151.424287856072, 12503.0, 12540.8118878216, 12617.684557886034, 12618.305993170372, 12643.936780316131, 4442.111577684412, 4565.360849481075, 4674.859754207379, 4757.3577567028005, 4758.048390321949, 9706.272029597809, 9708.271879609058, 9714.659986900424, 9716.902830971741, 9719.805603887882, 5408.080626293539, 5413.675179489243, 5421.132618780976, 5421.295231619864, 5422.0511410503, 4528.682992190581, 4669.112868554964, 4820.4456487503685, 4841.830535931225, 5080.110980578384, 3933.0, 3971.702122340836, 4024.2756303865, 4065.59344065597, 4069.8168582413864, 1033.2405681823852, 1187.0681515010674, 1199.1006744941294, 1199.382318106176, 1209.2502648358075, 877.8463768840427, 948.7343543807744, 953.1993125774383, 969.7672558585889, 975.8487434447673, 6104.145419641254, 6140.631562106288, 6161.106639537242, 6280.246370435577, 6358.1734374531015, 369.6396013886493, 438.0516182464991, 445.6813378434435, 448.21785983459074, 452.30119465426, 3404.761666683358, 4121.9587804122175, 4151.543330233671, 4161.52142503616, 4260.147970405931, 11101.722456938642, 11640.185187036996, 11648.184627076193, 11652.475638596283, 11671.241369310968, 11577.421128943519, 11653.708657283636, 11656.0, 11658.06735461178, 11663.066954643607, 7939.722109726247, 8706.564671766386, 8760.4305720128, 8788.2529984952, 8797.912020879709, 5978.940210597838, 6036.0644100164545, 6063.302720187235, 6137.324894261538, 6284.183056202664, 8769.824603507766, 10371.222158338305, 10762.246642734934, 10767.246292759432, 10989.0, 9829.606815727577, 9964.900350996397, 10516.631917882838, 10813.729656758644, 11022.614208502984, 7805.14143444232, 8055.677772889018, 8157.510549367057, 8165.632546535539, 8169.387295952709, 8731.607077681647, 8731.825363492568, 8825.293976481738, 8833.205011548991, 8843.425177363451, 7809.023872015998, 7928.445008849556, 7969.561674107747, 8054.0, 8112.553809540532, 7712.498687585514, 7778.416618753503, 7813.882791758015, 7835.451518393657, 7965.044194696674, 7357.301056399633, 7509.324160825552, 7512.474126811071, 7513.286237807618, 7520.661570229462, 5193.818216362409, 5230.450802665818, 5239.29269548606, 5335.306410166653, 5471.151971444432, 4285.978570107254, 5140.997505486544, 5239.528442440199, 5323.893522129459, 5365.302510673588], "value": 4675.898317359658, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [273.3862478735239, 298.13540731877555, 304.9573059771632, 308.3355369179419, 311.2669662943766, 5019.623528235388, 5128.794848206072, 5132.4867513248655, 5160.406553246377, 5185.974070129644, 4603.7237765734, 4999.375078115236, 5065.544101030907, 5122.6926384416965, 5123.718195499246, 3954.7231693781446, 3972.3842804365368, 3973.3642617181185, 3973.543042550115, 3988.6410223079915, 3458.8270586470703, 3706.555213374399, 3986.2027594481074, 3986.2625414298304, 3993.3011722948513, 3907.98046009771, 3913.5303763548413, 3917.315554311645, 3952.3281042222893, 3962.5641179470235, 3892.065904183004, 3905.9804700976456, 3906.4726261954697, 3919.1377896862928, 3939.3893946438347, 2785.470760555488, 3395.862386100659, 3396.4735466002808, 3400.693937545608, 3401.234722187513, 4283.764392958386, 4788.490976374572, 5047.671901326402, 5056.62075344347, 5248.373004368658, 4482.341533632577, 4486.4840543337605, 4496.685232033759, 4510.594046535794, 4516.841910533149, 5444.727763611803, 5456.372517160537, 5473.917891231635, 5473.932583146288, 5476.4249753775675, 3312.7681062325646, 3470.022087410152, 3703.2223233121076, 3763.0, 3777.9398687063567, 4617.2612382018715, 5558.666480011172, 5596.692181929992, 5615.410381909923, 5616.9157462638095, 3470.6182319944787, 3677.485152078711, 3721.627837216311, 3731.1231860512758, 3732.309522738302, 3812.7331086823656, 3817.4655548223272, 3821.3885778275344, 3822.235552889433, 3838.213166300902, 3668.559772827278, 4277.786110694453, 4367.563243675607, 4396.626286765597, 4422.933655995163, 4386.8025938832825, 5243.872567397952, 5340.813071542478, 5349.679019258857, 5351.474829673524, 1233.660743295583, 1263.7977923532192, 1269.774667445919, 1273.5924504158581, 1282.7306265684124, 732.0008188822219, 823.0452674897091, 850.6257246811507, 853.38129855854, 882.8455020371409, 4278.593533614302, 5173.715445650525, 5175.275461435402, 5186.585073194211, 5284.762185701653, 4407.581279778416, 4956.950430495649, 5442.727863606804, 5570.220169176318, 5617.848341090067, 5110.28456016158, 5116.002379535955, 5121.436641969381, 5130.948690513122, 5141.357330333708, 2899.884004639833, 2913.577531257998, 2915.7375836174847, 2921.9853900730786, 2943.7939344245697, 5521.613487055948, 5732.369439361667, 5735.770569177186, 5744.454276843693, 5817.992792486585, 4910.435299940481, 5661.094224923992, 5661.659620823733, 5668.149777533403, 5688.23208866806, 5468.277492589821, 5515.338159420895, 5696.088625819849, 5763.394843541451, 5817.38917413674, 4939.234418664969, 5238.333166783344, 5545.556355491632, 5574.86062848432, 5598.692071936082, 5132.255822905583, 5481.397046324981, 5487.368952570346, 5498.917516237179, 5502.504774570308, 5044.695724300589, 5056.533605254435, 5535.446455354593, 5579.523438592306, 5744.281964754406, 3300.851461684278, 3330.0176447948397, 3763.4542991266662, 3786.091338078896, 3793.9430908536947, 5042.571381432619, 5483.890322193454, 5516.834494965157, 5519.39286678473, 5586.921547270434, 4594.2419500782, 5092.784638682185, 5395.973020134874, 5420.807422367073, 5423.810166644306, 4374.650027997816, 4566.589006989387, 5289.693941286696, 5572.052751032254, 5576.944230557642, 4829.764058081024, 5293.550048245942, 5383.40782513931, 5412.0, 5473.972630136824, 4688.812447502061, 5487.890242195213, 5500.394956554695, 5546.694931778629, 5591.440855914376, 4588.931166032579, 5464.617476776588, 5472.962505809314, 5473.644213126293, 5485.890282194254], "value": 3972.554585830759, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [750.2460027672192, 768.7885831396366, 801.6272433318508, 809.2029351089172, 879.1604018162656, 16311.0, 17125.82874171258, 17204.967701937894, 17252.309907603696, 17259.0, 15315.693686126271, 15437.768433473479, 15515.689686206297, 15520.30158642861, 15883.285252163652, 878.2929741558044, 912.1015799437548, 914.2503147419086, 915.3501014279869, 916.8853893263342, 737.1964558631091, 760.6044856674525, 762.9427792915553, 917.9908200918005, 923.6536298887917, 775.6160700453255, 802.4743792815685, 806.6571707024491, 973.5570315506427, 979.0894468144622, 966.8888077870994, 969.1181025267008, 969.2536746705033, 972.2999440402899, 972.3048020665187, 710.9857802843966, 714.9821254468628, 715.6064164709389, 716.0977168767339, 717.6626985316892, 15711.842881571267, 15745.291461884128, 15769.211539422982, 15770.0, 15788.763168552481, 14544.981851270415, 14638.560843174615, 14674.853251467455, 14711.705765884622, 14732.3370448329, 12996.090273680846, 13191.802122968164, 13250.112348329678, 13416.46334146633, 13678.384472698654, 3985.481887354654, 4616.538346165356, 4691.929621055687, 4738.1708201064675, 4843.612510999112, 105057.8988420235, 108869.0, 109106.45446772715, 131273.0, 136642.0, 11042.061424778823, 11187.160962927814, 11572.56182921148, 11808.291502509877, 11840.230385025117, 22149.44626384321, 22456.0, 22464.887675561517, 22477.213297534836, 22488.662670059963, 7285.7814265572115, 7899.170587088388, 8118.553479558681, 8218.21926916942, 8466.915330846736, 4703.905921881543, 4793.592544633675, 4796.736179510091, 4797.592204662573, 5024.799008039638, 3748.475213470116, 3900.5124359455067, 3907.5506316773935, 3920.5295364556437, 4052.392141178788, 634.2294112653149, 750.0474397515126, 758.6623952341265, 759.9544027358377, 772.5017363800317, 612.2836281550597, 631.4664108828033, 660.0495286787011, 669.621663759974, 710.3251910684767, 9061.320400969953, 10068.345557538736, 10130.138938190335, 10407.271490995558, 10449.477526123816, 583.6381443505054, 626.4330780643525, 681.6898311268361, 686.3136863136863, 718.0736849464133, 4577.542245775396, 4968.503149685075, 4970.3538539990295, 4970.652054356233, 5002.424721157041, 122547.0, 147447.0, 177293.0, 180100.0, 184639.15360846487, 141132.0, 150863.2456837709, 152598.0, 153360.0, 156990.0, 107001.0, 127518.0, 128416.3579182098, 130012.0, 132228.33885830702, 7898.0, 8875.955620221857, 9162.770930726785, 9595.664151754934, 9622.470764107762, 70526.94209586758, 71261.0, 71380.0, 71831.64084179755, 73357.63321183574, 103044.93910121906, 107416.0, 107599.46200269261, 110402.89597103927, 111729.0, 12139.696507587381, 12242.938785306016, 12411.565595204125, 12502.687432814253, 12641.747165056831, 13712.17726936387, 13909.513167039106, 13954.923130503843, 14143.717125657635, 14194.219317937612, 14135.64660883486, 14204.715905681622, 14278.928605356907, 14402.42390304418, 14441.422343106158, 13823.032387732763, 14014.859851401356, 14078.788818167532, 14932.0, 15258.31337589789, 12916.514600821027, 13668.111572747739, 14664.0, 14722.705545889237, 14809.481668141563, 11298.0, 11865.347405892759, 12271.69320766988, 12283.877161228273, 12479.251244925334, 10554.947225263824, 11904.393680124742, 11968.880311196777, 12123.272603643809, 12212.633620991384], "value": 8344.704368934425, "unit": "score"}], "name": "dromaeo_css", "value": 7602.517417915768, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 113.0, 112.0, 112.0, 111.0, 121.0, 165.0, 160.0, 113.0, 113.0], "value": 123.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 136.0, 109.0, 142.0, 107.0, 108.0, 110.0, 102.0, 140.0, 109.0], "value": 123.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 182.0, 183.0, 183.0, 185.0, 182.0, 182.0, 185.0, 181.0], "value": 183.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 62.0, 89.0, 62.0, 59.0, 59.0, 58.0, 83.0, 58.0], "value": 67.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 72.0, 95.0, 70.0, 68.0, 70.0, 91.0, 67.0, 70.0, 114.0], "value": 80.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 88.0, 86.0, 87.0, 85.0, 79.0, 130.0, 134.0, 129.0], "value": 99.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 167.0, 96.0, 98.0, 97.0, 95.0, 97.0, 97.0, 96.0, 128.0], "value": 108.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 128.0, 140.0, 131.0, 84.0, 85.0, 85.0, 92.0, 86.0, 84.0], "value": 100.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 52.0, 53.0, 52.0, 56.0, 54.0, 55.0, 56.0, 56.0, 55.0], "value": 54.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 70.0, 75.0, 71.0, 71.0, 71.0, 68.0, 70.0, 69.0, 70.0], "value": 69.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 83.0, 84.0, 84.0, 83.0, 88.0, 88.0, 99.0, 87.0], "value": 86.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 149.0, 126.0, 135.0, 134.0, 134.0, 135.0, 134.0, 148.0, 150.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 160.0, 160.0, 163.0, 165.0, 161.0, 161.0, 159.0, 158.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 67.0, 66.0, 66.0, 65.0, 65.0, 63.0, 64.0, 65.0, 67.0], "value": 65.3, "unit": "score"}], "name": "kraken", "value": 1461.3999999999999, "alertThreshold": 2.0}]} 06:13:30 INFO - Return code: 0 06:13:30 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 06:13:30 INFO - # TBPL SUCCESS # 06:13:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:13:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:13:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:13:30 INFO - 2016-11-18 06:13:30.223 screenresolution[1924:17399] starting screenresolution argv=screenresolution get 06:13:30 INFO - 2016-11-18 06:13:30.225 screenresolution[1924:17399] Display 0: 1600x1200x32@60 06:13:30 INFO - 2016-11-18 06:13:30.231 screenresolution[1925:17401] starting screenresolution argv=screenresolution list 06:13:30 INFO - Available Modes on Display 0 06:13:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:13:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:13:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:13:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:13:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:13:30 INFO - Intel Iris: 06:13:30 INFO - Chipset Model: Intel Iris 06:13:30 INFO - Type: GPU 06:13:30 INFO - Bus: Built-In 06:13:30 INFO - VRAM (Dynamic, Max): 1536 MB 06:13:30 INFO - Vendor: Intel (0x8086) 06:13:30 INFO - Device ID: 0x0a2e 06:13:30 INFO - Revision ID: 0x0009 06:13:30 INFO - Displays: 06:13:30 INFO - Display: 06:13:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:13:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:13:30 INFO - Display Serial Number: 1600x1200 60 06:13:30 INFO - Main Display: Yes 06:13:30 INFO - Mirror: Off 06:13:30 INFO - Online: Yes 06:13:30 INFO - Rotation: Supported 06:13:30 INFO - Return code: 0 06:13:30 INFO - Running post-action listener: _resource_record_post_action 06:13:30 INFO - [mozharness: 2016-11-18 14:13:30.466271Z] Finished run-tests step (success) 06:13:30 INFO - Running post-run listener: _resource_record_post_run 06:13:30 INFO - Total resource usage - Wall time: 1197s; CPU: 53.0%; Read bytes: 1503232; Write bytes: 493964800; Read time: 9; Write time: 1566 06:13:30 INFO - TinderboxPrint: CPU usage
53.1% 06:13:30 INFO - TinderboxPrint: I/O read bytes / time
1,503,232 / 9 06:13:30 INFO - TinderboxPrint: I/O write bytes / time
493,964,800 / 1,566 06:13:30 INFO - TinderboxPrint: CPU idle
2,245.7 (46.9%) 06:13:30 INFO - TinderboxPrint: CPU system
958.8 (20.0%) 06:13:30 INFO - TinderboxPrint: CPU user
1,585.1 (33.1%) 06:13:30 INFO - TinderboxPrint: Swap in / out
196,128,768 / 0 06:13:30 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 186864128; Write bytes: 185774080; Read time: 17386; Write time: 401 06:13:30 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 1503232; Write bytes: 298028544; Read time: 9; Write time: 1131 06:13:30 INFO - Running post-run listener: _upload_blobber_files 06:13:30 INFO - Blob upload gear active. 06:13:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:13:30 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 06:13:30 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'] 06:13:30 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 06:13:31 INFO - (blobuploader) - INFO - Open directory for files ... 06:13:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 06:13:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 06:13:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:32 INFO - (blobuploader) - INFO - Done attempting. 06:13:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 06:13:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:34 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 06:13:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:34 INFO - (blobuploader) - INFO - Done attempting. 06:13:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 06:13:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:13:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:13:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 06:13:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:13:36 INFO - (blobuploader) - INFO - Done attempting. 06:13:36 INFO - (blobuploader) - INFO - Iteration through files over. 06:13:36 INFO - Return code: 0 06:13:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:13:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:13:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/38326a0426288ffeefb43558da73ee3b3d458a22be892438fcbcddb3b97f8d7bbd9994a5d441ee4b49bc9dd0363d4bf2ec6815439e72853f867e8a25f7ef0bdd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f3527dc3f0932ae555c7c9f6b45039e255ddef31a281c8b9cfc975aab83e05d93c3205114359e81f3e7c3471b78bc457e37e23711d12b59e161aed0ac4d1c4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/420d845390c1944c918b218564c0185b53e6bd5723e55993b03e982a3c364341216e6ba55e3cd2375122517388894df8f4606d3ad6efa66e1b83d99fa24f6aac"} 06:13:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:13:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:13:36 INFO - Contents: 06:13:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/38326a0426288ffeefb43558da73ee3b3d458a22be892438fcbcddb3b97f8d7bbd9994a5d441ee4b49bc9dd0363d4bf2ec6815439e72853f867e8a25f7ef0bdd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f3527dc3f0932ae555c7c9f6b45039e255ddef31a281c8b9cfc975aab83e05d93c3205114359e81f3e7c3471b78bc457e37e23711d12b59e161aed0ac4d1c4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/420d845390c1944c918b218564c0185b53e6bd5723e55993b03e982a3c364341216e6ba55e3cd2375122517388894df8f4606d3ad6efa66e1b83d99fa24f6aac"} 06:13:36 INFO - Running post-run listener: copy_logs_to_upload_dir 06:13:36 INFO - Copying logs to upload dir... 06:13:36 INFO - mkdir: /builds/slave/test/build/upload/logs 06:13:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.695116 ========= master_lag: 2.38 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 58 secs) (at 2016-11-18 06:13:38.931228) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 06:13:38.935168) ========= 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.CT9cLCvQaT/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.mqJYdtI8GW/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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/38326a0426288ffeefb43558da73ee3b3d458a22be892438fcbcddb3b97f8d7bbd9994a5d441ee4b49bc9dd0363d4bf2ec6815439e72853f867e8a25f7ef0bdd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f3527dc3f0932ae555c7c9f6b45039e255ddef31a281c8b9cfc975aab83e05d93c3205114359e81f3e7c3471b78bc457e37e23711d12b59e161aed0ac4d1c4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/420d845390c1944c918b218564c0185b53e6bd5723e55993b03e982a3c364341216e6ba55e3cd2375122517388894df8f4606d3ad6efa66e1b83d99fa24f6aac"} build_url:https://queue.taskcluster.net/v1/task/Zgfp4fGVQmKCJ5O3_cKp9A/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011265 build_url: 'https://queue.taskcluster.net/v1/task/Zgfp4fGVQmKCJ5O3_cKp9A/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/38326a0426288ffeefb43558da73ee3b3d458a22be892438fcbcddb3b97f8d7bbd9994a5d441ee4b49bc9dd0363d4bf2ec6815439e72853f867e8a25f7ef0bdd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7f3527dc3f0932ae555c7c9f6b45039e255ddef31a281c8b9cfc975aab83e05d93c3205114359e81f3e7c3471b78bc457e37e23711d12b59e161aed0ac4d1c4f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/420d845390c1944c918b218564c0185b53e6bd5723e55993b03e982a3c364341216e6ba55e3cd2375122517388894df8f4606d3ad6efa66e1b83d99fa24f6aac"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-18 06:13:38.977336) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 06:13:38.978083) ========= 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.CT9cLCvQaT/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.mqJYdtI8GW/Listeners TMPDIR=/var/folders/dd/py29nth97xxbf83ghv9hvnzr00000w/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.004714 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-18 06:13:39.029129) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 06:13:39.029521) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-18 06:13:39.030104) ========= ========= Total master_lag: 2.53 =========