builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0344 starttime: 1487885197.44 results: success (0) buildid: 20170223120023 builduid: 714cee15775a4dfd812a8a1647df13d5 revision: 0e612af21502fcee49f1d490058d8109f7c4e1b9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 13:26:37.444866) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-23 13:26:37.445403) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 13:26:37.445873) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-23 13:26:37.475070) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 13:26:37.475400) ========= 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.XVDFnJwU43/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.MQ51FT8P8T/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-02-23 13:26:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 57.8M=0s 2017-02-23 13:26:37 (57.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.097859 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 13:26:37.595837) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 13:26:37.596188) ========= 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.XVDFnJwU43/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.MQ51FT8P8T/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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.020020 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 13:26:37.644330) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-23 13:26:37.644677) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0e612af21502fcee49f1d490058d8109f7c4e1b9 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 0e612af21502fcee49f1d490058d8109f7c4e1b9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XVDFnJwU43/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.MQ51FT8P8T/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-02-23 13:26:37,736 truncating revision to first 12 chars 2017-02-23 13:26:37,736 Setting DEBUG logging. 2017-02-23 13:26:37,736 attempt 1/10 2017-02-23 13:26:37,736 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/0e612af21502?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-23 13:26:39,929 unpacking tar archive at: mozilla-aurora-0e612af21502/testing/mozharness/ program finished with exit code 0 elapsedTime=2.449104 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-02-23 13:26:40.115587) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 13:26:40.115888) ========= script_repo_revision: 0e612af21502fcee49f1d490058d8109f7c4e1b9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-23 13:26:40.116287) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 13:26:40.116545) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-23 13:26:40.135328) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-02-23 13:26:40.135728) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XVDFnJwU43/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.MQ51FT8P8T/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 13:26:40 INFO - MultiFileLogger online at 20170223 13:26:40 in /builds/slave/test 13:26:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 13:26:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:26:40 INFO - {'append_to_log': False, 13:26:40 INFO - 'base_work_dir': '/builds/slave/test', 13:26:40 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:26:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:26:40 INFO - 'branch': 'Mozilla-Aurora', 13:26:40 INFO - 'buildbot_json_path': 'buildprops.json', 13:26:40 INFO - 'config_files': ('talos/mac_config.py',), 13:26:40 INFO - 'default_actions': ('clobber', 13:26:40 INFO - 'read-buildbot-config', 13:26:40 INFO - 'download-and-extract', 13:26:40 INFO - 'populate-webroot', 13:26:40 INFO - 'create-virtualenv', 13:26:40 INFO - 'install', 13:26:40 INFO - 'run-tests'), 13:26:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:26:40 INFO - 'download_minidump_stackwalk': True, 13:26:40 INFO - 'download_symbols': 'ondemand', 13:26:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:26:40 INFO - 'tooltool.py': '/tools/tooltool.py', 13:26:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:26:40 INFO - '/tools/misc-python/virtualenv.py')}, 13:26:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:26:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:26:40 INFO - 'installer_path': 'installer.exe', 13:26:40 INFO - 'log_level': 'info', 13:26:40 INFO - 'log_name': 'talos', 13:26:40 INFO - 'log_to_console': True, 13:26:40 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:26:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:26:40 INFO - 'opt_config_files': (), 13:26:40 INFO - 'pip_index': False, 13:26:40 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:26:40 INFO - 'cmd': ('bash', 13:26:40 INFO - '-c', 13:26:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:26:40 INFO - 'enabled': True, 13:26:40 INFO - 'halt_on_failure': False, 13:26:40 INFO - 'name': 'check_screen_resolution'},), 13:26:40 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:26:40 INFO - 'cmd': ('bash', 13:26:40 INFO - '-c', 13:26:40 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:26:40 INFO - 'enabled': True, 13:26:40 INFO - 'halt_on_failure': False, 13:26:40 INFO - 'name': 'check_screen_resolution'},), 13:26:40 INFO - 'run_cmd_checks_enabled': True, 13:26:40 INFO - 'sps_profile': False, 13:26:40 INFO - 'sps_profile_interval': 0, 13:26:40 INFO - 'suite': 'dromaeojs-e10s', 13:26:40 INFO - 'system_bits': '32', 13:26:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:26:40 INFO - 'title': 't-yosemite-r7-0344', 13:26:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:26:40 INFO - 'use_talos_json': True, 13:26:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:26:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:26:40 INFO - 'work_dir': 'build'} 13:26:40 INFO - [mozharness: 2017-02-23 21:26:40.344857Z] Running clobber step. 13:26:40 INFO - Running pre-action listener: _resource_record_pre_action 13:26:40 INFO - Running main action method: clobber 13:26:40 INFO - rmtree: /builds/slave/test/build 13:26:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:26:40 INFO - Running post-action listener: _resource_record_post_action 13:26:40 INFO - [mozharness: 2017-02-23 21:26:40.501894Z] Finished clobber step (success) 13:26:40 INFO - [mozharness: 2017-02-23 21:26:40.502049Z] Running read-buildbot-config step. 13:26:40 INFO - Running pre-action listener: _resource_record_pre_action 13:26:40 INFO - Running main action method: read_buildbot_config 13:26:40 INFO - Using buildbot properties: 13:26:40 INFO - { 13:26:40 INFO - "project": "", 13:26:40 INFO - "product": "firefox", 13:26:40 INFO - "script_repo_revision": "production", 13:26:40 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 13:26:40 INFO - "repository": "", 13:26:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 13:26:40 INFO - "buildid": "20170223120023", 13:26:40 INFO - "pgo_build": "False", 13:26:40 INFO - "basedir": "/builds/slave/test", 13:26:40 INFO - "buildnumber": 7, 13:26:40 INFO - "slavename": "t-yosemite-r7-0344", 13:26:40 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 13:26:40 INFO - "platform": "yosemite_r7", 13:26:40 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 13:26:40 INFO - "branch": "mozilla-aurora", 13:26:40 INFO - "repo_path": "releases/mozilla-aurora", 13:26:40 INFO - "revision": "0e612af21502fcee49f1d490058d8109f7c4e1b9", 13:26:40 INFO - "stage_platform": "macosx64", 13:26:40 INFO - "builduid": "714cee15775a4dfd812a8a1647df13d5", 13:26:40 INFO - "slavebuilddir": "test" 13:26:40 INFO - } 13:26:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/RuLSl-hxS0Sj5yEhPyfMAw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 13:26:40 INFO - Running post-action listener: _resource_record_post_action 13:26:40 INFO - [mozharness: 2017-02-23 21:26:40.505397Z] Finished read-buildbot-config step (success) 13:26:40 INFO - [mozharness: 2017-02-23 21:26:40.505499Z] Running download-and-extract step. 13:26:40 INFO - Running pre-action listener: _resource_record_pre_action 13:26:40 INFO - Running main action method: download_and_extract 13:26:40 INFO - mkdir: /builds/slave/test/build/tests 13:26: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:40 INFO - trying https://queue.taskcluster.net/v1/task/RuLSl-hxS0Sj5yEhPyfMAw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 13:26:40 INFO - Downloading https://queue.taskcluster.net/v1/task/RuLSl-hxS0Sj5yEhPyfMAw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 13:26:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RuLSl-hxS0Sj5yEhPyfMAw/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 13:26:41 INFO - Downloaded 1199 bytes. 13:26:41 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 13:26:41 INFO - Using the following test package requirements: 13:26:41 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 13:26:41 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:26:41 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 13:26:41 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:26:41 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 13:26:41 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:26:41 INFO - u'jsshell-mac.zip'], 13:26:41 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:26:41 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 13:26:41 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 13:26:41 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:26:41 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 13:26:41 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:26:41 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 13:26:41 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:26:41 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 13:26:41 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 13:26:41 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 13:26:41 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 13:26:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RuLSl-hxS0Sj5yEhPyfMAw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 13:26:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RuLSl-hxS0Sj5yEhPyfMAw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:26:41 INFO - Fetch https://queue.taskcluster.net/v1/task/RuLSl-hxS0Sj5yEhPyfMAw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 13:26:42 INFO - Expected file size: 16357514 13:26:42 INFO - Obtained file size: 16357514 13:26:48 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 13:26:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RuLSl-hxS0Sj5yEhPyfMAw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 13:26:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RuLSl-hxS0Sj5yEhPyfMAw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:26:48 INFO - Fetch https://queue.taskcluster.net/v1/task/RuLSl-hxS0Sj5yEhPyfMAw/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 13:26:49 INFO - Expected file size: 16357514 13:26:49 INFO - Obtained file size: 16357514 13:26:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RuLSl-hxS0Sj5yEhPyfMAw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 13:26:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RuLSl-hxS0Sj5yEhPyfMAw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 13:26:55 INFO - Fetch https://queue.taskcluster.net/v1/task/RuLSl-hxS0Sj5yEhPyfMAw/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 13:26:56 INFO - Expected file size: 14403472 13:26:56 INFO - Obtained file size: 14403472 13:26:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:26:56 INFO - trying https://queue.taskcluster.net/v1/task/RuLSl-hxS0Sj5yEhPyfMAw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 13:26:56 INFO - Downloading https://queue.taskcluster.net/v1/task/RuLSl-hxS0Sj5yEhPyfMAw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 13:26:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RuLSl-hxS0Sj5yEhPyfMAw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 13:26:58 INFO - Downloaded 73931465 bytes. 13:26:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RuLSl-hxS0Sj5yEhPyfMAw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 13:26:58 INFO - mkdir: /builds/slave/test/properties 13:26:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:26:58 INFO - Writing to file /builds/slave/test/properties/build_url 13:26:58 INFO - Contents: 13:26:58 INFO - build_url:https://queue.taskcluster.net/v1/task/RuLSl-hxS0Sj5yEhPyfMAw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 13:26:59 INFO - Running post-action listener: _resource_record_post_action 13:26:59 INFO - Running post-action listener: set_extra_try_arguments 13:26:59 INFO - [mozharness: 2017-02-23 21:26:59.611894Z] Finished download-and-extract step (success) 13:26:59 INFO - [mozharness: 2017-02-23 21:26:59.612056Z] Running populate-webroot step. 13:26:59 INFO - Running pre-action listener: _resource_record_pre_action 13:26:59 INFO - Running main action method: populate_webroot 13:26:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:26:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:26:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:26:59 INFO - '--tppagecycles', 13:26:59 INFO - '7'], 13:26:59 INFO - 'tests': ['tsvgm']}}, 13:26:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:26:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:26:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:26:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:26:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:26:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:26:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:26:59 INFO - 'talos_options': ['--disable-e10s'], 13:26:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:26:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:26:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:26:59 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:26:59 INFO - 'talos_options': ['--disable-e10s'], 13:26:59 INFO - 'tests': ['damp', 'tps']}, 13:26:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:26:59 INFO - 'tests': ['damp', 'tps']}, 13:26:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:26:59 INFO - 'tests': ['dromaeo_dom']}, 13:26:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:26:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:26:59 INFO - 'tests': ['basic_compositor_video']}, 13:26:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:26:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:26:59 INFO - 'tests': ['a11yr', 13:26:59 INFO - 'ts_paint', 13:26:59 INFO - 'tpaint', 13:26:59 INFO - 'sessionrestore', 13:26:59 INFO - 'sessionrestore_no_auto_restore', 13:26:59 INFO - 'tabpaint']}, 13:26:59 INFO - 'other-e10s': {'tests': ['a11yr', 13:26:59 INFO - 'ts_paint', 13:26:59 INFO - 'tpaint', 13:26:59 INFO - 'sessionrestore', 13:26:59 INFO - 'sessionrestore_no_auto_restore', 13:26:59 INFO - 'tabpaint']}, 13:26:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:26:59 INFO - 'ts_paint', 13:26:59 INFO - 'tpaint', 13:26:59 INFO - 'sessionrestore', 13:26:59 INFO - 'sessionrestore_no_auto_restore', 13:26:59 INFO - 'tabpaint']}, 13:26:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:26:59 INFO - 'ts_paint', 13:26:59 INFO - 'tpaint', 13:26:59 INFO - 'sessionrestore', 13:26:59 INFO - 'sessionrestore_no_auto_restore', 13:26:59 INFO - 'tabpaint']}, 13:26:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:26:59 INFO - 'tests': ['a11yr', 13:26:59 INFO - 'ts_paint', 13:26:59 INFO - 'tpaint', 13:26:59 INFO - 'sessionrestore', 13:26:59 INFO - 'sessionrestore_no_auto_restore', 13:26:59 INFO - 'tabpaint']}, 13:26:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:26:59 INFO - 'tests': ['a11yr', 13:26:59 INFO - 'ts_paint', 13:26:59 INFO - 'tpaint', 13:26:59 INFO - 'sessionrestore', 13:26:59 INFO - 'sessionrestore_no_auto_restore', 13:26:59 INFO - 'tabpaint']}, 13:26:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:26:59 INFO - 'tests': ['tsvgx', 13:26:59 INFO - 'tsvgr_opacity', 13:26:59 INFO - 'tart', 13:26:59 INFO - 'tscrollx', 13:26:59 INFO - 'cart', 13:26:59 INFO - 'tsvg_static']}, 13:26:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:26:59 INFO - 'tsvgr_opacity', 13:26:59 INFO - 'tart', 13:26:59 INFO - 'tscrollx', 13:26:59 INFO - 'cart', 13:26:59 INFO - 'tsvg_static']}, 13:26:59 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:26:59 INFO - 'talos_options': ['--disable-e10s'], 13:26:59 INFO - 'tests': ['tp5o']}, 13:26:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:26:59 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:26:59 INFO - 'talos_options': ['--disable-e10s', 13:26:59 INFO - '--xperf_path', 13:26:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:26:59 INFO - 'tests': ['tp5n']}, 13:26:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:26:59 INFO - 'talos_options': ['--xperf_path', 13:26:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:26:59 INFO - 'tests': ['tp5n']}}, 13:26:59 INFO - 'talos.zip': {'path': '', 13:26:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:26:59 INFO - Running post-action listener: _resource_record_post_action 13:26:59 INFO - [mozharness: 2017-02-23 21:26:59.630502Z] Finished populate-webroot step (success) 13:26:59 INFO - [mozharness: 2017-02-23 21:26:59.630635Z] Running create-virtualenv step. 13:26:59 INFO - Running pre-action listener: _resource_record_pre_action 13:26:59 INFO - Running main action method: create_virtualenv 13:26:59 INFO - Creating virtualenv /builds/slave/test/build/venv 13:26:59 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 13:26:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:26:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:26:59 INFO - Using real prefix '/tools/python27' 13:26:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:27:00 INFO - Installing distribute.............................................................................................................................................................................................done. 13:27:03 INFO - Installing pip.................done. 13:27:03 INFO - Return code: 0 13:27:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:27:03 INFO - Reading from file tmpfile_stdout 13:27:03 INFO - Output received: 13:27:03 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:27:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:03 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 0x106384b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106387768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4f1c5f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106162d30>, '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 0x106089db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106157be8>, '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.XVDFnJwU43/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.MQ51FT8P8T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 13:27:03 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 13:27:03 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 13:27:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVDFnJwU43/Render', 13:27:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:03 INFO - 'HOME': '/Users/cltbld', 13:27:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:03 INFO - 'LOGNAME': 'cltbld', 13:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:03 INFO - 'MOZ_NO_REMOTE': '1', 13:27:03 INFO - 'NO_EM_RESTART': '1', 13:27:03 INFO - 'PAGER': '/bin/cat', 13:27:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:03 INFO - 'PWD': '/builds/slave/test', 13:27:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:03 INFO - 'SHELL': '/bin/bash', 13:27:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MQ51FT8P8T/Listeners', 13:27:03 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 13:27:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:03 INFO - 'USER': 'cltbld', 13:27:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:03 INFO - 'XPC_FLAGS': '0x0', 13:27:03 INFO - 'XPC_SERVICE_NAME': '0', 13:27:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:03 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 13:27:03 INFO - Cleaning up... 13:27:03 INFO - Return code: 0 13:27:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:03 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 0x106384b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106387768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4f1c5f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106162d30>, '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 0x106089db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106157be8>, '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.XVDFnJwU43/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.MQ51FT8P8T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 13:27:03 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 13:27:03 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 13:27:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVDFnJwU43/Render', 13:27:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:03 INFO - 'HOME': '/Users/cltbld', 13:27:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:03 INFO - 'LOGNAME': 'cltbld', 13:27:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:03 INFO - 'MOZ_NO_REMOTE': '1', 13:27:03 INFO - 'NO_EM_RESTART': '1', 13:27:03 INFO - 'PAGER': '/bin/cat', 13:27:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:03 INFO - 'PWD': '/builds/slave/test', 13:27:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:03 INFO - 'SHELL': '/bin/bash', 13:27:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MQ51FT8P8T/Listeners', 13:27:03 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 13:27:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:03 INFO - 'USER': 'cltbld', 13:27:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:03 INFO - 'XPC_FLAGS': '0x0', 13:27:03 INFO - 'XPC_SERVICE_NAME': '0', 13:27:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:04 INFO - Downloading/unpacking psutil>=3.1.1 13:27:04 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 13:27:04 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 13:27:04 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 13:27:04 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 13:27:04 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 13:27:04 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 13:27:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:27:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:27:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:27:07 INFO - Installing collected packages: psutil 13:27:07 INFO - Running setup.py install for psutil 13:27:07 INFO - building 'psutil._psutil_osx' extension 13:27:07 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 13:27:07 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 13:27:07 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 13:27:07 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 13:27:07 INFO - building 'psutil._psutil_posix' extension 13:27:07 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 13:27:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:27:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:27:08 INFO - ^ 13:27:08 INFO - 1 warning generated. 13:27:08 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 13:27:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:27:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:27:08 INFO - Successfully installed psutil 13:27:08 INFO - Cleaning up... 13:27:08 INFO - Return code: 0 13:27:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:08 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 0x106384b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106387768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4f1c5f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106162d30>, '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 0x106089db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106157be8>, '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.XVDFnJwU43/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.MQ51FT8P8T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 13:27:08 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 13:27:08 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 13:27:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVDFnJwU43/Render', 13:27:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:08 INFO - 'HOME': '/Users/cltbld', 13:27:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:08 INFO - 'LOGNAME': 'cltbld', 13:27:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:08 INFO - 'MOZ_NO_REMOTE': '1', 13:27:08 INFO - 'NO_EM_RESTART': '1', 13:27:08 INFO - 'PAGER': '/bin/cat', 13:27:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:08 INFO - 'PWD': '/builds/slave/test', 13:27:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:08 INFO - 'SHELL': '/bin/bash', 13:27:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MQ51FT8P8T/Listeners', 13:27:08 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 13:27:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:08 INFO - 'USER': 'cltbld', 13:27:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:08 INFO - 'XPC_FLAGS': '0x0', 13:27:08 INFO - 'XPC_SERVICE_NAME': '0', 13:27:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:27:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:27:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:27:11 INFO - Installing collected packages: mozsystemmonitor 13:27:11 INFO - Running setup.py install for mozsystemmonitor 13:27:11 INFO - Successfully installed mozsystemmonitor 13:27:11 INFO - Cleaning up... 13:27:11 INFO - Return code: 0 13:27:11 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:27:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:11 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 0x106384b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106387768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4f1c5f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106162d30>, '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 0x106089db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106157be8>, '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.XVDFnJwU43/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.MQ51FT8P8T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 13:27:11 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 13:27:11 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 13:27:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVDFnJwU43/Render', 13:27:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:11 INFO - 'HOME': '/Users/cltbld', 13:27:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:11 INFO - 'LOGNAME': 'cltbld', 13:27:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:11 INFO - 'MOZ_NO_REMOTE': '1', 13:27:11 INFO - 'NO_EM_RESTART': '1', 13:27:11 INFO - 'PAGER': '/bin/cat', 13:27:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:11 INFO - 'PWD': '/builds/slave/test', 13:27:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:11 INFO - 'SHELL': '/bin/bash', 13:27:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MQ51FT8P8T/Listeners', 13:27:11 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 13:27:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:11 INFO - 'USER': 'cltbld', 13:27:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:11 INFO - 'XPC_FLAGS': '0x0', 13:27:11 INFO - 'XPC_SERVICE_NAME': '0', 13:27:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:11 INFO - Downloading/unpacking jsonschema==2.5.1 13:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:27:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:27:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:27:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:27:14 INFO - Downloading functools32-3.2.3-2.tar.gz 13:27:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:27:14 INFO - warning: no files found matching '*.txt' 13:27:14 INFO - no previously-included directories found matching 'build' 13:27:14 INFO - no previously-included directories found matching 'dist' 13:27:14 INFO - no previously-included directories found matching '.git*' 13:27:14 INFO - Installing collected packages: jsonschema, functools32 13:27:14 INFO - Running setup.py install for functools32 13:27:14 INFO - warning: no files found matching '*.txt' 13:27:14 INFO - no previously-included directories found matching 'build' 13:27:14 INFO - no previously-included directories found matching 'dist' 13:27:14 INFO - no previously-included directories found matching '.git*' 13:27:14 INFO - Successfully installed jsonschema functools32 13:27:14 INFO - Cleaning up... 13:27:15 INFO - Return code: 0 13:27:15 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:27:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106384b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106387768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4f1c5f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106162d30>, '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 0x106089db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106157be8>, '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.XVDFnJwU43/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.MQ51FT8P8T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 13:27:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:27:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:27:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVDFnJwU43/Render', 13:27:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:15 INFO - 'HOME': '/Users/cltbld', 13:27:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:15 INFO - 'LOGNAME': 'cltbld', 13:27:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:15 INFO - 'MOZ_NO_REMOTE': '1', 13:27:15 INFO - 'NO_EM_RESTART': '1', 13:27:15 INFO - 'PAGER': '/bin/cat', 13:27:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:15 INFO - 'PWD': '/builds/slave/test', 13:27:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:15 INFO - 'SHELL': '/bin/bash', 13:27:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MQ51FT8P8T/Listeners', 13:27:15 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 13:27:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:15 INFO - 'USER': 'cltbld', 13:27:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:15 INFO - 'XPC_FLAGS': '0x0', 13:27:15 INFO - 'XPC_SERVICE_NAME': '0', 13:27:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:15 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:27:15 INFO - Cleaning up... 13:27:15 INFO - Return code: 0 13:27:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:27:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:15 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 0x106384b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106387768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4f1c5f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106162d30>, '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 0x106089db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106157be8>, '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.XVDFnJwU43/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.MQ51FT8P8T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 13:27:15 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 13:27:15 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 13:27:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVDFnJwU43/Render', 13:27:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:15 INFO - 'HOME': '/Users/cltbld', 13:27:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:15 INFO - 'LOGNAME': 'cltbld', 13:27:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:15 INFO - 'MOZ_NO_REMOTE': '1', 13:27:15 INFO - 'NO_EM_RESTART': '1', 13:27:15 INFO - 'PAGER': '/bin/cat', 13:27:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:15 INFO - 'PWD': '/builds/slave/test', 13:27:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:15 INFO - 'SHELL': '/bin/bash', 13:27:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MQ51FT8P8T/Listeners', 13:27:15 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 13:27:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:15 INFO - 'USER': 'cltbld', 13:27:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:15 INFO - 'XPC_FLAGS': '0x0', 13:27:15 INFO - 'XPC_SERVICE_NAME': '0', 13:27:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:15 INFO - Downloading/unpacking blobuploader==1.2.4 13:27:15 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 13:27:15 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 13:27:15 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 13:27:15 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 13:27:15 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 13:27:15 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 13:27:18 INFO - Downloading blobuploader-1.2.4.tar.gz 13:27:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:27:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:27:18 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 13:27:18 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 13:27:18 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 13:27:18 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 13:27:18 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 13:27:18 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 13:27:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:27:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:27:18 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 13:27:18 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 13:27:18 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 13:27:18 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 13:27:18 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 13:27:18 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 13:27:19 INFO - Downloading docopt-0.6.1.tar.gz 13:27:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:27:19 INFO - Installing collected packages: blobuploader, requests, docopt 13:27:19 INFO - Running setup.py install for blobuploader 13:27:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:27:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:27:19 INFO - Running setup.py install for requests 13:27:20 INFO - Running setup.py install for docopt 13:27:20 INFO - Successfully installed blobuploader requests docopt 13:27:20 INFO - Cleaning up... 13:27:20 INFO - Return code: 0 13:27:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:27:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:20 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 0x106384b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106387768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4f1c5f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106162d30>, '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 0x106089db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106157be8>, '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.XVDFnJwU43/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.MQ51FT8P8T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 13:27:20 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 13:27:20 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 13:27:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVDFnJwU43/Render', 13:27:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:20 INFO - 'HOME': '/Users/cltbld', 13:27:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:20 INFO - 'LOGNAME': 'cltbld', 13:27:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:20 INFO - 'MOZ_NO_REMOTE': '1', 13:27:20 INFO - 'NO_EM_RESTART': '1', 13:27:20 INFO - 'PAGER': '/bin/cat', 13:27:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:20 INFO - 'PWD': '/builds/slave/test', 13:27:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:20 INFO - 'SHELL': '/bin/bash', 13:27:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MQ51FT8P8T/Listeners', 13:27:20 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 13:27:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:20 INFO - 'USER': 'cltbld', 13:27:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:20 INFO - 'XPC_FLAGS': '0x0', 13:27:20 INFO - 'XPC_SERVICE_NAME': '0', 13:27:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:27:20 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-F4Cicy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:27:20 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-C78Mew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:27:20 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-SR5WXG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:27:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:27:21 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-BITAfN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:27:21 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-ONoYgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:27:21 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-8BLjVO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:27:21 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-ZmlUEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:27:21 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-KPApVc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:27:21 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-dahqbp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:27:21 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-HeVH1E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:27:21 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-zaZzOU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:27:21 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-emtdxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:27:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:27:21 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-s6jT7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:27:22 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-JzKIht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:22 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-gXao0u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:27:22 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-a4qDua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:27:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:27:22 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-3OlXZm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:27:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:27:22 INFO - Running setup.py install for manifestparser 13:27:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:27:22 INFO - Running setup.py install for mozcrash 13:27:22 INFO - Running setup.py install for mozdebug 13:27:22 INFO - Running setup.py install for mozdevice 13:27:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:27:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:27:23 INFO - Running setup.py install for mozfile 13:27:23 INFO - Running setup.py install for mozhttpd 13:27:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:27:23 INFO - Running setup.py install for mozinfo 13:27:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:27:23 INFO - Running setup.py install for mozInstall 13:27:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:27:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:27:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:27:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:27:23 INFO - Running setup.py install for mozleak 13:27:23 INFO - Running setup.py install for mozlog 13:27:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:27:23 INFO - Running setup.py install for moznetwork 13:27:24 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:27:24 INFO - Running setup.py install for mozprocess 13:27:24 INFO - Running setup.py install for mozprofile 13:27:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:27:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:27:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:27:24 INFO - Running setup.py install for mozrunner 13:27:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:27:24 INFO - Running setup.py install for mozscreenshot 13:27:24 INFO - Running setup.py install for moztest 13:27:24 INFO - Running setup.py install for mozversion 13:27:25 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:27:25 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:27:25 INFO - Cleaning up... 13:27:25 INFO - Return code: 0 13:27:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:27:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:25 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 0x106384b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106387768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4f1c5f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106162d30>, '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 0x106089db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106157be8>, '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.XVDFnJwU43/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.MQ51FT8P8T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 13:27:25 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 13:27:25 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 13:27:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVDFnJwU43/Render', 13:27:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:25 INFO - 'HOME': '/Users/cltbld', 13:27:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:25 INFO - 'LOGNAME': 'cltbld', 13:27:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:25 INFO - 'MOZ_NO_REMOTE': '1', 13:27:25 INFO - 'NO_EM_RESTART': '1', 13:27:25 INFO - 'PAGER': '/bin/cat', 13:27:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:25 INFO - 'PWD': '/builds/slave/test', 13:27:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:25 INFO - 'SHELL': '/bin/bash', 13:27:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MQ51FT8P8T/Listeners', 13:27:25 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 13:27:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:25 INFO - 'USER': 'cltbld', 13:27:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:25 INFO - 'XPC_FLAGS': '0x0', 13:27:25 INFO - 'XPC_SERVICE_NAME': '0', 13:27:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:27:25 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-2WSzWZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:27:25 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)) 13:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:27:25 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-InkIYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:27:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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)) 13:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:27:25 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-dT9rBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:27:25 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)) 13:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:27:25 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-KAVJC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:27:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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)) 13:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:27:25 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-GN3aYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:27:25 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)) 13:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:27:25 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-CrBXMZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:27:25 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)) 13:27:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:27:25 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-K3sxIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:27:26 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)) 13:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:27:26 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-T5n8xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:27:26 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)) 13:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:27:26 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-NZXJ_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:27:26 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)) 13:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:27:26 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-pDrDgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:27:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:27:26 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-GAf9tK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:27:26 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)) 13:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:27:26 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-8ZbRUQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:27:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 13:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:27:26 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-QS2I3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:27:26 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)) 13:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:27:26 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-1nyYF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:27:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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)) 13:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:26 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-dxMXBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:27:26 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)) 13:27:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:27:26 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-j11DzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:27:27 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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)) 13:27:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:27:27 INFO - Running setup.py (path:/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/pip-Ga5gMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:27:27 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)) 13:27:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:27:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:27:27 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)) 13:27:27 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:27:27 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:27:27 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:27:27 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 13:27:27 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 13:27:27 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 13:27:27 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 13:27:27 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 13:27:27 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 13:27:29 INFO - Downloading blessings-1.6.tar.gz 13:27:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:27:29 INFO - Installing collected packages: blessings 13:27:29 INFO - Running setup.py install for blessings 13:27:30 INFO - Successfully installed blessings 13:27:30 INFO - Cleaning up... 13:27:30 INFO - Return code: 0 13:27:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:27:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:27:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:27:30 INFO - Reading from file tmpfile_stdout 13:27:30 INFO - Current package versions: 13:27:30 INFO - blessings == 1.6 13:27:30 INFO - blobuploader == 1.2.4 13:27:30 INFO - docopt == 0.6.1 13:27:30 INFO - functools32 == 3.2.3-2 13:27:30 INFO - jsonschema == 2.5.1 13:27:30 INFO - manifestparser == 1.1 13:27:30 INFO - mozInstall == 1.12 13:27:30 INFO - mozcrash == 1.0 13:27:30 INFO - mozdebug == 0.1 13:27:30 INFO - mozdevice == 0.49 13:27:30 INFO - mozfile == 1.2 13:27:30 INFO - mozhttpd == 0.7 13:27:30 INFO - mozinfo == 0.9 13:27:30 INFO - mozleak == 0.1 13:27:30 INFO - mozlog == 3.4 13:27:30 INFO - moznetwork == 0.27 13:27:30 INFO - mozprocess == 0.24 13:27:30 INFO - mozprofile == 0.28 13:27:30 INFO - mozrunner == 6.13 13:27:30 INFO - mozscreenshot == 0.1 13:27:30 INFO - mozsystemmonitor == 0.3 13:27:30 INFO - moztest == 0.8 13:27:30 INFO - mozversion == 1.4 13:27:30 INFO - psutil == 3.1.1 13:27:30 INFO - requests == 1.2.3 13:27:30 INFO - wsgiref == 0.1.2 13:27:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:30 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 0x106384b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106387768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4f1c5f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106162d30>, '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 0x106089db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106157be8>, '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.XVDFnJwU43/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.MQ51FT8P8T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 13:27:30 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 13:27:30 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 13:27:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVDFnJwU43/Render', 13:27:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:30 INFO - 'HOME': '/Users/cltbld', 13:27:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:30 INFO - 'LOGNAME': 'cltbld', 13:27:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:30 INFO - 'MOZ_NO_REMOTE': '1', 13:27:30 INFO - 'NO_EM_RESTART': '1', 13:27:30 INFO - 'PAGER': '/bin/cat', 13:27:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:30 INFO - 'PWD': '/builds/slave/test', 13:27:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:30 INFO - 'SHELL': '/bin/bash', 13:27:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MQ51FT8P8T/Listeners', 13:27:30 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 13:27:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:30 INFO - 'USER': 'cltbld', 13:27:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:30 INFO - 'XPC_FLAGS': '0x0', 13:27:30 INFO - 'XPC_SERVICE_NAME': '0', 13:27:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:30 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)) 13:27:30 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)) 13:27:30 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)) 13:27:30 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)) 13:27:30 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)) 13:27:30 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)) 13:27:30 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)) 13:27:30 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)) 13:27:30 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)) 13:27:30 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)) 13:27:30 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)) 13:27:30 INFO - Cleaning up... 13:27:30 INFO - Return code: 0 13:27:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:27:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:27:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:27:30 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 0x106384b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106387768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb4f1c5f150>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106162d30>, '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 0x106089db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106157be8>, '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.XVDFnJwU43/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.MQ51FT8P8T/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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 13:27:30 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 13:27:30 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 13:27:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVDFnJwU43/Render', 13:27:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:30 INFO - 'HOME': '/Users/cltbld', 13:27:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:30 INFO - 'LOGNAME': 'cltbld', 13:27:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:30 INFO - 'MOZ_NO_REMOTE': '1', 13:27:30 INFO - 'NO_EM_RESTART': '1', 13:27:30 INFO - 'PAGER': '/bin/cat', 13:27:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:30 INFO - 'PWD': '/builds/slave/test', 13:27:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:30 INFO - 'SHELL': '/bin/bash', 13:27:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MQ51FT8P8T/Listeners', 13:27:30 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 13:27:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:30 INFO - 'USER': 'cltbld', 13:27:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:30 INFO - 'XPC_FLAGS': '0x0', 13:27:30 INFO - 'XPC_SERVICE_NAME': '0', 13:27:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:27:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:27:30 INFO - Cleaning up... 13:27:30 INFO - Return code: 0 13:27:30 INFO - Running post-action listener: _resource_record_post_action 13:27:30 INFO - Running post-action listener: _start_resource_monitoring 13:27:30 INFO - Starting resource monitoring. 13:27:31 INFO - [mozharness: 2017-02-23 21:27:31.006628Z] Finished create-virtualenv step (success) 13:27:31 INFO - [mozharness: 2017-02-23 21:27:31.007493Z] Running install step. 13:27:31 INFO - Running pre-action listener: _resource_record_pre_action 13:27:31 INFO - Running main action method: install 13:27:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:27:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:27:31 INFO - Reading from file tmpfile_stdout 13:27:31 INFO - Detecting whether we're running mozinstall >=1.0... 13:27:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:27:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:27:31 INFO - Reading from file tmpfile_stdout 13:27:31 INFO - Output received: 13:27:31 INFO - Usage: mozinstall [options] installer 13:27:31 INFO - Options: 13:27:31 INFO - -h, --help show this help message and exit 13:27:31 INFO - -d DEST, --destination=DEST 13:27:31 INFO - Directory to install application into. [default: 13:27:31 INFO - "/builds/slave/test"] 13:27:31 INFO - --app=APP Application being installed. [default: firefox] 13:27:31 INFO - mkdir: /builds/slave/test/build/application 13:27:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:27:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 13:27:51 INFO - Reading from file tmpfile_stdout 13:27:51 INFO - Output received: 13:27:51 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 13:27:51 INFO - Running post-action listener: _resource_record_post_action 13:27:51 INFO - [mozharness: 2017-02-23 21:27:51.116733Z] Finished install step (success) 13:27:51 INFO - [mozharness: 2017-02-23 21:27:51.116910Z] Running run-tests step. 13:27:51 INFO - Running pre-action listener: _resource_record_pre_action 13:27:51 INFO - Running main action method: run_tests 13:27:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:27:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:27:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:27:51 INFO - 2017-02-23 13:27:51.132 screenresolution[1886:8816] starting screenresolution argv=screenresolution get 13:27:51 INFO - 2017-02-23 13:27:51.134 screenresolution[1886:8816] Display 0: 1600x1200x32@60 13:27:51 INFO - 2017-02-23 13:27:51.140 screenresolution[1887:8819] starting screenresolution argv=screenresolution list 13:27:51 INFO - Available Modes on Display 0 13:27:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:27:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:27:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:27:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:27:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:27:51 INFO - Intel Iris: 13:27:51 INFO - Chipset Model: Intel Iris 13:27:51 INFO - Type: GPU 13:27:51 INFO - Bus: Built-In 13:27:51 INFO - VRAM (Dynamic, Max): 1536 MB 13:27:51 INFO - Vendor: Intel (0x8086) 13:27:51 INFO - Device ID: 0x0a2e 13:27:51 INFO - Revision ID: 0x0009 13:27:51 INFO - Displays: 13:27:51 INFO - Display: 13:27:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:27:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:27:51 INFO - Display Serial Number: 1600x1200 60 13:27:51 INFO - Main Display: Yes 13:27:51 INFO - Mirror: Off 13:27:51 INFO - Online: Yes 13:27:51 INFO - Rotation: Supported 13:27:51 INFO - Return code: 0 13:27:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:27:51 INFO - Python 2.7.3 13:27:51 INFO - Return code: 0 13:27:51 INFO - grabbing minidump binary from tooltool 13:27:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:27:51 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 0x106162d30>, '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 0x106089db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106157be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:27:51 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 13:27:51 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 13:27:51 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 13:27:51 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:27:51 INFO - Return code: 0 13:27:51 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:27:51 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:27:51 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:27:51 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:27:51 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:27:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RuLSl-hxS0Sj5yEhPyfMAw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0344', '--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 13:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RuLSl-hxS0Sj5yEhPyfMAw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0344 --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 13:27:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XVDFnJwU43/Render', 13:27:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:51 INFO - 'HOME': '/Users/cltbld', 13:27:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:51 INFO - 'LOGNAME': 'cltbld', 13:27:51 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:27:51 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:27:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:51 INFO - 'MOZ_NO_REMOTE': '1', 13:27:51 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:27:51 INFO - 'NO_EM_RESTART': '1', 13:27:51 INFO - 'PAGER': '/bin/cat', 13:27:51 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:51 INFO - 'PWD': '/builds/slave/test', 13:27:51 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:27:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:51 INFO - 'SHELL': '/bin/bash', 13:27:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MQ51FT8P8T/Listeners', 13:27:51 INFO - 'TMPDIR': '/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/', 13:27:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:51 INFO - 'USER': 'cltbld', 13:27:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:51 INFO - 'XPC_FLAGS': '0x0', 13:27:51 INFO - 'XPC_SERVICE_NAME': '0', 13:27:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:51 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RuLSl-hxS0Sj5yEhPyfMAw/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0344', '--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 13:27:51 INFO - mozversion application_buildid: 20170223120023 13:27:51 INFO - mozversion application_changeset: 0e612af21502fcee49f1d490058d8109f7c4e1b9 13:27:51 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:27:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:27:51 INFO - mozversion application_name: Firefox 13:27:51 INFO - mozversion application_remotingname: firefox-dev 13:27:51 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:27:51 INFO - mozversion application_vendor: Mozilla 13:27:51 INFO - mozversion application_version: 53.0a2 13:27:51 INFO - mozversion platform_buildid: 20170223120023 13:27:51 INFO - mozversion platform_changeset: 0e612af21502fcee49f1d490058d8109f7c4e1b9 13:27:51 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:27:51 INFO - mozversion platform_version: 53.0a2 13:27:51 INFO - using testdate: 1487885271 13:27:51 INFO - actual date: 1487885271 13:27:51 INFO - starting webserver on 'localhost:49367' 13:27:51 INFO - SUITE-START | Running 2 tests 13:27:51 INFO - TEST-START | dromaeo_css 13:27:51 INFO - operating with platform_type : mac_ 13:27:51 INFO - Initialising browser for dromaeo_css test... 13:27:51 INFO - TEST-INFO | started process 1897 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmpMZvvbf/profile http://localhost:49367/getInfo.html) 13:27:54 INFO - PROCESS | 1897 | 2017-02-23 13:27:54.734 plugin-container[1898:8965] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e3f, name = 'com.apple.tsm.portname' 13:27:54 INFO - PROCESS | 1897 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:27:54 INFO - PROCESS | 1897 | 2017-02-23 13:27:54.736 plugin-container[1898:8965] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940b, name = 'com.apple.CFPasteboardClient' 13:27:54 INFO - PROCESS | 1897 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:27:54 INFO - PROCESS | 1897 | 2017-02-23 13:27:54.736 plugin-container[1898:8965] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:27:54 INFO - PROCESS | 1897 | __metrics Screen width/height:1600/1200 13:27:54 INFO - PROCESS | 1897 | colorDepth:24 13:27:54 INFO - PROCESS | 1897 | Browser inner width/height: 1024/689 13:27:54 INFO - PROCESS | 1897 | __metrics 13:27:54 ERROR - PROCESS | 1897 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 13:27:55 INFO - TEST-INFO | 1897: exit 0 13:27:55 INFO - Browser initialized. 13:27:55 INFO - Running cycle 1/1 for dromaeo_css test... 13:27:55 INFO - TEST-INFO | started process 1900 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmpMZvvbf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:27:58 INFO - PROCESS | 1900 | 2017-02-23 13:27:58.084 plugin-container[1901:9102] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 13:27:58 INFO - PROCESS | 1900 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:27:58 INFO - PROCESS | 1900 | 2017-02-23 13:27:58.085 plugin-container[1901:9102] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 13:27:58 INFO - PROCESS | 1900 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:27:58 INFO - PROCESS | 1900 | 2017-02-23 13:27:58.085 plugin-container[1901:9102] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:28:07 INFO - PROCESS | 1900 | RSS: Main: 218824704 13:28:07 INFO - PROCESS | 1900 | 13:31:10 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49367/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49367/tests/dromaeo/cssquery-ext.html) 13:31:12 INFO - PROCESS | 1900 | RSS: Main: 239640576 13:31:12 INFO - PROCESS | 1900 | 13:32:55 INFO - PROCESS | 1900 | ************************* 13:32:55 INFO - PROCESS | 1900 | A coding exception was thrown and uncaught in a Task. 13:32:55 INFO - PROCESS | 1900 | 13:32:55 ERROR - PROCESS | 1900 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:32:55 INFO - PROCESS | 1900 | Full stack: 13:32:55 INFO - PROCESS | 1900 | ************************* 13:34:14 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49367/tests/dromaeo/cssquery-ext.html (next: http://localhost:49367/tests/dromaeo/cssquery-jquery.html) 13:34:15 INFO - PROCESS | 1900 | RSS: Main: 248152064 13:34:15 INFO - PROCESS | 1900 | 13:37:17 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49367/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49367/tests/dromaeo/cssquery-mootools.html) 13:37:18 INFO - PROCESS | 1900 | RSS: Main: 255229952 13:37:18 INFO - PROCESS | 1900 | 13:40:19 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49367/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49367/tests/dromaeo/cssquery-prototype.html) 13:40:20 INFO - PROCESS | 1900 | RSS: Main: 252928000 13:40:20 INFO - PROCESS | 1900 | 13:43:23 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49367/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49367/tests/dromaeo/cssquery-yui.html) 13:43:24 INFO - PROCESS | 1900 | RSS: Main: 258236416 13:43:24 INFO - PROCESS | 1900 | 13:46:26 INFO - PROCESS | 1900 | Cycle 1(1): loaded http://localhost:49367/tests/dromaeo/cssquery-yui.html (next: http://localhost:49367/tests/dromaeo/cssquery-dojo.html) 13:46:27 INFO - PROCESS | 1900 | RSS: Main: 259551232 13:46:27 INFO - PROCESS | 1900 | 13:46:27 INFO - PROCESS | 1900 | __start_tp_report 13:46:27 INFO - PROCESS | 1900 | _x_x_mozilla_page_load 13:46:27 INFO - PROCESS | 1900 | _x_x_mozilla_page_load_details 13:46:27 INFO - PROCESS | 1900 | |i|pagename|runs| 13:46:27 INFO - PROCESS | 1900 | |0;dojo.html;3370.544976428182;3375.3080618473214;3408.505766663833;3411.4712219605954;3420.572428446444;5701.45836145566;5714.085746280591;5728.627639203449;5756.654600723959;5785.132230165466;5754.395788442216;5807.651540907538;5822.796202132926;5832.504237139849;5863.149843272734;4880.755962201893;5254.737263136847;5276.076686579833;5290.523852853243;5341.4658534146465;5254.500822421864;5338.27933229015;5356.54469370104;5356.678599284036;5391.946080539204;5133.460986596391;5160.509751573594;5242.580593552507;5318.813841515567;5323.866903327409;4288.892777680583;5141.15170996785;5215.374155101412;5262.8684282892855;5306.7611957462;5143.794248230066;5155.871103222412;5189.662671926313;5201.791928322863;5224.529792318672;5485.917711234335;5570.721463926828;5643.492085712305;5692.857678558028;5750.482456578886;6242.344553821874;6263.091851681526;6268.028455589391;6293.276273228592;6338.7464501420345;6275;6287.937120628827;6294;6308.2430108386825;6317.589356691847;5970.104484327386;5978.342382337939;5979.1629171915965;5996.340402555716;5996.8500787480225;6150.815475535741;6175.228096487939;6231.532635052298;6251.0623406488485;6291.811245662638;6181.81454556364;6201.937980620136;6221.3156552779155;6232.719527621268;6248.968755156286;6266.905996410058;6270.7805226816845;6279.874402512016;6286.182796236551;6293.576972865389;5067.41724701664;6027.668478233739;6038.698065096728;6145.692715364214;6219.315875253718;6114.692773002168;6120.629988696826;6129.05316799051;6136.028952951454;6136.8772624547255;4891.559759621651;4906.215005599087;4911.45973942866;4914.410270767459;4943.90112197754;3663.8351274192723;4413.44831896013;4447.844325448594;4476.507584165739;4514.390557274792;4773;5873.20711703923;5890.587658863838;5911.467967882825;5937.643741375531;6205.47253483459;6254;6264.498840092781;6266.874662506724;6291.433770960635;5584.832455026356;5699.857503562444;5802.303723553201;5835.912461313083;5846.795362162304;5329.934013197376;5523.28197334344;5523.834284971457;5536.2249285100115;5565.387807341189;5292.41783403833;5302.734863256822;6377.7767778127545;6400.295967443671;6417.807465776034;6180.536459765625;6189.226346706661;6230.00319948806;6241.032639940817;6264.906026409699;5188.247704082963;6361.109444677656;6391.58454700443;6405.135306733531;6417.0695249187675;5036.395632523974;6110.205673262448;6214.731399308994;6250.343713909974;6304.779332723333;6178.598391104564;6212.316645169119;6227.719752611234;6249.25008998923;6280.717367718555;6140.8771824564155;6140.907886381798;6145.340757995227;6198.938010619836;6227.470664993526;6132.478739307209;6169.074638804215;6180.412860778219;6190.659513726789;6204.689765511616;5083.983203359417;6009.308929473166;6055.545834062551;6093.421124993119;6103.511719062376;6084.14821924922;6100.206973093469;6128.014278093809;6129.786714141161;6146.631202127886;6077.878442431038;6086.3305036446845;6088.8782224356155;6096.116063170904;6110.969445152924 13:46:27 INFO - PROCESS | 1900 | |1;ext.html;439.777912154362;494.04402481198906;504.60640700253805;511.0749543326579;511.98882207639895;37308.626913730855;39961.2007759845;40112.59887401125;40178.397324040125;43009;42088.57911420885;42586.57413425865;42596.148077038444;42635.78682106585;42651.14697706044;8333.583320833965;9285.907140928588;9448.433094014346;9472.431654100776;9506.47714375709;6548.1814773153355;6672.199336079677;6676.499262555303;6733.1820408489675;8385.790355241137;11255.887441125566;11384.203105782557;11388.829167562493;11395.97436230739;11419.486123124438;11316.603918862842;11454.370009649467;11457.36984465854;11459.427028648533;11469.025132863717;9653.469059201741;11252.54989800407;11335.263207891461;11342.262752921033;11363.545458181745;32358;39345.80327098375;39538.60461395378;39649.40525892114;39813.402798958035;3975.960240397617;4013.9397909031386;4054.7972601369815;4061.1268577255737;4061.695372847019;26082.478350432884;27831.721682783114;29549.70450295491;31142;31221.687783122106;3091.6599174090834;3208.0856955767727;3208.6470488246273;3219.3400352927592;3235.498497732855;445118;449001;449613;450314.99999999674;450954.74522627506;56394.7180264096;58390.4160958385;61401.69299153476;61750.4562385935;61751.38248617546;63837.680811595645;64828;64837.02744458837;65024;65091;15746.370145194063;16085.839141608669;16102.597435064217;16109.194540273174;16140.596485087966;10057.69826905194;11049.005589496985;11085.168612354106;12229.816552751716;12328.691782705504;16271.674566508604;16536.917315413346;16711.665766684597;16730.49808505747;16800.411985580446;7474.738384156529;7618.6190690466365;7627;7646.082470103624;7673.424493163036;863.9006514250941;875.5097145598485;877.9420797938469;893.3969570539989;911.6034524981654;25494.98020079213;30190.54714179289;30190.79236830502;30303.69696303009;30513.237169070508;969.9660511882191;1010.7725761703558;1012.4633944009687;1052.8052310322614;1198.634416502975;13713.862861371457;14154.929225354013;14247.857521424861;14373.425062997363;14506;628393;632734.8363258246;635602;636592;637843;51036.48963510391;51313;51406;51464;51547.71130721687;1413.0814970269203;1414.9363278652486;1450.6228380621114;1451.702401007791;1456.3664805809506;25215.236822819694;26315;26350.4967028132;26573.60139597946;26802.061927832434;44249.77875110604;44530.3320450187;44641.55358446374;44732.881677958314;44787.77606111948;541157;542256;543778;544683;545700;23993.28020159398;24128;24346.634800477652;24368.87815560911;24471;41496.792516037225;42331.576684233994;42368.788156059025;42428;42865.35701964535;27339.589906151024;34589;34677.65322346845;35559.46660800142;35720.571177152626;33753.83123084369;34203;34254.48618270678;34323.485147722306;34724.9582512525;33410.33179336351;33882.49176262407;33919;34094.65905341014;34255.48616770701;24876.626850596895;26501.734982649927;28261.15216543507;28469;31115.066548003597;19682.704759428332;21579.460513487287;23062.769372306062;23267.952942117983;23658.88170559136 13:46:27 INFO - PROCESS | 1900 | |2;jquery.html;357.6030606027309;387.846800513797;388.1402693034927;393.39065044776;424.2977871622464;14692.853071469282;16395.754063689055;19877.701834472475;21276.574468510622;21319.786802131992;20897.791022089776;21191.788082119176;21573.784262157373;21582.244621438254;21845.563088738254;5723.856903577403;5820.679862607555;5913.852153696171;5958.553108516857;5974.223350964368;5726.3987281335485;5830.067189249721;5950.464458198761;5954.672493012882;5958.523318134538;5877.970610146944;5948.910766338508;5953.255843019622;5953.88092238155;5960.284765828085;5615.494605485485;5862.648241105548;5940.138679891435;5945.762169513214;5965.313988891268;5160.122779127557;5164.586833053347;5168.095583272912;5170.017696637665;5183.092958732207;25346;25526.744732552623;25685.871570642026;25756.8712156438;26017.73982260172;2724.4278701472713;2746.8178627785633;2779.194033730216;2794.091920125967;2830.6886242513306;15840.76238856418;15868.968517046354;15873;15943.840561594352;16602;1498.692767982561;1506.6685329227553;1742.677604643145;1762.7091529897552;1780.8041115477288;102995;120975.3951230247;122243;126293;128653.71346286511;9566.952165239269;11531.711707207387;11739.941300293443;11780;11947;14661.48684796027;14739.336729847182;14739.557813265405;14752.483663071742;14788.186649734153;6788.864222715617;8579;8655.394122411371;8705.956470217609;8782.824343513093;6903.75836845718;8437.746867593982;8456.830863382698;8475.618597163142;8581.528015959057;6019.789307374221;6275;7452.105747310357;7499.137599176164;7531.548107113591;1626.764119202709;1652.2482270566863;1924.5477312831474;1949.756280464942;1959.8922059286876;895.9372843900994;908.7818923458323;916.7158180963789;935.1116439382614;946.7207173883721;17908.641827163385;20032.29725473322;22451.214207502984;22506.774932250795;22565.88717056437;832.9292010179203;852.26705033671;854.6026097864523;927.2628260532892;938.3712912348743;6469.5794773339585;6519.445847103049;6557.672116394161;6712.295209003082;6761.357671021344;518779;535173.3241333768;619919;716716;717997;153458;155946;164418.17790910968;172437.2756272421;173393;989.6140505202976;1013.6350913671073;1040.557762950743;1041.0422411381546;1043.8277684182176;18716.906415467834;20010.499737506678;20133.993300335216;20155.697664535335;20195.69706454375;58445;58638;59370;60505.0924236128;61420.69289653702;62134;72149.63925180341;81555;90540;92198.53900730453;8293.21214484623;8425.157484251526;8430;8689.782755431164;8819.867701984347;12200.694982625506;13036.934815325863;13089.934550327187;13354.465821367037;13407.32963351848;9419.952900235456;9849;11207.439628018403;11460.426978651201;11488.425578720864;8643.654253829776;11303.265287756269;11581.594644187413;11594.594189203675;11621.535138594361;6128.785492507741;7510.924890751241;10999.61501347449;11541.711457213636;11628.53485860556;7215.2063273038875;8087.827265046418;8305.086440491661;8727.170918762962;8745.56272186401;9271.75488578992;10815.297005694605;11087.501062452047;11286.604968826052;11355.772884542097 13:46:27 INFO - PROCESS | 1900 | |3;mootools.html;1311.2132720367774;1367.6239034265577;1412.1033143953593;1458.6426325550242;1462.4661998370595;7552.282533159355;7790.610469476518;8180.550069746169;8629.439086459375;8632.56837158142;8146.348292136629;8386.20331068549;8426;8534.57327133644;8538.615762290696;2333.708286464196;2384.8688322142275;2385.988070059656;2386.224477044959;2390.103711108334;1750.754894314797;2164.1235299703567;2351.8236132290062;2387.3076807725824;2403.3150552092657;2254.6730724045005;2327.976720232793;2336.579415705181;2345.108858633717;2346.8826558672;2327.837051406402;2331.988340058297;2352.8117750579913;2354.5997180479358;2355.7173139223405;2307.8153747700144;2342.6486027095903;2353.752855950118;2371.5612611666897;2380.797632201248;8488.53313067781;8532.488050716915;8532.829343413097;8534.189252021048;8547.658093676246;5118.769655365518;5270.4729527047375;5275.815346462856;5280.656757310762;5281.287026251445;3390.8135052572097;3569.785812851211;3569.94645080324;3610.783352998802;3622.0582648511577;1207.1265759844803;1217.4095563651622;1235.258844693186;1245.8255844181822;1279.181323952671;10942.726431839188;11000;11026.062784663232;11027.1729620278;11031.724206894893;4602.815887364535;4763.809447622126;4817.13291607507;4819.903601927942;4831.347768051339;9564.18704410119;9653.71038868821;9654.227661787181;9663.226941844636;9677.612895484242;5259.737013149327;5324.733763311819;5326.36083669962;5326.493983071602;5332.813351532678;4710.057988402334;4844.8304309349705;4863.683860549053;4941.901161976741;4945.579625731853;3662.1760103976394;3752.7560708553856;3760.5863355030924;3799.5630502492013;3839.3281175794123;1063.8882917293727;1176.8117101263929;1222.572099765075;1299.9015831622264;1303.5046682260681;717.5622870049266;733.6331834082958;901.0808974845621;903.6430609909049;922.6447817590276;5214.843554693365;5369.785208591613;5396.91904621431;5578.776848926079;5705.429457054262;935.9906400936039;978.1978777402604;992.8411454167299;997.7804882925744;1016.5425558498705;3258;3555.4000699685243;3720.813959302024;3797.582265950743;3820.84716611338;9977.201823854075;10126.98730126996;10170.593176273014;10178.592856285813;10185.33795303303;10059.849102263472;10100;10115.190784737204;10129.088382045651;10167.644132455329;7652.73215437457;7801.531908085533;7854.018247719036;8059.919400806034;8060.798480037929;5437.374701909331;5466.753996070266;5476.890462190813;5586.352669046184;5758.107493338539;9239.445633262027;9381.202597779265;9408;9432.481213533321;9436.669716560162;9144.3598948073;9571.664991725534;9590.712278631652;9591.664291749756;9596.616135354509;7196.96401517989;7329.1205055391565;7336.96331518339;7342.926570734225;7347.302006309392;7809.96095019544;7812.062552493737;7883.5664038478435;7885.842283154419;7890.210978902293;6250.687465626609;7064.399526040139;7182.367373044462;7200.747973820891;7311.926880731125;7037;7085.256048114874;7131.786046418616;7212.386947109554;7242.818929526804;6360.713767880364;6387.297397286387;6459.838504037437;6461.418472337512;6491.48068154537;4505.617022552989;4592;4647.837325693719;4682.906341873211;4728.71627702339;4085.8161382737253;4885.193942999365;4974.054929563516;5041.974790126026;5051.898962020812 13:46:27 INFO - PROCESS | 1900 | |4;prototype.html;359.0735901374454;359.1398600352158;359.33343647533826;369.0625810441478;372.57526419881356;4894.510548945103;4958.851234462963;5023.020511000356;5255.395629502608;5468.589855760814;3841.6926645868334;4892.208538382755;5176.50823171798;5312.60155488338;5321.813736519222;4219.299648225138;4236.335569732175;4242.406063151161;4252.468441444819;4263.893402664927;3525.4359302511602;3775.830087646049;3869.6262826696397;4238;4255.851045213418;3676.522052133232;4065;4207.831686732527;4212.368144778293;4225.915481690365;4169.91660166795;4174.123434078847;4192.434021407102;4199.383237453587;4203.7687927164;3719.516462859838;3724.646158614927;3730.459083432914;3749.512563366772;3764.6800021998165;5007.6244281678655;5165.870853228662;5218.504242096995;5280.894382112375;5312.973435132838;4538.478075021382;4603.654725895572;4747.52524747526;4891.108891108891;4907.3129761833015;5755.625884317547;5794.884102317972;5800.680962547058;5834.358220595731;5839.64962102271;4018.3369743992207;4040.474738284004;4050.8775075200574;4171.541130475645;4186.434831297766;5454.400015998237;5678.921005009076;6016.516711436853;6076;6079.756809727562;3685.6867166291167;3754.793486358222;4220.965863363495;4238.957610423918;4245.936310955338;3400.710939570115;3914.37370020801;4110.0752330725945;4261.531231564525;4280.657547396201;4708.576228139484;4788.257820037899;4859.222524396079;4888.2178851384315;4896.5837903777865;5133.921876405997;5738.651416917021;5744.569157313134;5768.798092066758;5791.942080579224;1245.9003279737599;1323.014354306029;1388.2017839742189;1404.4241860837008;1406.346049087159;849.8640217565284;879.2306731609841;881.395859535639;882.6734108379941;897.1028971028971;5084.398414499421;5094.49055094495;5094.566961808214;5110.4123025852505;5198.792048318101;4980.601551875914;5194.766235519411;5649.4350564944;5800.854978625568;5849.846608907638;4304.192239259456;4314.309710446313;4879.39007624047;4987.376577927759;5083.872903177376;2637.4593208392234;2711.457708458316;2841.744243018138;2842.801003929705;2857.6999415061537;4990.6506544541535;5439.836804895859;5611.775528978795;5642.294713160855;5849.280084760521;5389.493885343256;5507.71429856613;5525.557955363562;5730.942690573041;5802.4197580241635;5836.182934389274;5855.882882342415;5861.824145275648;5865.501432378295;6064.545159113084;4538.29656403258;4665.533446655308;4889.386502454253;5451.781928722807;5639.577031722555;5577.247071645438;5621.241132447068;5805.912911306418;5837.94162058374;5865.384134665798;5892.823215303548;6070.848228794315;6105.847353816012;6128.938710612837;6192.81421557354;3550.485179648988;3599.3161299353037;3651.8721844735305;3925.980370098131;3972.2591411925678;5479.232907392889;5602.915956260741;5803.274590676166;5870.706464676664;5967.8209653710455;5218.295530103387;5693.345265294544;5708.885822283614;5724;5746.649537358634;4680.074953154279;5321.733913304397;5460.699661518495;5722.971385143048;5753.453421924911;5044.646874718735;5295.073362161529;5298.682079075268;5417.891642167214;5689.317281926195;4632.953670463252;4836.799256338428;5757.222774925499;5780.132980053026;5781.55356777182;4782.760861956958;5381.596380271573;5426.403095659553;5595;5671 13:46:27 INFO - PROCESS | 1900 | |5;yui.html;651.6774196772601;689.0904006711137;696.6969368324777;752.1706772513024;831.3141658132041;14846.480373186942;14993.700125997473;15505.767413488808;15580.454684086058;15585.532434026969;14698.338574764135;14719.705605887875;14779.187144707037;14854.777178342334;14914.776278355806;845.5983407881238;860.9182127697859;861.0098386855104;862.0775769926181;864.4337958637103;657.4543129202774;684.336193891924;762.3024932187042;801.3308887079296;853.9914600854005;779.5829231361223;862.8921384826897;906.8458362078462;907.2560500389683;909.2634965677822;896.238197532099;898.0256421782374;898.4968417686117;901.058393978291;901.1664210605197;664.0404615330849;664.6510581944518;666.4002397841932;668.381746884135;670.4435318685479;14927.925360373238;15253.542393728207;15309.387624495006;15347.309371078329;15369.615759606098;13686.52097176604;13981.79027314591;13997.79003314941;14055.367508462145;14064.156150630892;12311.261324320569;12336.568220112344;12423.31671758053;12428.627141185689;12435.875641243561;4265.594768496988;4310.892227694301;4330.870073897788;4380.802863871101;4390.868273951786;99704.50147749287;101838;106948;111335.88664113336;111829.99999999919;10184.694459166238;10807.666492654156;10898.346099234072;10926.945365273123;11195.4962026709;20323;20354.49113772138;20471.38585842427;20573.794262057487;21007.474813129487;7828.444908824019;7887.369010479148;7996.04047514302;8047.919520804834;8125.228103330174;4305.784710764449;4372.868813935587;4378.868633940987;4421.624161946271;4571.245744452128;3287.539744435781;3612.1150318172217;3669.3578623740736;3670.6879915207505;3695.316366472211;602.3885755957618;671.835400326923;684.2404930527111;687.5805758487419;696.4428457234294;650.72344253692;680.9547344825669;682.2665634442993;687.2680595166232;703.1070540413748;8585.484870907641;9649.372790768577;10526.684199474028;10566.471676416302;10627.734306642396;693.3932808792307;703.9084918960605;704.4399702236734;708.8121647763347;720.121451828768;3678.448232765053;3941.994791328193;4177.456930599003;4184.8744537663915;4337.783110844445;72975.63512182405;82235.5888220567;99800;107086.59060409275;113183.43408282906;76480.61759691166;93770;96041.07917841604;99229;100303;70484;70889.64555177192;71830.64084679648;75917.62041189759;79855;10681.03870651645;10871.96716311949;11171.776564468828;11304.265222760494;11365.943170284096;48538.27192592043;48944.75527622339;49373.25940110973;50845.74577127091;51607;49032.75483622559;64392.03411948731;66427.66786166231;66585;68784;12732.172408793398;12814;12836.55072072473;13147.0139739518;13267;12111.697207569528;13848.238346891017;14339.952690480666;14464.783028254375;14649.780253296422;13093.607191784262;13552.983526235768;13581.524646637321;13666.658333541343;13714.86285137136;13065.869341306465;13138.948884089441;13602.115862468909;13766.105203161762;14040.597168699263;12906.161099528501;13380.732385352434;13562.118462299919;13781.310934453037;13806.102603330752;10735.785284294427;10956.397398142859;10991.120710343313;11184.328940263611;11317.660470185907;10391.896081039093;10618.8407173894;10871.565137394417;10876.12990960737;10892.836607450736 13:46:27 INFO - PROCESS | 1900 | __end_tp_report 13:46:27 INFO - PROCESS | 1900 | __start_cc_report 13:46:27 INFO - PROCESS | 1900 | _x_x_mozilla_cycle_collect,379 13:46:27 INFO - PROCESS | 1900 | __end_cc_report 13:46:27 INFO - PROCESS | 1900 | __startTimestamp1487886387176__endTimestamp 13:46:27 INFO - PROCESS | 1900 | 13:46:27 INFO - PROCESS | 1900 | ------- Summary: start ------- 13:46:27 INFO - PROCESS | 1900 | Number of tests: 6 13:46:27 INFO - PROCESS | 1900 | 13:46:27 INFO - PROCESS | 1900 | [#0] dojo.html Cycles:165 Average:5735.32 Median:6027.67 stddev:669.11 (11.1%) stddev-sans-first:644.94 13:46:27 INFO - PROCESS | 1900 | Values: 3370.5 3375.3 3408.5 3411.5 3420.6 5701.5 5714.1 5728.6 5756.7 5785.1 5754.4 5807.7 5822.8 5832.5 5863.1 4880.8 5254.7 5276.1 5290.5 5341.5 5254.5 5338.3 5356.5 5356.7 5391.9 5133.5 5160.5 5242.6 5318.8 5323.9 4288.9 5141.2 5215.4 5262.9 5306.8 5143.8 5155.9 5189.7 5201.8 5224.5 5485.9 5570.7 5643.5 5692.9 5750.5 6242.3 6263.1 6268.0 6293.3 6338.7 6275.0 6287.9 6294.0 6308.2 6317.6 5970.1 5978.3 5979.2 5996.3 5996.9 6150.8 6175.2 6231.5 6251.1 6291.8 6181.8 6201.9 6221.3 6232.7 6249.0 6266.9 6270.8 6279.9 6286.2 6293.6 5067.4 6027.7 6038.7 6145.7 6219.3 6114.7 6120.6 6129.1 6136.0 6136.9 4891.6 4906.2 4911.5 4914.4 4943.9 3663.8 4413.4 4447.8 4476.5 4514.4 4773.0 5873.2 5890.6 5911.5 5937.6 6205.5 6254.0 6264.5 6266.9 6291.4 5584.8 5699.9 5802.3 5835.9 5846.8 5329.9 5523.3 5523.8 5536.2 5565.4 5292.4 5302.7 6377.8 6400.3 6417.8 6180.5 6189.2 6230.0 6241.0 6264.9 5188.2 6361.1 6391.6 6405.1 6417.1 5036.4 6110.2 6214.7 6250.3 6304.8 6178.6 6212.3 6227.7 6249.3 6280.7 6140.9 6140.9 6145.3 6198.9 6227.5 6132.5 6169.1 6180.4 6190.7 6204.7 5084.0 6009.3 6055.5 6093.4 6103.5 6084.1 6100.2 6128.0 6129.8 6146.6 6077.9 6086.3 6088.9 6096.1 6111.0 13:46:27 INFO - PROCESS | 1900 | 13:46:27 INFO - PROCESS | 1900 | [#1] ext.html Cycles:180 Average:66615.71 Median:34701.31 stddev:146448.78 (422.0%) stddev-sans-first:146775.32 13:46:27 INFO - PROCESS | 1900 | Values: 439.8 494.0 504.6 511.1 512.0 37308.6 39961.2 40112.6 40178.4 43009.0 42088.6 42586.6 42596.1 42635.8 42651.1 8333.6 9285.9 9448.4 9472.4 9506.5 6548.2 6672.2 6676.5 6733.2 8385.8 11255.9 11384.2 11388.8 11396.0 11419.5 11316.6 11454.4 11457.4 11459.4 11469.0 9653.5 11252.5 11335.3 11342.3 11363.5 32358.0 39345.8 39538.6 39649.4 39813.4 3976.0 4013.9 4054.8 4061.1 4061.7 26082.5 27831.7 29549.7 31142.0 31221.7 3091.7 3208.1 3208.6 3219.3 3235.5 445118.0 449001.0 449613.0 450315.0 450954.7 56394.7 58390.4 61401.7 61750.5 61751.4 63837.7 64828.0 64837.0 65024.0 65091.0 15746.4 16085.8 16102.6 16109.2 16140.6 10057.7 11049.0 11085.2 12229.8 12328.7 16271.7 16536.9 16711.7 16730.5 16800.4 7474.7 7618.6 7627.0 7646.1 7673.4 863.9 875.5 877.9 893.4 911.6 25495.0 30190.5 30190.8 30303.7 30513.2 970.0 1010.8 1012.5 1052.8 1198.6 13713.9 14154.9 14247.9 14373.4 14506.0 628393.0 632734.8 635602.0 636592.0 637843.0 51036.5 51313.0 51406.0 51464.0 51547.7 1413.1 1414.9 1450.6 1451.7 1456.4 25215.2 26315.0 26350.5 26573.6 26802.1 44249.8 44530.3 44641.6 44732.9 44787.8 541157.0 542256.0 543778.0 544683.0 545700.0 23993.3 24128.0 24346.6 24368.9 24471.0 41496.8 42331.6 42368.8 42428.0 42865.4 27339.6 34589.0 34677.7 35559.5 35720.6 33753.8 34203.0 34254.5 34323.5 34725.0 33410.3 33882.5 33919.0 34094.7 34255.5 24876.6 26501.7 28261.2 28469.0 31115.1 19682.7 21579.5 23062.8 23268.0 23658.9 13:46:27 INFO - PROCESS | 1900 | 13:46:27 INFO - PROCESS | 1900 | [#2] jquery.html Cycles:180 Average:37056.85 Median:408.84 stddev:105701.68 (25853.8%) stddev-sans-first:105962.29 13:46:27 INFO - PROCESS | 1900 | Values: 357.6 387.8 388.1 393.4 424.3 14692.9 16395.8 19877.7 21276.6 21319.8 20897.8 21191.8 21573.8 21582.2 21845.6 5723.9 5820.7 5913.9 5958.6 5974.2 5726.4 5830.1 5950.5 5954.7 5958.5 5878.0 5948.9 5953.3 5953.9 5960.3 5615.5 5862.6 5940.1 5945.8 5965.3 5160.1 5164.6 5168.1 5170.0 5183.1 25346.0 25526.7 25685.9 25756.9 26017.7 2724.4 2746.8 2779.2 2794.1 2830.7 15840.8 15869.0 15873.0 15943.8 16602.0 1498.7 1506.7 1742.7 1762.7 1780.8 102995.0 120975.4 122243.0 126293.0 128653.7 9567.0 11531.7 11739.9 11780.0 11947.0 14661.5 14739.3 14739.6 14752.5 14788.2 6788.9 8579.0 8655.4 8706.0 8782.8 6903.8 8437.7 8456.8 8475.6 8581.5 6019.8 6275.0 7452.1 7499.1 7531.5 1626.8 1652.2 1924.5 1949.8 1959.9 895.9 908.8 916.7 935.1 946.7 17908.6 20032.3 22451.2 22506.8 22565.9 832.9 852.3 854.6 927.3 938.4 6469.6 6519.4 6557.7 6712.3 6761.4 518779.0 535173.3 619919.0 716716.0 717997.0 153458.0 155946.0 164418.2 172437.3 173393.0 989.6 1013.6 1040.6 1041.0 1043.8 18716.9 20010.5 20134.0 20155.7 20195.7 58445.0 58638.0 59370.0 60505.1 61420.7 62134.0 72149.6 81555.0 90540.0 92198.5 8293.2 8425.2 8430.0 8689.8 8819.9 12200.7 13036.9 13089.9 13354.5 13407.3 9420.0 9849.0 11207.4 11460.4 11488.4 8643.7 11303.3 11581.6 11594.6 11621.5 6128.8 7510.9 10999.6 11541.7 11628.5 7215.2 8087.8 8305.1 8727.2 8745.6 9271.8 10815.3 11087.5 11286.6 11355.8 13:46:27 INFO - PROCESS | 1900 | 13:46:27 INFO - PROCESS | 1900 | [#3] mootools.html Cycles:180 Average:5481.61 Median:5166.81 stddev:3015.89 (58.4%) stddev-sans-first:3008.07 13:46:27 INFO - PROCESS | 1900 | Values: 1311.2 1367.6 1412.1 1458.6 1462.5 7552.3 7790.6 8180.6 8629.4 8632.6 8146.3 8386.2 8426.0 8534.6 8538.6 2333.7 2384.9 2386.0 2386.2 2390.1 1750.8 2164.1 2351.8 2387.3 2403.3 2254.7 2328.0 2336.6 2345.1 2346.9 2327.8 2332.0 2352.8 2354.6 2355.7 2307.8 2342.6 2353.8 2371.6 2380.8 8488.5 8532.5 8532.8 8534.2 8547.7 5118.8 5270.5 5275.8 5280.7 5281.3 3390.8 3569.8 3569.9 3610.8 3622.1 1207.1 1217.4 1235.3 1245.8 1279.2 10942.7 11000.0 11026.1 11027.2 11031.7 4602.8 4763.8 4817.1 4819.9 4831.3 9564.2 9653.7 9654.2 9663.2 9677.6 5259.7 5324.7 5326.4 5326.5 5332.8 4710.1 4844.8 4863.7 4941.9 4945.6 3662.2 3752.8 3760.6 3799.6 3839.3 1063.9 1176.8 1222.6 1299.9 1303.5 717.6 733.6 901.1 903.6 922.6 5214.8 5369.8 5396.9 5578.8 5705.4 936.0 978.2 992.8 997.8 1016.5 3258.0 3555.4 3720.8 3797.6 3820.8 9977.2 10127.0 10170.6 10178.6 10185.3 10059.8 10100.0 10115.2 10129.1 10167.6 7652.7 7801.5 7854.0 8059.9 8060.8 5437.4 5466.8 5476.9 5586.4 5758.1 9239.4 9381.2 9408.0 9432.5 9436.7 9144.4 9571.7 9590.7 9591.7 9596.6 7197.0 7329.1 7337.0 7342.9 7347.3 7810.0 7812.1 7883.6 7885.8 7890.2 6250.7 7064.4 7182.4 7200.7 7311.9 7037.0 7085.3 7131.8 7212.4 7242.8 6360.7 6387.3 6459.8 6461.4 6491.5 4505.6 4592.0 4647.8 4682.9 4728.7 4085.8 4885.2 4974.1 5042.0 5051.9 13:46:27 INFO - PROCESS | 1900 | 13:46:27 INFO - PROCESS | 1900 | [#4] prototype.html Cycles:180 Average:4597.46 Median:5084.14 stddev:1388.37 (27.3%) stddev-sans-first:1355.33 13:46:27 INFO - PROCESS | 1900 | Values: 359.1 359.1 359.3 369.1 372.6 4894.5 4958.9 5023.0 5255.4 5468.6 3841.7 4892.2 5176.5 5312.6 5321.8 4219.3 4236.3 4242.4 4252.5 4263.9 3525.4 3775.8 3869.6 4238.0 4255.9 3676.5 4065.0 4207.8 4212.4 4225.9 4169.9 4174.1 4192.4 4199.4 4203.8 3719.5 3724.6 3730.5 3749.5 3764.7 5007.6 5165.9 5218.5 5280.9 5313.0 4538.5 4603.7 4747.5 4891.1 4907.3 5755.6 5794.9 5800.7 5834.4 5839.6 4018.3 4040.5 4050.9 4171.5 4186.4 5454.4 5678.9 6016.5 6076.0 6079.8 3685.7 3754.8 4221.0 4239.0 4245.9 3400.7 3914.4 4110.1 4261.5 4280.7 4708.6 4788.3 4859.2 4888.2 4896.6 5133.9 5738.7 5744.6 5768.8 5791.9 1245.9 1323.0 1388.2 1404.4 1406.3 849.9 879.2 881.4 882.7 897.1 5084.4 5094.5 5094.6 5110.4 5198.8 4980.6 5194.8 5649.4 5800.9 5849.8 4304.2 4314.3 4879.4 4987.4 5083.9 2637.5 2711.5 2841.7 2842.8 2857.7 4990.7 5439.8 5611.8 5642.3 5849.3 5389.5 5507.7 5525.6 5730.9 5802.4 5836.2 5855.9 5861.8 5865.5 6064.5 4538.3 4665.5 4889.4 5451.8 5639.6 5577.2 5621.2 5805.9 5837.9 5865.4 5892.8 6070.8 6105.8 6128.9 6192.8 3550.5 3599.3 3651.9 3926.0 3972.3 5479.2 5602.9 5803.3 5870.7 5967.8 5218.3 5693.3 5708.9 5724.0 5746.6 4680.1 5321.7 5460.7 5723.0 5753.5 5044.6 5295.1 5298.7 5417.9 5689.3 4633.0 4836.8 5757.2 5780.1 5781.6 4782.8 5381.6 5426.4 5595.0 5671.0 13:46:27 INFO - PROCESS | 1900 | 13:46:27 INFO - PROCESS | 1900 | [#5] yui.html Cycles:180 Average:20158.30 Median:3818.66 stddev:28837.94 (755.2%) stddev-sans-first:28881.64 13:46:27 INFO - PROCESS | 1900 | Values: 651.7 689.1 696.7 752.2 831.3 14846.5 14993.7 15505.8 15580.5 15585.5 14698.3 14719.7 14779.2 14854.8 14914.8 845.6 860.9 861.0 862.1 864.4 657.5 684.3 762.3 801.3 854.0 779.6 862.9 906.8 907.3 909.3 896.2 898.0 898.5 901.1 901.2 664.0 664.7 666.4 668.4 670.4 14927.9 15253.5 15309.4 15347.3 15369.6 13686.5 13981.8 13997.8 14055.4 14064.2 12311.3 12336.6 12423.3 12428.6 12435.9 4265.6 4310.9 4330.9 4380.8 4390.9 99704.5 101838.0 106948.0 111335.9 111830.0 10184.7 10807.7 10898.3 10926.9 11195.5 20323.0 20354.5 20471.4 20573.8 21007.5 7828.4 7887.4 7996.0 8047.9 8125.2 4305.8 4372.9 4378.9 4421.6 4571.2 3287.5 3612.1 3669.4 3670.7 3695.3 602.4 671.8 684.2 687.6 696.4 650.7 681.0 682.3 687.3 703.1 8585.5 9649.4 10526.7 10566.5 10627.7 693.4 703.9 704.4 708.8 720.1 3678.4 3942.0 4177.5 4184.9 4337.8 72975.6 82235.6 99800.0 107086.6 113183.4 76480.6 93770.0 96041.1 99229.0 100303.0 70484.0 70889.6 71830.6 75917.6 79855.0 10681.0 10872.0 11171.8 11304.3 11365.9 48538.3 48944.8 49373.3 50845.7 51607.0 49032.8 64392.0 66427.7 66585.0 68784.0 12732.2 12814.0 12836.6 13147.0 13267.0 12111.7 13848.2 14340.0 14464.8 14649.8 13093.6 13553.0 13581.5 13666.7 13714.9 13065.9 13138.9 13602.1 13766.1 14040.6 12906.2 13380.7 13562.1 13781.3 13806.1 10735.8 10956.4 10991.1 11184.3 11317.7 10391.9 10618.8 10871.6 10876.1 10892.8 13:46:27 INFO - PROCESS | 1900 | -------- Summary: end -------- 13:46:27 INFO - PROCESS | 1900 | 13:46:27 INFO - TEST-INFO | 1900: exit 0 13:46:27 INFO - TEST-OK | dromaeo_css | took 1116120ms 13:46:27 INFO - TEST-START | kraken 13:46:27 INFO - operating with platform_type : mac_ 13:46:27 INFO - Initialising browser for kraken test... 13:46:27 INFO - TEST-INFO | started process 1907 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmpugNuTe/profile http://localhost:49367/getInfo.html) 13:46:30 INFO - PROCESS | 1907 | 2017-02-23 13:46:30.726 plugin-container[1908:11216] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x873f, name = 'com.apple.tsm.portname' 13:46:30 INFO - PROCESS | 1907 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:46:30 INFO - PROCESS | 1907 | 2017-02-23 13:46:30.729 plugin-container[1908:11216] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0f, name = 'com.apple.CFPasteboardClient' 13:46:30 INFO - PROCESS | 1907 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:46:30 INFO - PROCESS | 1907 | 2017-02-23 13:46:30.729 plugin-container[1908:11216] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:46:30 INFO - PROCESS | 1907 | __metrics Screen width/height:1600/1200 13:46:30 INFO - PROCESS | 1907 | colorDepth:24 13:46:30 INFO - PROCESS | 1907 | Browser inner width/height: 1024/689 13:46:30 INFO - PROCESS | 1907 | __metrics 13:46:30 ERROR - PROCESS | 1907 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3277: TypeError: this.tabs is undefined 13:46:31 INFO - TEST-INFO | 1907: exit 0 13:46:31 INFO - Browser initialized. 13:46:31 INFO - Running cycle 1/1 for kraken test... 13:46:31 INFO - TEST-INFO | started process 1909 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/T/tmpugNuTe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:46:33 INFO - PROCESS | 1909 | 2017-02-23 13:46:33.934 plugin-container[1910:11343] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 13:46:33 INFO - PROCESS | 1909 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:46:33 INFO - PROCESS | 1909 | 2017-02-23 13:46:33.935 plugin-container[1910:11343] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 13:46:33 INFO - PROCESS | 1909 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:46:33 INFO - PROCESS | 1909 | 2017-02-23 13:46:33.935 plugin-container[1910:11343] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:46:43 INFO - PROCESS | 1909 | RSS: Main: 218615808 13:46:43 INFO - PROCESS | 1909 | 13:46:46 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49367/tests/kraken/driver.html?testName=audio-beat-detection) 13:46:47 INFO - PROCESS | 1909 | RSS: Main: 233209856 13:46:47 INFO - PROCESS | 1909 | 13:46:50 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49367/tests/kraken/driver.html?testName=audio-dft) 13:46:50 INFO - PROCESS | 1909 | RSS: Main: 242020352 13:46:50 INFO - PROCESS | 1909 | 13:46:54 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49367/tests/kraken/driver.html?testName=audio-fft) 13:46:54 INFO - PROCESS | 1909 | RSS: Main: 245055488 13:46:54 INFO - PROCESS | 1909 | 13:46:56 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49367/tests/kraken/driver.html?testName=audio-oscillator) 13:46:57 INFO - PROCESS | 1909 | RSS: Main: 245080064 13:46:57 INFO - PROCESS | 1909 | 13:46:59 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49367/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:47:00 INFO - PROCESS | 1909 | RSS: Main: 245088256 13:47:00 INFO - PROCESS | 1909 | 13:47:03 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49367/tests/kraken/driver.html?testName=imaging-darkroom) 13:47:03 INFO - PROCESS | 1909 | RSS: Main: 250372096 13:47:03 INFO - PROCESS | 1909 | 13:47:07 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49367/tests/kraken/driver.html?testName=imaging-desaturate) 13:47:07 INFO - PROCESS | 1909 | RSS: Main: 249212928 13:47:07 INFO - PROCESS | 1909 | 13:47:10 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49367/tests/kraken/driver.html?testName=json-parse-financial) 13:47:11 INFO - PROCESS | 1909 | RSS: Main: 249397248 13:47:11 INFO - PROCESS | 1909 | 13:47:13 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49367/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:47:13 INFO - PROCESS | 1909 | RSS: Main: 248856576 13:47:13 INFO - PROCESS | 1909 | 13:47:15 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49367/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:47:16 INFO - PROCESS | 1909 | RSS: Main: 248860672 13:47:16 INFO - PROCESS | 1909 | 13:47:18 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49367/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:47:19 INFO - PROCESS | 1909 | RSS: Main: 248893440 13:47:19 INFO - PROCESS | 1909 | 13:47:22 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49367/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:47:23 INFO - PROCESS | 1909 | RSS: Main: 249245696 13:47:23 INFO - PROCESS | 1909 | 13:47:25 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49367/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:47:26 INFO - PROCESS | 1909 | RSS: Main: 249040896 13:47:26 INFO - PROCESS | 1909 | 13:47:28 INFO - PROCESS | 1909 | Cycle 1(1): loaded http://localhost:49367/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49367/tests/kraken/driver.html?testName=ai-astar) 13:47:28 INFO - PROCESS | 1909 | RSS: Main: 251076608 13:47:28 INFO - PROCESS | 1909 | 13:47:28 INFO - PROCESS | 1909 | __start_tp_report 13:47:28 INFO - PROCESS | 1909 | _x_x_mozilla_page_load 13:47:28 INFO - PROCESS | 1909 | _x_x_mozilla_page_load_details 13:47:28 INFO - PROCESS | 1909 | |i|pagename|runs| 13:47:28 INFO - PROCESS | 1909 | |0;ai-astar;108;119;120;119;127;119;118;120;120;119 13:47:28 INFO - PROCESS | 1909 | |1;audio-beat-detection;141;115;116;146;160;143;145;129;131;118 13:47:28 INFO - PROCESS | 1909 | |2;audio-dft;203;192;198;198;196;196;193;194;202;192 13:47:28 INFO - PROCESS | 1909 | |3;audio-fft;85;59;62;87;63;59;58;64;93;90 13:47:28 INFO - PROCESS | 1909 | |4;audio-oscillator;86;71;84;71;72;103;111;99;84;84 13:47:28 INFO - PROCESS | 1909 | |5;imaging-gaussian-blur;135;115;90;123;87;81;134;132;90;86 13:47:28 INFO - PROCESS | 1909 | |6;imaging-darkroom;95;96;110;152;93;153;154;105;151;109 13:47:28 INFO - PROCESS | 1909 | |7;imaging-desaturate;118;143;91;147;143;107;91;91;95;91 13:47:28 INFO - PROCESS | 1909 | |8;json-parse-financial;59;60;59;65;72;95;94;96;97;83 13:47:28 INFO - PROCESS | 1909 | |9;json-stringify-tinderbox;92;98;72;78;74;68;69;69;74;72 13:47:28 INFO - PROCESS | 1909 | |10;stanford-crypto-aes;85;89;90;88;88;84;87;87;91;110 13:47:28 INFO - PROCESS | 1909 | |11;stanford-crypto-ccm;139;139;161;147;158;148;154;155;156;138 13:47:28 INFO - PROCESS | 1909 | |12;stanford-crypto-pbkdf2;169;172;173;168;171;166;171;169;167;180 13:47:28 INFO - PROCESS | 1909 | |13;stanford-crypto-sha256-iterative;69;65;85;95;84;92;87;67;67;67 13:47:28 INFO - PROCESS | 1909 | __end_tp_report 13:47:28 INFO - PROCESS | 1909 | __start_cc_report 13:47:28 INFO - PROCESS | 1909 | _x_x_mozilla_cycle_collect,980 13:47:28 INFO - PROCESS | 1909 | __end_cc_report 13:47:28 INFO - PROCESS | 1909 | __startTimestamp1487886448586__endTimestamp 13:47:28 INFO - PROCESS | 1909 | 13:47:28 INFO - PROCESS | 1909 | ------- Summary: start ------- 13:47:28 INFO - PROCESS | 1909 | Number of tests: 14 13:47:28 INFO - PROCESS | 1909 | 13:47:28 INFO - PROCESS | 1909 | [#0] ai-astar Cycles:10 Average:118.90 Median:119.50 stddev:4.58 (3.8%) stddev-sans-first:2.67 13:47:28 INFO - PROCESS | 1909 | Values: 108.0 119.0 120.0 119.0 127.0 119.0 118.0 120.0 120.0 119.0 13:47:28 INFO - PROCESS | 1909 | 13:47:28 INFO - PROCESS | 1909 | [#1] audio-beat-detection Cycles:10 Average:134.40 Median:142.00 stddev:15.07 (10.6%) stddev-sans-first:15.80 13:47:28 INFO - PROCESS | 1909 | Values: 141.0 115.0 116.0 146.0 160.0 143.0 145.0 129.0 131.0 118.0 13:47:28 INFO - PROCESS | 1909 | 13:47:28 INFO - PROCESS | 1909 | [#2] audio-dft Cycles:10 Average:196.40 Median:197.00 stddev:3.89 (2.0%) stddev-sans-first:3.32 13:47:28 INFO - PROCESS | 1909 | Values: 203.0 192.0 198.0 198.0 196.0 196.0 193.0 194.0 202.0 192.0 13:47:28 INFO - PROCESS | 1909 | 13:47:28 INFO - PROCESS | 1909 | [#3] audio-fft Cycles:10 Average:72.00 Median:74.50 stddev:14.67 (19.7%) stddev-sans-first:14.79 13:47:28 INFO - PROCESS | 1909 | Values: 85.0 59.0 62.0 87.0 63.0 59.0 58.0 64.0 93.0 90.0 13:47:28 INFO - PROCESS | 1909 | 13:47:28 INFO - PROCESS | 1909 | [#4] audio-oscillator Cycles:10 Average:86.50 Median:84.00 stddev:13.90 (16.5%) stddev-sans-first:14.74 13:47:28 INFO - PROCESS | 1909 | Values: 86.0 71.0 84.0 71.0 72.0 103.0 111.0 99.0 84.0 84.0 13:47:28 INFO - PROCESS | 1909 | 13:47:28 INFO - PROCESS | 1909 | [#5] imaging-gaussian-blur Cycles:10 Average:107.30 Median:83.50 stddev:22.49 (26.9%) stddev-sans-first:21.50 13:47:28 INFO - PROCESS | 1909 | Values: 135.0 115.0 90.0 123.0 87.0 81.0 134.0 132.0 90.0 86.0 13:47:28 INFO - PROCESS | 1909 | 13:47:28 INFO - PROCESS | 1909 | [#6] imaging-darkroom Cycles:10 Average:121.80 Median:153.50 stddev:27.03 (17.6%) stddev-sans-first:26.87 13:47:28 INFO - PROCESS | 1909 | Values: 95.0 96.0 110.0 152.0 93.0 153.0 154.0 105.0 151.0 109.0 13:47:28 INFO - PROCESS | 1909 | 13:47:28 INFO - PROCESS | 1909 | [#7] imaging-desaturate Cycles:10 Average:111.70 Median:91.00 stddev:24.18 (26.6%) stddev-sans-first:25.53 13:47:28 INFO - PROCESS | 1909 | Values: 118.0 143.0 91.0 147.0 143.0 107.0 91.0 91.0 95.0 91.0 13:47:28 INFO - PROCESS | 1909 | 13:47:28 INFO - PROCESS | 1909 | [#8] json-parse-financial Cycles:10 Average:78.00 Median:88.50 stddev:16.69 (18.9%) stddev-sans-first:16.22 13:47:28 INFO - PROCESS | 1909 | Values: 59.0 60.0 59.0 65.0 72.0 95.0 94.0 96.0 97.0 83.0 13:47:28 INFO - PROCESS | 1909 | 13:47:28 INFO - PROCESS | 1909 | [#9] json-stringify-tinderbox Cycles:10 Average:76.60 Median:74.00 stddev:10.23 (13.8%) stddev-sans-first:9.21 13:47:28 INFO - PROCESS | 1909 | Values: 92.0 98.0 72.0 78.0 74.0 68.0 69.0 69.0 74.0 72.0 13:47:28 INFO - PROCESS | 1909 | 13:47:28 INFO - PROCESS | 1909 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:88.00 stddev:7.37 (8.4%) stddev-sans-first:7.60 13:47:28 INFO - PROCESS | 1909 | Values: 85.0 89.0 90.0 88.0 88.0 84.0 87.0 87.0 91.0 110.0 13:47:28 INFO - PROCESS | 1909 | 13:47:28 INFO - PROCESS | 1909 | [#11] stanford-crypto-ccm Cycles:10 Average:149.50 Median:154.50 stddev:8.55 (5.5%) stddev-sans-first:8.19 13:47:28 INFO - PROCESS | 1909 | Values: 139.0 139.0 161.0 147.0 158.0 148.0 154.0 155.0 156.0 138.0 13:47:28 INFO - PROCESS | 1909 | 13:47:28 INFO - PROCESS | 1909 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.60 Median:171.00 stddev:3.98 (2.3%) stddev-sans-first:4.18 13:47:28 INFO - PROCESS | 1909 | Values: 169.0 172.0 173.0 168.0 171.0 166.0 171.0 169.0 167.0 180.0 13:47:28 INFO - PROCESS | 1909 | 13:47:28 INFO - PROCESS | 1909 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.80 Median:84.50 stddev:11.85 (14.0%) stddev-sans-first:12.13 13:47:28 INFO - PROCESS | 1909 | Values: 69.0 65.0 85.0 95.0 84.0 92.0 87.0 67.0 67.0 67.0 13:47:28 INFO - PROCESS | 1909 | -------- Summary: end -------- 13:47:28 INFO - PROCESS | 1909 | 13:47:29 INFO - TEST-INFO | 1909: exit 0 13:47:29 INFO - TEST-OK | kraken | took 61628ms 13:47:29 INFO - SUITE-END | took 1177s 13:47:29 INFO - Completed test suite (00:19:38) 13:47:29 INFO - javascript benchmark 13:47:29 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7261.992874020366, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3370.544976428182, 3375.3080618473214, 3408.505766663833, 3411.4712219605954, 3420.572428446444, 5701.45836145566, 5714.085746280591, 5728.627639203449, 5756.654600723959, 5785.132230165466, 5754.395788442216, 5807.651540907538, 5822.796202132926, 5832.504237139849, 5863.149843272734, 4880.755962201893, 5254.737263136847, 5276.076686579833, 5290.523852853243, 5341.4658534146465, 5254.500822421864, 5338.27933229015, 5356.54469370104, 5356.678599284036, 5391.946080539204, 5133.460986596391, 5160.509751573594, 5242.580593552507, 5318.813841515567, 5323.866903327409, 4288.892777680583, 5141.15170996785, 5215.374155101412, 5262.8684282892855, 5306.7611957462, 5143.794248230066, 5155.871103222412, 5189.662671926313, 5201.791928322863, 5224.529792318672, 5485.917711234335, 5570.721463926828, 5643.492085712305, 5692.857678558028, 5750.482456578886, 6242.344553821874, 6263.091851681526, 6268.028455589391, 6293.276273228592, 6338.7464501420345, 6275.0, 6287.937120628827, 6294.0, 6308.2430108386825, 6317.589356691847, 5970.104484327386, 5978.342382337939, 5979.1629171915965, 5996.340402555716, 5996.8500787480225, 6150.815475535741, 6175.228096487939, 6231.532635052298, 6251.0623406488485, 6291.811245662638, 6181.81454556364, 6201.937980620136, 6221.3156552779155, 6232.719527621268, 6248.968755156286, 6266.905996410058, 6270.7805226816845, 6279.874402512016, 6286.182796236551, 6293.576972865389, 5067.41724701664, 6027.668478233739, 6038.698065096728, 6145.692715364214, 6219.315875253718, 6114.692773002168, 6120.629988696826, 6129.05316799051, 6136.028952951454, 6136.8772624547255, 4891.559759621651, 4906.215005599087, 4911.45973942866, 4914.410270767459, 4943.90112197754, 3663.8351274192723, 4413.44831896013, 4447.844325448594, 4476.507584165739, 4514.390557274792, 4773.0, 5873.20711703923, 5890.587658863838, 5911.467967882825, 5937.643741375531, 6205.47253483459, 6254.0, 6264.498840092781, 6266.874662506724, 6291.433770960635, 5584.832455026356, 5699.857503562444, 5802.303723553201, 5835.912461313083, 5846.795362162304, 5329.934013197376, 5523.28197334344, 5523.834284971457, 5536.2249285100115, 5565.387807341189, 5292.41783403833, 5302.734863256822, 6377.7767778127545, 6400.295967443671, 6417.807465776034, 6180.536459765625, 6189.226346706661, 6230.00319948806, 6241.032639940817, 6264.906026409699, 5188.247704082963, 6361.109444677656, 6391.58454700443, 6405.135306733531, 6417.0695249187675, 5036.395632523974, 6110.205673262448, 6214.731399308994, 6250.343713909974, 6304.779332723333, 6178.598391104564, 6212.316645169119, 6227.719752611234, 6249.25008998923, 6280.717367718555, 6140.8771824564155, 6140.907886381798, 6145.340757995227, 6198.938010619836, 6227.470664993526, 6132.478739307209, 6169.074638804215, 6180.412860778219, 6190.659513726789, 6204.689765511616, 5083.983203359417, 6009.308929473166, 6055.545834062551, 6093.421124993119, 6103.511719062376, 6084.14821924922, 6100.206973093469, 6128.014278093809, 6129.786714141161, 6146.631202127886, 6077.878442431038, 6086.3305036446845, 6088.8782224356155, 6096.116063170904, 6110.969445152924], "value": 5694.091235000593, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [439.777912154362, 494.04402481198906, 504.60640700253805, 511.0749543326579, 511.98882207639895, 37308.626913730855, 39961.2007759845, 40112.59887401125, 40178.397324040125, 43009.0, 42088.57911420885, 42586.57413425865, 42596.148077038444, 42635.78682106585, 42651.14697706044, 8333.583320833965, 9285.907140928588, 9448.433094014346, 9472.431654100776, 9506.47714375709, 6548.1814773153355, 6672.199336079677, 6676.499262555303, 6733.1820408489675, 8385.790355241137, 11255.887441125566, 11384.203105782557, 11388.829167562493, 11395.97436230739, 11419.486123124438, 11316.603918862842, 11454.370009649467, 11457.36984465854, 11459.427028648533, 11469.025132863717, 9653.469059201741, 11252.54989800407, 11335.263207891461, 11342.262752921033, 11363.545458181745, 32358.0, 39345.80327098375, 39538.60461395378, 39649.40525892114, 39813.402798958035, 3975.960240397617, 4013.9397909031386, 4054.7972601369815, 4061.1268577255737, 4061.695372847019, 26082.478350432884, 27831.721682783114, 29549.70450295491, 31142.0, 31221.687783122106, 3091.6599174090834, 3208.0856955767727, 3208.6470488246273, 3219.3400352927592, 3235.498497732855, 445118.0, 449001.0, 449613.0, 450314.99999999674, 450954.74522627506, 56394.7180264096, 58390.4160958385, 61401.69299153476, 61750.4562385935, 61751.38248617546, 63837.680811595645, 64828.0, 64837.02744458837, 65024.0, 65091.0, 15746.370145194063, 16085.839141608669, 16102.597435064217, 16109.194540273174, 16140.596485087966, 10057.69826905194, 11049.005589496985, 11085.168612354106, 12229.816552751716, 12328.691782705504, 16271.674566508604, 16536.917315413346, 16711.665766684597, 16730.49808505747, 16800.411985580446, 7474.738384156529, 7618.6190690466365, 7627.0, 7646.082470103624, 7673.424493163036, 863.9006514250941, 875.5097145598485, 877.9420797938469, 893.3969570539989, 911.6034524981654, 25494.98020079213, 30190.54714179289, 30190.79236830502, 30303.69696303009, 30513.237169070508, 969.9660511882191, 1010.7725761703558, 1012.4633944009687, 1052.8052310322614, 1198.634416502975, 13713.862861371457, 14154.929225354013, 14247.857521424861, 14373.425062997363, 14506.0, 628393.0, 632734.8363258246, 635602.0, 636592.0, 637843.0, 51036.48963510391, 51313.0, 51406.0, 51464.0, 51547.71130721687, 1413.0814970269203, 1414.9363278652486, 1450.6228380621114, 1451.702401007791, 1456.3664805809506, 25215.236822819694, 26315.0, 26350.4967028132, 26573.60139597946, 26802.061927832434, 44249.77875110604, 44530.3320450187, 44641.55358446374, 44732.881677958314, 44787.77606111948, 541157.0, 542256.0, 543778.0, 544683.0, 545700.0, 23993.28020159398, 24128.0, 24346.634800477652, 24368.87815560911, 24471.0, 41496.792516037225, 42331.576684233994, 42368.788156059025, 42428.0, 42865.35701964535, 27339.589906151024, 34589.0, 34677.65322346845, 35559.46660800142, 35720.571177152626, 33753.83123084369, 34203.0, 34254.48618270678, 34323.485147722306, 34724.9582512525, 33410.33179336351, 33882.49176262407, 33919.0, 34094.65905341014, 34255.48616770701, 24876.626850596895, 26501.734982649927, 28261.15216543507, 28469.0, 31115.066548003597, 19682.704759428332, 21579.460513487287, 23062.769372306062, 23267.952942117983, 23658.88170559136], "value": 19084.91941993338, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.6030606027309, 387.846800513797, 388.1402693034927, 393.39065044776, 424.2977871622464, 14692.853071469282, 16395.754063689055, 19877.701834472475, 21276.574468510622, 21319.786802131992, 20897.791022089776, 21191.788082119176, 21573.784262157373, 21582.244621438254, 21845.563088738254, 5723.856903577403, 5820.679862607555, 5913.852153696171, 5958.553108516857, 5974.223350964368, 5726.3987281335485, 5830.067189249721, 5950.464458198761, 5954.672493012882, 5958.523318134538, 5877.970610146944, 5948.910766338508, 5953.255843019622, 5953.88092238155, 5960.284765828085, 5615.494605485485, 5862.648241105548, 5940.138679891435, 5945.762169513214, 5965.313988891268, 5160.122779127557, 5164.586833053347, 5168.095583272912, 5170.017696637665, 5183.092958732207, 25346.0, 25526.744732552623, 25685.871570642026, 25756.8712156438, 26017.73982260172, 2724.4278701472713, 2746.8178627785633, 2779.194033730216, 2794.091920125967, 2830.6886242513306, 15840.76238856418, 15868.968517046354, 15873.0, 15943.840561594352, 16602.0, 1498.692767982561, 1506.6685329227553, 1742.677604643145, 1762.7091529897552, 1780.8041115477288, 102995.0, 120975.3951230247, 122243.0, 126293.0, 128653.71346286511, 9566.952165239269, 11531.711707207387, 11739.941300293443, 11780.0, 11947.0, 14661.48684796027, 14739.336729847182, 14739.557813265405, 14752.483663071742, 14788.186649734153, 6788.864222715617, 8579.0, 8655.394122411371, 8705.956470217609, 8782.824343513093, 6903.75836845718, 8437.746867593982, 8456.830863382698, 8475.618597163142, 8581.528015959057, 6019.789307374221, 6275.0, 7452.105747310357, 7499.137599176164, 7531.548107113591, 1626.764119202709, 1652.2482270566863, 1924.5477312831474, 1949.756280464942, 1959.8922059286876, 895.9372843900994, 908.7818923458323, 916.7158180963789, 935.1116439382614, 946.7207173883721, 17908.641827163385, 20032.29725473322, 22451.214207502984, 22506.774932250795, 22565.88717056437, 832.9292010179203, 852.26705033671, 854.6026097864523, 927.2628260532892, 938.3712912348743, 6469.5794773339585, 6519.445847103049, 6557.672116394161, 6712.295209003082, 6761.357671021344, 518779.0, 535173.3241333768, 619919.0, 716716.0, 717997.0, 153458.0, 155946.0, 164418.17790910968, 172437.2756272421, 173393.0, 989.6140505202976, 1013.6350913671073, 1040.557762950743, 1041.0422411381546, 1043.8277684182176, 18716.906415467834, 20010.499737506678, 20133.993300335216, 20155.697664535335, 20195.69706454375, 58445.0, 58638.0, 59370.0, 60505.0924236128, 61420.69289653702, 62134.0, 72149.63925180341, 81555.0, 90540.0, 92198.53900730453, 8293.21214484623, 8425.157484251526, 8430.0, 8689.782755431164, 8819.867701984347, 12200.694982625506, 13036.934815325863, 13089.934550327187, 13354.465821367037, 13407.32963351848, 9419.952900235456, 9849.0, 11207.439628018403, 11460.426978651201, 11488.425578720864, 8643.654253829776, 11303.265287756269, 11581.594644187413, 11594.594189203675, 11621.535138594361, 6128.785492507741, 7510.924890751241, 10999.61501347449, 11541.711457213636, 11628.53485860556, 7215.2063273038875, 8087.827265046418, 8305.086440491661, 8727.170918762962, 8745.56272186401, 9271.75488578992, 10815.297005694605, 11087.501062452047, 11286.604968826052, 11355.772884542097], "value": 9743.117492978403, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1311.2132720367774, 1367.6239034265577, 1412.1033143953593, 1458.6426325550242, 1462.4661998370595, 7552.282533159355, 7790.610469476518, 8180.550069746169, 8629.439086459375, 8632.56837158142, 8146.348292136629, 8386.20331068549, 8426.0, 8534.57327133644, 8538.615762290696, 2333.708286464196, 2384.8688322142275, 2385.988070059656, 2386.224477044959, 2390.103711108334, 1750.754894314797, 2164.1235299703567, 2351.8236132290062, 2387.3076807725824, 2403.3150552092657, 2254.6730724045005, 2327.976720232793, 2336.579415705181, 2345.108858633717, 2346.8826558672, 2327.837051406402, 2331.988340058297, 2352.8117750579913, 2354.5997180479358, 2355.7173139223405, 2307.8153747700144, 2342.6486027095903, 2353.752855950118, 2371.5612611666897, 2380.797632201248, 8488.53313067781, 8532.488050716915, 8532.829343413097, 8534.189252021048, 8547.658093676246, 5118.769655365518, 5270.4729527047375, 5275.815346462856, 5280.656757310762, 5281.287026251445, 3390.8135052572097, 3569.785812851211, 3569.94645080324, 3610.783352998802, 3622.0582648511577, 1207.1265759844803, 1217.4095563651622, 1235.258844693186, 1245.8255844181822, 1279.181323952671, 10942.726431839188, 11000.0, 11026.062784663232, 11027.1729620278, 11031.724206894893, 4602.815887364535, 4763.809447622126, 4817.13291607507, 4819.903601927942, 4831.347768051339, 9564.18704410119, 9653.71038868821, 9654.227661787181, 9663.226941844636, 9677.612895484242, 5259.737013149327, 5324.733763311819, 5326.36083669962, 5326.493983071602, 5332.813351532678, 4710.057988402334, 4844.8304309349705, 4863.683860549053, 4941.901161976741, 4945.579625731853, 3662.1760103976394, 3752.7560708553856, 3760.5863355030924, 3799.5630502492013, 3839.3281175794123, 1063.8882917293727, 1176.8117101263929, 1222.572099765075, 1299.9015831622264, 1303.5046682260681, 717.5622870049266, 733.6331834082958, 901.0808974845621, 903.6430609909049, 922.6447817590276, 5214.843554693365, 5369.785208591613, 5396.91904621431, 5578.776848926079, 5705.429457054262, 935.9906400936039, 978.1978777402604, 992.8411454167299, 997.7804882925744, 1016.5425558498705, 3258.0, 3555.4000699685243, 3720.813959302024, 3797.582265950743, 3820.84716611338, 9977.201823854075, 10126.98730126996, 10170.593176273014, 10178.592856285813, 10185.33795303303, 10059.849102263472, 10100.0, 10115.190784737204, 10129.088382045651, 10167.644132455329, 7652.73215437457, 7801.531908085533, 7854.018247719036, 8059.919400806034, 8060.798480037929, 5437.374701909331, 5466.753996070266, 5476.890462190813, 5586.352669046184, 5758.107493338539, 9239.445633262027, 9381.202597779265, 9408.0, 9432.481213533321, 9436.669716560162, 9144.3598948073, 9571.664991725534, 9590.712278631652, 9591.664291749756, 9596.616135354509, 7196.96401517989, 7329.1205055391565, 7336.96331518339, 7342.926570734225, 7347.302006309392, 7809.96095019544, 7812.062552493737, 7883.5664038478435, 7885.842283154419, 7890.210978902293, 6250.687465626609, 7064.399526040139, 7182.367373044462, 7200.747973820891, 7311.926880731125, 7037.0, 7085.256048114874, 7131.786046418616, 7212.386947109554, 7242.818929526804, 6360.713767880364, 6387.297397286387, 6459.838504037437, 6461.418472337512, 6491.48068154537, 4505.617022552989, 4592.0, 4647.837325693719, 4682.906341873211, 4728.71627702339, 4085.8161382737253, 4885.193942999365, 4974.054929563516, 5041.974790126026, 5051.898962020812], "value": 4440.7346534338485, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.0735901374454, 359.1398600352158, 359.33343647533826, 369.0625810441478, 372.57526419881356, 4894.510548945103, 4958.851234462963, 5023.020511000356, 5255.395629502608, 5468.589855760814, 3841.6926645868334, 4892.208538382755, 5176.50823171798, 5312.60155488338, 5321.813736519222, 4219.299648225138, 4236.335569732175, 4242.406063151161, 4252.468441444819, 4263.893402664927, 3525.4359302511602, 3775.830087646049, 3869.6262826696397, 4238.0, 4255.851045213418, 3676.522052133232, 4065.0, 4207.831686732527, 4212.368144778293, 4225.915481690365, 4169.91660166795, 4174.123434078847, 4192.434021407102, 4199.383237453587, 4203.7687927164, 3719.516462859838, 3724.646158614927, 3730.459083432914, 3749.512563366772, 3764.6800021998165, 5007.6244281678655, 5165.870853228662, 5218.504242096995, 5280.894382112375, 5312.973435132838, 4538.478075021382, 4603.654725895572, 4747.52524747526, 4891.108891108891, 4907.3129761833015, 5755.625884317547, 5794.884102317972, 5800.680962547058, 5834.358220595731, 5839.64962102271, 4018.3369743992207, 4040.474738284004, 4050.8775075200574, 4171.541130475645, 4186.434831297766, 5454.400015998237, 5678.921005009076, 6016.516711436853, 6076.0, 6079.756809727562, 3685.6867166291167, 3754.793486358222, 4220.965863363495, 4238.957610423918, 4245.936310955338, 3400.710939570115, 3914.37370020801, 4110.0752330725945, 4261.531231564525, 4280.657547396201, 4708.576228139484, 4788.257820037899, 4859.222524396079, 4888.2178851384315, 4896.5837903777865, 5133.921876405997, 5738.651416917021, 5744.569157313134, 5768.798092066758, 5791.942080579224, 1245.9003279737599, 1323.014354306029, 1388.2017839742189, 1404.4241860837008, 1406.346049087159, 849.8640217565284, 879.2306731609841, 881.395859535639, 882.6734108379941, 897.1028971028971, 5084.398414499421, 5094.49055094495, 5094.566961808214, 5110.4123025852505, 5198.792048318101, 4980.601551875914, 5194.766235519411, 5649.4350564944, 5800.854978625568, 5849.846608907638, 4304.192239259456, 4314.309710446313, 4879.39007624047, 4987.376577927759, 5083.872903177376, 2637.4593208392234, 2711.457708458316, 2841.744243018138, 2842.801003929705, 2857.6999415061537, 4990.6506544541535, 5439.836804895859, 5611.775528978795, 5642.294713160855, 5849.280084760521, 5389.493885343256, 5507.71429856613, 5525.557955363562, 5730.942690573041, 5802.4197580241635, 5836.182934389274, 5855.882882342415, 5861.824145275648, 5865.501432378295, 6064.545159113084, 4538.29656403258, 4665.533446655308, 4889.386502454253, 5451.781928722807, 5639.577031722555, 5577.247071645438, 5621.241132447068, 5805.912911306418, 5837.94162058374, 5865.384134665798, 5892.823215303548, 6070.848228794315, 6105.847353816012, 6128.938710612837, 6192.81421557354, 3550.485179648988, 3599.3161299353037, 3651.8721844735305, 3925.980370098131, 3972.2591411925678, 5479.232907392889, 5602.915956260741, 5803.274590676166, 5870.706464676664, 5967.8209653710455, 5218.295530103387, 5693.345265294544, 5708.885822283614, 5724.0, 5746.649537358634, 4680.074953154279, 5321.733913304397, 5460.699661518495, 5722.971385143048, 5753.453421924911, 5044.646874718735, 5295.073362161529, 5298.682079075268, 5417.891642167214, 5689.317281926195, 4632.953670463252, 4836.799256338428, 5757.222774925499, 5780.132980053026, 5781.55356777182, 4782.760861956958, 5381.596380271573, 5426.403095659553, 5595.0, 5671.0], "value": 4166.536904123511, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [651.6774196772601, 689.0904006711137, 696.6969368324777, 752.1706772513024, 831.3141658132041, 14846.480373186942, 14993.700125997473, 15505.767413488808, 15580.454684086058, 15585.532434026969, 14698.338574764135, 14719.705605887875, 14779.187144707037, 14854.777178342334, 14914.776278355806, 845.5983407881238, 860.9182127697859, 861.0098386855104, 862.0775769926181, 864.4337958637103, 657.4543129202774, 684.336193891924, 762.3024932187042, 801.3308887079296, 853.9914600854005, 779.5829231361223, 862.8921384826897, 906.8458362078462, 907.2560500389683, 909.2634965677822, 896.238197532099, 898.0256421782374, 898.4968417686117, 901.058393978291, 901.1664210605197, 664.0404615330849, 664.6510581944518, 666.4002397841932, 668.381746884135, 670.4435318685479, 14927.925360373238, 15253.542393728207, 15309.387624495006, 15347.309371078329, 15369.615759606098, 13686.52097176604, 13981.79027314591, 13997.79003314941, 14055.367508462145, 14064.156150630892, 12311.261324320569, 12336.568220112344, 12423.31671758053, 12428.627141185689, 12435.875641243561, 4265.594768496988, 4310.892227694301, 4330.870073897788, 4380.802863871101, 4390.868273951786, 99704.50147749287, 101838.0, 106948.0, 111335.88664113336, 111829.99999999919, 10184.694459166238, 10807.666492654156, 10898.346099234072, 10926.945365273123, 11195.4962026709, 20323.0, 20354.49113772138, 20471.38585842427, 20573.794262057487, 21007.474813129487, 7828.444908824019, 7887.369010479148, 7996.04047514302, 8047.919520804834, 8125.228103330174, 4305.784710764449, 4372.868813935587, 4378.868633940987, 4421.624161946271, 4571.245744452128, 3287.539744435781, 3612.1150318172217, 3669.3578623740736, 3670.6879915207505, 3695.316366472211, 602.3885755957618, 671.835400326923, 684.2404930527111, 687.5805758487419, 696.4428457234294, 650.72344253692, 680.9547344825669, 682.2665634442993, 687.2680595166232, 703.1070540413748, 8585.484870907641, 9649.372790768577, 10526.684199474028, 10566.471676416302, 10627.734306642396, 693.3932808792307, 703.9084918960605, 704.4399702236734, 708.8121647763347, 720.121451828768, 3678.448232765053, 3941.994791328193, 4177.456930599003, 4184.8744537663915, 4337.783110844445, 72975.63512182405, 82235.5888220567, 99800.0, 107086.59060409275, 113183.43408282906, 76480.61759691166, 93770.0, 96041.07917841604, 99229.0, 100303.0, 70484.0, 70889.64555177192, 71830.64084679648, 75917.62041189759, 79855.0, 10681.03870651645, 10871.96716311949, 11171.776564468828, 11304.265222760494, 11365.943170284096, 48538.27192592043, 48944.75527622339, 49373.25940110973, 50845.74577127091, 51607.0, 49032.75483622559, 64392.03411948731, 66427.66786166231, 66585.0, 68784.0, 12732.172408793398, 12814.0, 12836.55072072473, 13147.0139739518, 13267.0, 12111.697207569528, 13848.238346891017, 14339.952690480666, 14464.783028254375, 14649.780253296422, 13093.607191784262, 13552.983526235768, 13581.524646637321, 13666.658333541343, 13714.86285137136, 13065.869341306465, 13138.948884089441, 13602.115862468909, 13766.105203161762, 14040.597168699263, 12906.161099528501, 13380.732385352434, 13562.118462299919, 13781.310934453037, 13806.102603330752, 10735.785284294427, 10956.397398142859, 10991.120710343313, 11184.328940263611, 11317.660470185907, 10391.896081039093, 10618.8407173894, 10871.565137394417, 10876.12990960737, 10892.836607450736], "value": 7485.957362606371, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1591.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 119.0, 120.0, 119.0, 127.0, 119.0, 118.0, 120.0, 120.0, 119.0], "value": 118.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 115.0, 116.0, 146.0, 160.0, 143.0, 145.0, 129.0, 131.0, 118.0], "value": 134.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 192.0, 198.0, 198.0, 196.0, 196.0, 193.0, 194.0, 202.0, 192.0], "value": 196.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 59.0, 62.0, 87.0, 63.0, 59.0, 58.0, 64.0, 93.0, 90.0], "value": 72.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 84.0, 71.0, 72.0, 103.0, 111.0, 99.0, 84.0, 84.0], "value": 86.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 115.0, 90.0, 123.0, 87.0, 81.0, 134.0, 132.0, 90.0, 86.0], "value": 107.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 110.0, 152.0, 93.0, 153.0, 154.0, 105.0, 151.0, 109.0], "value": 121.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 143.0, 91.0, 147.0, 143.0, 107.0, 91.0, 91.0, 95.0, 91.0], "value": 111.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 59.0, 65.0, 72.0, 95.0, 94.0, 96.0, 97.0, 83.0], "value": 78.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 98.0, 72.0, 78.0, 74.0, 68.0, 69.0, 69.0, 74.0, 72.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 89.0, 90.0, 88.0, 88.0, 84.0, 87.0, 87.0, 91.0, 110.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 139.0, 161.0, 147.0, 158.0, 148.0, 154.0, 155.0, 156.0, 138.0], "value": 149.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 172.0, 173.0, 168.0, 171.0, 166.0, 171.0, 169.0, 167.0, 180.0], "value": 170.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 65.0, 85.0, 95.0, 84.0, 92.0, 87.0, 67.0, 67.0, 67.0], "value": 77.8, "unit": "score"}]}]} 13:47:29 INFO - Return code: 0 13:47:29 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:47:29 ERROR - # TBPL SUCCESS # 13:47:29 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:47:29 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:47:29 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:47:29 INFO - 2017-02-23 13:47:29.896 screenresolution[1914:11730] starting screenresolution argv=screenresolution get 13:47:29 INFO - 2017-02-23 13:47:29.898 screenresolution[1914:11730] Display 0: 1600x1200x32@60 13:47:29 INFO - 2017-02-23 13:47:29.905 screenresolution[1915:11733] starting screenresolution argv=screenresolution list 13:47:29 INFO - Available Modes on Display 0 13:47:29 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:47:29 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:47:29 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:47:29 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:47:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:47:30 INFO - Intel Iris: 13:47:30 INFO - Chipset Model: Intel Iris 13:47:30 INFO - Type: GPU 13:47:30 INFO - Bus: Built-In 13:47:30 INFO - VRAM (Dynamic, Max): 1536 MB 13:47:30 INFO - Vendor: Intel (0x8086) 13:47:30 INFO - Device ID: 0x0a2e 13:47:30 INFO - Revision ID: 0x0009 13:47:30 INFO - Displays: 13:47:30 INFO - Display: 13:47:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:47:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:47:30 INFO - Display Serial Number: 1600x1200 60 13:47:30 INFO - Main Display: Yes 13:47:30 INFO - Mirror: Off 13:47:30 INFO - Online: Yes 13:47:30 INFO - Rotation: Supported 13:47:30 INFO - Return code: 0 13:47:30 INFO - Running post-action listener: _resource_record_post_action 13:47:30 INFO - [mozharness: 2017-02-23 21:47:30.141137Z] Finished run-tests step (success) 13:47:30 INFO - Running post-run listener: _resource_record_post_run 13:47:30 INFO - Total resource usage - Wall time: 1198s; CPU: 54.0%; Read bytes: 3085824; Write bytes: 506746368; Read time: 26; Write time: 1598 13:47:30 INFO - TinderboxPrint: CPU usage
54.4% 13:47:30 INFO - TinderboxPrint: I/O read bytes / time
3,085,824 / 26 13:47:30 INFO - TinderboxPrint: I/O write bytes / time
506,746,368 / 1,598 13:47:30 INFO - TinderboxPrint: CPU idle
2,186.0 (45.6%) 13:47:30 INFO - TinderboxPrint: CPU system
965.5 (20.1%) 13:47:30 INFO - TinderboxPrint: CPU user
1,642.3 (34.3%) 13:47:30 INFO - TinderboxPrint: Swap in / out
211,476,480 / 0 13:47:30 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208693760; Write bytes: 209962496; Read time: 16001; Write time: 475 13:47:30 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 2184704; Write bytes: 295157760; Read time: 23; Write time: 1113 13:47:30 INFO - Running post-run listener: _upload_blobber_files 13:47:30 INFO - Blob upload gear active. 13:47:30 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:47:30 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:47:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:47:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:47:31 INFO - (blobuploader) - INFO - Open directory for files ... 13:47:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:47:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:47:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:47:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:47:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:47:32 INFO - (blobuploader) - INFO - Done attempting. 13:47:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:47:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:47:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:47:33 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:47:33 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:47:33 INFO - (blobuploader) - INFO - Done attempting. 13:47:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:47:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:47:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:47:34 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:47:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:47:34 INFO - (blobuploader) - INFO - Done attempting. 13:47:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:47:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:47:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:47:36 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:47:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:47:36 INFO - (blobuploader) - INFO - Done attempting. 13:47:36 INFO - (blobuploader) - INFO - Iteration through files over. 13:47:36 INFO - Return code: 0 13:47:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:47:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:47:36 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33022d531c8f919113cb59b2d27ae1beb63af742c0708c40cdf23f073ddd0da31935c2faca499672114c039cfa31f9fae3422df4d45cc57b4430705a37cb278c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9997b8e2c1c83114bdf47a91ea5e3c96ef8f7a0fc865aad1cb2c10ceeccebae447aa6509ff42327c8fe3eeede029204ee54c742965eefa42dd92bd98dffb22ea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d75453973e2e0019dbdf9d419b6cc7f9da2750ff08ebb18528786d6bf98b55fbb263ea7e98552eef8be22d9cf16e1232f8604c58dfce9b1d41b4ea2e8a869b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4cedddb8ac1f3bdb2694625d9ff8924e74a3548093869d7bc384e8470a662ea15aa6875cfa1b42e882b161a2f8513812c27f4c97448c2f1b8dfc587ccfa9ab18"} 13:47:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:47:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:47:36 INFO - Contents: 13:47:36 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33022d531c8f919113cb59b2d27ae1beb63af742c0708c40cdf23f073ddd0da31935c2faca499672114c039cfa31f9fae3422df4d45cc57b4430705a37cb278c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9997b8e2c1c83114bdf47a91ea5e3c96ef8f7a0fc865aad1cb2c10ceeccebae447aa6509ff42327c8fe3eeede029204ee54c742965eefa42dd92bd98dffb22ea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d75453973e2e0019dbdf9d419b6cc7f9da2750ff08ebb18528786d6bf98b55fbb263ea7e98552eef8be22d9cf16e1232f8604c58dfce9b1d41b4ea2e8a869b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4cedddb8ac1f3bdb2694625d9ff8924e74a3548093869d7bc384e8470a662ea15aa6875cfa1b42e882b161a2f8513812c27f4c97448c2f1b8dfc587ccfa9ab18"} 13:47:36 INFO - Running post-run listener: copy_logs_to_upload_dir 13:47:36 INFO - Copying logs to upload dir... 13:47:36 INFO - mkdir: /builds/slave/test/build/upload/logs 13:47:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.281813 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2017-02-23 13:47:36.457347) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 13:47:36.461039) ========= 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.XVDFnJwU43/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.MQ51FT8P8T/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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/Mozilla-Aurora/sha512/33022d531c8f919113cb59b2d27ae1beb63af742c0708c40cdf23f073ddd0da31935c2faca499672114c039cfa31f9fae3422df4d45cc57b4430705a37cb278c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9997b8e2c1c83114bdf47a91ea5e3c96ef8f7a0fc865aad1cb2c10ceeccebae447aa6509ff42327c8fe3eeede029204ee54c742965eefa42dd92bd98dffb22ea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d75453973e2e0019dbdf9d419b6cc7f9da2750ff08ebb18528786d6bf98b55fbb263ea7e98552eef8be22d9cf16e1232f8604c58dfce9b1d41b4ea2e8a869b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4cedddb8ac1f3bdb2694625d9ff8924e74a3548093869d7bc384e8470a662ea15aa6875cfa1b42e882b161a2f8513812c27f4c97448c2f1b8dfc587ccfa9ab18"} build_url:https://queue.taskcluster.net/v1/task/RuLSl-hxS0Sj5yEhPyfMAw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011002 build_url: 'https://queue.taskcluster.net/v1/task/RuLSl-hxS0Sj5yEhPyfMAw/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/33022d531c8f919113cb59b2d27ae1beb63af742c0708c40cdf23f073ddd0da31935c2faca499672114c039cfa31f9fae3422df4d45cc57b4430705a37cb278c", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/9997b8e2c1c83114bdf47a91ea5e3c96ef8f7a0fc865aad1cb2c10ceeccebae447aa6509ff42327c8fe3eeede029204ee54c742965eefa42dd92bd98dffb22ea", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4d75453973e2e0019dbdf9d419b6cc7f9da2750ff08ebb18528786d6bf98b55fbb263ea7e98552eef8be22d9cf16e1232f8604c58dfce9b1d41b4ea2e8a869b3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4cedddb8ac1f3bdb2694625d9ff8924e74a3548093869d7bc384e8470a662ea15aa6875cfa1b42e882b161a2f8513812c27f4c97448c2f1b8dfc587ccfa9ab18"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-23 13:47:36.494760) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 13:47:36.495101) ========= 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.XVDFnJwU43/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.MQ51FT8P8T/Listeners TMPDIR=/var/folders/7f/fg9p30710059mjlmd28p1g2w00000w/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.004953 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-23 13:47:36.543539) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 13:47:36.543924) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-23 13:47:36.544290) ========= ========= Total master_lag: 0.18 =========