builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0017 starttime: 1467786967.4 results: success (0) buildid: 20160705205623 builduid: c4a51a39c70c4e73aafe0e9496136fe5 revision: cec1ab33c0d6bdc2638e0e76566a5009f033d949 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 23:36:07.399597) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 23:36:07.400029) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 23:36:07.400304) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 23:36:07.425490) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 23:36:07.425776) ========= 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.FXuOHCwbOY/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.00zXJruWcl/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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-07-05 23:36:07-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2016-07-05 23:36:08 (159 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.594488 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 23:36:08.040764) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 23:36:08.041057) ========= 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.FXuOHCwbOY/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.00zXJruWcl/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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.020512 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 23:36:08.088376) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 23:36:08.088674) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev cec1ab33c0d6bdc2638e0e76566a5009f033d949 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev cec1ab33c0d6bdc2638e0e76566a5009f033d949 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FXuOHCwbOY/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.00zXJruWcl/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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-07-05 23:36:08,162 truncating revision to first 12 chars 2016-07-05 23:36:08,162 Setting DEBUG logging. 2016-07-05 23:36:08,162 attempt 1/10 2016-07-05 23:36:08,163 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/cec1ab33c0d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 23:36:08,801 unpacking tar archive at: fx-team-cec1ab33c0d6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.898567 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 23:36:09.007730) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 23:36:09.008017) ========= script_repo_revision: cec1ab33c0d6bdc2638e0e76566a5009f033d949 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 23:36:09.008397) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 23:36:09.008659) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 23:36:09.028184) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 11 secs) (at 2016-07-05 23:36:09.028469) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.FXuOHCwbOY/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.00zXJruWcl/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 23:36:09 INFO - MultiFileLogger online at 20160705 23:36:09 in /builds/slave/test 23:36:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:36:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:36:09 INFO - {'append_to_log': False, 23:36:09 INFO - 'base_work_dir': '/builds/slave/test', 23:36:09 INFO - 'blob_upload_branch': 'Fx-Team', 23:36:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:36:09 INFO - 'branch': 'Fx-Team', 23:36:09 INFO - 'buildbot_json_path': 'buildprops.json', 23:36:09 INFO - 'config_files': ('talos/mac_config.py',), 23:36:09 INFO - 'default_actions': ('clobber', 23:36:09 INFO - 'read-buildbot-config', 23:36:09 INFO - 'download-and-extract', 23:36:09 INFO - 'populate-webroot', 23:36:09 INFO - 'create-virtualenv', 23:36:09 INFO - 'install', 23:36:09 INFO - 'run-tests'), 23:36:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:36:09 INFO - 'download_minidump_stackwalk': True, 23:36:09 INFO - 'download_symbols': 'ondemand', 23:36:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:36:09 INFO - 'tooltool.py': '/tools/tooltool.py', 23:36:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:36:09 INFO - '/tools/misc-python/virtualenv.py')}, 23:36:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:36:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:36:09 INFO - 'installer_path': 'installer.exe', 23:36:09 INFO - 'log_level': 'info', 23:36:09 INFO - 'log_name': 'talos', 23:36:09 INFO - 'log_to_console': True, 23:36:09 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:36:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:36:09 INFO - 'opt_config_files': (), 23:36:09 INFO - 'pip_index': False, 23:36:09 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:36:09 INFO - 'cmd': ('bash', 23:36:09 INFO - '-c', 23:36:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:36:09 INFO - 'enabled': True, 23:36:09 INFO - 'halt_on_failure': False, 23:36:09 INFO - 'name': 'check_screen_resolution'},), 23:36:09 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:36:09 INFO - 'cmd': ('bash', 23:36:09 INFO - '-c', 23:36:09 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:36:09 INFO - 'enabled': True, 23:36:09 INFO - 'halt_on_failure': False, 23:36:09 INFO - 'name': 'check_screen_resolution'},), 23:36:09 INFO - 'run_cmd_checks_enabled': True, 23:36:09 INFO - 'sps_profile': False, 23:36:09 INFO - 'sps_profile_interval': 0, 23:36:09 INFO - 'suite': 'dromaeojs-e10s', 23:36:09 INFO - 'system_bits': '32', 23:36:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:36:09 INFO - 'title': 't-yosemite-r7-0017', 23:36:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:36:09 INFO - 'use_talos_json': True, 23:36:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:36:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:36:09 INFO - 'work_dir': 'build'} 23:36:09 INFO - ##### 23:36:09 INFO - ##### Running clobber step. 23:36:09 INFO - ##### 23:36:09 INFO - Running pre-action listener: _resource_record_pre_action 23:36:09 INFO - Running main action method: clobber 23:36:09 INFO - rmtree: /builds/slave/test/build 23:36:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:36:10 INFO - Running post-action listener: _resource_record_post_action 23:36:10 INFO - ##### 23:36:10 INFO - ##### Finished clobber step (success) 23:36:10 INFO - ##### 23:36:10 INFO - ##### 23:36:10 INFO - ##### Running read-buildbot-config step. 23:36:10 INFO - ##### 23:36:10 INFO - Running pre-action listener: _resource_record_pre_action 23:36:10 INFO - Running main action method: read_buildbot_config 23:36:10 INFO - Using buildbot properties: 23:36:10 INFO - { 23:36:10 INFO - "project": "", 23:36:10 INFO - "product": "firefox", 23:36:10 INFO - "script_repo_revision": "production", 23:36:10 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 23:36:10 INFO - "repository": "", 23:36:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 23:36:10 INFO - "buildid": "20160705205623", 23:36:10 INFO - "pgo_build": "False", 23:36:10 INFO - "basedir": "/builds/slave/test", 23:36:10 INFO - "buildnumber": 710, 23:36:10 INFO - "slavename": "t-yosemite-r7-0017", 23:36:10 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 23:36:10 INFO - "platform": "yosemite_r7", 23:36:10 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 23:36:10 INFO - "branch": "fx-team", 23:36:10 INFO - "repo_path": "integration/fx-team", 23:36:10 INFO - "revision": "cec1ab33c0d6bdc2638e0e76566a5009f033d949", 23:36:10 INFO - "stage_platform": "macosx64", 23:36:10 INFO - "builduid": "c4a51a39c70c4e73aafe0e9496136fe5", 23:36:10 INFO - "slavebuilddir": "test" 23:36:10 INFO - } 23:36:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg. 23:36:10 INFO - Running post-action listener: _resource_record_post_action 23:36:10 INFO - ##### 23:36:10 INFO - ##### Finished read-buildbot-config step (success) 23:36:10 INFO - ##### 23:36:10 INFO - ##### 23:36:10 INFO - ##### Running download-and-extract step. 23:36:10 INFO - ##### 23:36:10 INFO - Running pre-action listener: _resource_record_pre_action 23:36:10 INFO - Running main action method: download_and_extract 23:36:10 INFO - mkdir: /builds/slave/test/build/tests 23:36: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:36:10 INFO - https://queue.taskcluster.net/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 23:36:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 23:36:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json 23:36:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 23:36:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #1 23:36:40 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json: timed out 23:36:40 INFO - retry: attempt #1 caught exception: timed out 23:36:40 INFO - retry: Failed, sleeping 30 seconds before retrying 23:37:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json'}, attempt #2 23:37:17 INFO - Downloaded 1199 bytes. 23:37:17 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.mac.test_packages.json 23:37:17 INFO - Using the following test package requirements: 23:37:17 INFO - {u'common': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 23:37:17 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 23:37:17 INFO - u'firefox-50.0a1.en-US.mac.cppunittest.tests.zip'], 23:37:17 INFO - u'gtest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 23:37:17 INFO - u'firefox-50.0a1.en-US.mac.gtest.tests.zip'], 23:37:17 INFO - u'jittest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 23:37:17 INFO - u'jsshell-mac.zip'], 23:37:17 INFO - u'mochitest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 23:37:17 INFO - u'firefox-50.0a1.en-US.mac.mochitest.tests.zip'], 23:37:17 INFO - u'mozbase': [u'firefox-50.0a1.en-US.mac.common.tests.zip'], 23:37:17 INFO - u'reftest': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 23:37:17 INFO - u'firefox-50.0a1.en-US.mac.reftest.tests.zip'], 23:37:17 INFO - u'talos': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 23:37:17 INFO - u'firefox-50.0a1.en-US.mac.talos.tests.zip'], 23:37:17 INFO - u'web-platform': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 23:37:17 INFO - u'firefox-50.0a1.en-US.mac.web-platform.tests.zip'], 23:37:17 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.mac.common.tests.zip', 23:37:17 INFO - u'firefox-50.0a1.en-US.mac.xpcshell.tests.zip']} 23:37:17 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:37: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:37:17 INFO - https://queue.taskcluster.net/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:37:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 23:37:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 23:37:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 23:37:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:37:18 INFO - Downloaded 18802536 bytes. 23:37:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:37:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 23:37:21 INFO - Return code: 0 23:37:21 INFO - Downloading packages: [u'firefox-50.0a1.en-US.mac.common.tests.zip', u'firefox-50.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 23:37:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:37:21 INFO - https://queue.taskcluster.net/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 23:37:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 23:37:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip 23:37:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip 23:37:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:37:23 INFO - Downloaded 18802536 bytes. 23:37:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:37:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 23:37:26 INFO - Return code: 0 23:37:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:37:26 INFO - https://queue.taskcluster.net/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 23:37:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 23:37:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip 23:37:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip 23:37:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip'}, attempt #1 23:37:28 INFO - Downloaded 14403333 bytes. 23:37:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 23:37:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 23:37:28 INFO - Return code: 0 23:37:28 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:37:28 INFO - https://queue.taskcluster.net/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 23:37:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 23:37:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 23:37:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg 23:37:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg'}, attempt #1 23:37:34 INFO - Downloaded 112488386 bytes. 23:37:34 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 23:37:34 INFO - mkdir: /builds/slave/test/properties 23:37:34 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:37:34 INFO - Writing to file /builds/slave/test/properties/build_url 23:37:34 INFO - Contents: 23:37:34 INFO - build_url:https://queue.taskcluster.net/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg 23:37:35 INFO - Running post-action listener: _resource_record_post_action 23:37:35 INFO - Running post-action listener: set_extra_try_arguments 23:37:35 INFO - ##### 23:37:35 INFO - ##### Finished download-and-extract step (success) 23:37:35 INFO - ##### 23:37:35 INFO - ##### 23:37:35 INFO - ##### Running populate-webroot step. 23:37:35 INFO - ##### 23:37:35 INFO - Running pre-action listener: _resource_record_pre_action 23:37:35 INFO - Running main action method: populate_webroot 23:37:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:37:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:37:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:37:35 INFO - '--tppagecycles', 23:37:35 INFO - '7'], 23:37:35 INFO - 'tests': ['tsvgm']}}, 23:37:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:37:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:37:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:37:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:37:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:37:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:37:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:37:35 INFO - 'talos_options': ['--disable-e10s'], 23:37:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:37:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:37:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:37:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:37:35 INFO - 'talos_options': ['--disable-e10s'], 23:37:35 INFO - 'tests': ['damp', 'tps']}, 23:37:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:37:35 INFO - 'tests': ['damp', 'tps']}, 23:37:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:37:35 INFO - 'tests': ['dromaeo_dom']}, 23:37:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:37:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:37:35 INFO - 'tests': ['basic_compositor_video']}, 23:37:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:37:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:37:35 INFO - 'tests': ['a11yr', 23:37:35 INFO - 'ts_paint', 23:37:35 INFO - 'tpaint', 23:37:35 INFO - 'sessionrestore', 23:37:35 INFO - 'sessionrestore_no_auto_restore', 23:37:35 INFO - 'tabpaint']}, 23:37:35 INFO - 'other-e10s': {'tests': ['a11yr', 23:37:35 INFO - 'ts_paint', 23:37:35 INFO - 'tpaint', 23:37:35 INFO - 'sessionrestore', 23:37:35 INFO - 'sessionrestore_no_auto_restore', 23:37:35 INFO - 'tabpaint']}, 23:37:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:37:35 INFO - 'ts_paint', 23:37:35 INFO - 'tpaint', 23:37:35 INFO - 'sessionrestore', 23:37:35 INFO - 'sessionrestore_no_auto_restore', 23:37:35 INFO - 'tabpaint']}, 23:37:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:37:35 INFO - 'ts_paint', 23:37:35 INFO - 'tpaint', 23:37:35 INFO - 'sessionrestore', 23:37:35 INFO - 'sessionrestore_no_auto_restore', 23:37:35 INFO - 'tabpaint']}, 23:37:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:37:35 INFO - 'tests': ['a11yr', 23:37:35 INFO - 'ts_paint', 23:37:35 INFO - 'tpaint', 23:37:35 INFO - 'sessionrestore', 23:37:35 INFO - 'sessionrestore_no_auto_restore', 23:37:35 INFO - 'tabpaint']}, 23:37:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:37:35 INFO - 'tests': ['a11yr', 23:37:35 INFO - 'ts_paint', 23:37:35 INFO - 'tpaint', 23:37:35 INFO - 'sessionrestore', 23:37:35 INFO - 'sessionrestore_no_auto_restore', 23:37:35 INFO - 'tabpaint']}, 23:37:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:37:35 INFO - 'tests': ['tsvgx', 23:37:35 INFO - 'tsvgr_opacity', 23:37:35 INFO - 'tart', 23:37:35 INFO - 'tscrollx', 23:37:35 INFO - 'cart']}, 23:37:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:37:35 INFO - 'tsvgr_opacity', 23:37:35 INFO - 'tart', 23:37:35 INFO - 'tscrollx', 23:37:35 INFO - 'cart']}, 23:37:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:37:35 INFO - 'talos_options': ['--disable-e10s'], 23:37:35 INFO - 'tests': ['tp5o']}, 23:37:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:37:35 INFO - 'tests': ['tp5o']}, 23:37:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:37:35 INFO - 'talos_options': ['--disable-e10s', 23:37:35 INFO - '--xperf_path', 23:37:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:37:35 INFO - 'tests': ['tp5n']}, 23:37:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:37:35 INFO - 'talos_options': ['--xperf_path', 23:37:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:37:35 INFO - 'tests': ['tp5n']}}, 23:37:35 INFO - 'talos.zip': {'path': '', 23:37:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:37:35 INFO - Running post-action listener: _resource_record_post_action 23:37:35 INFO - ##### 23:37:35 INFO - ##### Finished populate-webroot step (success) 23:37:35 INFO - ##### 23:37:35 INFO - ##### 23:37:35 INFO - ##### Running create-virtualenv step. 23:37:35 INFO - ##### 23:37:35 INFO - Running pre-action listener: _resource_record_pre_action 23:37:35 INFO - Running main action method: create_virtualenv 23:37:35 INFO - Creating virtualenv /builds/slave/test/build/venv 23:37:35 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 23:37:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:37:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:37:35 INFO - Using real prefix '/tools/python27' 23:37:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:37:36 INFO - Installing distribute.............................................................................................................................................................................................done. 23:37:39 INFO - Installing pip.................done. 23:37:39 INFO - Return code: 0 23:37:39 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:37:39 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:37:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:39 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:37:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:37:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:39 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 0x10d67fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d714618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbee148cb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5e3d30>, '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 0x10d348db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5dbb20>, '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.FXuOHCwbOY/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.00zXJruWcl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 23:37:39 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 23:37:39 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 23:37:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FXuOHCwbOY/Render', 23:37:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:37:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:37:39 INFO - 'HOME': '/Users/cltbld', 23:37:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:37:39 INFO - 'LOGNAME': 'cltbld', 23:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:37:39 INFO - 'MOZ_NO_REMOTE': '1', 23:37:39 INFO - 'NO_EM_RESTART': '1', 23:37:39 INFO - 'PAGER': '/bin/cat', 23:37:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:37:39 INFO - 'PWD': '/builds/slave/test', 23:37:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:37:39 INFO - 'SHELL': '/bin/bash', 23:37:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.00zXJruWcl/Listeners', 23:37:39 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 23:37:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:37:39 INFO - 'USER': 'cltbld', 23:37:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:37:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:37:39 INFO - 'XPC_FLAGS': '0x0', 23:37:39 INFO - 'XPC_SERVICE_NAME': '0', 23:37:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:37:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:37:39 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 23:37:39 INFO - Cleaning up... 23:37:39 INFO - Return code: 0 23:37:39 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:37:39 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:37:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:39 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:37:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:37:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:39 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 0x10d67fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d714618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbee148cb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5e3d30>, '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 0x10d348db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5dbb20>, '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.FXuOHCwbOY/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.00zXJruWcl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 23:37:39 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 23:37:39 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 23:37:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FXuOHCwbOY/Render', 23:37:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:37:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:37:39 INFO - 'HOME': '/Users/cltbld', 23:37:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:37:39 INFO - 'LOGNAME': 'cltbld', 23:37:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:37:39 INFO - 'MOZ_NO_REMOTE': '1', 23:37:39 INFO - 'NO_EM_RESTART': '1', 23:37:39 INFO - 'PAGER': '/bin/cat', 23:37:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:37:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:37:39 INFO - 'PWD': '/builds/slave/test', 23:37:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:37:39 INFO - 'SHELL': '/bin/bash', 23:37:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.00zXJruWcl/Listeners', 23:37:39 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 23:37:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:37:39 INFO - 'USER': 'cltbld', 23:37:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:37:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:37:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:37:39 INFO - 'XPC_FLAGS': '0x0', 23:37:39 INFO - 'XPC_SERVICE_NAME': '0', 23:37:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:37:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:37:39 INFO - Downloading/unpacking psutil>=3.1.1 23:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:37:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:37:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:37:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:37:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:37:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:37:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:37:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:37:42 INFO - Installing collected packages: psutil 23:37:42 INFO - Running setup.py install for psutil 23:37:42 INFO - building 'psutil._psutil_osx' extension 23:37:42 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 23:37:43 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 23:37:43 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 23:37:43 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 23:37:43 INFO - building 'psutil._psutil_posix' extension 23:37:43 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 23:37:43 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:37:43 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:37:43 INFO - ^ 23:37:43 INFO - 1 warning generated. 23:37:43 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 23:37:43 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:37:43 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:37:43 INFO - Successfully installed psutil 23:37:43 INFO - Cleaning up... 23:37:43 INFO - Return code: 0 23:37:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:37:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:37:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:37:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:43 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:37:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:37:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:43 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 0x10d67fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d714618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbee148cb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5e3d30>, '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 0x10d348db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5dbb20>, '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.FXuOHCwbOY/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.00zXJruWcl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 23:37:43 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 23:37:43 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 23:37:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FXuOHCwbOY/Render', 23:37:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:37:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:37:43 INFO - 'HOME': '/Users/cltbld', 23:37:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:37:43 INFO - 'LOGNAME': 'cltbld', 23:37:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:37:43 INFO - 'MOZ_NO_REMOTE': '1', 23:37:43 INFO - 'NO_EM_RESTART': '1', 23:37:43 INFO - 'PAGER': '/bin/cat', 23:37:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:37:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:37:43 INFO - 'PWD': '/builds/slave/test', 23:37:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:37:43 INFO - 'SHELL': '/bin/bash', 23:37:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.00zXJruWcl/Listeners', 23:37:43 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 23:37:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:37:43 INFO - 'USER': 'cltbld', 23:37:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:37:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:37:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:37:43 INFO - 'XPC_FLAGS': '0x0', 23:37:43 INFO - 'XPC_SERVICE_NAME': '0', 23:37:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:37:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:37:43 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:37:43 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 23:37:43 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 23:37:43 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 23:37:43 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 23:37:43 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 23:37:43 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 23:37:46 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:37:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:37:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:37:46 INFO - Installing collected packages: mozsystemmonitor 23:37:46 INFO - Running setup.py install for mozsystemmonitor 23:37:46 INFO - Successfully installed mozsystemmonitor 23:37:46 INFO - Cleaning up... 23:37:46 INFO - Return code: 0 23:37:46 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:37:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:37:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:37:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d67fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d714618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbee148cb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5e3d30>, '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 0x10d348db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5dbb20>, '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.FXuOHCwbOY/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.00zXJruWcl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 23:37:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 23:37:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 23:37:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FXuOHCwbOY/Render', 23:37:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:37:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:37:46 INFO - 'HOME': '/Users/cltbld', 23:37:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:37:46 INFO - 'LOGNAME': 'cltbld', 23:37:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:37:46 INFO - 'MOZ_NO_REMOTE': '1', 23:37:46 INFO - 'NO_EM_RESTART': '1', 23:37:46 INFO - 'PAGER': '/bin/cat', 23:37:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:37:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:37:46 INFO - 'PWD': '/builds/slave/test', 23:37:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:37:46 INFO - 'SHELL': '/bin/bash', 23:37:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.00zXJruWcl/Listeners', 23:37:46 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 23:37:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:37:46 INFO - 'USER': 'cltbld', 23:37:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:37:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:37:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:37:46 INFO - 'XPC_FLAGS': '0x0', 23:37:46 INFO - 'XPC_SERVICE_NAME': '0', 23:37:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:37:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:37:46 INFO - Downloading/unpacking jsonschema==2.5.1 23:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:37:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:37:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:37:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:37:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:37:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:37:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:37:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:37:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:37:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:37:49 INFO - Downloading functools32-3.2.3-2.tar.gz 23:37:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:37:49 INFO - warning: no files found matching '*.txt' 23:37:49 INFO - no previously-included directories found matching 'build' 23:37:49 INFO - no previously-included directories found matching 'dist' 23:37:49 INFO - no previously-included directories found matching '.git*' 23:37:49 INFO - Installing collected packages: jsonschema, functools32 23:37:49 INFO - Running setup.py install for functools32 23:37:49 INFO - warning: no files found matching '*.txt' 23:37:49 INFO - no previously-included directories found matching 'build' 23:37:49 INFO - no previously-included directories found matching 'dist' 23:37:49 INFO - no previously-included directories found matching '.git*' 23:37:49 INFO - Successfully installed jsonschema functools32 23:37:49 INFO - Cleaning up... 23:37:49 INFO - Return code: 0 23:37:49 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:37:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:37:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:37:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:37:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10d67fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d714618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbee148cb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5e3d30>, '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 0x10d348db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5dbb20>, '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.FXuOHCwbOY/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.00zXJruWcl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 23:37:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:37:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:37:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FXuOHCwbOY/Render', 23:37:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:37:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:37:49 INFO - 'HOME': '/Users/cltbld', 23:37:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:37:49 INFO - 'LOGNAME': 'cltbld', 23:37:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:37:49 INFO - 'MOZ_NO_REMOTE': '1', 23:37:50 INFO - 'NO_EM_RESTART': '1', 23:37:50 INFO - 'PAGER': '/bin/cat', 23:37:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:37:50 INFO - 'PWD': '/builds/slave/test', 23:37:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:37:50 INFO - 'SHELL': '/bin/bash', 23:37:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.00zXJruWcl/Listeners', 23:37:50 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 23:37:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:37:50 INFO - 'USER': 'cltbld', 23:37:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:37:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:37:50 INFO - 'XPC_FLAGS': '0x0', 23:37:50 INFO - 'XPC_SERVICE_NAME': '0', 23:37:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:37:50 INFO - Downloading/unpacking blobuploader==1.2.4 23:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:37:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:37:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:37:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:37:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:37:52 INFO - Downloading blobuploader-1.2.4.tar.gz 23:37:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:37:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:37:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:37:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:37:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:37:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:37:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:37:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:37:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:37:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:37:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:37:53 INFO - Downloading docopt-0.6.1.tar.gz 23:37:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:37:54 INFO - Installing collected packages: blobuploader, requests, docopt 23:37:54 INFO - Running setup.py install for blobuploader 23:37:54 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:37:54 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:37:54 INFO - Running setup.py install for requests 23:37:54 INFO - Running setup.py install for docopt 23:37:54 INFO - Successfully installed blobuploader requests docopt 23:37:54 INFO - Cleaning up... 23:37:54 INFO - Return code: 0 23:37:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:37:54 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:37:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:37:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:54 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:37:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:37:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:54 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 0x10d67fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d714618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbee148cb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5e3d30>, '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 0x10d348db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5dbb20>, '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.FXuOHCwbOY/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.00zXJruWcl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 23:37:54 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 23:37:54 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 23:37:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FXuOHCwbOY/Render', 23:37:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:37:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:37:54 INFO - 'HOME': '/Users/cltbld', 23:37:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:37:54 INFO - 'LOGNAME': 'cltbld', 23:37:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:37:54 INFO - 'MOZ_NO_REMOTE': '1', 23:37:54 INFO - 'NO_EM_RESTART': '1', 23:37:54 INFO - 'PAGER': '/bin/cat', 23:37:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:37:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:37:54 INFO - 'PWD': '/builds/slave/test', 23:37:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:37:54 INFO - 'SHELL': '/bin/bash', 23:37:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.00zXJruWcl/Listeners', 23:37:54 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 23:37:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:37:54 INFO - 'USER': 'cltbld', 23:37:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:37:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:37:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:37:55 INFO - 'XPC_FLAGS': '0x0', 23:37:55 INFO - 'XPC_SERVICE_NAME': '0', 23:37:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:37:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:37:55 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-J_OpzB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:37:55 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-zJwxMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:37:55 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-MN2o_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:37:55 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-eKsQid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:37:55 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-8DRdT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:37:55 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-XWwGHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:37:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:37:55 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-qREdKS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:37:56 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-nRNl0D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:37:56 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-KthuA_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:37:56 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-orUsOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:37:56 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-axKisa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:37:56 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-D4MFty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:37:56 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-NYn7sf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:37:56 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-OZivyu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:37:56 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-1gGYg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:37:56 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-TBKu9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:37:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:37:56 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-Ml3oOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:37:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:37:57 INFO - Running setup.py install for manifestparser 23:37:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:37:57 INFO - Running setup.py install for mozcrash 23:37:57 INFO - Running setup.py install for mozdebug 23:37:57 INFO - Running setup.py install for mozdevice 23:37:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:37:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:37:57 INFO - Running setup.py install for mozfile 23:37:57 INFO - Running setup.py install for mozhttpd 23:37:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:37:57 INFO - Running setup.py install for mozinfo 23:37:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:37:58 INFO - Running setup.py install for mozInstall 23:37:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:37:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:37:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:37:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:37:58 INFO - Running setup.py install for mozleak 23:37:58 INFO - Running setup.py install for mozlog 23:37:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:37:58 INFO - Running setup.py install for moznetwork 23:37:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:37:58 INFO - Running setup.py install for mozprocess 23:37:58 INFO - Running setup.py install for mozprofile 23:37:59 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:37:59 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:37:59 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:37:59 INFO - Running setup.py install for mozrunner 23:37:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:37:59 INFO - Running setup.py install for mozscreenshot 23:37:59 INFO - Running setup.py install for moztest 23:37:59 INFO - Running setup.py install for mozversion 23:37:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:37:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:37:59 INFO - Cleaning up... 23:37:59 INFO - Return code: 0 23:37:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:37: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:37:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:37:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:37:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:37:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:37:59 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 0x10d67fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d714618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbee148cb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5e3d30>, '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 0x10d348db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5dbb20>, '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.FXuOHCwbOY/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.00zXJruWcl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 23:37:59 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 23:37:59 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 23:37:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FXuOHCwbOY/Render', 23:37:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:37:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:37:59 INFO - 'HOME': '/Users/cltbld', 23:37:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:37:59 INFO - 'LOGNAME': 'cltbld', 23:37:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:37:59 INFO - 'MOZ_NO_REMOTE': '1', 23:37:59 INFO - 'NO_EM_RESTART': '1', 23:37:59 INFO - 'PAGER': '/bin/cat', 23:37:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:37:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:37:59 INFO - 'PWD': '/builds/slave/test', 23:37:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:37:59 INFO - 'SHELL': '/bin/bash', 23:37:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.00zXJruWcl/Listeners', 23:37:59 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 23:37:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:37:59 INFO - 'USER': 'cltbld', 23:37:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:37:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:37:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:37:59 INFO - 'XPC_FLAGS': '0x0', 23:37:59 INFO - 'XPC_SERVICE_NAME': '0', 23:37:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:37:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:37:59 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-4GRaWi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:38:00 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)) 23:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:38:00 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-iBq2dN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:38:00 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)) 23:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:38:00 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-jj6M6Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:38:00 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)) 23:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:38:00 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-0lLm0l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:38:00 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)) 23:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:38:00 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-TGDljH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:38:00 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)) 23:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:38:00 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-Y6SKYT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:38:00 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)) 23:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:38:00 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-U5eCtW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:38:00 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)) 23:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:38:00 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-dcILg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:38:00 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)) 23:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:38:00 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-CaTWKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:38:00 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)) 23:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:38:00 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-cBOcNi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 23:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:38:01 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-hHeEtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:38:01 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)) 23:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:38:01 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-YWr1yK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 23:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:38:01 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-qm_zAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:38:01 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)) 23:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:38:01 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-mf9qbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:38:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 23:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:38:01 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-_h0RQX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:38:01 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)) 23:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:38:01 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-PjRNCC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:38:01 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)) 23:38:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:38:01 INFO - Running setup.py (path:/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/pip-6TgZJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:38:01 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)) 23:38:01 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)) 23:38:01 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)) 23:38:01 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)) 23:38:01 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)) 23:38:01 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)) 23:38:01 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:38:01 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 23:38:01 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 23:38:01 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 23:38:01 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 23:38:01 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 23:38:01 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 23:38:04 INFO - Downloading blessings-1.6.tar.gz 23:38:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:38:04 INFO - Installing collected packages: blessings 23:38:04 INFO - Running setup.py install for blessings 23:38:04 INFO - Successfully installed blessings 23:38:04 INFO - Cleaning up... 23:38:04 INFO - Return code: 0 23:38:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:38:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:38:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:38:04 INFO - Reading from file tmpfile_stdout 23:38:04 INFO - Current package versions: 23:38:04 INFO - blessings == 1.6 23:38:04 INFO - blobuploader == 1.2.4 23:38:04 INFO - docopt == 0.6.1 23:38:04 INFO - functools32 == 3.2.3-2 23:38:04 INFO - jsonschema == 2.5.1 23:38:04 INFO - manifestparser == 1.1 23:38:04 INFO - mozInstall == 1.12 23:38:04 INFO - mozcrash == 0.17 23:38:04 INFO - mozdebug == 0.1 23:38:04 INFO - mozdevice == 0.48 23:38:04 INFO - mozfile == 1.2 23:38:04 INFO - mozhttpd == 0.7 23:38:04 INFO - mozinfo == 0.9 23:38:04 INFO - mozleak == 0.1 23:38:04 INFO - mozlog == 3.2 23:38:04 INFO - moznetwork == 0.27 23:38:04 INFO - mozprocess == 0.22 23:38:04 INFO - mozprofile == 0.28 23:38:04 INFO - mozrunner == 6.11 23:38:04 INFO - mozscreenshot == 0.1 23:38:04 INFO - mozsystemmonitor == 0.3 23:38:04 INFO - moztest == 0.7 23:38:04 INFO - mozversion == 1.4 23:38:04 INFO - psutil == 3.1.1 23:38:04 INFO - requests == 1.2.3 23:38:04 INFO - wsgiref == 0.1.2 23:38:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:38:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:38:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:04 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:38:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:38:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:04 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 0x10d67fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d714618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbee148cb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5e3d30>, '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 0x10d348db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5dbb20>, '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.FXuOHCwbOY/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.00zXJruWcl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 23:38:04 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 23:38:04 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 23:38:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FXuOHCwbOY/Render', 23:38:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:38:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:38:04 INFO - 'HOME': '/Users/cltbld', 23:38:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:38:04 INFO - 'LOGNAME': 'cltbld', 23:38:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:38:04 INFO - 'MOZ_NO_REMOTE': '1', 23:38:04 INFO - 'NO_EM_RESTART': '1', 23:38:04 INFO - 'PAGER': '/bin/cat', 23:38:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:38:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:38:04 INFO - 'PWD': '/builds/slave/test', 23:38:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:38:04 INFO - 'SHELL': '/bin/bash', 23:38:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.00zXJruWcl/Listeners', 23:38:04 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 23:38:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:38:04 INFO - 'USER': 'cltbld', 23:38:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:38:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:38:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:38:04 INFO - 'XPC_FLAGS': '0x0', 23:38:04 INFO - 'XPC_SERVICE_NAME': '0', 23:38:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:38:05 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)) 23:38:05 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)) 23:38:05 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)) 23:38:05 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)) 23:38:05 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)) 23:38:05 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)) 23:38:05 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)) 23:38:05 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)) 23:38:05 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)) 23:38:05 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)) 23:38:05 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)) 23:38:05 INFO - Cleaning up... 23:38:05 INFO - Return code: 0 23:38:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:38:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:38:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:38:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:38:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:38:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:38:05 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 0x10d67fa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d714618>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbee148cb00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d5e3d30>, '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 0x10d348db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5dbb20>, '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.FXuOHCwbOY/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.00zXJruWcl/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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 23:38:05 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 23:38:05 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 23:38:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FXuOHCwbOY/Render', 23:38:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:38:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:38:05 INFO - 'HOME': '/Users/cltbld', 23:38:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:38:05 INFO - 'LOGNAME': 'cltbld', 23:38:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:38:05 INFO - 'MOZ_NO_REMOTE': '1', 23:38:05 INFO - 'NO_EM_RESTART': '1', 23:38:05 INFO - 'PAGER': '/bin/cat', 23:38:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:38:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:38:05 INFO - 'PWD': '/builds/slave/test', 23:38:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:38:05 INFO - 'SHELL': '/bin/bash', 23:38:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.00zXJruWcl/Listeners', 23:38:05 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 23:38:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:38:05 INFO - 'USER': 'cltbld', 23:38:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:38:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:38:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:38:05 INFO - 'XPC_FLAGS': '0x0', 23:38:05 INFO - 'XPC_SERVICE_NAME': '0', 23:38:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:38:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:38:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:38:05 INFO - Cleaning up... 23:38:05 INFO - Return code: 0 23:38:05 INFO - Running post-action listener: _resource_record_post_action 23:38:05 INFO - Running post-action listener: _start_resource_monitoring 23:38:05 INFO - Starting resource monitoring. 23:38:05 INFO - ##### 23:38:05 INFO - ##### Finished create-virtualenv step (success) 23:38:05 INFO - ##### 23:38:05 INFO - ##### 23:38:05 INFO - ##### Running install step. 23:38:05 INFO - ##### 23:38:05 INFO - Running pre-action listener: _resource_record_pre_action 23:38:05 INFO - Running main action method: install 23:38:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:38:05 INFO - Reading from file tmpfile_stdout 23:38:05 INFO - Detecting whether we're running mozinstall >=1.0... 23:38:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:38:05 INFO - Reading from file tmpfile_stdout 23:38:05 INFO - Output received: 23:38:05 INFO - Usage: mozinstall [options] installer 23:38:05 INFO - Options: 23:38:05 INFO - -h, --help show this help message and exit 23:38:05 INFO - -d DEST, --destination=DEST 23:38:05 INFO - Directory to install application into. [default: 23:38:05 INFO - "/builds/slave/test"] 23:38:05 INFO - --app=APP Application being installed. [default: firefox] 23:38:05 INFO - mkdir: /builds/slave/test/build/application 23:38:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 23:38:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 23:38:39 INFO - Reading from file tmpfile_stdout 23:38:39 INFO - Output received: 23:38:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:38:39 INFO - Running post-action listener: _resource_record_post_action 23:38:39 INFO - ##### 23:38:39 INFO - ##### Finished install step (success) 23:38:39 INFO - ##### 23:38:39 INFO - ##### 23:38:39 INFO - ##### Running run-tests step. 23:38:39 INFO - ##### 23:38:39 INFO - Running pre-action listener: _resource_record_pre_action 23:38:39 INFO - Running main action method: run_tests 23:38:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:38:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:38:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:38:39 INFO - 2016-07-05 23:38:39.996 screenresolution[2270:25073] starting screenresolution argv=screenresolution get 23:38:39 INFO - 2016-07-05 23:38:39.998 screenresolution[2270:25073] Display 0: 1600x1200x32@50 23:38:40 INFO - 2016-07-05 23:38:40.004 screenresolution[2271:25076] starting screenresolution argv=screenresolution list 23:38:40 INFO - Available Modes on Display 0 23:38:40 INFO - 1600x1200x32@50 1152x870x32@75 1280x1024x32@75 23:38:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:38:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:38:40 INFO - 640x480x32@60 1280x1024x32@60 1600x1200x32@60 23:38:40 INFO - 1280x960x32@60 1280x960x32@75 1344x1008x32@50 23:38:40 INFO - Graphics/Displays: 23:38:40 INFO - Intel Iris: 23:38:40 INFO - Chipset Model: Intel Iris 23:38:40 INFO - Type: GPU 23:38:40 INFO - Bus: Built-In 23:38:40 INFO - VRAM (Dynamic, Max): 1536 MB 23:38:40 INFO - Vendor: Intel (0x8086) 23:38:40 INFO - Device ID: 0x0a2e 23:38:40 INFO - Revision ID: 0x0009 23:38:40 INFO - Displays: 23:38:40 INFO - Display: 23:38:40 INFO - Resolution: 1600 x 1200 @ 50 Hz 23:38:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:38:40 INFO - Display Serial Number: 1600x1200 50 23:38:40 INFO - Main Display: Yes 23:38:40 INFO - Mirror: Off 23:38:40 INFO - Online: Yes 23:38:40 INFO - Rotation: Supported 23:38:40 INFO - Return code: 0 23:38:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:38:40 INFO - Python 2.7.3 23:38:40 INFO - Return code: 0 23:38:40 INFO - grabbing minidump binary from tooltool 23:38:40 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:38:40 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 0x10d5e3d30>, '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 0x10d348db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d5dbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:38:40 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 23:38:40 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 23:38:40 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 23:38:40 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:38:40 INFO - Return code: 0 23:38:40 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:38:40 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:38:40 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:38:40 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:38:40 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:38:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 23:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0017 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 23:38:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.FXuOHCwbOY/Render', 23:38:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:38:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:38:40 INFO - 'HOME': '/Users/cltbld', 23:38:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:38:40 INFO - 'LOGNAME': 'cltbld', 23:38:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:38:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:38:40 INFO - 'MOZ_NO_REMOTE': '1', 23:38:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:38:40 INFO - 'NO_EM_RESTART': '1', 23:38:40 INFO - 'PAGER': '/bin/cat', 23:38:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:38:40 INFO - 'PWD': '/builds/slave/test', 23:38:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:38:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:38:40 INFO - 'SHELL': '/bin/bash', 23:38:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.00zXJruWcl/Listeners', 23:38:40 INFO - 'TMPDIR': '/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/', 23:38:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:38:40 INFO - 'USER': 'cltbld', 23:38:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:38:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:38:40 INFO - 'XPC_FLAGS': '0x0', 23:38:40 INFO - 'XPC_SERVICE_NAME': '0', 23:38:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:38:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0017', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 23:38:40 INFO - mozversion application_buildid: 20160705205623 23:38:40 INFO - mozversion application_changeset: cec1ab33c0d6bdc2638e0e76566a5009f033d949 23:38:40 INFO - mozversion application_display_name: Nightly 23:38:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:38:40 INFO - mozversion application_name: Firefox 23:38:40 INFO - mozversion application_remotingname: firefox 23:38:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:38:40 INFO - mozversion application_vendor: Mozilla 23:38:40 INFO - mozversion application_version: 50.0a1 23:38:40 INFO - mozversion platform_buildid: 20160705205623 23:38:40 INFO - mozversion platform_changeset: cec1ab33c0d6bdc2638e0e76566a5009f033d949 23:38:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:38:40 INFO - mozversion platform_version: 50.0a1 23:38:40 INFO - using testdate: 1467787120 23:38:40 INFO - actual date: 1467787120 23:38:40 INFO - starting webserver on 'localhost:58100' 23:38:40 INFO - SUITE-START | Running 2 tests 23:38:40 INFO - TEST-START | dromaeo_css 23:38:40 INFO - operating with platform_type : mac_ 23:38:40 INFO - Initialising browser for dromaeo_css test... 23:38:40 INFO - TEST-INFO | started process 2281 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmpcObG7m/profile http://localhost:58100/getInfo.html) 23:38:43 INFO - PROCESS | 2281 | __metrics Screen width/height:1600/1200 23:38:43 INFO - PROCESS | 2281 | colorDepth:24 23:38:43 INFO - PROCESS | 2281 | Browser inner width/height: 1024/689 23:38:43 INFO - PROCESS | 2281 | __metrics 23:38:43 ERROR - PROCESS | 2281 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 23:38:44 INFO - TEST-INFO | 2281: exit 0 23:38:44 INFO - Browser initialized. 23:38:44 INFO - Running cycle 1/1 for dromaeo_css test... 23:38:44 INFO - TEST-INFO | started process 2284 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmpcObG7m/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:38:56 INFO - PROCESS | 2284 | RSS: Main: 255778816 23:38:56 INFO - PROCESS | 2284 | 23:39:46 INFO - PROCESS | 2284 | 1467787186087 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] 23:41:58 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:58100/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58100/tests/dromaeo/cssquery-ext.html) 23:41:59 INFO - PROCESS | 2284 | RSS: Main: 269803520 23:41:59 INFO - PROCESS | 2284 | 23:45:01 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:58100/tests/dromaeo/cssquery-ext.html (next: http://localhost:58100/tests/dromaeo/cssquery-jquery.html) 23:45:02 INFO - PROCESS | 2284 | RSS: Main: 278605824 23:45:02 INFO - PROCESS | 2284 | 23:48:04 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:58100/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58100/tests/dromaeo/cssquery-mootools.html) 23:48:04 INFO - PROCESS | 2284 | RSS: Main: 283222016 23:48:04 INFO - PROCESS | 2284 | 23:51:06 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:58100/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58100/tests/dromaeo/cssquery-prototype.html) 23:51:07 INFO - PROCESS | 2284 | RSS: Main: 282574848 23:51:07 INFO - PROCESS | 2284 | 23:54:10 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:58100/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58100/tests/dromaeo/cssquery-yui.html) 23:54:10 INFO - PROCESS | 2284 | RSS: Main: 286199808 23:54:10 INFO - PROCESS | 2284 | 23:57:13 INFO - PROCESS | 2284 | Cycle 1(1): loaded http://localhost:58100/tests/dromaeo/cssquery-yui.html (next: http://localhost:58100/tests/dromaeo/cssquery-dojo.html) 23:57:13 INFO - PROCESS | 2284 | RSS: Main: 285896704 23:57:13 INFO - PROCESS | 2284 | 23:57:13 INFO - PROCESS | 2284 | __start_tp_report 23:57:13 INFO - PROCESS | 2284 | _x_x_mozilla_page_load 23:57:13 INFO - PROCESS | 2284 | _x_x_mozilla_page_load_details 23:57:13 INFO - PROCESS | 2284 | |i|pagename|runs| 23:57:13 INFO - PROCESS | 2284 | |0;dojo.html;3269.0192942117365;3362.0754292569554;3392.3554524640326;3394.2532642818587;3407.148212946763;4415.624671902892;5213.244079608459;5454.781808727646;5783.797567085153;5784.103463963087;5700.1449782532645;5732.312122545301;5740.253767010283;5799.13013048043;5809;5206.167013277876;5237.816676416326;5249.212618107276;5340.06548853951;5383.569314454834;5372.973135134319;5394.6493477924005;5437.293151890269;5440.727963601804;5444.292242008553;5178.14560597501;5195.558377537914;5240.3187585614005;5304.522592966613;5335.279737235482;5251.632385733;5268.8155914543195;5295.602829787781;5337.626366154371;5376.220448035013;5288;5295.523402893758;5321.122014867542;5340.118880384732;5369.5972802040005;5034.496550344973;5711.428857114297;5902.822915312548;5934.1692163097205;5961.612495187799;6145.385461453863;6230.750769969196;6264.906026409608;6270.372962703693;6273.0904018917;6142.560166306837;6165.136880836686;6237.157983672237;6291.433770960635;6302.873942521124;5908.67502287374;5963.194968679173;5981.970090149608;5986.431289027535;6030.758769649165;5507.421720719347;6377.904331435032;6388.329225431356;6431.710573024225;6444.7744328948265;5230.555402790806;6143.266246520256;6166.537509686791;6217.658028808459;6237.220347456568;5546.528545073714;6164.907526387108;6280.340564240781;6297.244330680348;6305.684715764193;6119.533019689859;6129;6228.5017198624;6249.281332646713;6266.592671476339;6141.056449558059;6174.536909731788;6198.6280823150755;6201.7519299228425;6253.1245625612455;4994.700317980933;4998.125328067574;5001.824936127291;5016.2224855147515;5042.268871013755;4418.6023257906945;4447.132809102194;4480.753558554311;4504.189245935698;4535.682502224812;5778.508826749689;5935.317438494629;5972;5997.520198384119;6010.789622363196;5604.523615492647;6226;6233;6258.624482530971;6278.434940855345;6006.759729610767;6010.609310394898;6016.729247183887;6033.42682445167;6039.939600603938;5410.864728381822;5499.092649712753;5526.171074338801;5559.805406810742;5561.58288128392;6501.577397469149;6543.116679248241;6543.869122617616;6546.869062618816;6554.049662798868;6168.321484636596;6309.49524038085;6314.55798094129;6317.4630156437215;6331.398517140864;6398.4561312287115;6412.198475190601;6458.644774537445;6483.027545868157;6530.902036469552;6209.192804935329;6229.221347331583;6241.594296370721;6262.436380725757;6264.812055638338;5888.263967004124;6170.56806023592;6228.844278892882;6272.278687950944;6291.339409361951;6104.853288833144;6112.898653789679;6113.57204995646;6153.969230153821;6232.937670623236;6108.4807791338235;6173;6179.81460556184;6184.845378865564;6190.876182476415;4856.465788763304;5435.23906653061;5925;5971.822601448591;6087.117367981707;6114.0236562776045;6114.266954506099;6162.322144564005;6176.567640265138;6263.404976527223;6082.087686847009;6104;6104.572679912363;6114.969425153024;6116.944513560587 23:57:13 INFO - PROCESS | 2284 | |1;ext.html;481.9926353920307;486.96276930138805;528.0495108804151;528.252522680407;598.0550729846842;37179;38070;39285.803570982105;39463;39665.603343966555;40148.397774033416;40652;41406.58593414065;41450.792746036306;41457.58542414575;9464.621415143385;9606.039396060409;9644.807103857918;9721;9725.27060470464;8437.240648341649;9596.424214547114;9616.23070154386;9748.512574371252;9773.26700497462;9700.369475984038;9725.756856078584;9751.658691945784;9754.414735115915;9761.853572196424;9615.375000624937;9701.466419346933;9708.854367184498;9728.17310528606;9772.169365603932;8624.137586241388;8759.255463285628;9153;9590.712278631583;9655.855162172573;39330.60669393327;39520.802395988125;39655;39685.20629587392;39779.00552486182;2748.40909204522;3374.8650053997812;3618.0773902654655;3837.2517359114986;4330.17726631939;31034.37931241385;31262;31479.84260078708;31602.683973160434;32183.6781632183;3130.4365214261425;3186.920326991844;3203.823789691566;3219.613646362428;3317.1872891141825;393664;448582;453894;456564;459805;33697.66302336945;33784.32431351359;34044;34193.829030854686;34195;35287.29425411477;35729.642703573154;35821.925342239774;35992;36060;12917.354132293347;15021.849781502264;15302.617434564003;15317.23413829304;15333.846661533466;12911.483540658268;13006.934965325112;13017.153884997444;13038;13064.477420903057;7802.921970780219;7849.568273744884;7861.685532578747;7913.406494512819;7931.167227441151;3305.1076209423322;3310.2551925816497;3310.4372256716415;3329.6836800503916;3345.6988871001727;980.8136454073704;985.4973963278779;1064.3401091323428;1083.409541799721;1089.6404186618397;21671.891640541697;27701.584476232874;29988.201852856575;31204;31972.680273197435;1097.9670609881716;1115.4478533126155;1132.3828513460185;1145.1983611472003;1163.319458117011;14497;15534.300956456986;15826.208689565476;16202.946808457413;16400.425985090464;663306;666874;674042;675061;675163;58395;58459;58807.70596146992;58986.705066474395;59154.70422647859;1402.5511836212313;1420.779779134236;1438.4030627289767;1449.4854326713864;1453.0627745104136;28663.570046448902;29741.14793534632;30688;31126.53310200394;31486.37027259488;48340.758296208296;48627.027459449906;48991.75504122599;49040.2643960348;49084;596069;607054;607174;608335;609011;27227;27680;27740;28410.715892841636;28627.570586441638;49131.754341228065;49563.752181238866;49741.502584973685;50191.74904125456;50259;36302.27395452129;40262;40959.59040409558;41773;42400;31055.84472077625;32023.855309754294;33675.83162084174;38601.80699096486;42191.789041054595;33554;39094.4135837957;39398.81803545898;39717.80141099276;39984;35308.29383412369;35577;35808.46287305745;36105.0973725659;36139.638603613625;25804.741952580232;25824.741752582235;25947.351316217246;26227.344316392242;26662.46675066449 23:57:13 INFO - PROCESS | 2284 | |2;jquery.html;345.2938740276135;383.38849534991687;387.44595228822783;391.67490982484543;415.1158033388881;16945.745813812802;19939.700904486424;21045.894770526127;21594.028268727907;21711.782882171174;11926.28442293463;12101;12229.38853057348;12444.315562644051;12449.315287659176;4872.829450969217;5659.717014149297;5666.943330566683;5669.461401166883;5676.971615141919;3961.2671655743634;6606.768763093292;6953.408960238386;6968.860622787542;7033.261507541685;5910;6248.062790581426;6937.306269373073;6956.234814170462;6964.303569643046;6211.720472578722;6235.625862448245;6259.624422534663;6260.937390626081;6292.968535157341;5823.650580965155;6130.264368275791;6150.077488376734;6150.231221097363;6157.815265542041;13683.589492315146;13887.4445022199;17240.741388879178;26739.732602673917;26806.195814125607;1917.3481016454473;2332.3352844439255;2370.2059809963685;2385.2009576791797;2872.238856702975;9914.355566888129;10145.695629131138;10675.786484270271;10688.14494840411;10692.037716605542;1845.6677797996356;1860.5534671678836;1926.268018153093;1926.951826204342;1996.8003199679915;119804.40097799542;129688;129734;131746.6825331744;133762.33118834344;11166.553337866395;11183.944080279709;11725.296482211095;11890.940545297219;11975.64073077809;14751.631209219855;14845.183514906568;14963.40146394132;14989.400423983137;15038.32327545263;8539.676350165735;8694.91305086941;8708.216260536456;8749.825003499895;8785.51679657625;7286.4899457038555;7897.447178697436;8634.697785577475;8667.913320866837;8808.427452215585;4270.914581708348;4579.977100114545;4584.541545845455;4644.164050470948;4714.316424118484;3238.36851813894;3533.505309256706;3608.0258330250686;3940.0937784309767;3965.0285680008583;344.2924789557433;385.5161771976152;387.61238761238764;431.43697474795067;876.7019213467452;10067;10782.029617334478;11987.22083064598;12153.027757779357;12336.62990110298;431.66977262394295;441.8740658912259;458.44757067733303;465.0304115918348;469.6383784485927;6187.659678717714;6226.875462490725;6287.717052732638;6341.112244285804;6342.714577844008;524882;526222;638366;646333;647474;136340.99999999802;141727;149053;150459;153694.23152884163;370.6071564142018;458.89904221070645;458.8990422107131;459.11161901720277;460.4842576314549;11110.500027498943;11343.128383816578;11641.941790291334;11717.589884354007;11826.994705450134;57435;59071.70464147652;59266.111008334046;59591.1061334089;61120.694396529514;75683.48633027419;87001.56499217464;89302;89359.55320223357;89974;6515.934840651533;8162.755117346489;8263.876041859257;8275.462094963808;8343.624536895733;10844.837327440253;13119.737605248032;13425.932870335586;13539.932300338829;13565.050446468653;10610.310329828846;10789.352638841694;10882.129429645767;10948.945255273673;11727.179097463095;9489.952550237205;11341.546338146381;11359.261647993184;11362.204645674723;11492.94253528727;11784.351860647746;11793.29240245588;11821.645350639494;11902.583409580624;11942.16404851652;6950.65246737651;8362.205590468895;8403.453775504573;8467.237948584658;8481.787955301166;8475.49147051179;10625.574977000833;11489.368084755084;11523.193376463567;11569.305841649528 23:57:13 INFO - PROCESS | 2284 | |3;mootools.html;1366.8633136686333;1516.0827699241954;1767.964640707186;1962.0876292523965;1966.2135145941631;7976.122626511079;8055.355571554276;8699;9161.587728552215;9175.908240917588;6660.300668429805;8526.275266602346;8682.73951781446;8860.069692682273;8867.935847698285;2355.3640517060426;2392.246442370648;2399.436132508859;2402.1592442645024;2402.651615515758;2367.8579285242854;2383.9284821455385;2395.1257790906366;2403.6995375578053;2413.8431001984814;2367.75138610446;2373.8338316317863;2385.916492922748;2405.795507381875;2409.144753612469;2127.414960885761;2243.607368710469;2343.718753749544;2350.612148995422;2352.3413444235644;2148.419926619804;2226.5212979209387;2345.6247000479843;2361.775631315022;2363.3855197648563;8857.247133993618;8858.11418858109;8960.820783584291;9023.323250756219;9047.18575328217;4410;5319.5744340452675;5324.973375133139;5348.411674715778;5450.836474905759;3536.5579302587175;3608.873689420884;3619.3847046002243;3648.106213977566;3649.872254471081;1084.6474895658941;1105.2429086076063;1110.838928355392;1128.0749785176158;1130.8812574679623;11705.239159454693;11857.881421185764;11873.881261187364;11896.048316134775;11912.821307680391;3981.8009099544906;4177.540470548237;4488.865334039984;4563.338315944169;4723.905521889612;10115.645952391778;10162.796744065077;10170.949145254375;10178.389296642225;10182.898171018343;4668.206404911173;5420.864478388072;5458.099413596712;5461.808836690697;5472.589555783332;4403.889902752457;4779.211430113992;4947.332110165154;4963.156263435225;4985.152524070917;4068.9390887384748;4073.368627862686;4131.938020929689;4158.958410415918;4173.040200753843;1290.2000759528964;1306.6210798868221;1317.0583033131356;1324.4966912573161;1334.5129027904745;864.3517361978517;946.9573869175904;953.1040821627648;957.482959202037;994.5822754443151;5958.821235362946;6011.759529618854;6086.2696476422225;6163.907541386883;6202.255729312511;970.2965350121106;972.1833659725864;978.4422878959067;1011.3375738891039;1032.3341444768082;3312.2381852174135;4042.2319759245647;4064.4716186895516;4119.485064366954;4134.441850350225;10297.53661085253;10735.677929662123;10763.56945722178;10769.461526923622;10778.461076946121;10477.68566942993;10655.57377704883;10699.94650026745;10700.30448020876;10720.517576709066;8254.54599996994;8338.62476188573;8354.916450835535;8506.234438900405;8532.573371331533;4665.976670116627;6035.517158627212;6097.481714054177;6128.356522565066;6147.200863887666;9785.36395134314;10049.14582260516;10157.441340726036;10194.949025254826;10236.744081398025;10102.89897101049;10299.536520856429;10460.47697615101;10517.000884916226;10526.631567895087;6719.731210751515;7026.508144429841;7189.892151617834;7194.856102877809;7322.743703970335;8243.629036693243;8559.22966932979;8592.484450932963;8653.480791152551;8658.177473140042;7511.474196806171;7651.655675494505;7655.46411751172;7720.613969301625;7766.766996990099;7498.32515073646;7576.469647124648;7579.204183560647;7703.268189521987;7705.7688269349765;6254.906176407267;7178.102737157856;7226.277372262942;7231.3130252625915;7272.200057993511;4969.35398398206;5051.419086805065;5084.771185296597;5098.209777484496;5162.741862906914;5144.331236939174;5168.689878607295;5207.192885102815;5240.921386179134;5292.259083728204 23:57:13 INFO - PROCESS | 2284 | |4;prototype.html;318.7816345803125;321.6124569893279;326.4955643530743;326.76636205113346;331.47626749735423;4606.930896036562;4739.194336962716;5559.191953511842;5644.887102257952;5775.5090817280525;5323.414424413321;5735.741891614877;5748.9939260629435;5797.275340582427;5851.239338885949;4127.307803800442;4260.914781704364;4385.386045953569;4387.495438024636;4411.867643970686;3915.941260881089;3977.602239776014;4270.957290427087;4395.428594282739;4405.493368262642;4350.4344435223375;4364.236258654739;4365.3451982202605;4406.603405693487;4418.248897687401;3542.681158695704;4183.97908010461;4261.360795880627;4376.212281789277;4376.6936314458;3718.8140592970512;3726.863306691485;3744.1575645479547;3753.906152346186;3763.9059023524355;5675.120356344773;5677.403872593401;5707.145177817226;5711.314642242957;5723.511886909433;4019.934717299918;4241.915161696779;5043.62172837035;5056.924146137811;5072.797088116471;4784.30627559002;5843.4448727371255;5922.733476993546;6121.785737499166;6155.660848877398;3633.836477358499;3661.498785497933;4143.57046818847;4167.4790651168605;4170.562090980434;5459;6105.938940610626;6151.401430163404;6354.5551811373225;6540.416535468464;4072.511298644182;4142.523609784853;4208.558101399371;4214.262504061777;4222.662187025031;3442.829437991095;3801.3917773156713;4165.562615925284;4262.936055959101;4304.677149213759;4788.856334309976;5056.797728090909;5059.974700126476;5071.449985010508;5072.15959062926;4806.7836947337455;6066.938285799967;6153.953827849276;6190.9475389183945;6220.937790622036;1330.303862575205;1376.9586912392645;1467.7284702330103;1470.4632809024629;1471.3305446022034;891.6477991193442;895.8297923394534;902.7111324376136;960.7550074730899;1010.5048526222246;4809.639277054235;5385.865353366197;5622.803201887914;5686.175504551817;5694.6583205007;5539.864327812788;5622.971885140548;5950.821475355746;6278.300330857775;6331.905021424683;4460.8661740147845;4956.553910148104;5237.39109583564;5675.864827034609;5688.260526131659;2908.5200941844782;3023.8488075596574;3279.868445386338;3291.9341613167603;3313.624845689012;6125.295591007091;6372.4583410409705;6450.903236451457;6584.967075164594;6619.768308109193;5129.435762066169;6108.297545782203;6192.287886892975;6446;6467.191601049774;5765.933302339081;6484.254310754323;6506.674666266667;6516.902246466307;6533.738650453929;4753.6672432930745;5821.825345239649;6134.04922237054;6147.848253111375;6265.655388953469;5874.240486088821;6202.5658203925295;6206.875862482635;6212.347703491249;6212.968935155295;5952.821415357546;6053.969730151321;6482.643454610042;6494.740210391531;6523.412892839668;4080.3063479208013;4080.8571699990357;4105.548389677193;4209.221294060609;4264.850730224427;5043.445221025758;5538.196961440488;6155.199824022849;6189.783357582463;6262.68686565679;5758.510526605285;5975.521958243417;5984.229935140834;6012.819615411545;6021.939780602138;5555.555555555581;5972.70136493165;5984.12761874294;6001.609895356788;6057.4851137653795;4975.9004819902675;5283.7093959831045;5614;5623.746931388179;5854.511832471268;5934.465898069022;6022.36765139654;6102.626908945452;6149.739303442873;6165.537584681257;5098.847034588968;5513.696746678971;5684.886302274014;5956.319656154661;6071.210742603434 23:57:13 INFO - PROCESS | 2284 | |5;yui.html;748.8539734751724;778.4395235430488;780.2041917244411;846.1876598465473;877.157928388747;15237.16195609241;15638.921805390986;15815.44645937391;15829.445969391074;15874.68250634988;14017.719645607107;14230.644233894158;14330.570082897504;14524;14524.854751452482;715.5599306426536;886.4282537763139;889.5552223888056;924.8843894513186;929.3308817651314;715.989260161098;801.8797180422924;908.7092130518237;916.6425094213229;918.3479729392106;951.4006176109076;971.5288085278635;974.1768205866032;974.3423189347197;977.9168770654503;958.4249450329816;966.970990870275;967.5404183013083;968.1141755293897;971.2569884038716;677.2719326723792;688.1501345837886;719.6437763307144;720.6432815756182;725.9637018149124;14651.706965860623;15183.62040948974;15326.927115101947;15344.232788360538;15369;13640.249786261751;13710.177389356571;13861.445542178402;13968.58094257174;14160;13323.333833308392;13333.39999700006;13355.732885342335;13518.188908665414;13545.390457429341;4666.9766651166865;4707.340972263886;4711.057788442326;4853.830115945961;4856.525333413039;86782.26435471255;119164;123293.38353308266;124243;126380;9870.30907836459;11119;11198.272112312674;11385.259958102697;11515.942420288013;21913.780862191175;21925.780742192692;21935.67096493554;21940.45148871291;21954.34136975893;7681.692732290758;7911.090224624242;8034;8043.718469853527;8096.392770542233;4451.59935605797;4509.143262780061;4510.661700372485;4518.593326600556;4525.909481810345;3554.591222009502;3617.330793803102;3646.08847788053;3647.6717095461004;3660.2862441824122;669.5714742564762;677.3057615943698;683.3030309084705;688.8243497908102;693.2893783871572;552.917062440629;566.1564269238804;594.5927039977629;619.2135987296109;640.484410049905;8743.737687869374;8987.46075235488;9109.635614575343;9260.30547708911;9289.953550232342;520.903632827928;634.3276127305071;637.1494055436045;640.5964242527178;662.1127688896901;3507.3686736387185;3610.7291953103095;3904.843806247775;4436.911261774746;4446.288593824973;94410.52794735982;112160;160117;163573;163810;137904;138172.30913845566;138957.9156312656;139002;139999.6000040007;88778.82865411628;98273.50863245637;110469;113893;116941.8305816948;8595.44129631572;8618;8639.265662418513;8698.999615044351;8803.251723603566;51277.48722512877;61638;61962;62693.43266418376;63353;89372;91323.08676913411;91951;92397.61403579086;92673;9827.253378211213;11399.316041037564;11413.714657133305;11515.654530364103;12000.699982500159;9926.454045027593;12035.75928481408;12111.152219344562;12364.876351236373;12690.302033388252;11831.645050648494;11956.521739130338;11960.222585531912;11966.880331196577;12105;11902.383756466284;12047;12156.392180391122;12371.876281237073;12456.813147802972;10209.9489502552;11914.76170476603;12088.274703517816;12232.816507752568;12273.386330683608;9734.36726612768;9790.314677972758;9821.214302855611;10050.949745251228;10310.226732994905;9802.705918822447;9922.900770992486;10069.597216111273;10104.444255566015;10147.797044059225 23:57:13 INFO - PROCESS | 2284 | __end_tp_report 23:57:13 INFO - PROCESS | 2284 | __start_cc_report 23:57:13 INFO - PROCESS | 2284 | _x_x_mozilla_cycle_collect,442 23:57:13 INFO - PROCESS | 2284 | __end_cc_report 23:57:13 INFO - PROCESS | 2284 | __startTimestamp1467788233593__endTimestamp 23:57:13 INFO - PROCESS | 2284 | 23:57:13 INFO - PROCESS | 2284 | ------- Summary: start ------- 23:57:13 INFO - PROCESS | 2284 | Number of tests: 6 23:57:13 INFO - PROCESS | 2284 | 23:57:13 INFO - PROCESS | 2284 | [#0] dojo.html Cycles:165 Average:5785.81 Median:6033.43 stddev:656.85 (10.9%) stddev-sans-first:628.49 23:57:13 INFO - PROCESS | 2284 | Values: 3269.0 3362.1 3392.4 3394.3 3407.1 4415.6 5213.2 5454.8 5783.8 5784.1 5700.1 5732.3 5740.3 5799.1 5809.0 5206.2 5237.8 5249.2 5340.1 5383.6 5373.0 5394.6 5437.3 5440.7 5444.3 5178.1 5195.6 5240.3 5304.5 5335.3 5251.6 5268.8 5295.6 5337.6 5376.2 5288.0 5295.5 5321.1 5340.1 5369.6 5034.5 5711.4 5902.8 5934.2 5961.6 6145.4 6230.8 6264.9 6270.4 6273.1 6142.6 6165.1 6237.2 6291.4 6302.9 5908.7 5963.2 5982.0 5986.4 6030.8 5507.4 6377.9 6388.3 6431.7 6444.8 5230.6 6143.3 6166.5 6217.7 6237.2 5546.5 6164.9 6280.3 6297.2 6305.7 6119.5 6129.0 6228.5 6249.3 6266.6 6141.1 6174.5 6198.6 6201.8 6253.1 4994.7 4998.1 5001.8 5016.2 5042.3 4418.6 4447.1 4480.8 4504.2 4535.7 5778.5 5935.3 5972.0 5997.5 6010.8 5604.5 6226.0 6233.0 6258.6 6278.4 6006.8 6010.6 6016.7 6033.4 6039.9 5410.9 5499.1 5526.2 5559.8 5561.6 6501.6 6543.1 6543.9 6546.9 6554.0 6168.3 6309.5 6314.6 6317.5 6331.4 6398.5 6412.2 6458.6 6483.0 6530.9 6209.2 6229.2 6241.6 6262.4 6264.8 5888.3 6170.6 6228.8 6272.3 6291.3 6104.9 6112.9 6113.6 6154.0 6232.9 6108.5 6173.0 6179.8 6184.8 6190.9 4856.5 5435.2 5925.0 5971.8 6087.1 6114.0 6114.3 6162.3 6176.6 6263.4 6082.1 6104.0 6104.6 6115.0 6116.9 23:57:13 INFO - PROCESS | 2284 | 23:57:13 INFO - PROCESS | 2284 | [#1] ext.html Cycles:180 Average:68695.11 Median:39190.11 stddev:155881.04 (397.8%) stddev-sans-first:156234.19 23:57:13 INFO - PROCESS | 2284 | Values: 482.0 487.0 528.0 528.3 598.1 37179.0 38070.0 39285.8 39463.0 39665.6 40148.4 40652.0 41406.6 41450.8 41457.6 9464.6 9606.0 9644.8 9721.0 9725.3 8437.2 9596.4 9616.2 9748.5 9773.3 9700.4 9725.8 9751.7 9754.4 9761.9 9615.4 9701.5 9708.9 9728.2 9772.2 8624.1 8759.3 9153.0 9590.7 9655.9 39330.6 39520.8 39655.0 39685.2 39779.0 2748.4 3374.9 3618.1 3837.3 4330.2 31034.4 31262.0 31479.8 31602.7 32183.7 3130.4 3186.9 3203.8 3219.6 3317.2 393664.0 448582.0 453894.0 456564.0 459805.0 33697.7 33784.3 34044.0 34193.8 34195.0 35287.3 35729.6 35821.9 35992.0 36060.0 12917.4 15021.8 15302.6 15317.2 15333.8 12911.5 13006.9 13017.2 13038.0 13064.5 7802.9 7849.6 7861.7 7913.4 7931.2 3305.1 3310.3 3310.4 3329.7 3345.7 980.8 985.5 1064.3 1083.4 1089.6 21671.9 27701.6 29988.2 31204.0 31972.7 1098.0 1115.4 1132.4 1145.2 1163.3 14497.0 15534.3 15826.2 16202.9 16400.4 663306.0 666874.0 674042.0 675061.0 675163.0 58395.0 58459.0 58807.7 58986.7 59154.7 1402.6 1420.8 1438.4 1449.5 1453.1 28663.6 29741.1 30688.0 31126.5 31486.4 48340.8 48627.0 48991.8 49040.3 49084.0 596069.0 607054.0 607174.0 608335.0 609011.0 27227.0 27680.0 27740.0 28410.7 28627.6 49131.8 49563.8 49741.5 50191.7 50259.0 36302.3 40262.0 40959.6 41773.0 42400.0 31055.8 32023.9 33675.8 38601.8 42191.8 33554.0 39094.4 39398.8 39717.8 39984.0 35308.3 35577.0 35808.5 36105.1 36139.6 25804.7 25824.7 25947.4 26227.3 26662.5 23:57:13 INFO - PROCESS | 2284 | 23:57:13 INFO - PROCESS | 2284 | [#2] jquery.html Cycles:180 Average:35313.09 Median:387.53 stddev:101178.36 (26108.6%) stddev-sans-first:101428.13 23:57:13 INFO - PROCESS | 2284 | Values: 345.3 383.4 387.4 391.7 415.1 16945.7 19939.7 21045.9 21594.0 21711.8 11926.3 12101.0 12229.4 12444.3 12449.3 4872.8 5659.7 5666.9 5669.5 5677.0 3961.3 6606.8 6953.4 6968.9 7033.3 5910.0 6248.1 6937.3 6956.2 6964.3 6211.7 6235.6 6259.6 6260.9 6293.0 5823.7 6130.3 6150.1 6150.2 6157.8 13683.6 13887.4 17240.7 26739.7 26806.2 1917.3 2332.3 2370.2 2385.2 2872.2 9914.4 10145.7 10675.8 10688.1 10692.0 1845.7 1860.6 1926.3 1927.0 1996.8 119804.4 129688.0 129734.0 131746.7 133762.3 11166.6 11183.9 11725.3 11890.9 11975.6 14751.6 14845.2 14963.4 14989.4 15038.3 8539.7 8694.9 8708.2 8749.8 8785.5 7286.5 7897.4 8634.7 8667.9 8808.4 4270.9 4580.0 4584.5 4644.2 4714.3 3238.4 3533.5 3608.0 3940.1 3965.0 344.3 385.5 387.6 431.4 876.7 10067.0 10782.0 11987.2 12153.0 12336.6 431.7 441.9 458.4 465.0 469.6 6187.7 6226.9 6287.7 6341.1 6342.7 524882.0 526222.0 638366.0 646333.0 647474.0 136341.0 141727.0 149053.0 150459.0 153694.2 370.6 458.9 458.9 459.1 460.5 11110.5 11343.1 11641.9 11717.6 11827.0 57435.0 59071.7 59266.1 59591.1 61120.7 75683.5 87001.6 89302.0 89359.6 89974.0 6515.9 8162.8 8263.9 8275.5 8343.6 10844.8 13119.7 13425.9 13539.9 13565.1 10610.3 10789.4 10882.1 10948.9 11727.2 9490.0 11341.5 11359.3 11362.2 11492.9 11784.4 11793.3 11821.6 11902.6 11942.2 6950.7 8362.2 8403.5 8467.2 8481.8 8475.5 10625.6 11489.4 11523.2 11569.3 23:57:13 INFO - PROCESS | 2284 | 23:57:13 INFO - PROCESS | 2284 | [#3] mootools.html Cycles:180 Average:5760.00 Median:4526.10 stddev:3229.72 (71.4%) stddev-sans-first:3221.90 23:57:13 INFO - PROCESS | 2284 | Values: 1366.9 1516.1 1768.0 1962.1 1966.2 7976.1 8055.4 8699.0 9161.6 9175.9 6660.3 8526.3 8682.7 8860.1 8867.9 2355.4 2392.2 2399.4 2402.2 2402.7 2367.9 2383.9 2395.1 2403.7 2413.8 2367.8 2373.8 2385.9 2405.8 2409.1 2127.4 2243.6 2343.7 2350.6 2352.3 2148.4 2226.5 2345.6 2361.8 2363.4 8857.2 8858.1 8960.8 9023.3 9047.2 4410.0 5319.6 5325.0 5348.4 5450.8 3536.6 3608.9 3619.4 3648.1 3649.9 1084.6 1105.2 1110.8 1128.1 1130.9 11705.2 11857.9 11873.9 11896.0 11912.8 3981.8 4177.5 4488.9 4563.3 4723.9 10115.6 10162.8 10170.9 10178.4 10182.9 4668.2 5420.9 5458.1 5461.8 5472.6 4403.9 4779.2 4947.3 4963.2 4985.2 4068.9 4073.4 4131.9 4159.0 4173.0 1290.2 1306.6 1317.1 1324.5 1334.5 864.4 947.0 953.1 957.5 994.6 5958.8 6011.8 6086.3 6163.9 6202.3 970.3 972.2 978.4 1011.3 1032.3 3312.2 4042.2 4064.5 4119.5 4134.4 10297.5 10735.7 10763.6 10769.5 10778.5 10477.7 10655.6 10699.9 10700.3 10720.5 8254.5 8338.6 8354.9 8506.2 8532.6 4666.0 6035.5 6097.5 6128.4 6147.2 9785.4 10049.1 10157.4 10194.9 10236.7 10102.9 10299.5 10460.5 10517.0 10526.6 6719.7 7026.5 7189.9 7194.9 7322.7 8243.6 8559.2 8592.5 8653.5 8658.2 7511.5 7651.7 7655.5 7720.6 7766.8 7498.3 7576.5 7579.2 7703.3 7705.8 6254.9 7178.1 7226.3 7231.3 7272.2 4969.4 5051.4 5084.8 5098.2 5162.7 5144.3 5168.7 5207.2 5240.9 5292.3 23:57:13 INFO - PROCESS | 2284 | 23:57:13 INFO - PROCESS | 2284 | [#4] prototype.html Cycles:180 Average:4879.22 Median:5547.71 stddev:1517.67 (27.4%) stddev-sans-first:1482.82 23:57:13 INFO - PROCESS | 2284 | Values: 318.8 321.6 326.5 326.8 331.5 4606.9 4739.2 5559.2 5644.9 5775.5 5323.4 5735.7 5749.0 5797.3 5851.2 4127.3 4260.9 4385.4 4387.5 4411.9 3915.9 3977.6 4271.0 4395.4 4405.5 4350.4 4364.2 4365.3 4406.6 4418.2 3542.7 4184.0 4261.4 4376.2 4376.7 3718.8 3726.9 3744.2 3753.9 3763.9 5675.1 5677.4 5707.1 5711.3 5723.5 4019.9 4241.9 5043.6 5056.9 5072.8 4784.3 5843.4 5922.7 6121.8 6155.7 3633.8 3661.5 4143.6 4167.5 4170.6 5459.0 6105.9 6151.4 6354.6 6540.4 4072.5 4142.5 4208.6 4214.3 4222.7 3442.8 3801.4 4165.6 4262.9 4304.7 4788.9 5056.8 5060.0 5071.4 5072.2 4806.8 6066.9 6154.0 6190.9 6220.9 1330.3 1377.0 1467.7 1470.5 1471.3 891.6 895.8 902.7 960.8 1010.5 4809.6 5385.9 5622.8 5686.2 5694.7 5539.9 5623.0 5950.8 6278.3 6331.9 4460.9 4956.6 5237.4 5675.9 5688.3 2908.5 3023.8 3279.9 3291.9 3313.6 6125.3 6372.5 6450.9 6585.0 6619.8 5129.4 6108.3 6192.3 6446.0 6467.2 5765.9 6484.3 6506.7 6516.9 6533.7 4753.7 5821.8 6134.0 6147.8 6265.7 5874.2 6202.6 6206.9 6212.3 6213.0 5952.8 6054.0 6482.6 6494.7 6523.4 4080.3 4080.9 4105.5 4209.2 4264.9 5043.4 5538.2 6155.2 6189.8 6262.7 5758.5 5975.5 5984.2 6012.8 6021.9 5555.6 5972.7 5984.1 6001.6 6057.5 4975.9 5283.7 5614.0 5623.7 5854.5 5934.5 6022.4 6102.6 6149.7 6165.5 5098.8 5513.7 5684.9 5956.3 6071.2 23:57:13 INFO - PROCESS | 2284 | 23:57:13 INFO - PROCESS | 2284 | [#5] yui.html Cycles:180 Average:24581.90 Median:4514.63 stddev:40069.99 (887.6%) stddev-sans-first:40142.44 23:57:13 INFO - PROCESS | 2284 | Values: 748.9 778.4 780.2 846.2 877.2 15237.2 15638.9 15815.4 15829.4 15874.7 14017.7 14230.6 14330.6 14524.0 14524.9 715.6 886.4 889.6 924.9 929.3 716.0 801.9 908.7 916.6 918.3 951.4 971.5 974.2 974.3 977.9 958.4 967.0 967.5 968.1 971.3 677.3 688.2 719.6 720.6 726.0 14651.7 15183.6 15326.9 15344.2 15369.0 13640.2 13710.2 13861.4 13968.6 14160.0 13323.3 13333.4 13355.7 13518.2 13545.4 4667.0 4707.3 4711.1 4853.8 4856.5 86782.3 119164.0 123293.4 124243.0 126380.0 9870.3 11119.0 11198.3 11385.3 11515.9 21913.8 21925.8 21935.7 21940.5 21954.3 7681.7 7911.1 8034.0 8043.7 8096.4 4451.6 4509.1 4510.7 4518.6 4525.9 3554.6 3617.3 3646.1 3647.7 3660.3 669.6 677.3 683.3 688.8 693.3 552.9 566.2 594.6 619.2 640.5 8743.7 8987.5 9109.6 9260.3 9290.0 520.9 634.3 637.1 640.6 662.1 3507.4 3610.7 3904.8 4436.9 4446.3 94410.5 112160.0 160117.0 163573.0 163810.0 137904.0 138172.3 138957.9 139002.0 139999.6 88778.8 98273.5 110469.0 113893.0 116941.8 8595.4 8618.0 8639.3 8699.0 8803.3 51277.5 61638.0 61962.0 62693.4 63353.0 89372.0 91323.1 91951.0 92397.6 92673.0 9827.3 11399.3 11413.7 11515.7 12000.7 9926.5 12035.8 12111.2 12364.9 12690.3 11831.6 11956.5 11960.2 11966.9 12105.0 11902.4 12047.0 12156.4 12371.9 12456.8 10209.9 11914.8 12088.3 12232.8 12273.4 9734.4 9790.3 9821.2 10050.9 10310.2 9802.7 9922.9 10069.6 10104.4 10147.8 23:57:13 INFO - PROCESS | 2284 | -------- Summary: end -------- 23:57:13 INFO - PROCESS | 2284 | 23:57:14 INFO - TEST-INFO | 2284: exit 0 23:57:14 INFO - TEST-OK | dromaeo_css | took 1113578ms 23:57:14 INFO - TEST-START | kraken 23:57:14 INFO - operating with platform_type : mac_ 23:57:14 INFO - Initialising browser for kraken test... 23:57:14 INFO - TEST-INFO | started process 2289 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmp2s8jx_/profile http://localhost:58100/getInfo.html) 23:57:17 INFO - PROCESS | 2289 | __metrics Screen width/height:1600/1200 23:57:17 INFO - PROCESS | 2289 | colorDepth:24 23:57:17 INFO - PROCESS | 2289 | Browser inner width/height: 1024/689 23:57:17 INFO - PROCESS | 2289 | __metrics 23:57:17 ERROR - PROCESS | 2289 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2952: TypeError: this.tabs is undefined 23:57:17 INFO - TEST-INFO | 2289: exit 0 23:57:17 INFO - Browser initialized. 23:57:17 INFO - Running cycle 1/1 for kraken test... 23:57:17 INFO - TEST-INFO | started process 2291 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/T/tmp2s8jx_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:57:29 INFO - PROCESS | 2291 | RSS: Main: 256020480 23:57:29 INFO - PROCESS | 2291 | 23:57:32 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:58100/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58100/tests/kraken/driver.html?testName=audio-beat-detection) 23:57:33 INFO - PROCESS | 2291 | RSS: Main: 269156352 23:57:33 INFO - PROCESS | 2291 | 23:57:36 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:58100/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58100/tests/kraken/driver.html?testName=audio-dft) 23:57:36 INFO - PROCESS | 2291 | RSS: Main: 272867328 23:57:36 INFO - PROCESS | 2291 | 23:57:40 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:58100/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58100/tests/kraken/driver.html?testName=audio-fft) 23:57:40 INFO - PROCESS | 2291 | RSS: Main: 273051648 23:57:40 INFO - PROCESS | 2291 | 23:57:42 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:58100/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58100/tests/kraken/driver.html?testName=audio-oscillator) 23:57:43 INFO - PROCESS | 2291 | RSS: Main: 273940480 23:57:43 INFO - PROCESS | 2291 | 23:57:45 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:58100/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58100/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:57:45 INFO - PROCESS | 2291 | RSS: Main: 274747392 23:57:45 INFO - PROCESS | 2291 | 23:57:48 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:58100/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58100/tests/kraken/driver.html?testName=imaging-darkroom) 23:57:49 INFO - PROCESS | 2291 | RSS: Main: 274632704 23:57:49 INFO - PROCESS | 2291 | 23:57:52 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:58100/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58100/tests/kraken/driver.html?testName=imaging-desaturate) 23:57:53 INFO - PROCESS | 2291 | RSS: Main: 275472384 23:57:53 INFO - PROCESS | 2291 | 23:57:56 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:58100/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58100/tests/kraken/driver.html?testName=json-parse-financial) 23:57:56 INFO - PROCESS | 2291 | RSS: Main: 275763200 23:57:56 INFO - PROCESS | 2291 | 23:57:58 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:58100/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58100/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:57:59 INFO - PROCESS | 2291 | RSS: Main: 275398656 23:57:59 INFO - PROCESS | 2291 | 23:58:01 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:58100/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58100/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:58:01 INFO - PROCESS | 2291 | RSS: Main: 275193856 23:58:01 INFO - PROCESS | 2291 | 23:58:03 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:58100/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58100/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:58:04 INFO - PROCESS | 2291 | RSS: Main: 275484672 23:58:04 INFO - PROCESS | 2291 | 23:58:07 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:58100/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58100/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:58:08 INFO - PROCESS | 2291 | RSS: Main: 275701760 23:58:08 INFO - PROCESS | 2291 | 23:58:10 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:58100/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58100/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:58:11 INFO - PROCESS | 2291 | RSS: Main: 275562496 23:58:11 INFO - PROCESS | 2291 | 23:58:13 INFO - PROCESS | 2291 | Cycle 1(1): loaded http://localhost:58100/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58100/tests/kraken/driver.html?testName=ai-astar) 23:58:13 INFO - PROCESS | 2291 | RSS: Main: 276746240 23:58:13 INFO - PROCESS | 2291 | 23:58:13 INFO - PROCESS | 2291 | __start_tp_report 23:58:13 INFO - PROCESS | 2291 | _x_x_mozilla_page_load 23:58:13 INFO - PROCESS | 2291 | _x_x_mozilla_page_load_details 23:58:13 INFO - PROCESS | 2291 | |i|pagename|runs| 23:58:13 INFO - PROCESS | 2291 | |0;ai-astar;103;125;110;116;116;115;113;116;115;115 23:58:13 INFO - PROCESS | 2291 | |1;audio-beat-detection;148;108;132;152;110;150;166;94;197;144 23:58:13 INFO - PROCESS | 2291 | |2;audio-dft;194;197;194;218;270;198;193;197;205;195 23:58:13 INFO - PROCESS | 2291 | |3;audio-fft;71;80;69;110;57;57;57;62;132;58 23:58:13 INFO - PROCESS | 2291 | |4;audio-oscillator;68;71;118;70;71;93;115;69;72;119 23:58:13 INFO - PROCESS | 2291 | |5;imaging-gaussian-blur;135;132;88;91;89;96;136;86;90;88 23:58:13 INFO - PROCESS | 2291 | |6;imaging-darkroom;120;95;139;157;136;93;97;97;94;111 23:58:13 INFO - PROCESS | 2291 | |7;imaging-desaturate;137;150;96;94;90;90;96;143;149;90 23:58:13 INFO - PROCESS | 2291 | |8;json-parse-financial;55;57;56;56;53;59;63;83;78;56 23:58:13 INFO - PROCESS | 2291 | |9;json-stringify-tinderbox;66;82;64;76;78;75;74;70;69;68 23:58:13 INFO - PROCESS | 2291 | |10;stanford-crypto-aes;88;86;86;86;97;101;81;82;88;86 23:58:13 INFO - PROCESS | 2291 | |11;stanford-crypto-ccm;135;136;144;120;138;142;167;128;171;157 23:58:13 INFO - PROCESS | 2291 | |12;stanford-crypto-pbkdf2;161;195;152;224;205;166;158;162;161;162 23:58:13 INFO - PROCESS | 2291 | |13;stanford-crypto-sha256-iterative;65;69;66;66;73;73;84;85;87;84 23:58:13 INFO - PROCESS | 2291 | __end_tp_report 23:58:13 INFO - PROCESS | 2291 | __start_cc_report 23:58:13 INFO - PROCESS | 2291 | _x_x_mozilla_cycle_collect,1107 23:58:13 INFO - PROCESS | 2291 | __end_cc_report 23:58:13 INFO - PROCESS | 2291 | __startTimestamp1467788293578__endTimestamp 23:58:13 INFO - PROCESS | 2291 | 23:58:13 INFO - PROCESS | 2291 | ------- Summary: start ------- 23:58:13 INFO - PROCESS | 2291 | Number of tests: 14 23:58:13 INFO - PROCESS | 2291 | 23:58:13 INFO - PROCESS | 2291 | [#0] ai-astar Cycles:10 Average:114.40 Median:115.50 stddev:5.50 (4.8%) stddev-sans-first:4.00 23:58:13 INFO - PROCESS | 2291 | Values: 103.0 125.0 110.0 116.0 116.0 115.0 113.0 116.0 115.0 115.0 23:58:13 INFO - PROCESS | 2291 | 23:58:13 INFO - PROCESS | 2291 | [#1] audio-beat-detection Cycles:10 Average:140.10 Median:151.00 stddev:30.46 (20.2%) stddev-sans-first:32.18 23:58:13 INFO - PROCESS | 2291 | Values: 148.0 108.0 132.0 152.0 110.0 150.0 166.0 94.0 197.0 144.0 23:58:13 INFO - PROCESS | 2291 | 23:58:13 INFO - PROCESS | 2291 | [#2] audio-dft Cycles:10 Average:206.10 Median:197.50 stddev:23.68 (12.0%) stddev-sans-first:24.70 23:58:13 INFO - PROCESS | 2291 | Values: 194.0 197.0 194.0 218.0 270.0 198.0 193.0 197.0 205.0 195.0 23:58:13 INFO - PROCESS | 2291 | 23:58:13 INFO - PROCESS | 2291 | [#3] audio-fft Cycles:10 Average:75.30 Median:60.00 stddev:25.78 (43.0%) stddev-sans-first:27.29 23:58:13 INFO - PROCESS | 2291 | Values: 71.0 80.0 69.0 110.0 57.0 57.0 57.0 62.0 132.0 58.0 23:58:13 INFO - PROCESS | 2291 | 23:58:13 INFO - PROCESS | 2291 | [#4] audio-oscillator Cycles:10 Average:86.60 Median:70.50 stddev:22.40 (31.8%) stddev-sans-first:22.72 23:58:13 INFO - PROCESS | 2291 | Values: 68.0 71.0 118.0 70.0 71.0 93.0 115.0 69.0 72.0 119.0 23:58:13 INFO - PROCESS | 2291 | 23:58:13 INFO - PROCESS | 2291 | [#5] imaging-gaussian-blur Cycles:10 Average:103.10 Median:88.50 stddev:21.73 (24.6%) stddev-sans-first:19.75 23:58:13 INFO - PROCESS | 2291 | Values: 135.0 132.0 88.0 91.0 89.0 96.0 136.0 86.0 90.0 88.0 23:58:13 INFO - PROCESS | 2291 | 23:58:13 INFO - PROCESS | 2291 | [#6] imaging-darkroom Cycles:10 Average:113.90 Median:93.50 stddev:23.05 (24.7%) stddev-sans-first:24.35 23:58:13 INFO - PROCESS | 2291 | Values: 120.0 95.0 139.0 157.0 136.0 93.0 97.0 97.0 94.0 111.0 23:58:13 INFO - PROCESS | 2291 | 23:58:13 INFO - PROCESS | 2291 | [#7] imaging-desaturate Cycles:10 Average:113.50 Median:90.00 stddev:27.21 (30.2%) stddev-sans-first:27.50 23:58:13 INFO - PROCESS | 2291 | Values: 137.0 150.0 96.0 94.0 90.0 90.0 96.0 143.0 149.0 90.0 23:58:13 INFO - PROCESS | 2291 | 23:58:13 INFO - PROCESS | 2291 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:58.00 stddev:10.37 (17.9%) stddev-sans-first:10.72 23:58:13 INFO - PROCESS | 2291 | Values: 55.0 57.0 56.0 56.0 53.0 59.0 63.0 83.0 78.0 56.0 23:58:13 INFO - PROCESS | 2291 | 23:58:13 INFO - PROCESS | 2291 | [#9] json-stringify-tinderbox Cycles:10 Average:72.20 Median:74.50 stddev:5.71 (7.7%) stddev-sans-first:5.60 23:58:13 INFO - PROCESS | 2291 | Values: 66.0 82.0 64.0 76.0 78.0 75.0 74.0 70.0 69.0 68.0 23:58:13 INFO - PROCESS | 2291 | 23:58:13 INFO - PROCESS | 2291 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:86.00 stddev:6.24 (7.3%) stddev-sans-first:6.62 23:58:13 INFO - PROCESS | 2291 | Values: 88.0 86.0 86.0 86.0 97.0 101.0 81.0 82.0 88.0 86.0 23:58:13 INFO - PROCESS | 2291 | 23:58:13 INFO - PROCESS | 2291 | [#11] stanford-crypto-ccm Cycles:10 Average:143.80 Median:143.00 stddev:16.48 (11.5%) stddev-sans-first:17.17 23:58:13 INFO - PROCESS | 2291 | Values: 135.0 136.0 144.0 120.0 138.0 142.0 167.0 128.0 171.0 157.0 23:58:13 INFO - PROCESS | 2291 | 23:58:13 INFO - PROCESS | 2291 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.60 Median:164.00 stddev:24.33 (14.8%) stddev-sans-first:25.31 23:58:13 INFO - PROCESS | 2291 | Values: 161.0 195.0 152.0 224.0 205.0 166.0 158.0 162.0 161.0 162.0 23:58:13 INFO - PROCESS | 2291 | 23:58:13 INFO - PROCESS | 2291 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.20 Median:78.50 stddev:8.89 (11.3%) stddev-sans-first:8.63 23:58:13 INFO - PROCESS | 2291 | Values: 65.0 69.0 66.0 66.0 73.0 73.0 84.0 85.0 87.0 84.0 23:58:13 INFO - PROCESS | 2291 | -------- Summary: end -------- 23:58:13 INFO - PROCESS | 2291 | 23:58:14 INFO - TEST-INFO | 2291: exit 0 23:58:14 INFO - TEST-OK | kraken | took 60231ms 23:58:14 INFO - SUITE-END | took 1173s 23:58:14 INFO - Completed test suite (00:19:34) 23:58:14 INFO - javascript benchmark 23:58:14 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7270.709525447281, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3269.0192942117365, 3362.0754292569554, 3392.3554524640326, 3394.2532642818587, 3407.148212946763, 4415.624671902892, 5213.244079608459, 5454.781808727646, 5783.797567085153, 5784.103463963087, 5700.1449782532645, 5732.312122545301, 5740.253767010283, 5799.13013048043, 5809.0, 5206.167013277876, 5237.816676416326, 5249.212618107276, 5340.06548853951, 5383.569314454834, 5372.973135134319, 5394.6493477924005, 5437.293151890269, 5440.727963601804, 5444.292242008553, 5178.14560597501, 5195.558377537914, 5240.3187585614005, 5304.522592966613, 5335.279737235482, 5251.632385733, 5268.8155914543195, 5295.602829787781, 5337.626366154371, 5376.220448035013, 5288.0, 5295.523402893758, 5321.122014867542, 5340.118880384732, 5369.5972802040005, 5034.496550344973, 5711.428857114297, 5902.822915312548, 5934.1692163097205, 5961.612495187799, 6145.385461453863, 6230.750769969196, 6264.906026409608, 6270.372962703693, 6273.0904018917, 6142.560166306837, 6165.136880836686, 6237.157983672237, 6291.433770960635, 6302.873942521124, 5908.67502287374, 5963.194968679173, 5981.970090149608, 5986.431289027535, 6030.758769649165, 5507.421720719347, 6377.904331435032, 6388.329225431356, 6431.710573024225, 6444.7744328948265, 5230.555402790806, 6143.266246520256, 6166.537509686791, 6217.658028808459, 6237.220347456568, 5546.528545073714, 6164.907526387108, 6280.340564240781, 6297.244330680348, 6305.684715764193, 6119.533019689859, 6129.0, 6228.5017198624, 6249.281332646713, 6266.592671476339, 6141.056449558059, 6174.536909731788, 6198.6280823150755, 6201.7519299228425, 6253.1245625612455, 4994.700317980933, 4998.125328067574, 5001.824936127291, 5016.2224855147515, 5042.268871013755, 4418.6023257906945, 4447.132809102194, 4480.753558554311, 4504.189245935698, 4535.682502224812, 5778.508826749689, 5935.317438494629, 5972.0, 5997.520198384119, 6010.789622363196, 5604.523615492647, 6226.0, 6233.0, 6258.624482530971, 6278.434940855345, 6006.759729610767, 6010.609310394898, 6016.729247183887, 6033.42682445167, 6039.939600603938, 5410.864728381822, 5499.092649712753, 5526.171074338801, 5559.805406810742, 5561.58288128392, 6501.577397469149, 6543.116679248241, 6543.869122617616, 6546.869062618816, 6554.049662798868, 6168.321484636596, 6309.49524038085, 6314.55798094129, 6317.4630156437215, 6331.398517140864, 6398.4561312287115, 6412.198475190601, 6458.644774537445, 6483.027545868157, 6530.902036469552, 6209.192804935329, 6229.221347331583, 6241.594296370721, 6262.436380725757, 6264.812055638338, 5888.263967004124, 6170.56806023592, 6228.844278892882, 6272.278687950944, 6291.339409361951, 6104.853288833144, 6112.898653789679, 6113.57204995646, 6153.969230153821, 6232.937670623236, 6108.4807791338235, 6173.0, 6179.81460556184, 6184.845378865564, 6190.876182476415, 4856.465788763304, 5435.23906653061, 5925.0, 5971.822601448591, 6087.117367981707, 6114.0236562776045, 6114.266954506099, 6162.322144564005, 6176.567640265138, 6263.404976527223, 6082.087686847009, 6104.0, 6104.572679912363, 6114.969425153024, 6116.944513560587], "value": 5744.750375460351, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [481.9926353920307, 486.96276930138805, 528.0495108804151, 528.252522680407, 598.0550729846842, 37179.0, 38070.0, 39285.803570982105, 39463.0, 39665.603343966555, 40148.397774033416, 40652.0, 41406.58593414065, 41450.792746036306, 41457.58542414575, 9464.621415143385, 9606.039396060409, 9644.807103857918, 9721.0, 9725.27060470464, 8437.240648341649, 9596.424214547114, 9616.23070154386, 9748.512574371252, 9773.26700497462, 9700.369475984038, 9725.756856078584, 9751.658691945784, 9754.414735115915, 9761.853572196424, 9615.375000624937, 9701.466419346933, 9708.854367184498, 9728.17310528606, 9772.169365603932, 8624.137586241388, 8759.255463285628, 9153.0, 9590.712278631583, 9655.855162172573, 39330.60669393327, 39520.802395988125, 39655.0, 39685.20629587392, 39779.00552486182, 2748.40909204522, 3374.8650053997812, 3618.0773902654655, 3837.2517359114986, 4330.17726631939, 31034.37931241385, 31262.0, 31479.84260078708, 31602.683973160434, 32183.6781632183, 3130.4365214261425, 3186.920326991844, 3203.823789691566, 3219.613646362428, 3317.1872891141825, 393664.0, 448582.0, 453894.0, 456564.0, 459805.0, 33697.66302336945, 33784.32431351359, 34044.0, 34193.829030854686, 34195.0, 35287.29425411477, 35729.642703573154, 35821.925342239774, 35992.0, 36060.0, 12917.354132293347, 15021.849781502264, 15302.617434564003, 15317.23413829304, 15333.846661533466, 12911.483540658268, 13006.934965325112, 13017.153884997444, 13038.0, 13064.477420903057, 7802.921970780219, 7849.568273744884, 7861.685532578747, 7913.406494512819, 7931.167227441151, 3305.1076209423322, 3310.2551925816497, 3310.4372256716415, 3329.6836800503916, 3345.6988871001727, 980.8136454073704, 985.4973963278779, 1064.3401091323428, 1083.409541799721, 1089.6404186618397, 21671.891640541697, 27701.584476232874, 29988.201852856575, 31204.0, 31972.680273197435, 1097.9670609881716, 1115.4478533126155, 1132.3828513460185, 1145.1983611472003, 1163.319458117011, 14497.0, 15534.300956456986, 15826.208689565476, 16202.946808457413, 16400.425985090464, 663306.0, 666874.0, 674042.0, 675061.0, 675163.0, 58395.0, 58459.0, 58807.70596146992, 58986.705066474395, 59154.70422647859, 1402.5511836212313, 1420.779779134236, 1438.4030627289767, 1449.4854326713864, 1453.0627745104136, 28663.570046448902, 29741.14793534632, 30688.0, 31126.53310200394, 31486.37027259488, 48340.758296208296, 48627.027459449906, 48991.75504122599, 49040.2643960348, 49084.0, 596069.0, 607054.0, 607174.0, 608335.0, 609011.0, 27227.0, 27680.0, 27740.0, 28410.715892841636, 28627.570586441638, 49131.754341228065, 49563.752181238866, 49741.502584973685, 50191.74904125456, 50259.0, 36302.27395452129, 40262.0, 40959.59040409558, 41773.0, 42400.0, 31055.84472077625, 32023.855309754294, 33675.83162084174, 38601.80699096486, 42191.789041054595, 33554.0, 39094.4135837957, 39398.81803545898, 39717.80141099276, 39984.0, 35308.29383412369, 35577.0, 35808.46287305745, 36105.0973725659, 36139.638603613625, 25804.741952580232, 25824.741752582235, 25947.351316217246, 26227.344316392242, 26662.46675066449], "value": 18581.511844288172, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [345.2938740276135, 383.38849534991687, 387.44595228822783, 391.67490982484543, 415.1158033388881, 16945.745813812802, 19939.700904486424, 21045.894770526127, 21594.028268727907, 21711.782882171174, 11926.28442293463, 12101.0, 12229.38853057348, 12444.315562644051, 12449.315287659176, 4872.829450969217, 5659.717014149297, 5666.943330566683, 5669.461401166883, 5676.971615141919, 3961.2671655743634, 6606.768763093292, 6953.408960238386, 6968.860622787542, 7033.261507541685, 5910.0, 6248.062790581426, 6937.306269373073, 6956.234814170462, 6964.303569643046, 6211.720472578722, 6235.625862448245, 6259.624422534663, 6260.937390626081, 6292.968535157341, 5823.650580965155, 6130.264368275791, 6150.077488376734, 6150.231221097363, 6157.815265542041, 13683.589492315146, 13887.4445022199, 17240.741388879178, 26739.732602673917, 26806.195814125607, 1917.3481016454473, 2332.3352844439255, 2370.2059809963685, 2385.2009576791797, 2872.238856702975, 9914.355566888129, 10145.695629131138, 10675.786484270271, 10688.14494840411, 10692.037716605542, 1845.6677797996356, 1860.5534671678836, 1926.268018153093, 1926.951826204342, 1996.8003199679915, 119804.40097799542, 129688.0, 129734.0, 131746.6825331744, 133762.33118834344, 11166.553337866395, 11183.944080279709, 11725.296482211095, 11890.940545297219, 11975.64073077809, 14751.631209219855, 14845.183514906568, 14963.40146394132, 14989.400423983137, 15038.32327545263, 8539.676350165735, 8694.91305086941, 8708.216260536456, 8749.825003499895, 8785.51679657625, 7286.4899457038555, 7897.447178697436, 8634.697785577475, 8667.913320866837, 8808.427452215585, 4270.914581708348, 4579.977100114545, 4584.541545845455, 4644.164050470948, 4714.316424118484, 3238.36851813894, 3533.505309256706, 3608.0258330250686, 3940.0937784309767, 3965.0285680008583, 344.2924789557433, 385.5161771976152, 387.61238761238764, 431.43697474795067, 876.7019213467452, 10067.0, 10782.029617334478, 11987.22083064598, 12153.027757779357, 12336.62990110298, 431.66977262394295, 441.8740658912259, 458.44757067733303, 465.0304115918348, 469.6383784485927, 6187.659678717714, 6226.875462490725, 6287.717052732638, 6341.112244285804, 6342.714577844008, 524882.0, 526222.0, 638366.0, 646333.0, 647474.0, 136340.99999999802, 141727.0, 149053.0, 150459.0, 153694.23152884163, 370.6071564142018, 458.89904221070645, 458.8990422107131, 459.11161901720277, 460.4842576314549, 11110.500027498943, 11343.128383816578, 11641.941790291334, 11717.589884354007, 11826.994705450134, 57435.0, 59071.70464147652, 59266.111008334046, 59591.1061334089, 61120.694396529514, 75683.48633027419, 87001.56499217464, 89302.0, 89359.55320223357, 89974.0, 6515.934840651533, 8162.755117346489, 8263.876041859257, 8275.462094963808, 8343.624536895733, 10844.837327440253, 13119.737605248032, 13425.932870335586, 13539.932300338829, 13565.050446468653, 10610.310329828846, 10789.352638841694, 10882.129429645767, 10948.945255273673, 11727.179097463095, 9489.952550237205, 11341.546338146381, 11359.261647993184, 11362.204645674723, 11492.94253528727, 11784.351860647746, 11793.29240245588, 11821.645350639494, 11902.583409580624, 11942.16404851652, 6950.65246737651, 8362.205590468895, 8403.453775504573, 8467.237948584658, 8481.787955301166, 8475.49147051179, 10625.574977000833, 11489.368084755084, 11523.193376463567, 11569.305841649528], "value": 8788.494115292358, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.8633136686333, 1516.0827699241954, 1767.964640707186, 1962.0876292523965, 1966.2135145941631, 7976.122626511079, 8055.355571554276, 8699.0, 9161.587728552215, 9175.908240917588, 6660.300668429805, 8526.275266602346, 8682.73951781446, 8860.069692682273, 8867.935847698285, 2355.3640517060426, 2392.246442370648, 2399.436132508859, 2402.1592442645024, 2402.651615515758, 2367.8579285242854, 2383.9284821455385, 2395.1257790906366, 2403.6995375578053, 2413.8431001984814, 2367.75138610446, 2373.8338316317863, 2385.916492922748, 2405.795507381875, 2409.144753612469, 2127.414960885761, 2243.607368710469, 2343.718753749544, 2350.612148995422, 2352.3413444235644, 2148.419926619804, 2226.5212979209387, 2345.6247000479843, 2361.775631315022, 2363.3855197648563, 8857.247133993618, 8858.11418858109, 8960.820783584291, 9023.323250756219, 9047.18575328217, 4410.0, 5319.5744340452675, 5324.973375133139, 5348.411674715778, 5450.836474905759, 3536.5579302587175, 3608.873689420884, 3619.3847046002243, 3648.106213977566, 3649.872254471081, 1084.6474895658941, 1105.2429086076063, 1110.838928355392, 1128.0749785176158, 1130.8812574679623, 11705.239159454693, 11857.881421185764, 11873.881261187364, 11896.048316134775, 11912.821307680391, 3981.8009099544906, 4177.540470548237, 4488.865334039984, 4563.338315944169, 4723.905521889612, 10115.645952391778, 10162.796744065077, 10170.949145254375, 10178.389296642225, 10182.898171018343, 4668.206404911173, 5420.864478388072, 5458.099413596712, 5461.808836690697, 5472.589555783332, 4403.889902752457, 4779.211430113992, 4947.332110165154, 4963.156263435225, 4985.152524070917, 4068.9390887384748, 4073.368627862686, 4131.938020929689, 4158.958410415918, 4173.040200753843, 1290.2000759528964, 1306.6210798868221, 1317.0583033131356, 1324.4966912573161, 1334.5129027904745, 864.3517361978517, 946.9573869175904, 953.1040821627648, 957.482959202037, 994.5822754443151, 5958.821235362946, 6011.759529618854, 6086.2696476422225, 6163.907541386883, 6202.255729312511, 970.2965350121106, 972.1833659725864, 978.4422878959067, 1011.3375738891039, 1032.3341444768082, 3312.2381852174135, 4042.2319759245647, 4064.4716186895516, 4119.485064366954, 4134.441850350225, 10297.53661085253, 10735.677929662123, 10763.56945722178, 10769.461526923622, 10778.461076946121, 10477.68566942993, 10655.57377704883, 10699.94650026745, 10700.30448020876, 10720.517576709066, 8254.54599996994, 8338.62476188573, 8354.916450835535, 8506.234438900405, 8532.573371331533, 4665.976670116627, 6035.517158627212, 6097.481714054177, 6128.356522565066, 6147.200863887666, 9785.36395134314, 10049.14582260516, 10157.441340726036, 10194.949025254826, 10236.744081398025, 10102.89897101049, 10299.536520856429, 10460.47697615101, 10517.000884916226, 10526.631567895087, 6719.731210751515, 7026.508144429841, 7189.892151617834, 7194.856102877809, 7322.743703970335, 8243.629036693243, 8559.22966932979, 8592.484450932963, 8653.480791152551, 8658.177473140042, 7511.474196806171, 7651.655675494505, 7655.46411751172, 7720.613969301625, 7766.766996990099, 7498.32515073646, 7576.469647124648, 7579.204183560647, 7703.268189521987, 7705.7688269349765, 6254.906176407267, 7178.102737157856, 7226.277372262942, 7231.3130252625915, 7272.200057993511, 4969.35398398206, 5051.419086805065, 5084.771185296597, 5098.209777484496, 5162.741862906914, 5144.331236939174, 5168.689878607295, 5207.192885102815, 5240.921386179134, 5292.259083728204], "value": 4644.384012205833, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.7816345803125, 321.6124569893279, 326.4955643530743, 326.76636205113346, 331.47626749735423, 4606.930896036562, 4739.194336962716, 5559.191953511842, 5644.887102257952, 5775.5090817280525, 5323.414424413321, 5735.741891614877, 5748.9939260629435, 5797.275340582427, 5851.239338885949, 4127.307803800442, 4260.914781704364, 4385.386045953569, 4387.495438024636, 4411.867643970686, 3915.941260881089, 3977.602239776014, 4270.957290427087, 4395.428594282739, 4405.493368262642, 4350.4344435223375, 4364.236258654739, 4365.3451982202605, 4406.603405693487, 4418.248897687401, 3542.681158695704, 4183.97908010461, 4261.360795880627, 4376.212281789277, 4376.6936314458, 3718.8140592970512, 3726.863306691485, 3744.1575645479547, 3753.906152346186, 3763.9059023524355, 5675.120356344773, 5677.403872593401, 5707.145177817226, 5711.314642242957, 5723.511886909433, 4019.934717299918, 4241.915161696779, 5043.62172837035, 5056.924146137811, 5072.797088116471, 4784.30627559002, 5843.4448727371255, 5922.733476993546, 6121.785737499166, 6155.660848877398, 3633.836477358499, 3661.498785497933, 4143.57046818847, 4167.4790651168605, 4170.562090980434, 5459.0, 6105.938940610626, 6151.401430163404, 6354.5551811373225, 6540.416535468464, 4072.511298644182, 4142.523609784853, 4208.558101399371, 4214.262504061777, 4222.662187025031, 3442.829437991095, 3801.3917773156713, 4165.562615925284, 4262.936055959101, 4304.677149213759, 4788.856334309976, 5056.797728090909, 5059.974700126476, 5071.449985010508, 5072.15959062926, 4806.7836947337455, 6066.938285799967, 6153.953827849276, 6190.9475389183945, 6220.937790622036, 1330.303862575205, 1376.9586912392645, 1467.7284702330103, 1470.4632809024629, 1471.3305446022034, 891.6477991193442, 895.8297923394534, 902.7111324376136, 960.7550074730899, 1010.5048526222246, 4809.639277054235, 5385.865353366197, 5622.803201887914, 5686.175504551817, 5694.6583205007, 5539.864327812788, 5622.971885140548, 5950.821475355746, 6278.300330857775, 6331.905021424683, 4460.8661740147845, 4956.553910148104, 5237.39109583564, 5675.864827034609, 5688.260526131659, 2908.5200941844782, 3023.8488075596574, 3279.868445386338, 3291.9341613167603, 3313.624845689012, 6125.295591007091, 6372.4583410409705, 6450.903236451457, 6584.967075164594, 6619.768308109193, 5129.435762066169, 6108.297545782203, 6192.287886892975, 6446.0, 6467.191601049774, 5765.933302339081, 6484.254310754323, 6506.674666266667, 6516.902246466307, 6533.738650453929, 4753.6672432930745, 5821.825345239649, 6134.04922237054, 6147.848253111375, 6265.655388953469, 5874.240486088821, 6202.5658203925295, 6206.875862482635, 6212.347703491249, 6212.968935155295, 5952.821415357546, 6053.969730151321, 6482.643454610042, 6494.740210391531, 6523.412892839668, 4080.3063479208013, 4080.8571699990357, 4105.548389677193, 4209.221294060609, 4264.850730224427, 5043.445221025758, 5538.196961440488, 6155.199824022849, 6189.783357582463, 6262.68686565679, 5758.510526605285, 5975.521958243417, 5984.229935140834, 6012.819615411545, 6021.939780602138, 5555.555555555581, 5972.70136493165, 5984.12761874294, 6001.609895356788, 6057.4851137653795, 4975.9004819902675, 5283.7093959831045, 5614.0, 5623.746931388179, 5854.511832471268, 5934.465898069022, 6022.36765139654, 6102.626908945452, 6149.739303442873, 6165.537584681257, 5098.847034588968, 5513.696746678971, 5684.886302274014, 5956.319656154661, 6071.210742603434], "value": 4394.72550437401, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.8539734751724, 778.4395235430488, 780.2041917244411, 846.1876598465473, 877.157928388747, 15237.16195609241, 15638.921805390986, 15815.44645937391, 15829.445969391074, 15874.68250634988, 14017.719645607107, 14230.644233894158, 14330.570082897504, 14524.0, 14524.854751452482, 715.5599306426536, 886.4282537763139, 889.5552223888056, 924.8843894513186, 929.3308817651314, 715.989260161098, 801.8797180422924, 908.7092130518237, 916.6425094213229, 918.3479729392106, 951.4006176109076, 971.5288085278635, 974.1768205866032, 974.3423189347197, 977.9168770654503, 958.4249450329816, 966.970990870275, 967.5404183013083, 968.1141755293897, 971.2569884038716, 677.2719326723792, 688.1501345837886, 719.6437763307144, 720.6432815756182, 725.9637018149124, 14651.706965860623, 15183.62040948974, 15326.927115101947, 15344.232788360538, 15369.0, 13640.249786261751, 13710.177389356571, 13861.445542178402, 13968.58094257174, 14160.0, 13323.333833308392, 13333.39999700006, 13355.732885342335, 13518.188908665414, 13545.390457429341, 4666.9766651166865, 4707.340972263886, 4711.057788442326, 4853.830115945961, 4856.525333413039, 86782.26435471255, 119164.0, 123293.38353308266, 124243.0, 126380.0, 9870.30907836459, 11119.0, 11198.272112312674, 11385.259958102697, 11515.942420288013, 21913.780862191175, 21925.780742192692, 21935.67096493554, 21940.45148871291, 21954.34136975893, 7681.692732290758, 7911.090224624242, 8034.0, 8043.718469853527, 8096.392770542233, 4451.59935605797, 4509.143262780061, 4510.661700372485, 4518.593326600556, 4525.909481810345, 3554.591222009502, 3617.330793803102, 3646.08847788053, 3647.6717095461004, 3660.2862441824122, 669.5714742564762, 677.3057615943698, 683.3030309084705, 688.8243497908102, 693.2893783871572, 552.917062440629, 566.1564269238804, 594.5927039977629, 619.2135987296109, 640.484410049905, 8743.737687869374, 8987.46075235488, 9109.635614575343, 9260.30547708911, 9289.953550232342, 520.903632827928, 634.3276127305071, 637.1494055436045, 640.5964242527178, 662.1127688896901, 3507.3686736387185, 3610.7291953103095, 3904.843806247775, 4436.911261774746, 4446.288593824973, 94410.52794735982, 112160.0, 160117.0, 163573.0, 163810.0, 137904.0, 138172.30913845566, 138957.9156312656, 139002.0, 139999.6000040007, 88778.82865411628, 98273.50863245637, 110469.0, 113893.0, 116941.8305816948, 8595.44129631572, 8618.0, 8639.265662418513, 8698.999615044351, 8803.251723603566, 51277.48722512877, 61638.0, 61962.0, 62693.43266418376, 63353.0, 89372.0, 91323.08676913411, 91951.0, 92397.61403579086, 92673.0, 9827.253378211213, 11399.316041037564, 11413.714657133305, 11515.654530364103, 12000.699982500159, 9926.454045027593, 12035.75928481408, 12111.152219344562, 12364.876351236373, 12690.302033388252, 11831.645050648494, 11956.521739130338, 11960.222585531912, 11966.880331196577, 12105.0, 11902.383756466284, 12047.0, 12156.392180391122, 12371.876281237073, 12456.813147802972, 10209.9489502552, 11914.76170476603, 12088.274703517816, 12232.816507752568, 12273.386330683608, 9734.36726612768, 9790.314677972758, 9821.214302855611, 10050.949745251228, 10310.226732994905, 9802.705918822447, 9922.900770992486, 10069.597216111273, 10104.444255566015, 10147.797044059225], "value": 7714.283628127467, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1568.4999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 125.0, 110.0, 116.0, 116.0, 115.0, 113.0, 116.0, 115.0, 115.0], "value": 114.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 108.0, 132.0, 152.0, 110.0, 150.0, 166.0, 94.0, 197.0, 144.0], "value": 140.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 197.0, 194.0, 218.0, 270.0, 198.0, 193.0, 197.0, 205.0, 195.0], "value": 206.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 80.0, 69.0, 110.0, 57.0, 57.0, 57.0, 62.0, 132.0, 58.0], "value": 75.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 71.0, 118.0, 70.0, 71.0, 93.0, 115.0, 69.0, 72.0, 119.0], "value": 86.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 88.0, 91.0, 89.0, 96.0, 136.0, 86.0, 90.0, 88.0], "value": 103.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 95.0, 139.0, 157.0, 136.0, 93.0, 97.0, 97.0, 94.0, 111.0], "value": 113.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 150.0, 96.0, 94.0, 90.0, 90.0, 96.0, 143.0, 149.0, 90.0], "value": 113.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 57.0, 56.0, 56.0, 53.0, 59.0, 63.0, 83.0, 78.0, 56.0], "value": 61.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 82.0, 64.0, 76.0, 78.0, 75.0, 74.0, 70.0, 69.0, 68.0], "value": 72.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 86.0, 86.0, 97.0, 101.0, 81.0, 82.0, 88.0, 86.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 136.0, 144.0, 120.0, 138.0, 142.0, 167.0, 128.0, 171.0, 157.0], "value": 143.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 195.0, 152.0, 224.0, 205.0, 166.0, 158.0, 162.0, 161.0, 162.0], "value": 174.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 69.0, 66.0, 66.0, 73.0, 73.0, 84.0, 85.0, 87.0, 84.0], "value": 75.2, "unit": "score"}]}]} 23:58:14 INFO - Return code: 0 23:58:14 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:58:14 ERROR - # TBPL SUCCESS # 23:58:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:58:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:58:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:58:14 INFO - 2016-07-05 23:58:14.869 screenresolution[2296:27651] starting screenresolution argv=screenresolution get 23:58:14 INFO - 2016-07-05 23:58:14.871 screenresolution[2296:27651] Display 0: 1600x1200x32@50 23:58:14 INFO - 2016-07-05 23:58:14.877 screenresolution[2297:27654] starting screenresolution argv=screenresolution list 23:58:14 INFO - Available Modes on Display 0 23:58:14 INFO - 1600x1200x32@50 1152x870x32@75 1280x1024x32@75 23:58:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:58:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:58:14 INFO - 640x480x32@60 1280x1024x32@60 1600x1200x32@60 23:58:14 INFO - 1280x960x32@60 1280x960x32@75 1344x1008x32@50 23:58:15 INFO - Graphics/Displays: 23:58:15 INFO - Intel Iris: 23:58:15 INFO - Chipset Model: Intel Iris 23:58:15 INFO - Type: GPU 23:58:15 INFO - Bus: Built-In 23:58:15 INFO - VRAM (Dynamic, Max): 1536 MB 23:58:15 INFO - Vendor: Intel (0x8086) 23:58:15 INFO - Device ID: 0x0a2e 23:58:15 INFO - Revision ID: 0x0009 23:58:15 INFO - Displays: 23:58:15 INFO - Display: 23:58:15 INFO - Resolution: 1600 x 1200 @ 50 Hz 23:58:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:58:15 INFO - Display Serial Number: 1600x1200 50 23:58:15 INFO - Main Display: Yes 23:58:15 INFO - Mirror: Off 23:58:15 INFO - Online: Yes 23:58:15 INFO - Rotation: Supported 23:58:15 INFO - Return code: 0 23:58:15 INFO - Running post-action listener: _resource_record_post_action 23:58:15 INFO - ##### 23:58:15 INFO - ##### Finished run-tests step (success) 23:58:15 INFO - ##### 23:58:15 INFO - Running post-run listener: _resource_record_post_run 23:58:15 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 4096; Write bytes: 709641728; Read time: 0; Write time: 1970 23:58:15 INFO - TinderboxPrint: CPU usage
54.1% 23:58:15 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 0 23:58:15 INFO - TinderboxPrint: I/O write bytes / time
709,641,728 / 1,970 23:58:15 INFO - TinderboxPrint: CPU idle
2,219.0 (45.9%) 23:58:15 INFO - TinderboxPrint: CPU system
971.3 (20.1%) 23:58:15 INFO - TinderboxPrint: CPU user
1,647.3 (34.1%) 23:58:15 INFO - TinderboxPrint: Swap in / out
406,405,120 / 0 23:58:15 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 396315136; Write bytes: 390428672; Read time: 29582; Write time: 757 23:58:15 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 4096; Write bytes: 297936896; Read time: 0; Write time: 1164 23:58:15 INFO - Running post-run listener: _upload_blobber_files 23:58:15 INFO - Blob upload gear active. 23:58:15 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:58:15 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 23:58:15 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:58:15 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:58:15 INFO - (blobuploader) - INFO - Open directory for files ... 23:58:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:58:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:58:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:58:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:58:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:58:16 INFO - (blobuploader) - INFO - Done attempting. 23:58:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:58:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:58:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:58:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:58:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:58:18 INFO - (blobuploader) - INFO - Done attempting. 23:58:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:58:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:58:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:58:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:58:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:58:20 INFO - (blobuploader) - INFO - Done attempting. 23:58:20 INFO - (blobuploader) - INFO - Iteration through files over. 23:58:20 INFO - Return code: 0 23:58:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:58:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:58:20 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d0661123820e8ea86a45e1f0efa6336bc11b17b76b44f94483dcd82f8d68d8c1910382ac8e75c2fdc4cde4018f350eb53f585f6c60ca19cb2a365923f874268e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4bfe55e27c7c59bb5c2418629889bd35f3f459c72b5a02772a263513d777dc48f8d58a8aff9565cce1cdbdef0343dbeba760672581cf93bee4a5aebc212b0c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/891b6b3745ba7201a1ba5a4fc54d07a6f90ad1e364c869ebe8fb5539e20236c924d265f7453cc9b3b8b553b36880c099f4d120df207936de9ac630374618df7f"} 23:58:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:58:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:58:20 INFO - Contents: 23:58:20 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d0661123820e8ea86a45e1f0efa6336bc11b17b76b44f94483dcd82f8d68d8c1910382ac8e75c2fdc4cde4018f350eb53f585f6c60ca19cb2a365923f874268e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4bfe55e27c7c59bb5c2418629889bd35f3f459c72b5a02772a263513d777dc48f8d58a8aff9565cce1cdbdef0343dbeba760672581cf93bee4a5aebc212b0c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/891b6b3745ba7201a1ba5a4fc54d07a6f90ad1e364c869ebe8fb5539e20236c924d265f7453cc9b3b8b553b36880c099f4d120df207936de9ac630374618df7f"} 23:58:20 INFO - Running post-run listener: copy_logs_to_upload_dir 23:58:20 INFO - Copying logs to upload dir... 23:58:20 INFO - mkdir: /builds/slave/test/build/upload/logs 23:58:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1331.522694 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 11 secs) (at 2016-07-05 23:58:20.589042) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 23:58:20.592449) ========= 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.FXuOHCwbOY/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.00zXJruWcl/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d0661123820e8ea86a45e1f0efa6336bc11b17b76b44f94483dcd82f8d68d8c1910382ac8e75c2fdc4cde4018f350eb53f585f6c60ca19cb2a365923f874268e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4bfe55e27c7c59bb5c2418629889bd35f3f459c72b5a02772a263513d777dc48f8d58a8aff9565cce1cdbdef0343dbeba760672581cf93bee4a5aebc212b0c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/891b6b3745ba7201a1ba5a4fc54d07a6f90ad1e364c869ebe8fb5539e20236c924d265f7453cc9b3b8b553b36880c099f4d120df207936de9ac630374618df7f"} build_url:https://queue.taskcluster.net/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011484 build_url: 'https://queue.taskcluster.net/v1/task/bYxOBAJjTYOkIaKCMoeHZQ/artifacts/public/build/firefox-50.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d0661123820e8ea86a45e1f0efa6336bc11b17b76b44f94483dcd82f8d68d8c1910382ac8e75c2fdc4cde4018f350eb53f585f6c60ca19cb2a365923f874268e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c4bfe55e27c7c59bb5c2418629889bd35f3f459c72b5a02772a263513d777dc48f8d58a8aff9565cce1cdbdef0343dbeba760672581cf93bee4a5aebc212b0c8", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/891b6b3745ba7201a1ba5a4fc54d07a6f90ad1e364c869ebe8fb5539e20236c924d265f7453cc9b3b8b553b36880c099f4d120df207936de9ac630374618df7f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 23:58:20.625219) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 23:58:20.625502) ========= 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.FXuOHCwbOY/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.00zXJruWcl/Listeners TMPDIR=/var/folders/gx/gg1mk0bs7f17x8sk8mkdg3_h00000w/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.005298 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 23:58:20.674423) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 23:58:20.674723) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 23:58:20.675045) ========= ========= Total master_lag: 0.17 =========