builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0088 starttime: 1491335885.78 results: success (0) buildid: 20170404112528 builduid: d2dd5d41513b4d4b84c75ae7bb6d34fc revision: b043233ec04f06768d59dcdfb9e928142280f3cc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 12:58:05.776860) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 12:58:05.777556) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 12:58:05.777873) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 12:58:05.804819) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 12:58:05.805536) ========= 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.q7AginveNb/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.f4oa5WtQRO/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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-04-04 12:58:05-- 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% 66.4M=0s 2017-04-04 12:58:05 (66.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.130279 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 12:58:05.964251) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 12:58:05.964897) ========= 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.q7AginveNb/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.f4oa5WtQRO/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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.029300 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 12:58:06.020371) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-04 12:58:06.021280) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev b043233ec04f06768d59dcdfb9e928142280f3cc --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev b043233ec04f06768d59dcdfb9e928142280f3cc --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.q7AginveNb/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.f4oa5WtQRO/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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-04-04 12:58:06,166 truncating revision to first 12 chars 2017-04-04 12:58:06,166 Setting DEBUG logging. 2017-04-04 12:58:06,166 attempt 1/10 2017-04-04 12:58:06,166 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/b043233ec04f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-04 12:58:08,144 unpacking tar archive at: mozilla-central-b043233ec04f/testing/mozharness/ program finished with exit code 0 elapsedTime=2.265344 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-04 12:58:08.315301) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 12:58:08.316151) ========= script_repo_revision: b043233ec04f06768d59dcdfb9e928142280f3cc ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 12:58:08.317125) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 12:58:08.317805) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 12:58:08.339966) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-04 12:58:08.340366) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.q7AginveNb/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.f4oa5WtQRO/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 12:58:08 INFO - MultiFileLogger online at 20170404 12:58:08 in /builds/slave/test 12:58:08 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 12:58:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:58:08 INFO - {'append_to_log': False, 12:58:08 INFO - 'base_work_dir': '/builds/slave/test', 12:58:08 INFO - 'blob_upload_branch': 'Firefox', 12:58:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:58:08 INFO - 'branch': 'Firefox', 12:58:08 INFO - 'buildbot_json_path': 'buildprops.json', 12:58:08 INFO - 'config_files': ('talos/mac_config.py',), 12:58:08 INFO - 'default_actions': ('clobber', 12:58:08 INFO - 'read-buildbot-config', 12:58:08 INFO - 'download-and-extract', 12:58:08 INFO - 'populate-webroot', 12:58:08 INFO - 'create-virtualenv', 12:58:08 INFO - 'install', 12:58:08 INFO - 'run-tests'), 12:58:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:58:08 INFO - 'download_minidump_stackwalk': True, 12:58:08 INFO - 'download_symbols': 'ondemand', 12:58:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:58:08 INFO - 'tooltool.py': '/tools/tooltool.py', 12:58:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:58:08 INFO - '/tools/misc-python/virtualenv.py')}, 12:58:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:58:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:58:08 INFO - 'gecko_profile': False, 12:58:08 INFO - 'gecko_profile_interval': 0, 12:58:08 INFO - 'installer_path': 'installer.exe', 12:58:08 INFO - 'log_level': 'info', 12:58:08 INFO - 'log_name': 'talos', 12:58:08 INFO - 'log_to_console': True, 12:58:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:58:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:58:08 INFO - 'opt_config_files': (), 12:58:08 INFO - 'pip_index': False, 12:58:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:58:08 INFO - 'cmd': ('bash', 12:58:08 INFO - '-c', 12:58:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:58:08 INFO - 'enabled': True, 12:58:08 INFO - 'halt_on_failure': False, 12:58:08 INFO - 'name': 'check_screen_resolution'},), 12:58:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:58:08 INFO - 'cmd': ('bash', 12:58:08 INFO - '-c', 12:58:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:58:08 INFO - 'enabled': True, 12:58:08 INFO - 'halt_on_failure': False, 12:58:08 INFO - 'name': 'check_screen_resolution'},), 12:58:08 INFO - 'run_cmd_checks_enabled': True, 12:58:08 INFO - 'suite': 'dromaeojs-e10s', 12:58:08 INFO - 'system_bits': '32', 12:58:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:58:08 INFO - 'title': 't-yosemite-r7-0088', 12:58:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:58:08 INFO - 'use_talos_json': True, 12:58:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:58:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:58:08 INFO - 'work_dir': 'build'} 12:58:08 INFO - [mozharness: 2017-04-04 19:58:08.605308Z] Running clobber step. 12:58:08 INFO - Running pre-action listener: _resource_record_pre_action 12:58:08 INFO - Running main action method: clobber 12:58:08 INFO - rmtree: /builds/slave/test/build 12:58:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:58:11 INFO - Running post-action listener: _resource_record_post_action 12:58:11 INFO - [mozharness: 2017-04-04 19:58:11.109899Z] Finished clobber step (success) 12:58:11 INFO - [mozharness: 2017-04-04 19:58:11.110022Z] Running read-buildbot-config step. 12:58:11 INFO - Running pre-action listener: _resource_record_pre_action 12:58:11 INFO - Running main action method: read_buildbot_config 12:58:11 INFO - Using buildbot properties: 12:58:11 INFO - { 12:58:11 INFO - "project": "", 12:58:11 INFO - "product": "firefox", 12:58:11 INFO - "script_repo_revision": "production", 12:58:11 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 12:58:11 INFO - "repository": "", 12:58:11 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 12:58:11 INFO - "buildid": "20170404112528", 12:58:11 INFO - "pgo_build": "False", 12:58:11 INFO - "basedir": "/builds/slave/test", 12:58:11 INFO - "buildnumber": 24, 12:58:11 INFO - "slavename": "t-yosemite-r7-0088", 12:58:11 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 12:58:11 INFO - "platform": "yosemite_r7", 12:58:11 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 12:58:11 INFO - "branch": "mozilla-central", 12:58:11 INFO - "repo_path": "mozilla-central", 12:58:11 INFO - "revision": "b043233ec04f06768d59dcdfb9e928142280f3cc", 12:58:11 INFO - "stage_platform": "macosx64", 12:58:11 INFO - "builduid": "d2dd5d41513b4d4b84c75ae7bb6d34fc", 12:58:11 INFO - "slavebuilddir": "test" 12:58:11 INFO - } 12:58:11 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dv7IC06yT-aEuB-OSR2lug/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 12:58:11 INFO - Running post-action listener: _resource_record_post_action 12:58:11 INFO - [mozharness: 2017-04-04 19:58:11.113045Z] Finished read-buildbot-config step (success) 12:58:11 INFO - [mozharness: 2017-04-04 19:58:11.113182Z] Running download-and-extract step. 12:58:11 INFO - Running pre-action listener: _resource_record_pre_action 12:58:11 INFO - Running main action method: download_and_extract 12:58:11 INFO - mkdir: /builds/slave/test/build/tests 12:58: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')]} 12:58:11 INFO - trying https://queue.taskcluster.net/v1/task/Dv7IC06yT-aEuB-OSR2lug/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 12:58:11 INFO - Downloading https://queue.taskcluster.net/v1/task/Dv7IC06yT-aEuB-OSR2lug/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 12:58:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dv7IC06yT-aEuB-OSR2lug/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 12:58:12 INFO - Downloaded 1325 bytes. 12:58:12 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 12:58:12 INFO - Using the following test package requirements: 12:58:12 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:58:12 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 12:58:12 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 12:58:12 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:58:12 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 12:58:12 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:58:12 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 12:58:12 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:58:12 INFO - u'jsshell-mac.zip'], 12:58:12 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:58:12 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 12:58:12 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 12:58:12 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:58:12 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 12:58:12 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:58:12 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 12:58:12 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:58:12 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 12:58:12 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 12:58:12 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 12:58:12 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:58:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dv7IC06yT-aEuB-OSR2lug/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 12:58:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dv7IC06yT-aEuB-OSR2lug/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:58:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Dv7IC06yT-aEuB-OSR2lug/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 12:58:14 INFO - Expected file size: 52517770 12:58:14 INFO - Obtained file size: 52517770 12:58:30 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 12:58:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dv7IC06yT-aEuB-OSR2lug/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 12:58:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dv7IC06yT-aEuB-OSR2lug/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 12:58:30 INFO - Fetch https://queue.taskcluster.net/v1/task/Dv7IC06yT-aEuB-OSR2lug/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 12:58:32 INFO - Expected file size: 52517770 12:58:32 INFO - Obtained file size: 52517770 12:58:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dv7IC06yT-aEuB-OSR2lug/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 12:58:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dv7IC06yT-aEuB-OSR2lug/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 12:58:47 INFO - Fetch https://queue.taskcluster.net/v1/task/Dv7IC06yT-aEuB-OSR2lug/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 12:58:49 INFO - Expected file size: 14404152 12:58:49 INFO - Obtained file size: 14404152 12:58:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:58:49 INFO - trying https://queue.taskcluster.net/v1/task/Dv7IC06yT-aEuB-OSR2lug/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:58:49 INFO - Downloading https://queue.taskcluster.net/v1/task/Dv7IC06yT-aEuB-OSR2lug/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 12:58:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dv7IC06yT-aEuB-OSR2lug/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 12:58:51 INFO - Downloaded 70689279 bytes. 12:58:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dv7IC06yT-aEuB-OSR2lug/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:58:51 INFO - mkdir: /builds/slave/test/properties 12:58:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:58:51 INFO - Writing to file /builds/slave/test/properties/build_url 12:58:51 INFO - Contents: 12:58:51 INFO - build_url:https://queue.taskcluster.net/v1/task/Dv7IC06yT-aEuB-OSR2lug/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 12:58:52 INFO - Running post-action listener: _resource_record_post_action 12:58:52 INFO - Running post-action listener: set_extra_try_arguments 12:58:52 INFO - [mozharness: 2017-04-04 19:58:52.220322Z] Finished download-and-extract step (success) 12:58:52 INFO - [mozharness: 2017-04-04 19:58:52.220470Z] Running populate-webroot step. 12:58:52 INFO - Running pre-action listener: _resource_record_pre_action 12:58:52 INFO - Running main action method: populate_webroot 12:58:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:58:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:58:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:58:52 INFO - '--tppagecycles', 12:58:52 INFO - '7'], 12:58:52 INFO - 'tests': ['tsvgm']}}, 12:58:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 12:58:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:58:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 12:58:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 12:58:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 12:58:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 12:58:52 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 12:58:52 INFO - 'talos_options': ['--disable-e10s'], 12:58:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:58:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 12:58:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:58:52 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 12:58:52 INFO - 'talos_options': ['--disable-e10s'], 12:58:52 INFO - 'tests': ['damp', 'tps']}, 12:58:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 12:58:52 INFO - 'tests': ['damp', 'tps']}, 12:58:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 12:58:52 INFO - 'tests': ['dromaeo_dom']}, 12:58:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:58:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 12:58:52 INFO - 'tests': ['basic_compositor_video']}, 12:58:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 12:58:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 12:58:52 INFO - 'tests': ['a11yr', 12:58:52 INFO - 'ts_paint', 12:58:52 INFO - 'tpaint', 12:58:52 INFO - 'sessionrestore', 12:58:52 INFO - 'sessionrestore_no_auto_restore', 12:58:52 INFO - 'tabpaint']}, 12:58:52 INFO - 'other-e10s': {'tests': ['a11yr', 12:58:52 INFO - 'ts_paint', 12:58:52 INFO - 'tpaint', 12:58:52 INFO - 'sessionrestore', 12:58:52 INFO - 'sessionrestore_no_auto_restore', 12:58:52 INFO - 'tabpaint']}, 12:58:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 12:58:52 INFO - 'ts_paint', 12:58:52 INFO - 'tpaint', 12:58:52 INFO - 'sessionrestore', 12:58:52 INFO - 'sessionrestore_no_auto_restore', 12:58:52 INFO - 'tabpaint']}, 12:58:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 12:58:52 INFO - 'ts_paint', 12:58:52 INFO - 'tpaint', 12:58:52 INFO - 'sessionrestore', 12:58:52 INFO - 'sessionrestore_no_auto_restore', 12:58:52 INFO - 'tabpaint']}, 12:58:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 12:58:52 INFO - 'tests': ['a11yr', 12:58:52 INFO - 'ts_paint', 12:58:52 INFO - 'tpaint', 12:58:52 INFO - 'sessionrestore', 12:58:52 INFO - 'sessionrestore_no_auto_restore', 12:58:52 INFO - 'tabpaint']}, 12:58:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 12:58:52 INFO - 'tests': ['a11yr', 12:58:52 INFO - 'ts_paint', 12:58:52 INFO - 'tpaint', 12:58:52 INFO - 'sessionrestore', 12:58:52 INFO - 'sessionrestore_no_auto_restore', 12:58:52 INFO - 'tabpaint']}, 12:58:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 12:58:52 INFO - 'tests': ['tsvgx', 12:58:52 INFO - 'tsvgr_opacity', 12:58:52 INFO - 'tart', 12:58:52 INFO - 'tscrollx', 12:58:52 INFO - 'cart', 12:58:52 INFO - 'tsvg_static']}, 12:58:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 12:58:52 INFO - 'tsvgr_opacity', 12:58:52 INFO - 'tart', 12:58:52 INFO - 'tscrollx', 12:58:52 INFO - 'cart', 12:58:52 INFO - 'tsvg_static']}, 12:58:52 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 12:58:52 INFO - 'talos_options': ['--disable-e10s'], 12:58:52 INFO - 'tests': ['tp5o']}, 12:58:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 12:58:52 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 12:58:52 INFO - 'talos_options': ['--disable-e10s', 12:58:52 INFO - '--xperf_path', 12:58:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:58:52 INFO - 'tests': ['tp5n']}, 12:58:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 12:58:52 INFO - 'talos_options': ['--xperf_path', 12:58:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:58:52 INFO - 'tests': ['tp5n']}}, 12:58:52 INFO - 'talos.zip': {'path': '', 12:58:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:58:52 INFO - Running post-action listener: _resource_record_post_action 12:58:52 INFO - [mozharness: 2017-04-04 19:58:52.238837Z] Finished populate-webroot step (success) 12:58:52 INFO - [mozharness: 2017-04-04 19:58:52.238949Z] Running create-virtualenv step. 12:58:52 INFO - Running pre-action listener: _resource_record_pre_action 12:58:52 INFO - Running main action method: create_virtualenv 12:58:52 INFO - Creating virtualenv /builds/slave/test/build/venv 12:58:52 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 12:58:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:58:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:58:52 INFO - Using real prefix '/tools/python27' 12:58:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:58:53 INFO - Installing distribute.............................................................................................................................................................................................done. 12:58:55 INFO - Installing pip.................done. 12:58:55 INFO - Return code: 0 12:58:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 12:58:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 12:58:56 INFO - Reading from file tmpfile_stdout 12:58:56 INFO - Output received: 12:58:56 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) 12:58:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:58: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')]} 12:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58: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')]} 12:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1079f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb894a4ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077d1d30>, '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 0x1076f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c6be8>, '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.q7AginveNb/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.f4oa5WtQRO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 12:58:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:58:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q7AginveNb/Render', 12:58:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:58:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:58:56 INFO - 'HOME': '/Users/cltbld', 12:58:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:58:56 INFO - 'LOGNAME': 'cltbld', 12:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:56 INFO - 'MOZ_NO_REMOTE': '1', 12:58:56 INFO - 'NO_EM_RESTART': '1', 12:58:56 INFO - 'PAGER': '/bin/cat', 12:58:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:56 INFO - 'PWD': '/builds/slave/test', 12:58:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:58:56 INFO - 'SHELL': '/bin/bash', 12:58:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f4oa5WtQRO/Listeners', 12:58:56 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 12:58:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:58:56 INFO - 'USER': 'cltbld', 12:58:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:58:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:56 INFO - 'XPC_FLAGS': '0x0', 12:58:56 INFO - 'XPC_SERVICE_NAME': '0', 12:58:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:56 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 12:58:56 INFO - Cleaning up... 12:58:56 INFO - Return code: 0 12:58:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 12:58: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')]} 12:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58: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')]} 12:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:58:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1079f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb894a4ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077d1d30>, '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 0x1076f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c6be8>, '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.q7AginveNb/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.f4oa5WtQRO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 12:58:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 12:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 12:58:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q7AginveNb/Render', 12:58:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:58:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:58:56 INFO - 'HOME': '/Users/cltbld', 12:58:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:58:56 INFO - 'LOGNAME': 'cltbld', 12:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:58:56 INFO - 'MOZ_NO_REMOTE': '1', 12:58:56 INFO - 'NO_EM_RESTART': '1', 12:58:56 INFO - 'PAGER': '/bin/cat', 12:58:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:58:56 INFO - 'PWD': '/builds/slave/test', 12:58:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:58:56 INFO - 'SHELL': '/bin/bash', 12:58:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f4oa5WtQRO/Listeners', 12:58:56 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 12:58:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:58:56 INFO - 'USER': 'cltbld', 12:58:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:58:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:58:56 INFO - 'XPC_FLAGS': '0x0', 12:58:56 INFO - 'XPC_SERVICE_NAME': '0', 12:58:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:58:56 INFO - Downloading/unpacking psutil>=3.1.1 12:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:58:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:58:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:59:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:59:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:59:00 INFO - Installing collected packages: psutil 12:59:00 INFO - Running setup.py install for psutil 12:59:00 INFO - building 'psutil._psutil_osx' extension 12:59:00 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 12:59:00 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 12:59:01 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 12:59:01 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 12:59:01 INFO - building 'psutil._psutil_posix' extension 12:59:01 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 12:59:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:59:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:59:01 INFO - ^ 12:59:01 INFO - 1 warning generated. 12:59:01 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 12:59:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:59:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:59:01 INFO - Successfully installed psutil 12:59:01 INFO - Cleaning up... 12:59:01 INFO - Return code: 0 12:59:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 12:59:01 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')]} 12:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:01 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')]} 12:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:02 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 0x1079f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb894a4ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077d1d30>, '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 0x1076f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c6be8>, '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.q7AginveNb/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.f4oa5WtQRO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 12:59:02 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 12:59:02 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 12:59:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q7AginveNb/Render', 12:59:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:59:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:59:02 INFO - 'HOME': '/Users/cltbld', 12:59:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:59:02 INFO - 'LOGNAME': 'cltbld', 12:59:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:02 INFO - 'MOZ_NO_REMOTE': '1', 12:59:02 INFO - 'NO_EM_RESTART': '1', 12:59:02 INFO - 'PAGER': '/bin/cat', 12:59:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:59:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:02 INFO - 'PWD': '/builds/slave/test', 12:59:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:59:02 INFO - 'SHELL': '/bin/bash', 12:59:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f4oa5WtQRO/Listeners', 12:59:02 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 12:59:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:59:02 INFO - 'USER': 'cltbld', 12:59:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:59:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:59:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:02 INFO - 'XPC_FLAGS': '0x0', 12:59:02 INFO - 'XPC_SERVICE_NAME': '0', 12:59:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:02 INFO - Downloading/unpacking mozsystemmonitor==0.3 12:59:02 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 12:59:02 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 12:59:02 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 12:59:02 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 12:59:02 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 12:59:02 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 12:59:05 INFO - Downloading mozsystemmonitor-0.3.tar.gz 12:59:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:59:05 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 12:59:05 INFO - Installing collected packages: mozsystemmonitor 12:59:05 INFO - Running setup.py install for mozsystemmonitor 12:59:05 INFO - Successfully installed mozsystemmonitor 12:59:05 INFO - Cleaning up... 12:59:05 INFO - Return code: 0 12:59:05 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 12:59:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:59:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1079f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb894a4ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077d1d30>, '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 0x1076f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c6be8>, '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.q7AginveNb/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.f4oa5WtQRO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 12:59:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 12:59:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 12:59:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q7AginveNb/Render', 12:59:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:59:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:59:06 INFO - 'HOME': '/Users/cltbld', 12:59:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:59:06 INFO - 'LOGNAME': 'cltbld', 12:59:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:06 INFO - 'MOZ_NO_REMOTE': '1', 12:59:06 INFO - 'NO_EM_RESTART': '1', 12:59:06 INFO - 'PAGER': '/bin/cat', 12:59:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:59:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:06 INFO - 'PWD': '/builds/slave/test', 12:59:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:59:06 INFO - 'SHELL': '/bin/bash', 12:59:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f4oa5WtQRO/Listeners', 12:59:06 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 12:59:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:59:06 INFO - 'USER': 'cltbld', 12:59:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:59:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:59:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:06 INFO - 'XPC_FLAGS': '0x0', 12:59:06 INFO - 'XPC_SERVICE_NAME': '0', 12:59:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:06 INFO - Downloading/unpacking jsonschema==2.5.1 12:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 12:59:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 12:59:09 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 12:59:09 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 12:59:09 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 12:59:09 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 12:59:09 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 12:59:09 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 12:59:09 INFO - Downloading functools32-3.2.3-2.tar.gz 12:59:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 12:59:09 INFO - warning: no files found matching '*.txt' 12:59:09 INFO - no previously-included directories found matching 'build' 12:59:09 INFO - no previously-included directories found matching 'dist' 12:59:09 INFO - no previously-included directories found matching '.git*' 12:59:09 INFO - Installing collected packages: jsonschema, functools32 12:59:09 INFO - Running setup.py install for functools32 12:59:09 INFO - warning: no files found matching '*.txt' 12:59:09 INFO - no previously-included directories found matching 'build' 12:59:09 INFO - no previously-included directories found matching 'dist' 12:59:09 INFO - no previously-included directories found matching '.git*' 12:59:09 INFO - Successfully installed jsonschema functools32 12:59:09 INFO - Cleaning up... 12:59:09 INFO - Return code: 0 12:59:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 12:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:59:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:59:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1079f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb894a4ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077d1d30>, '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 0x1076f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c6be8>, '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.q7AginveNb/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.f4oa5WtQRO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 12:59:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 12:59:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 12:59:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q7AginveNb/Render', 12:59:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:59:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:59:09 INFO - 'HOME': '/Users/cltbld', 12:59:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:59:09 INFO - 'LOGNAME': 'cltbld', 12:59:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:09 INFO - 'MOZ_NO_REMOTE': '1', 12:59:09 INFO - 'NO_EM_RESTART': '1', 12:59:09 INFO - 'PAGER': '/bin/cat', 12:59:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:59:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:09 INFO - 'PWD': '/builds/slave/test', 12:59:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:59:09 INFO - 'SHELL': '/bin/bash', 12:59:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f4oa5WtQRO/Listeners', 12:59:09 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 12:59:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:59:09 INFO - 'USER': 'cltbld', 12:59:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:59:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:59:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:09 INFO - 'XPC_FLAGS': '0x0', 12:59:09 INFO - 'XPC_SERVICE_NAME': '0', 12:59:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 12:59:10 INFO - Cleaning up... 12:59:10 INFO - Return code: 0 12:59:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:59:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1079f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb894a4ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077d1d30>, '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 0x1076f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c6be8>, '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.q7AginveNb/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.f4oa5WtQRO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 12:59:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:59:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:59:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q7AginveNb/Render', 12:59:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:59:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:59:10 INFO - 'HOME': '/Users/cltbld', 12:59:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:59:10 INFO - 'LOGNAME': 'cltbld', 12:59:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:10 INFO - 'MOZ_NO_REMOTE': '1', 12:59:10 INFO - 'NO_EM_RESTART': '1', 12:59:10 INFO - 'PAGER': '/bin/cat', 12:59:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:59:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:10 INFO - 'PWD': '/builds/slave/test', 12:59:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:59:10 INFO - 'SHELL': '/bin/bash', 12:59:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f4oa5WtQRO/Listeners', 12:59:10 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 12:59:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:59:10 INFO - 'USER': 'cltbld', 12:59:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:59:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:59:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:10 INFO - 'XPC_FLAGS': '0x0', 12:59:10 INFO - 'XPC_SERVICE_NAME': '0', 12:59:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:59:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:10 INFO - Downloading/unpacking blobuploader==1.2.4 12:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:13 INFO - Downloading blobuploader-1.2.4.tar.gz 12:59:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:59:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:59:13 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 12:59:13 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 12:59:13 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 12:59:13 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 12:59:13 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 12:59:13 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 12:59:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:59:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:59:13 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 12:59:13 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 12:59:13 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 12:59:13 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 12:59:13 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 12:59:13 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 12:59:14 INFO - Downloading docopt-0.6.1.tar.gz 12:59:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:59:14 INFO - Installing collected packages: blobuploader, requests, docopt 12:59:14 INFO - Running setup.py install for blobuploader 12:59:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:59:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:59:14 INFO - Running setup.py install for requests 12:59:15 INFO - Running setup.py install for docopt 12:59:15 INFO - Successfully installed blobuploader requests docopt 12:59:15 INFO - Cleaning up... 12:59:15 INFO - Return code: 0 12:59:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:59: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')]} 12:59:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59: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')]} 12:59:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:15 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 0x1079f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb894a4ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077d1d30>, '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 0x1076f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c6be8>, '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.q7AginveNb/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.f4oa5WtQRO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 12:59:15 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 12:59:15 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 12:59:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q7AginveNb/Render', 12:59:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:59:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:59:15 INFO - 'HOME': '/Users/cltbld', 12:59:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:59:15 INFO - 'LOGNAME': 'cltbld', 12:59:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:15 INFO - 'MOZ_NO_REMOTE': '1', 12:59:15 INFO - 'NO_EM_RESTART': '1', 12:59:15 INFO - 'PAGER': '/bin/cat', 12:59:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:59:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:15 INFO - 'PWD': '/builds/slave/test', 12:59:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:59:15 INFO - 'SHELL': '/bin/bash', 12:59:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f4oa5WtQRO/Listeners', 12:59:15 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 12:59:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:59:15 INFO - 'USER': 'cltbld', 12:59:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:59:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:59:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:15 INFO - 'XPC_FLAGS': '0x0', 12:59:15 INFO - 'XPC_SERVICE_NAME': '0', 12:59:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:59:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:59:15 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-1QE33f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:59:15 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-z7hDH6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:59:15 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-FU0vd7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:59:15 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-RyOtGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:59:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:59:15 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-SBfZXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:59:16 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-0zB69q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:59:16 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-LRS9K2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:59:16 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-Ozzwut-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:59:16 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-zSGHM9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:59:16 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-pLasf5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:59:16 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-S77P4L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:59:16 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-gz9jDh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:59:16 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-QIOztD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:59:16 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-l5GPIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:59:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:59:16 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-LkE25I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:59:17 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-hwcT9O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:59:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:59:17 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-gYAii3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:59:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:59:17 INFO - Running setup.py install for manifestparser 12:59:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:59:17 INFO - Running setup.py install for mozcrash 12:59:17 INFO - Running setup.py install for mozdebug 12:59:17 INFO - Running setup.py install for mozdevice 12:59:17 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:59:17 INFO - Running setup.py install for mozfile 12:59:18 INFO - Running setup.py install for mozhttpd 12:59:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:59:18 INFO - Running setup.py install for mozinfo 12:59:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:59:18 INFO - Running setup.py install for mozInstall 12:59:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:59:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:59:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:59:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:59:18 INFO - Running setup.py install for mozleak 12:59:18 INFO - Running setup.py install for mozlog 12:59:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:59:18 INFO - Running setup.py install for moznetwork 12:59:18 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:59:18 INFO - Running setup.py install for mozprocess 12:59:19 INFO - Running setup.py install for mozprofile 12:59:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:59:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:59:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:59:19 INFO - Running setup.py install for mozrunner 12:59:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:59:19 INFO - Running setup.py install for mozscreenshot 12:59:19 INFO - Running setup.py install for moztest 12:59:19 INFO - Running setup.py install for mozversion 12:59:19 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:59:19 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:59:19 INFO - Cleaning up... 12:59:19 INFO - Return code: 0 12:59:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:59:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:59:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:19 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 0x1079f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb894a4ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077d1d30>, '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 0x1076f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c6be8>, '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.q7AginveNb/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.f4oa5WtQRO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 12:59:19 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 12:59:19 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 12:59:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q7AginveNb/Render', 12:59:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:59:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:59:19 INFO - 'HOME': '/Users/cltbld', 12:59:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:59:19 INFO - 'LOGNAME': 'cltbld', 12:59:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:19 INFO - 'MOZ_NO_REMOTE': '1', 12:59:19 INFO - 'NO_EM_RESTART': '1', 12:59:19 INFO - 'PAGER': '/bin/cat', 12:59:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:59:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:19 INFO - 'PWD': '/builds/slave/test', 12:59:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:59:19 INFO - 'SHELL': '/bin/bash', 12:59:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f4oa5WtQRO/Listeners', 12:59:19 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 12:59:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:59:19 INFO - 'USER': 'cltbld', 12:59:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:59:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:59:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:19 INFO - 'XPC_FLAGS': '0x0', 12:59:19 INFO - 'XPC_SERVICE_NAME': '0', 12:59:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:59:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:59:20 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-XrndwX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:59:20 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)) 12:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:59:20 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-BFyQLR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:59:20 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)) 12:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:59:20 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-kh8aF4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:59:20 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)) 12:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:59:20 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-9rRa54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:59:20 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)) 12:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:59:20 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-VpMOD4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:59:20 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)) 12:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:59:20 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-eBUcFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:59:20 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)) 12:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:59:20 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-5qpzpq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:59:20 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)) 12:59:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:59:20 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-4w3_qo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:59:21 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)) 12:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:59:21 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-Ulng8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:59:21 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)) 12:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:59:21 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-qdMcQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:59:21 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)) 12:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:59:21 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-Ot_Lr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:59:21 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)) 12:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:59:21 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-9w1HVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:59:21 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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)) 12:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:59:21 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-WisTIh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:59:21 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)) 12:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:59:21 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-3rhakC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:59:21 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)) 12:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:59:21 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-NPuzxq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:59:21 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)) 12:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:59:21 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-pHig2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:59:21 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)) 12:59:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:59:21 INFO - Running setup.py (path:/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/pip-Ykk1Ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:59:21 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)) 12:59:21 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)) 12:59:21 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)) 12:59:21 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)) 12:59:21 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)) 12:59:21 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)) 12:59:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:59:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:59:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:59:24 INFO - Downloading blessings-1.6.tar.gz 12:59:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:59:24 INFO - Installing collected packages: blessings 12:59:24 INFO - Running setup.py install for blessings 12:59:24 INFO - Successfully installed blessings 12:59:24 INFO - Cleaning up... 12:59:24 INFO - Return code: 0 12:59:24 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:59:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:59:25 INFO - Reading from file tmpfile_stdout 12:59:25 INFO - Current package versions: 12:59:25 INFO - blessings == 1.6 12:59:25 INFO - blobuploader == 1.2.4 12:59:25 INFO - docopt == 0.6.1 12:59:25 INFO - functools32 == 3.2.3-2 12:59:25 INFO - jsonschema == 2.5.1 12:59:25 INFO - manifestparser == 1.1 12:59:25 INFO - mozInstall == 1.12 12:59:25 INFO - mozcrash == 1.0 12:59:25 INFO - mozdebug == 0.1 12:59:25 INFO - mozdevice == 0.49 12:59:25 INFO - mozfile == 1.2 12:59:25 INFO - mozhttpd == 0.7 12:59:25 INFO - mozinfo == 0.9 12:59:25 INFO - mozleak == 0.1 12:59:25 INFO - mozlog == 3.4 12:59:25 INFO - moznetwork == 0.27 12:59:25 INFO - mozprocess == 0.25 12:59:25 INFO - mozprofile == 0.28 12:59:25 INFO - mozrunner == 6.13 12:59:25 INFO - mozscreenshot == 0.1 12:59:25 INFO - mozsystemmonitor == 0.3 12:59:25 INFO - moztest == 0.8 12:59:25 INFO - mozversion == 1.4 12:59:25 INFO - psutil == 3.1.1 12:59:25 INFO - requests == 1.2.3 12:59:25 INFO - wsgiref == 0.1.2 12:59:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:59: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')]} 12:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59: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')]} 12:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:25 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 0x1079f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb894a4ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077d1d30>, '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 0x1076f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c6be8>, '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.q7AginveNb/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.f4oa5WtQRO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 12:59:25 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 12:59:25 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 12:59:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q7AginveNb/Render', 12:59:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:59:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:59:25 INFO - 'HOME': '/Users/cltbld', 12:59:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:59:25 INFO - 'LOGNAME': 'cltbld', 12:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:25 INFO - 'MOZ_NO_REMOTE': '1', 12:59:25 INFO - 'NO_EM_RESTART': '1', 12:59:25 INFO - 'PAGER': '/bin/cat', 12:59:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:25 INFO - 'PWD': '/builds/slave/test', 12:59:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:59:25 INFO - 'SHELL': '/bin/bash', 12:59:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f4oa5WtQRO/Listeners', 12:59:25 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 12:59:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:59:25 INFO - 'USER': 'cltbld', 12:59:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:59:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:25 INFO - 'XPC_FLAGS': '0x0', 12:59:25 INFO - 'XPC_SERVICE_NAME': '0', 12:59:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:25 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)) 12:59:25 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)) 12:59:25 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)) 12:59:25 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)) 12:59:25 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)) 12:59:25 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)) 12:59:25 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)) 12:59:25 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)) 12:59:25 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)) 12:59:25 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)) 12:59:25 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)) 12:59:25 INFO - Cleaning up... 12:59:25 INFO - Return code: 0 12:59:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 12:59: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')]} 12:59:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:59:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59: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')]} 12:59:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:59:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:59:25 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 0x1079f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1079f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fdb894a4ac0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1077d1d30>, '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 0x1076f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c6be8>, '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.q7AginveNb/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.f4oa5WtQRO/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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 12:59:25 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 12:59:25 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 12:59:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q7AginveNb/Render', 12:59:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:59:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:59:25 INFO - 'HOME': '/Users/cltbld', 12:59:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:59:25 INFO - 'LOGNAME': 'cltbld', 12:59:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:25 INFO - 'MOZ_NO_REMOTE': '1', 12:59:25 INFO - 'NO_EM_RESTART': '1', 12:59:25 INFO - 'PAGER': '/bin/cat', 12:59:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:59:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:25 INFO - 'PWD': '/builds/slave/test', 12:59:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:59:25 INFO - 'SHELL': '/bin/bash', 12:59:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f4oa5WtQRO/Listeners', 12:59:25 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 12:59:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:59:25 INFO - 'USER': 'cltbld', 12:59:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:59:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:59:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:25 INFO - 'XPC_FLAGS': '0x0', 12:59:25 INFO - 'XPC_SERVICE_NAME': '0', 12:59:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:59:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:59:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 12:59:25 INFO - Cleaning up... 12:59:25 INFO - Return code: 0 12:59:25 INFO - Running post-action listener: _resource_record_post_action 12:59:25 INFO - Running post-action listener: _start_resource_monitoring 12:59:25 INFO - Starting resource monitoring. 12:59:25 INFO - [mozharness: 2017-04-04 19:59:25.838640Z] Finished create-virtualenv step (success) 12:59:25 INFO - [mozharness: 2017-04-04 19:59:25.839592Z] Running install step. 12:59:25 INFO - Running pre-action listener: _resource_record_pre_action 12:59:25 INFO - Running main action method: install 12:59:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:59:26 INFO - Reading from file tmpfile_stdout 12:59:26 INFO - Detecting whether we're running mozinstall >=1.0... 12:59:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:59:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:59:26 INFO - Reading from file tmpfile_stdout 12:59:26 INFO - Output received: 12:59:26 INFO - Usage: mozinstall [options] installer 12:59:26 INFO - Options: 12:59:26 INFO - -h, --help show this help message and exit 12:59:26 INFO - -d DEST, --destination=DEST 12:59:26 INFO - Directory to install application into. [default: 12:59:26 INFO - "/builds/slave/test"] 12:59:26 INFO - --app=APP Application being installed. [default: firefox] 12:59:26 INFO - mkdir: /builds/slave/test/build/application 12:59:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 12:59:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 12:59:46 INFO - Reading from file tmpfile_stdout 12:59:46 INFO - Output received: 12:59:46 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:59:46 INFO - Running post-action listener: _resource_record_post_action 12:59:46 INFO - [mozharness: 2017-04-04 19:59:46.033179Z] Finished install step (success) 12:59:46 INFO - [mozharness: 2017-04-04 19:59:46.033331Z] Running run-tests step. 12:59:46 INFO - Running pre-action listener: _resource_record_pre_action 12:59:46 INFO - Running main action method: run_tests 12:59:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:59:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:59:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:59:46 INFO - 2017-04-04 12:59:46.047 screenresolution[1618:7233] starting screenresolution argv=screenresolution get 12:59:46 INFO - 2017-04-04 12:59:46.050 screenresolution[1618:7233] Display 0: 1600x1200x32@60 12:59:46 INFO - 2017-04-04 12:59:46.056 screenresolution[1619:7236] starting screenresolution argv=screenresolution list 12:59:46 INFO - Available Modes on Display 0 12:59:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:59:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:59:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:59:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:59:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:59:46 INFO - Intel Iris: 12:59:46 INFO - Chipset Model: Intel Iris 12:59:46 INFO - Type: GPU 12:59:46 INFO - Bus: Built-In 12:59:46 INFO - VRAM (Dynamic, Max): 1536 MB 12:59:46 INFO - Vendor: Intel (0x8086) 12:59:46 INFO - Device ID: 0x0a2e 12:59:46 INFO - Revision ID: 0x0009 12:59:46 INFO - Displays: 12:59:46 INFO - Display: 12:59:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:59:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:59:46 INFO - Display Serial Number: 1600x1200 60 12:59:46 INFO - Main Display: Yes 12:59:46 INFO - Mirror: Off 12:59:46 INFO - Online: Yes 12:59:46 INFO - Rotation: Supported 12:59:46 INFO - Return code: 0 12:59:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:59:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:59:46 INFO - Python 2.7.3 12:59:46 INFO - Return code: 0 12:59:46 INFO - grabbing minidump binary from tooltool 12:59:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 12:59:46 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 0x1077d1d30>, '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 0x1076f8db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1077c6be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:59:46 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 12:59:46 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 12:59:46 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 12:59:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:59:46 INFO - Return code: 0 12:59:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:59:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:59:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:59:46 INFO - ENV: RUST_BACKTRACE is now 1 12:59:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:59:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:59:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dv7IC06yT-aEuB-OSR2lug/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0088', '--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 12:59:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Dv7IC06yT-aEuB-OSR2lug/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0088 --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 12:59:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.q7AginveNb/Render', 12:59:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:59:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:59:46 INFO - 'HOME': '/Users/cltbld', 12:59:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:59:46 INFO - 'LOGNAME': 'cltbld', 12:59:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:59:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:59:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:59:46 INFO - 'MOZ_NO_REMOTE': '1', 12:59:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:59:46 INFO - 'NO_EM_RESTART': '1', 12:59:46 INFO - 'PAGER': '/bin/cat', 12:59:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:59:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:59:46 INFO - 'PWD': '/builds/slave/test', 12:59:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:59:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:59:46 INFO - 'RUST_BACKTRACE': '1', 12:59:46 INFO - 'SHELL': '/bin/bash', 12:59:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.f4oa5WtQRO/Listeners', 12:59:46 INFO - 'TMPDIR': '/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/', 12:59:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:59:46 INFO - 'USER': 'cltbld', 12:59:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:59:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:59:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:59:46 INFO - 'XPC_FLAGS': '0x0', 12:59:46 INFO - 'XPC_SERVICE_NAME': '0', 12:59:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:59:46 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dv7IC06yT-aEuB-OSR2lug/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0088', '--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 12:59:46 INFO - mozversion application_buildid: 20170404112528 12:59:46 INFO - mozversion application_changeset: b043233ec04f06768d59dcdfb9e928142280f3cc 12:59:46 INFO - mozversion application_display_name: Nightly 12:59:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:59:46 INFO - mozversion application_name: Firefox 12:59:46 INFO - mozversion application_remotingname: firefox 12:59:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 12:59:46 INFO - mozversion application_vendor: Mozilla 12:59:46 INFO - mozversion application_version: 55.0a1 12:59:46 INFO - mozversion platform_buildid: 20170404112528 12:59:46 INFO - mozversion platform_changeset: b043233ec04f06768d59dcdfb9e928142280f3cc 12:59:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 12:59:46 INFO - mozversion platform_version: 55.0a1 12:59:46 INFO - using testdate: 1491335986 12:59:46 INFO - actual date: 1491335986 12:59:46 INFO - starting webserver on 'localhost:49243' 12:59:46 INFO - SUITE-START | Running 2 tests 12:59:46 INFO - TEST-START | dromaeo_css 12:59:46 INFO - operating with platform_type : mac_ 12:59:46 INFO - Initialising browser for dromaeo_css test... 12:59:46 INFO - TEST-INFO | started process 1629 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpz4TREL/profile http://localhost:49243/getInfo.html) 12:59:49 INFO - PID 1629 | 2017-04-04 12:59:49.279 plugin-container[1631:7417] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b3f, name = 'com.apple.tsm.portname' 12:59:49 INFO - PID 1629 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:59:49 INFO - PID 1629 | 2017-04-04 12:59:49.282 plugin-container[1631:7417] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x494b, name = 'com.apple.CFPasteboardClient' 12:59:49 INFO - PID 1629 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:59:49 INFO - PID 1629 | 2017-04-04 12:59:49.282 plugin-container[1631:7417] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 12:59:49 INFO - PID 1629 | __metrics Screen width/height:1600/1200 12:59:49 INFO - PID 1629 | colorDepth:24 12:59:49 INFO - PID 1629 | Browser inner width/height: 1024/689 12:59:49 INFO - PID 1629 | __metrics 12:59:49 ERROR - PID 1629 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3362: TypeError: this.tabs is undefined 12:59:50 INFO - TEST-INFO | 1629: exit 0 12:59:50 INFO - Browser initialized. 12:59:50 INFO - Running cycle 1/1 for dromaeo_css test... 12:59:50 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpz4TREL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:59:53 INFO - PID 1632 | 2017-04-04 12:59:53.793 plugin-container[1633:7549] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 12:59:53 INFO - PID 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:59:53 INFO - PID 1632 | 2017-04-04 12:59:53.794 plugin-container[1633:7549] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0f, name = 'com.apple.CFPasteboardClient' 12:59:53 INFO - PID 1632 | See /usr/include/servers/bootstrap_defs.h for the error codes. 12:59:53 INFO - PID 1632 | 2017-04-04 12:59:53.794 plugin-container[1633:7549] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:00:03 INFO - PID 1632 | RSS: Main: 249176064 13:00:03 INFO - PID 1632 | 13:03:07 INFO - PID 1632 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 13:03:09 INFO - PID 1632 | RSS: Main: 253009920 13:03:09 INFO - PID 1632 | 13:04:51 INFO - PID 1632 | ************************* 13:04:51 INFO - PID 1632 | A coding exception was thrown and uncaught in a Task. 13:04:51 INFO - PID 1632 | 13:04:51 ERROR - PID 1632 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:04:51 INFO - PID 1632 | Full stack: 13:04:51 INFO - PID 1632 | ************************* 13:04:51 INFO - PID 1632 | ************************* 13:04:51 INFO - PID 1632 | A coding exception was thrown and uncaught in a Task. 13:04:51 INFO - PID 1632 | 13:04:51 ERROR - PID 1632 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:04:51 INFO - PID 1632 | Full stack: 13:04:51 INFO - PID 1632 | ************************* 13:04:51 INFO - PID 1632 | ************************* 13:04:51 INFO - PID 1632 | A coding exception was thrown and uncaught in a Task. 13:04:51 INFO - PID 1632 | 13:04:51 ERROR - PID 1632 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:04:51 INFO - PID 1632 | Full stack: 13:04:51 INFO - PID 1632 | ************************* 13:04:51 INFO - PID 1632 | ************************* 13:04:51 INFO - PID 1632 | A coding exception was thrown and uncaught in a Task. 13:04:51 INFO - PID 1632 | 13:04:51 ERROR - PID 1632 | Full message: TypeError: NetworkError when attempting to fetch resource. 13:04:51 INFO - PID 1632 | Full stack: 13:04:51 INFO - PID 1632 | ************************* 13:06:11 INFO - PID 1632 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 13:06:12 INFO - PID 1632 | RSS: Main: 263720960 13:06:12 INFO - PID 1632 | 13:09:13 INFO - PID 1632 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 13:09:14 INFO - PID 1632 | RSS: Main: 274997248 13:09:14 INFO - PID 1632 | 13:12:16 INFO - PID 1632 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 13:12:16 INFO - PID 1632 | RSS: Main: 268275712 13:12:16 INFO - PID 1632 | 13:15:19 INFO - PID 1632 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 13:15:20 INFO - PID 1632 | RSS: Main: 278601728 13:15:20 INFO - PID 1632 | 13:18:23 INFO - PID 1632 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 13:18:23 INFO - PID 1632 | RSS: Main: 272375808 13:18:23 INFO - PID 1632 | 13:18:23 INFO - PID 1632 | __start_tp_report 13:18:23 INFO - PID 1632 | _x_x_mozilla_page_load 13:18:23 INFO - PID 1632 | _x_x_mozilla_page_load_details 13:18:23 INFO - PID 1632 | |i|pagename|runs| 13:18:23 INFO - PID 1632 | |0;dojo.html;2939.4708952388573;3421.794692318461;3488.9651103488964;3519.87680431185;3555.093451169951;6133.181650350766;6215.12988181655;6227.28386235583;6248.468880145182;6259.843503912399;6106.794380079887;6142.56016630686;6230.065490176476;6266.811995640138;6273.874522509547;5442.210879422481;5486.204500347447;5514.338279406456;5554.750036248379;5587.245721827542;5385.380681221651;5468.863278418052;5572.359178694442;5583.3300003999575;5633.774649014034;5413.890152518724;5460.153676180198;5485.945140548583;5493.945060549403;5513.228148059275;4640.443146822369;5364.383095943977;5452.754626041838;5490.862728431781;5499.752511137009;5389.110796718537;5402.216678581583;5407.324084489439;5424.728763561806;5484.91772623411;6068.908966365508;6080.635161890301;6134.926457743771;6136.3352719466575;6192.535559833031;5549.223108764776;6694.59832410057;6710.966445167743;6712.731490740364;6721.1598550181225;6713.530052896251;6790.5925644461495;6792;6794.932050679528;6795.592264464148;6123.142760013601;6203.441690247809;6390.360963903572;6391.265004524446;6395.808125756234;6881.65591720412;6938.965305173442;6955.7217711292;6960.79117626472;6992.300769922967;5360.16917377807;5552.555795536347;5705.5150312223095;6260.655663938527;6396.392342727433;6678.7328506859185;6695.598264104072;6776.356246156607;6806.7957961261245;6812.93187068123;6378.840528986812;6464.612123272619;6669.599824010575;6681.265060843303;6689;5102.821401250939;5807.390224026501;6500.674966251669;6624.701888415033;6732;5363.490468405495;5367.5169234769055;5378.97310513445;5383.2194331821665;5383.892322153535;4057.5536690963972;4656.348111264426;4722.268048452426;4744.596709279681;4767.213409787416;6183.598066125687;6364.363563643598;6368.84077898047;6404.5516813823515;6405.327440618668;6825.249222585511;6859.7256109756045;6871.828204294832;6872.518923675295;6888.242293347727;6354.714037868307;6365.713542890581;6422.935770642327;6427.935720642828;6439.839004024843;5769.8557536061935;5851.063829787298;5854.502367298827;5855.736491857877;5936.643801371932;6947.305269473113;6998.790036298919;7010.789676309719;7023.789286321418;7030.543014704028;6764.526483146329;6806.047153398429;6806.353396427331;6808.489363297674;6849;6684.933150668626;6821.761238356634;6930.168379794457;6991.405730512964;7019.122609673791;6596;6604.438622716931;6659.467242620675;6679.265280819009;6692.732290708317;6413.518986076157;6678.866422671616;6805;6811;6817.625030623363;6347.460465860454;6388.329225431448;6398.232212134573;6445.355464453517;6520;6434.099226108255;6483.805485835433;6526.543141980016;6538.313477084837;6538.607683539003;6282.623042617458;6293.307736149111;6316.210473690789;6360.840978975562;6378.77674281398;6424.261209960914;6500.739970401131;6510.934890651222;6515.967420163059;6530;6382;6389.648569328546;6404.455621272244;6408.743650253938;6416.390442907917 13:18:23 INFO - PID 1632 | |1;ext.html;801.6633014134063;1260.7982722764355;1283.6983308922408;1284.755896379688;1285.7042880137562;38321.42517862231;39229;39248;39305.820825375245;39439.40840887385;38681.80659096708;39069.41395879064;39158.608413915856;39186.60813391865;39218.411723824094;7464.730995730739;8829.23415316936;8889.244414224766;8899.243564297043;8934.687285944994;8831.470111793313;8894.332925030616;8939.776505587348;8948.194662480375;8967.95516022419;8875.556222188865;8906.287497000225;8927.419717718327;8960.10398960102;8972.327075469333;8904.554772261394;8931.955340223321;8938.821223575493;8944.463332200025;8946.239569636622;8683.305335573139;8683.696070637498;8705.869411958825;8750.737477875675;8754.606042728092;38743.61256387428;39025.41461878074;39029;39032.80483597592;39160.60839391598;3452.1197094740933;3477.078574177845;3485.7559970802054;3491.7555771096036;3501.7723847950056;30998;31206.687933120604;31275.84362078175;31306.37387252242;31369.74521019179;3108.9689103108904;3126.4059828632485;3137.545055966895;3168.1604374840686;3170.508571171472;270148.999999998;285194;286614;287048;287301.5634921812;40766.388504172464;48289;49345.259821102714;49365.75317123463;49371.75314123406;51943.48056519462;52124;52290.738546307024;52324.476755232725;52380.95238095217;14304.356303966346;14330.355134018993;14447.349869255699;14450.710985780226;14470.421183152555;11478.655640330804;11663.533458661559;11700.414979251003;11734.647960561197;11736.765264694659;13952.790708139386;14069.226192559507;14075.507357242652;14118.85881141196;14224.715505690036;6056.3338032816355;6091.390860913962;6121.84695382619;6122.7244773984385;6126.693665316717;864.8659457784054;975.1175186456269;995.9800803983879;1007.8236308645958;1042.61944390297;24110.87944560266;24213;24373.02507899664;24389.14637987662;24481.877590611934;1083.2363183955292;1084.1868598551087;1093.5407129005837;1116.7431490757172;1138.2942575603013;9558.761030974143;12294.262344259372;12487.188332758524;12628.368581570885;12632.873671263169;417739;421757;422794;423529.8823105935;425227;54909.70541767507;55142.44857551373;55233;55279.44720552823;55305.723471382385;1494.7757836324638;1499.0780669888159;1530.3648985671045;1530.456687875788;1545.0189129902592;20414.489637759176;23900.73102750498;24018.87990560036;24303;24303.878480607484;39746;39885.202295953335;39942.400863986484;40221.79889100536;40224.798876005436;398198;398486;399766;400168;400845;34036.659633403346;34095.82952085323;34708.958731238105;34745.65254347424;34851.47722784211;43631.78184109059;43831.34252986272;44178.337324940796;44193.55806441895;44640.77679611581;29886.701132988394;29959.400811983203;30158.095257142322;30713.539296910116;30781.69218307878;29876.103716888527;30792.692073079877;30906.0728178155;30982.845085775327;31160.844195779784;36027.81986090053;36390.63609363873;36508.45237321389;36735.89792306235;36856.44715329326;29460.852695736383;30021.5496767553;31186.844065779525;31254.687453125178;31628.367432651678;21471.141154353652;21703;24084;24642.753572464764;24850.37874053091 13:18:23 INFO - PID 1632 | |2;jquery.html;376.5124164207351;418.6378782353265;421.83126749300277;435.7886425083835;449.2744218087787;17997.64004719905;20266.493337666565;21317.93410329481;21997.450063748413;22447.663285050738;19237.038148092608;22736.88631556844;22793.886030569825;23340.64989025166;23483;6089.299730530979;6351.2060992375955;6355.713992870309;6358.141650877142;6370.171877655898;6025.427584379477;6189.659568723719;6192.380761923817;6255.030470277115;6263.749450021994;6190.876182476371;6198.659073750942;6220.315765265817;6224.284207316148;6230.906536401958;5948.583599148062;6197.81406557804;6260.686965651699;6274.184356033709;6274.403931626488;5311.336082989626;5518.641288316287;5518.91721624176;5553.500184983331;5571.66570005801;23602;27361.726382736117;27387.86306068477;27440.313992150157;27500.17499475019;2170.6418440957223;2239.2386588559966;2242.2264318809985;2247.449374903159;2247.910083596654;17486.737698934397;17645.911770441195;18078.01141874393;18186.545336366566;18402.447926562225;2071.4510654676524;2076.6158260721813;2127.1704035426196;2129.2441183379988;2140.9464763380884;148198;154928;157135;158742;159971.40028599682;11805.23265987708;12003.819942700866;12404.56584019573;12440.875591244152;12477.812832807514;14141.363638636287;15905.68188636244;16173.757393639105;16177.4337898173;16188.433404830774;8686.565671716515;8741.781455463664;8871.645134194689;8912.287017038621;8922.821543569093;8303.4602750821;8403.663853445916;8447;8479.618417171243;8539.402241843012;7763.4953728007495;7826.726064587712;7894.565798881002;7905.407094467938;7918.683252669829;2129.8285942731436;2144.324537770597;2144.731908511436;2151.978480215209;2317.768223177669;913.1097180249336;913.8081002989313;929.9581518831669;951.6764300137986;972.7908499672604;17483.388081417088;18100.094995250183;19481.902590486956;20138;20181.596368072558;836.8828364029041;866.276658989738;953.4279432340679;974.7270764186039;982.9950850245702;9728.805423891483;10342.689719308433;10376.16990640762;10796.190285728602;11907.52369905194;652428.7378563076;665254;666656;675959;679035;136248;139397.45422911784;140827;142569;144425;1216.5012344938532;1219.2379762648345;1246.5450110709708;1250.8686587908321;1256.6732649511193;20289.188432462535;20465.48836279105;20820.75075495475;21547.676784847925;21626;51392.48607513877;61393.69303153456;62336.75326493535;62382.688086559276;62811.68594157;87755.1224487747;90943;91765.54117229371;92167.53916230376;92445.53777231071;8569.314454843723;8639.95680021596;8866.113388661082;8947.239484643878;9169.220616247694;13601.319934003459;13701;13843.861561384258;13956;14061;10179.694609161737;11029.338239705323;11642.76714465723;11685.298882066763;11812.114091443003;9770.75573110678;10890.945545272223;11160.888391115985;11447.713807154887;11451.713707157387;11776.470058847544;11909.40452977365;12235.816462752888;12383;12417.503299867903;8159.8576199330955;8353.33173346143;8914.955425222832;8925.464472131693;8991.730248092568;10050.949745251228;11638.476268567765;11673.182877198515;11962.282263064244;11985.400729963641 13:18:23 INFO - PID 1632 | |3;mootools.html;1235;1396.5461225101837;1411.4495346814745;1414.3564678071477;1436.5618486361661;10767.24629275951;11023.228374013823;11117.444127793608;11227.045701115405;11428.599999000036;11066.170037247219;11086.279391839525;11239.269447485927;11268.492917818718;11269.985701286903;2437.6465412515176;2447.155731272708;2463.4580392313665;2464.7904928081134;2465.6671349367784;2386.2483317754936;2393.453666461924;2410.674558934548;2426.3934016495878;2432.8297019208662;2365.302235840423;2396.4967356854995;2409.5060512594964;2456.987715061422;2459.0409740201335;1963.5091227193202;2403.158894386959;2421.3462365161395;2431.927042188728;2436.062116085302;2029.5839352932614;2122.1299267300333;2349.6240601503678;2417.311066346083;2433.1848830641757;10865.728356791064;11085.944570277097;11158.944205279004;11170.329780213133;11179.44102794857;5322.547583455411;6412.903806442907;6420.454261387741;6425.22897252328;6434.163558737381;3475.8609655613745;3712.1833196696684;4054.979725101385;4104.261232978063;4149.211649786531;982.0326977926736;1214.908881833857;1252.7431876465394;1272.4019710736031;1276.7893297605883;12667.746645067047;14582.927085364612;14982.550523484313;15111.168885711282;15191.62020949474;5160.174372100446;5289.735513224324;5335.679859208382;5431.131019037014;5443.42844001382;11441.084713222923;11453.942730286295;11508.36703981289;11546.653600392001;11599.362035088152;5202.4277329493725;6223.37766223374;6244.781432649836;6276.968615156895;6344.936550634435;5689.374168841424;5758.712064396764;5783.2192653992015;5822.505087067647;5907.291125064934;3628.618995005539;4273.67947403946;4298.957010429918;4332.978335108367;4334.41485399467;1264.968375790594;1266.3541593787052;1274.4774642396574;1281.6603600045996;1282.6152154353842;745.9627018649046;747.7607165706921;771.4946709905021;777.3547955197173;778.1284960843891;5965.55258355625;6236.095766113979;6258.74965001404;6314.8421289467215;6352.936470635327;563.7096895099028;564.5963136357442;567.1322875999728;571.7084287013653;585.1486087742325;3022.3653032862903;3049.359634476785;3172.460681684119;3606.206634540397;3791.9241615168094;13506.324683765772;14099.647508812157;14231.64420889486;14273;14285.285735713172;13524.12093213938;14138.151710897379;14178.291085445893;14197.36111874968;14206.934479914047;9656.613735450645;10107.241956853266;10305.639302624371;10369.429681367446;10385.792284154275;5281.55106815925;6049.576529643059;6280.026595877646;6455.096286519797;6480.287168411565;10580.788384232426;12231.633051008484;12622.684432888884;12689.111762176559;12869.22784632925;10711.94644026775;11072.833907491233;12693.80959285593;12811.679708007374;13039.804402933774;8220.506769593843;8299.253067223979;8354.87467687973;8372.87440688378;8393.034800997719;9328.440293582407;9423.764405889908;10157.54291056919;10172.440515771703;10266.178705703376;8488.193621605938;8617.741467755977;8712.433691810265;8771.298296136167;8900.020997690119;8464.153584641486;8531.274841638531;8562.657493700182;8574.27118694918;8578.528180950108;7826.139124696393;7847.489913155627;7926.920730792618;7927.652299109281;7950.324222441157;5811.593188476766;5858.297004359504;5900.203472531153;5999.370066143167;6067.605605635619;5853.795117170878;5904.881902361843;5987.970060149845;6147.538934579835;6213.565050446426 13:18:23 INFO - PID 1632 | |4;prototype.html;284.4581073055829;356.69324381032294;379.5938345969812;396.3836234655111;403.46943768943845;5985.551083668721;6184.783532576355;6207.658578778165;6247.812565623033;6263.467605253559;4365.410669559608;5249.527542521172;6115.235595550556;6122.1428999939935;6128.662923539204;4436.979494716217;4446.577575130374;4464.799084041218;4482.238019536687;4489.236829738952;3699.889003329891;4287.678424118204;4451.5103338632725;4453.28747400416;4490.730556166641;3656.8902932912056;4153.11033479766;4390.560943905616;4404.801783919731;4406.184855801687;3429.3141371725505;3665.7617254878346;4393.802278897441;4422.933655995179;4424.358468022151;3319.319539494422;3687.1703866630064;3733.775973441602;3816.790076545789;3851.287511810324;4928.950710492885;5022.89954200914;5570.888582228333;5905.379935106838;5974.6713930733795;4379.912401751947;4811.278308253755;5252.474752524755;5254.264402983586;5255.448177941299;6261.436470717612;6464.450521705614;6485.93514064858;6514.7621951829;6540.574862633961;3785.905352366213;3796.8860934171744;4304.720193187432;4345.630621397185;4352.521222665504;6630.535862489628;6750.493712971498;6808.5914845109455;6918.446524278046;6967.303269672992;4348.891277718082;4353.608175264241;4357.694961352675;4385.9692972151515;4401.273789824707;3757.323681737259;4458.331250312479;4460.687751857339;4464.027015955802;4497.437820272466;5087.481696560227;5214.765335559909;5247.344081989751;5287.576993840484;5289.735513224324;6579.111819904348;6587.341265873471;6593.241777195684;6599.1091202687985;6629.5359324846795;1406.5709958462767;1508.3891024135244;1518.5899807052035;1518.8860835437386;1523.9847601523843;902.8194361127801;944.6599224279254;1002.3284399452384;1003.267614641316;1016.7356487313352;6177.227846519185;6197.17183430889;6232.376762323822;6238.189035425366;6272.773165526264;6417.326180750954;6731.225909020427;6743.831404214836;6772.492063095287;6821.21556021054;6234.9688251558455;6272.1219029335925;6302.432781049728;6313.463355614732;6363.268224154189;2657.9601305980427;3248.642649308574;3560.839762210707;3570.1610121621397;3597.7661452005536;6483.513736469784;6710.563813352116;6958.686859091353;7015.36861682451;7036.331548502884;6875.415589674833;6959.82600434983;7010.509264351446;7042;7068.5758854468895;6639.668016599151;6898.206706228848;6915.715035358266;6953.443724502028;7155.534890232014;6656.267810540739;6827.829304267234;6853.211880633791;6866.4506839453725;6882.208546017072;5280.920786188287;6551.44312733423;6576.684663067502;6670.332966703291;6769.830754231184;6232.407921247474;7039.60653377854;7062.8940565890525;7064.293570642894;7088.326608972139;4132.090939993197;4201.97899010503;4396.27461468854;4397.956020439755;4398.032432864765;6533.607983521004;6566.785144748237;6688.699008544724;6867.450603951772;7036.663034023519;5164.992826398816;5934.406559344031;5974.641521508724;6129.908051379144;6614.735410583523;6386.393292637378;6530.771423000172;6593.340665933369;6617.404433600999;6618.801435956736;6387.265464471459;6416.241016362822;6416.582922110048;6430.678466076771;6442.581232219891;6215.347388524321;6580.440662543738;6583.144191255106;6602.537822352389;6615.206175259;6223.657698826608;6336.352548337373;6357.205349331333;6357.884636528161;6376.234851817811 13:18:23 INFO - PID 1632 | |5;yui.html;781.9491733037356;819.1726356380057;832.737687628397;842.0400743152807;842.6587232170973;15430.845691543082;15469.535913922586;16003.83996160038;16165.83834161658;16242.83757162428;14517.20155391453;14887.553373398789;14935.253237338144;15083.92458037711;15144.924275378607;969.9951500242506;1001.5042553935812;1001.7195185348114;1002.9247806414512;1006.6476733143414;962.3456049886074;991.6281394477071;1003.3478239144541;1005.3465247589089;1007.5214273220236;1065.1585247654343;1069.4706120470378;1080.6703955293633;1080.7406222506581;1083.6911480228136;1057.9682609521687;1068.8610480637506;1071.4910417551678;1075.4622688655672;1076.7039064257312;783.4046124945025;793;799.9200079992013;800.4436916343144;803.4375936844233;13789.586312410644;13811.309434528233;15963.600909977227;16104.436344727877;16575.83969122162;14570.708585828224;14900;14911.254437278092;15063.397464101423;15690.529284121381;13119.540816071487;13310.334483275894;13475.528356507573;13583.592492225249;13610.659733506642;3332.583427071616;3371.544841446422;3392.2537041850755;3404.382918113901;3471.444568868994;79319.20680793175;87881;97877;103167.48416257945;103736;11210.775784484427;11331;11482;11885.28688278706;12069.793020698036;24428;24584.754152458605;24651.50696986086;24730.752692473205;24758.13346532863;6732.2931092235585;7763;8210.425270231146;8283;8317.376196785266;4170.085380832345;4193.454850869368;4201.474815648044;4258.488981322261;4321.438213032286;3641.780003698738;4022.8591999279884;4072.470578824734;4169.228692691861;4172.624463798273;899.6986009686829;915.1443400420628;919.2783664823082;919.6689191890914;920.9171174594319;544.5045009041753;615.8244900203421;618.329112912495;624.4848000399597;642.7396904253785;9668.806623867484;10006.38302116367;10038.598456061822;10182.541785619665;10193.898061019296;528.6854321678595;571.6455797405636;634.6223996721943;655.8655475627485;670.0351493848842;4221.852235171754;4404.933925991113;4674.205385084544;4738.431388233434;4820.1805693031565;94430;94803;96665.033349667;97783.53324700135;99237;65128;76276.85584716234;81009.16467923712;86197.56901215453;89021.55489222512;70810;71167.64416177887;71904.2809571908;74524;76446.47107057828;8274.379421543528;10903.945480272549;10964.671059868217;11089.833652495381;11096.547409812547;34318.48522272218;34549.82725086459;36146.81926590455;37676;40254.597454026254;39826.60173398229;50613;50789.74605126951;50922;50924.745376272884;13292.601221963356;13448;13566.457341706617;13651.249181295125;14047.297635118408;14297.285135742963;14342;14437.927810361301;14478.927605362327;14782.113073215642;13442.529511467052;13673.79489307681;13923.651908702364;14055.862017322554;14498.927505362828;12886.226826390446;13463.730725385241;13480.932595337354;13813.266206158405;14165.008449408442;12997.805032924703;13788.517401890886;13809.102408343426;13810;13823.170609763447;8164;9759.51202439861;9876.111149996535;10027.49862506857;10047.992648784631;11041.165124033687;11087.944560277147;11492.425378731197;11497.425128743696;11539.423028848356 13:18:23 INFO - PID 1632 | __end_tp_report 13:18:23 INFO - PID 1632 | __start_cc_report 13:18:23 INFO - PID 1632 | _x_x_mozilla_cycle_collect,425 13:18:23 INFO - PID 1632 | __end_cc_report 13:18:23 INFO - PID 1632 | __startTimestamp1491337103625__endTimestamp 13:18:23 INFO - PID 1632 | 13:18:23 INFO - PID 1632 | ------- Summary: start ------- 13:18:23 INFO - PID 1632 | Number of tests: 6 13:18:23 INFO - PID 1632 | 13:18:23 INFO - PID 1632 | [#0] dojo.html Cycles:165 Average:6140.21 Median:6388.33 stddev:770.45 (12.1%) stddev-sans-first:730.76 13:18:23 INFO - PID 1632 | Values: 2939.5 3421.8 3489.0 3519.9 3555.1 6133.2 6215.1 6227.3 6248.5 6259.8 6106.8 6142.6 6230.1 6266.8 6273.9 5442.2 5486.2 5514.3 5554.8 5587.2 5385.4 5468.9 5572.4 5583.3 5633.8 5413.9 5460.2 5485.9 5493.9 5513.2 4640.4 5364.4 5452.8 5490.9 5499.8 5389.1 5402.2 5407.3 5424.7 5484.9 6068.9 6080.6 6134.9 6136.3 6192.5 5549.2 6694.6 6711.0 6712.7 6721.2 6713.5 6790.6 6792.0 6794.9 6795.6 6123.1 6203.4 6390.4 6391.3 6395.8 6881.7 6939.0 6955.7 6960.8 6992.3 5360.2 5552.6 5705.5 6260.7 6396.4 6678.7 6695.6 6776.4 6806.8 6812.9 6378.8 6464.6 6669.6 6681.3 6689.0 5102.8 5807.4 6500.7 6624.7 6732.0 5363.5 5367.5 5379.0 5383.2 5383.9 4057.6 4656.3 4722.3 4744.6 4767.2 6183.6 6364.4 6368.8 6404.6 6405.3 6825.2 6859.7 6871.8 6872.5 6888.2 6354.7 6365.7 6422.9 6427.9 6439.8 5769.9 5851.1 5854.5 5855.7 5936.6 6947.3 6998.8 7010.8 7023.8 7030.5 6764.5 6806.0 6806.4 6808.5 6849.0 6684.9 6821.8 6930.2 6991.4 7019.1 6596.0 6604.4 6659.5 6679.3 6692.7 6413.5 6678.9 6805.0 6811.0 6817.6 6347.5 6388.3 6398.2 6445.4 6520.0 6434.1 6483.8 6526.5 6538.3 6538.6 6282.6 6293.3 6316.2 6360.8 6378.8 6424.3 6500.7 6510.9 6516.0 6530.0 6382.0 6389.6 6404.5 6408.7 6416.4 13:18:23 INFO - PID 1632 | 13:18:23 INFO - PID 1632 | [#1] ext.html Cycles:180 Average:51104.34 Median:36209.23 stddev:98792.77 (272.8%) stddev-sans-first:98997.71 13:18:23 INFO - PID 1632 | Values: 801.7 1260.8 1283.7 1284.8 1285.7 38321.4 39229.0 39248.0 39305.8 39439.4 38681.8 39069.4 39158.6 39186.6 39218.4 7464.7 8829.2 8889.2 8899.2 8934.7 8831.5 8894.3 8939.8 8948.2 8968.0 8875.6 8906.3 8927.4 8960.1 8972.3 8904.6 8932.0 8938.8 8944.5 8946.2 8683.3 8683.7 8705.9 8750.7 8754.6 38743.6 39025.4 39029.0 39032.8 39160.6 3452.1 3477.1 3485.8 3491.8 3501.8 30998.0 31206.7 31275.8 31306.4 31369.7 3109.0 3126.4 3137.5 3168.2 3170.5 270149.0 285194.0 286614.0 287048.0 287301.6 40766.4 48289.0 49345.3 49365.8 49371.8 51943.5 52124.0 52290.7 52324.5 52381.0 14304.4 14330.4 14447.3 14450.7 14470.4 11478.7 11663.5 11700.4 11734.6 11736.8 13952.8 14069.2 14075.5 14118.9 14224.7 6056.3 6091.4 6121.8 6122.7 6126.7 864.9 975.1 996.0 1007.8 1042.6 24110.9 24213.0 24373.0 24389.1 24481.9 1083.2 1084.2 1093.5 1116.7 1138.3 9558.8 12294.3 12487.2 12628.4 12632.9 417739.0 421757.0 422794.0 423529.9 425227.0 54909.7 55142.4 55233.0 55279.4 55305.7 1494.8 1499.1 1530.4 1530.5 1545.0 20414.5 23900.7 24018.9 24303.0 24303.9 39746.0 39885.2 39942.4 40221.8 40224.8 398198.0 398486.0 399766.0 400168.0 400845.0 34036.7 34095.8 34709.0 34745.7 34851.5 43631.8 43831.3 44178.3 44193.6 44640.8 29886.7 29959.4 30158.1 30713.5 30781.7 29876.1 30792.7 30906.1 30982.8 31160.8 36027.8 36390.6 36508.5 36735.9 36856.4 29460.9 30021.5 31186.8 31254.7 31628.4 21471.1 21703.0 24084.0 24642.8 24850.4 13:18:23 INFO - PID 1632 | 13:18:23 INFO - PID 1632 | [#2] jquery.html Cycles:180 Average:39568.99 Median:12829.21 stddev:112158.23 (874.2%) stddev-sans-first:112434.25 13:18:23 INFO - PID 1632 | Values: 376.5 418.6 421.8 435.8 449.3 17997.6 20266.5 21317.9 21997.5 22447.7 19237.0 22736.9 22793.9 23340.6 23483.0 6089.3 6351.2 6355.7 6358.1 6370.2 6025.4 6189.7 6192.4 6255.0 6263.7 6190.9 6198.7 6220.3 6224.3 6230.9 5948.6 6197.8 6260.7 6274.2 6274.4 5311.3 5518.6 5518.9 5553.5 5571.7 23602.0 27361.7 27387.9 27440.3 27500.2 2170.6 2239.2 2242.2 2247.4 2247.9 17486.7 17645.9 18078.0 18186.5 18402.4 2071.5 2076.6 2127.2 2129.2 2140.9 148198.0 154928.0 157135.0 158742.0 159971.4 11805.2 12003.8 12404.6 12440.9 12477.8 14141.4 15905.7 16173.8 16177.4 16188.4 8686.6 8741.8 8871.6 8912.3 8922.8 8303.5 8403.7 8447.0 8479.6 8539.4 7763.5 7826.7 7894.6 7905.4 7918.7 2129.8 2144.3 2144.7 2152.0 2317.8 913.1 913.8 930.0 951.7 972.8 17483.4 18100.1 19481.9 20138.0 20181.6 836.9 866.3 953.4 974.7 983.0 9728.8 10342.7 10376.2 10796.2 11907.5 652428.7 665254.0 666656.0 675959.0 679035.0 136248.0 139397.5 140827.0 142569.0 144425.0 1216.5 1219.2 1246.5 1250.9 1256.7 20289.2 20465.5 20820.8 21547.7 21626.0 51392.5 61393.7 62336.8 62382.7 62811.7 87755.1 90943.0 91765.5 92167.5 92445.5 8569.3 8640.0 8866.1 8947.2 9169.2 13601.3 13701.0 13843.9 13956.0 14061.0 10179.7 11029.3 11642.8 11685.3 11812.1 9770.8 10890.9 11160.9 11447.7 11451.7 11776.5 11909.4 12235.8 12383.0 12417.5 8159.9 8353.3 8915.0 8925.5 8991.7 10050.9 11638.5 11673.2 11962.3 11985.4 13:18:23 INFO - PID 1632 | 13:18:23 INFO - PID 1632 | [#3] mootools.html Cycles:180 Average:6706.73 Median:2744.02 stddev:4204.36 (153.2%) stddev-sans-first:4196.05 13:18:23 INFO - PID 1632 | Values: 1235.0 1396.5 1411.4 1414.4 1436.6 10767.2 11023.2 11117.4 11227.0 11428.6 11066.2 11086.3 11239.3 11268.5 11270.0 2437.6 2447.2 2463.5 2464.8 2465.7 2386.2 2393.5 2410.7 2426.4 2432.8 2365.3 2396.5 2409.5 2457.0 2459.0 1963.5 2403.2 2421.3 2431.9 2436.1 2029.6 2122.1 2349.6 2417.3 2433.2 10865.7 11085.9 11158.9 11170.3 11179.4 5322.5 6412.9 6420.5 6425.2 6434.2 3475.9 3712.2 4055.0 4104.3 4149.2 982.0 1214.9 1252.7 1272.4 1276.8 12667.7 14582.9 14982.6 15111.2 15191.6 5160.2 5289.7 5335.7 5431.1 5443.4 11441.1 11453.9 11508.4 11546.7 11599.4 5202.4 6223.4 6244.8 6277.0 6344.9 5689.4 5758.7 5783.2 5822.5 5907.3 3628.6 4273.7 4299.0 4333.0 4334.4 1265.0 1266.4 1274.5 1281.7 1282.6 746.0 747.8 771.5 777.4 778.1 5965.6 6236.1 6258.7 6314.8 6352.9 563.7 564.6 567.1 571.7 585.1 3022.4 3049.4 3172.5 3606.2 3791.9 13506.3 14099.6 14231.6 14273.0 14285.3 13524.1 14138.2 14178.3 14197.4 14206.9 9656.6 10107.2 10305.6 10369.4 10385.8 5281.6 6049.6 6280.0 6455.1 6480.3 10580.8 12231.6 12622.7 12689.1 12869.2 10711.9 11072.8 12693.8 12811.7 13039.8 8220.5 8299.3 8354.9 8372.9 8393.0 9328.4 9423.8 10157.5 10172.4 10266.2 8488.2 8617.7 8712.4 8771.3 8900.0 8464.2 8531.3 8562.7 8574.3 8578.5 7826.1 7847.5 7926.9 7927.7 7950.3 5811.6 5858.3 5900.2 5999.4 6067.6 5853.8 5904.9 5988.0 6147.5 6213.6 13:18:23 INFO - PID 1632 | 13:18:23 INFO - PID 1632 | [#4] prototype.html Cycles:180 Average:5274.33 Median:6190.98 stddev:1727.74 (27.9%) stddev-sans-first:1691.51 13:18:23 INFO - PID 1632 | Values: 284.5 356.7 379.6 396.4 403.5 5985.6 6184.8 6207.7 6247.8 6263.5 4365.4 5249.5 6115.2 6122.1 6128.7 4437.0 4446.6 4464.8 4482.2 4489.2 3699.9 4287.7 4451.5 4453.3 4490.7 3656.9 4153.1 4390.6 4404.8 4406.2 3429.3 3665.8 4393.8 4422.9 4424.4 3319.3 3687.2 3733.8 3816.8 3851.3 4929.0 5022.9 5570.9 5905.4 5974.7 4379.9 4811.3 5252.5 5254.3 5255.4 6261.4 6464.5 6485.9 6514.8 6540.6 3785.9 3796.9 4304.7 4345.6 4352.5 6630.5 6750.5 6808.6 6918.4 6967.3 4348.9 4353.6 4357.7 4386.0 4401.3 3757.3 4458.3 4460.7 4464.0 4497.4 5087.5 5214.8 5247.3 5287.6 5289.7 6579.1 6587.3 6593.2 6599.1 6629.5 1406.6 1508.4 1518.6 1518.9 1524.0 902.8 944.7 1002.3 1003.3 1016.7 6177.2 6197.2 6232.4 6238.2 6272.8 6417.3 6731.2 6743.8 6772.5 6821.2 6235.0 6272.1 6302.4 6313.5 6363.3 2658.0 3248.6 3560.8 3570.2 3597.8 6483.5 6710.6 6958.7 7015.4 7036.3 6875.4 6959.8 7010.5 7042.0 7068.6 6639.7 6898.2 6915.7 6953.4 7155.5 6656.3 6827.8 6853.2 6866.5 6882.2 5280.9 6551.4 6576.7 6670.3 6769.8 6232.4 7039.6 7062.9 7064.3 7088.3 4132.1 4202.0 4396.3 4398.0 4398.0 6533.6 6566.8 6688.7 6867.5 7036.7 5165.0 5934.4 5974.6 6129.9 6614.7 6386.4 6530.8 6593.3 6617.4 6618.8 6387.3 6416.2 6416.6 6430.7 6442.6 6215.3 6580.4 6583.1 6602.5 6615.2 6223.7 6336.4 6357.2 6357.9 6376.2 13:18:23 INFO - PID 1632 | 13:18:23 INFO - PID 1632 | [#5] yui.html Cycles:180 Average:18942.53 Median:24618.13 stddev:26024.83 (105.7%) stddev-sans-first:26062.11 13:18:23 INFO - PID 1632 | Values: 781.9 819.2 832.7 842.0 842.7 15430.8 15469.5 16003.8 16165.8 16242.8 14517.2 14887.6 14935.3 15083.9 15144.9 970.0 1001.5 1001.7 1002.9 1006.6 962.3 991.6 1003.3 1005.3 1007.5 1065.2 1069.5 1080.7 1080.7 1083.7 1058.0 1068.9 1071.5 1075.5 1076.7 783.4 793.0 799.9 800.4 803.4 13789.6 13811.3 15963.6 16104.4 16575.8 14570.7 14900.0 14911.3 15063.4 15690.5 13119.5 13310.3 13475.5 13583.6 13610.7 3332.6 3371.5 3392.3 3404.4 3471.4 79319.2 87881.0 97877.0 103167.5 103736.0 11210.8 11331.0 11482.0 11885.3 12069.8 24428.0 24584.8 24651.5 24730.8 24758.1 6732.3 7763.0 8210.4 8283.0 8317.4 4170.1 4193.5 4201.5 4258.5 4321.4 3641.8 4022.9 4072.5 4169.2 4172.6 899.7 915.1 919.3 919.7 920.9 544.5 615.8 618.3 624.5 642.7 9668.8 10006.4 10038.6 10182.5 10193.9 528.7 571.6 634.6 655.9 670.0 4221.9 4404.9 4674.2 4738.4 4820.2 94430.0 94803.0 96665.0 97783.5 99237.0 65128.0 76276.9 81009.2 86197.6 89021.6 70810.0 71167.6 71904.3 74524.0 76446.5 8274.4 10903.9 10964.7 11089.8 11096.5 34318.5 34549.8 36146.8 37676.0 40254.6 39826.6 50613.0 50789.7 50922.0 50924.7 13292.6 13448.0 13566.5 13651.2 14047.3 14297.3 14342.0 14437.9 14478.9 14782.1 13442.5 13673.8 13923.7 14055.9 14498.9 12886.2 13463.7 13480.9 13813.3 14165.0 12997.8 13788.5 13809.1 13810.0 13823.2 8164.0 9759.5 9876.1 10027.5 10048.0 11041.2 11087.9 11492.4 11497.4 11539.4 13:18:23 INFO - PID 1632 | -------- Summary: end -------- 13:18:23 INFO - PID 1632 | 13:18:24 INFO - TEST-INFO | 1632: exit 0 13:18:24 INFO - TEST-OK | dromaeo_css | took 1117652ms 13:18:24 INFO - TEST-START | kraken 13:18:24 INFO - operating with platform_type : mac_ 13:18:24 INFO - Initialising browser for kraken test... 13:18:24 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpdjZKk_/profile http://localhost:49243/getInfo.html) 13:18:27 INFO - PID 1646 | 2017-04-04 13:18:27.307 plugin-container[1647:10008] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 13:18:27 INFO - PID 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:18:27 INFO - PID 1646 | 2017-04-04 13:18:27.310 plugin-container[1647:10008] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d0f, name = 'com.apple.CFPasteboardClient' 13:18:27 INFO - PID 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:18:27 INFO - PID 1646 | 2017-04-04 13:18:27.310 plugin-container[1647:10008] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:18:27 INFO - PID 1646 | __metrics Screen width/height:1600/1200 13:18:27 INFO - PID 1646 | colorDepth:24 13:18:27 INFO - PID 1646 | Browser inner width/height: 1024/689 13:18:27 INFO - PID 1646 | __metrics 13:18:27 ERROR - PID 1646 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3362: TypeError: this.tabs is undefined 13:18:28 INFO - TEST-INFO | 1646: exit 0 13:18:28 INFO - Browser initialized. 13:18:28 INFO - Running cycle 1/1 for kraken test... 13:18:28 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/T/tmpdjZKk_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:18:31 INFO - PID 1648 | 2017-04-04 13:18:31.131 plugin-container[1649:10129] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8d47, name = 'com.apple.tsm.portname' 13:18:31 INFO - PID 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:18:31 INFO - PID 1648 | 2017-04-04 13:18:31.131 plugin-container[1649:10129] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x451b, name = 'com.apple.CFPasteboardClient' 13:18:31 INFO - PID 1648 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:18:31 INFO - PID 1648 | 2017-04-04 13:18:31.131 plugin-container[1649:10129] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:18:40 INFO - PID 1648 | RSS: Main: 234184704 13:18:40 INFO - PID 1648 | 13:18:43 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 13:18:44 INFO - PID 1648 | RSS: Main: 248352768 13:18:44 INFO - PID 1648 | 13:18:47 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 13:18:48 INFO - PID 1648 | RSS: Main: 256851968 13:18:48 INFO - PID 1648 | 13:18:51 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 13:18:52 INFO - PID 1648 | RSS: Main: 259207168 13:18:52 INFO - PID 1648 | 13:18:54 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 13:18:55 INFO - PID 1648 | RSS: Main: 261156864 13:18:55 INFO - PID 1648 | 13:18:57 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:18:57 INFO - PID 1648 | RSS: Main: 261869568 13:18:57 INFO - PID 1648 | 13:19:00 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 13:19:01 INFO - PID 1648 | RSS: Main: 266715136 13:19:01 INFO - PID 1648 | 13:19:04 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 13:19:05 INFO - PID 1648 | RSS: Main: 267976704 13:19:05 INFO - PID 1648 | 13:19:08 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 13:19:09 INFO - PID 1648 | RSS: Main: 268025856 13:19:09 INFO - PID 1648 | 13:19:10 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:19:11 INFO - PID 1648 | RSS: Main: 267718656 13:19:11 INFO - PID 1648 | 13:19:13 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:19:14 INFO - PID 1648 | RSS: Main: 267739136 13:19:14 INFO - PID 1648 | 13:19:16 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:19:16 INFO - PID 1648 | RSS: Main: 267554816 13:19:16 INFO - PID 1648 | 13:19:19 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:19:20 INFO - PID 1648 | RSS: Main: 268058624 13:19:20 INFO - PID 1648 | 13:19:24 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:19:24 INFO - PID 1648 | RSS: Main: 265707520 13:19:24 INFO - PID 1648 | 13:19:26 INFO - PID 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 13:19:26 INFO - PID 1648 | RSS: Main: 268636160 13:19:26 INFO - PID 1648 | 13:19:26 INFO - PID 1648 | __start_tp_report 13:19:26 INFO - PID 1648 | _x_x_mozilla_page_load 13:19:26 INFO - PID 1648 | _x_x_mozilla_page_load_details 13:19:26 INFO - PID 1648 | |i|pagename|runs| 13:19:26 INFO - PID 1648 | |0;ai-astar;111;123;123;125;142;182;158;122;126;123 13:19:26 INFO - PID 1648 | |1;audio-beat-detection;153;119;116;160;136;147;118;144;152;145 13:19:26 INFO - PID 1648 | |2;audio-dft;221;230;217;235;248;211;213;209;211;224 13:19:26 INFO - PID 1648 | |3;audio-fft;85;49;75;105;88;86;87;85;78;63 13:19:26 INFO - PID 1648 | |4;audio-oscillator;83;71;89;73;71;73;84;71;74;86 13:19:26 INFO - PID 1648 | |5;imaging-gaussian-blur;92;94;93;93;92;93;94;87;139;87 13:19:26 INFO - PID 1648 | |6;imaging-darkroom;127;141;158;101;102;102;104;102;102;102 13:19:26 INFO - PID 1648 | |7;imaging-desaturate;155;101;101;101;98;159;158;102;103;103 13:19:26 INFO - PID 1648 | |8;json-parse-financial;51;52;54;54;79;42;45;73;78;54 13:19:26 INFO - PID 1648 | |9;json-stringify-tinderbox;60;66;62;65;66;65;62;61;60;62 13:19:26 INFO - PID 1648 | |10;stanford-crypto-aes;107;87;85;87;90;86;89;88;87;92 13:19:26 INFO - PID 1648 | |11;stanford-crypto-ccm;166;167;160;161;160;168;144;136;220;177 13:19:26 INFO - PID 1648 | |12;stanford-crypto-pbkdf2;198;197;198;208;198;193;199;198;198;197 13:19:26 INFO - PID 1648 | |13;stanford-crypto-sha256-iterative;79;85;71;71;71;77;78;72;72;69 13:19:26 INFO - PID 1648 | __end_tp_report 13:19:26 INFO - PID 1648 | __start_cc_report 13:19:26 INFO - PID 1648 | _x_x_mozilla_cycle_collect,990 13:19:26 INFO - PID 1648 | __end_cc_report 13:19:26 INFO - PID 1648 | __startTimestamp1491337166717__endTimestamp 13:19:26 INFO - PID 1648 | 13:19:26 INFO - PID 1648 | ------- Summary: start ------- 13:19:26 INFO - PID 1648 | Number of tests: 14 13:19:26 INFO - PID 1648 | 13:19:26 INFO - PID 1648 | [#0] ai-astar Cycles:10 Average:133.50 Median:125.50 stddev:21.40 (17.1%) stddev-sans-first:21.10 13:19:26 INFO - PID 1648 | Values: 111.0 123.0 123.0 125.0 142.0 182.0 158.0 122.0 126.0 123.0 13:19:26 INFO - PID 1648 | 13:19:26 INFO - PID 1648 | [#1] audio-beat-detection Cycles:10 Average:139.00 Median:146.00 stddev:16.02 (11.0%) stddev-sans-first:16.17 13:19:26 INFO - PID 1648 | Values: 153.0 119.0 116.0 160.0 136.0 147.0 118.0 144.0 152.0 145.0 13:19:26 INFO - PID 1648 | 13:19:26 INFO - PID 1648 | [#2] audio-dft Cycles:10 Average:221.90 Median:222.50 stddev:12.61 (5.7%) stddev-sans-first:13.37 13:19:26 INFO - PID 1648 | Values: 221.0 230.0 217.0 235.0 248.0 211.0 213.0 209.0 211.0 224.0 13:19:26 INFO - PID 1648 | 13:19:26 INFO - PID 1648 | [#3] audio-fft Cycles:10 Average:80.10 Median:85.00 stddev:15.29 (18.0%) stddev-sans-first:16.11 13:19:26 INFO - PID 1648 | Values: 85.0 49.0 75.0 105.0 88.0 86.0 87.0 85.0 78.0 63.0 13:19:26 INFO - PID 1648 | 13:19:26 INFO - PID 1648 | [#4] audio-oscillator Cycles:10 Average:77.50 Median:78.50 stddev:7.12 (9.1%) stddev-sans-first:7.27 13:19:26 INFO - PID 1648 | Values: 83.0 71.0 89.0 73.0 71.0 73.0 84.0 71.0 74.0 86.0 13:19:26 INFO - PID 1648 | 13:19:26 INFO - PID 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:96.40 Median:93.00 stddev:15.19 (16.3%) stddev-sans-first:16.03 13:19:26 INFO - PID 1648 | Values: 92.0 94.0 93.0 93.0 92.0 93.0 94.0 87.0 139.0 87.0 13:19:26 INFO - PID 1648 | 13:19:26 INFO - PID 1648 | [#6] imaging-darkroom Cycles:10 Average:114.10 Median:103.00 stddev:20.61 (20.0%) stddev-sans-first:21.32 13:19:26 INFO - PID 1648 | Values: 127.0 141.0 158.0 101.0 102.0 102.0 104.0 102.0 102.0 102.0 13:19:26 INFO - PID 1648 | 13:19:26 INFO - PID 1648 | [#7] imaging-desaturate Cycles:10 Average:118.10 Median:129.00 stddev:27.13 (21.0%) stddev-sans-first:25.27 13:19:26 INFO - PID 1648 | Values: 155.0 101.0 101.0 101.0 98.0 159.0 158.0 102.0 103.0 103.0 13:19:26 INFO - PID 1648 | 13:19:26 INFO - PID 1648 | [#8] json-parse-financial Cycles:10 Average:58.20 Median:54.00 stddev:13.43 (24.9%) stddev-sans-first:13.99 13:19:26 INFO - PID 1648 | Values: 51.0 52.0 54.0 54.0 79.0 42.0 45.0 73.0 78.0 54.0 13:19:26 INFO - PID 1648 | 13:19:26 INFO - PID 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:62.90 Median:63.50 stddev:2.38 (3.7%) stddev-sans-first:2.28 13:19:26 INFO - PID 1648 | Values: 60.0 66.0 62.0 65.0 66.0 65.0 62.0 61.0 60.0 62.0 13:19:26 INFO - PID 1648 | 13:19:26 INFO - PID 1648 | [#10] stanford-crypto-aes Cycles:10 Average:89.80 Median:87.50 stddev:6.37 (7.3%) stddev-sans-first:2.15 13:19:26 INFO - PID 1648 | Values: 107.0 87.0 85.0 87.0 90.0 86.0 89.0 88.0 87.0 92.0 13:19:26 INFO - PID 1648 | 13:19:26 INFO - PID 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:165.90 Median:166.50 stddev:22.42 (13.5%) stddev-sans-first:23.78 13:19:26 INFO - PID 1648 | Values: 166.0 167.0 160.0 161.0 160.0 168.0 144.0 136.0 220.0 177.0 13:19:26 INFO - PID 1648 | 13:19:26 INFO - PID 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.40 Median:198.00 stddev:3.75 (1.9%) stddev-sans-first:3.97 13:19:26 INFO - PID 1648 | Values: 198.0 197.0 198.0 208.0 198.0 193.0 199.0 198.0 198.0 197.0 13:19:26 INFO - PID 1648 | 13:19:26 INFO - PID 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.50 Median:74.50 stddev:5.04 (6.8%) stddev-sans-first:5.07 13:19:26 INFO - PID 1648 | Values: 79.0 85.0 71.0 71.0 71.0 77.0 78.0 72.0 72.0 69.0 13:19:26 INFO - PID 1648 | -------- Summary: end -------- 13:19:26 INFO - PID 1648 | 13:19:27 INFO - TEST-INFO | 1648: exit 0 13:19:27 INFO - TEST-OK | kraken | took 63494ms 13:19:27 INFO - SUITE-END | took 1181s 13:19:27 INFO - Completed test suite (00:19:41) 13:19:27 INFO - javascript benchmark 13:19:27 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7713.567336318986, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2939.4708952388573, 3421.794692318461, 3488.9651103488964, 3519.87680431185, 3555.093451169951, 6133.181650350766, 6215.12988181655, 6227.28386235583, 6248.468880145182, 6259.843503912399, 6106.794380079887, 6142.56016630686, 6230.065490176476, 6266.811995640138, 6273.874522509547, 5442.210879422481, 5486.204500347447, 5514.338279406456, 5554.750036248379, 5587.245721827542, 5385.380681221651, 5468.863278418052, 5572.359178694442, 5583.3300003999575, 5633.774649014034, 5413.890152518724, 5460.153676180198, 5485.945140548583, 5493.945060549403, 5513.228148059275, 4640.443146822369, 5364.383095943977, 5452.754626041838, 5490.862728431781, 5499.752511137009, 5389.110796718537, 5402.216678581583, 5407.324084489439, 5424.728763561806, 5484.91772623411, 6068.908966365508, 6080.635161890301, 6134.926457743771, 6136.3352719466575, 6192.535559833031, 5549.223108764776, 6694.59832410057, 6710.966445167743, 6712.731490740364, 6721.1598550181225, 6713.530052896251, 6790.5925644461495, 6792.0, 6794.932050679528, 6795.592264464148, 6123.142760013601, 6203.441690247809, 6390.360963903572, 6391.265004524446, 6395.808125756234, 6881.65591720412, 6938.965305173442, 6955.7217711292, 6960.79117626472, 6992.300769922967, 5360.16917377807, 5552.555795536347, 5705.5150312223095, 6260.655663938527, 6396.392342727433, 6678.7328506859185, 6695.598264104072, 6776.356246156607, 6806.7957961261245, 6812.93187068123, 6378.840528986812, 6464.612123272619, 6669.599824010575, 6681.265060843303, 6689.0, 5102.821401250939, 5807.390224026501, 6500.674966251669, 6624.701888415033, 6732.0, 5363.490468405495, 5367.5169234769055, 5378.97310513445, 5383.2194331821665, 5383.892322153535, 4057.5536690963972, 4656.348111264426, 4722.268048452426, 4744.596709279681, 4767.213409787416, 6183.598066125687, 6364.363563643598, 6368.84077898047, 6404.5516813823515, 6405.327440618668, 6825.249222585511, 6859.7256109756045, 6871.828204294832, 6872.518923675295, 6888.242293347727, 6354.714037868307, 6365.713542890581, 6422.935770642327, 6427.935720642828, 6439.839004024843, 5769.8557536061935, 5851.063829787298, 5854.502367298827, 5855.736491857877, 5936.643801371932, 6947.305269473113, 6998.790036298919, 7010.789676309719, 7023.789286321418, 7030.543014704028, 6764.526483146329, 6806.047153398429, 6806.353396427331, 6808.489363297674, 6849.0, 6684.933150668626, 6821.761238356634, 6930.168379794457, 6991.405730512964, 7019.122609673791, 6596.0, 6604.438622716931, 6659.467242620675, 6679.265280819009, 6692.732290708317, 6413.518986076157, 6678.866422671616, 6805.0, 6811.0, 6817.625030623363, 6347.460465860454, 6388.329225431448, 6398.232212134573, 6445.355464453517, 6520.0, 6434.099226108255, 6483.805485835433, 6526.543141980016, 6538.313477084837, 6538.607683539003, 6282.623042617458, 6293.307736149111, 6316.210473690789, 6360.840978975562, 6378.77674281398, 6424.261209960914, 6500.739970401131, 6510.934890651222, 6515.967420163059, 6530.0, 6382.0, 6389.648569328546, 6404.455621272244, 6408.743650253938, 6416.390442907917], "value": 6085.510010328711, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [801.6633014134063, 1260.7982722764355, 1283.6983308922408, 1284.755896379688, 1285.7042880137562, 38321.42517862231, 39229.0, 39248.0, 39305.820825375245, 39439.40840887385, 38681.80659096708, 39069.41395879064, 39158.608413915856, 39186.60813391865, 39218.411723824094, 7464.730995730739, 8829.23415316936, 8889.244414224766, 8899.243564297043, 8934.687285944994, 8831.470111793313, 8894.332925030616, 8939.776505587348, 8948.194662480375, 8967.95516022419, 8875.556222188865, 8906.287497000225, 8927.419717718327, 8960.10398960102, 8972.327075469333, 8904.554772261394, 8931.955340223321, 8938.821223575493, 8944.463332200025, 8946.239569636622, 8683.305335573139, 8683.696070637498, 8705.869411958825, 8750.737477875675, 8754.606042728092, 38743.61256387428, 39025.41461878074, 39029.0, 39032.80483597592, 39160.60839391598, 3452.1197094740933, 3477.078574177845, 3485.7559970802054, 3491.7555771096036, 3501.7723847950056, 30998.0, 31206.687933120604, 31275.84362078175, 31306.37387252242, 31369.74521019179, 3108.9689103108904, 3126.4059828632485, 3137.545055966895, 3168.1604374840686, 3170.508571171472, 270148.999999998, 285194.0, 286614.0, 287048.0, 287301.5634921812, 40766.388504172464, 48289.0, 49345.259821102714, 49365.75317123463, 49371.75314123406, 51943.48056519462, 52124.0, 52290.738546307024, 52324.476755232725, 52380.95238095217, 14304.356303966346, 14330.355134018993, 14447.349869255699, 14450.710985780226, 14470.421183152555, 11478.655640330804, 11663.533458661559, 11700.414979251003, 11734.647960561197, 11736.765264694659, 13952.790708139386, 14069.226192559507, 14075.507357242652, 14118.85881141196, 14224.715505690036, 6056.3338032816355, 6091.390860913962, 6121.84695382619, 6122.7244773984385, 6126.693665316717, 864.8659457784054, 975.1175186456269, 995.9800803983879, 1007.8236308645958, 1042.61944390297, 24110.87944560266, 24213.0, 24373.02507899664, 24389.14637987662, 24481.877590611934, 1083.2363183955292, 1084.1868598551087, 1093.5407129005837, 1116.7431490757172, 1138.2942575603013, 9558.761030974143, 12294.262344259372, 12487.188332758524, 12628.368581570885, 12632.873671263169, 417739.0, 421757.0, 422794.0, 423529.8823105935, 425227.0, 54909.70541767507, 55142.44857551373, 55233.0, 55279.44720552823, 55305.723471382385, 1494.7757836324638, 1499.0780669888159, 1530.3648985671045, 1530.456687875788, 1545.0189129902592, 20414.489637759176, 23900.73102750498, 24018.87990560036, 24303.0, 24303.878480607484, 39746.0, 39885.202295953335, 39942.400863986484, 40221.79889100536, 40224.798876005436, 398198.0, 398486.0, 399766.0, 400168.0, 400845.0, 34036.659633403346, 34095.82952085323, 34708.958731238105, 34745.65254347424, 34851.47722784211, 43631.78184109059, 43831.34252986272, 44178.337324940796, 44193.55806441895, 44640.77679611581, 29886.701132988394, 29959.400811983203, 30158.095257142322, 30713.539296910116, 30781.69218307878, 29876.103716888527, 30792.692073079877, 30906.0728178155, 30982.845085775327, 31160.844195779784, 36027.81986090053, 36390.63609363873, 36508.45237321389, 36735.89792306235, 36856.44715329326, 29460.852695736383, 30021.5496767553, 31186.844065779525, 31254.687453125178, 31628.367432651678, 21471.141154353652, 21703.0, 24084.0, 24642.753572464764, 24850.37874053091], "value": 18129.199798229332, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.5124164207351, 418.6378782353265, 421.83126749300277, 435.7886425083835, 449.2744218087787, 17997.64004719905, 20266.493337666565, 21317.93410329481, 21997.450063748413, 22447.663285050738, 19237.038148092608, 22736.88631556844, 22793.886030569825, 23340.64989025166, 23483.0, 6089.299730530979, 6351.2060992375955, 6355.713992870309, 6358.141650877142, 6370.171877655898, 6025.427584379477, 6189.659568723719, 6192.380761923817, 6255.030470277115, 6263.749450021994, 6190.876182476371, 6198.659073750942, 6220.315765265817, 6224.284207316148, 6230.906536401958, 5948.583599148062, 6197.81406557804, 6260.686965651699, 6274.184356033709, 6274.403931626488, 5311.336082989626, 5518.641288316287, 5518.91721624176, 5553.500184983331, 5571.66570005801, 23602.0, 27361.726382736117, 27387.86306068477, 27440.313992150157, 27500.17499475019, 2170.6418440957223, 2239.2386588559966, 2242.2264318809985, 2247.449374903159, 2247.910083596654, 17486.737698934397, 17645.911770441195, 18078.01141874393, 18186.545336366566, 18402.447926562225, 2071.4510654676524, 2076.6158260721813, 2127.1704035426196, 2129.2441183379988, 2140.9464763380884, 148198.0, 154928.0, 157135.0, 158742.0, 159971.40028599682, 11805.23265987708, 12003.819942700866, 12404.56584019573, 12440.875591244152, 12477.812832807514, 14141.363638636287, 15905.68188636244, 16173.757393639105, 16177.4337898173, 16188.433404830774, 8686.565671716515, 8741.781455463664, 8871.645134194689, 8912.287017038621, 8922.821543569093, 8303.4602750821, 8403.663853445916, 8447.0, 8479.618417171243, 8539.402241843012, 7763.4953728007495, 7826.726064587712, 7894.565798881002, 7905.407094467938, 7918.683252669829, 2129.8285942731436, 2144.324537770597, 2144.731908511436, 2151.978480215209, 2317.768223177669, 913.1097180249336, 913.8081002989313, 929.9581518831669, 951.6764300137986, 972.7908499672604, 17483.388081417088, 18100.094995250183, 19481.902590486956, 20138.0, 20181.596368072558, 836.8828364029041, 866.276658989738, 953.4279432340679, 974.7270764186039, 982.9950850245702, 9728.805423891483, 10342.689719308433, 10376.16990640762, 10796.190285728602, 11907.52369905194, 652428.7378563076, 665254.0, 666656.0, 675959.0, 679035.0, 136248.0, 139397.45422911784, 140827.0, 142569.0, 144425.0, 1216.5012344938532, 1219.2379762648345, 1246.5450110709708, 1250.8686587908321, 1256.6732649511193, 20289.188432462535, 20465.48836279105, 20820.75075495475, 21547.676784847925, 21626.0, 51392.48607513877, 61393.69303153456, 62336.75326493535, 62382.688086559276, 62811.68594157, 87755.1224487747, 90943.0, 91765.54117229371, 92167.53916230376, 92445.53777231071, 8569.314454843723, 8639.95680021596, 8866.113388661082, 8947.239484643878, 9169.220616247694, 13601.319934003459, 13701.0, 13843.861561384258, 13956.0, 14061.0, 10179.694609161737, 11029.338239705323, 11642.76714465723, 11685.298882066763, 11812.114091443003, 9770.75573110678, 10890.945545272223, 11160.888391115985, 11447.713807154887, 11451.713707157387, 11776.470058847544, 11909.40452977365, 12235.816462752888, 12383.0, 12417.503299867903, 8159.8576199330955, 8353.33173346143, 8914.955425222832, 8925.464472131693, 8991.730248092568, 10050.949745251228, 11638.476268567765, 11673.182877198515, 11962.282263064244, 11985.400729963641], "value": 10505.691137973881, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1235.0, 1396.5461225101837, 1411.4495346814745, 1414.3564678071477, 1436.5618486361661, 10767.24629275951, 11023.228374013823, 11117.444127793608, 11227.045701115405, 11428.599999000036, 11066.170037247219, 11086.279391839525, 11239.269447485927, 11268.492917818718, 11269.985701286903, 2437.6465412515176, 2447.155731272708, 2463.4580392313665, 2464.7904928081134, 2465.6671349367784, 2386.2483317754936, 2393.453666461924, 2410.674558934548, 2426.3934016495878, 2432.8297019208662, 2365.302235840423, 2396.4967356854995, 2409.5060512594964, 2456.987715061422, 2459.0409740201335, 1963.5091227193202, 2403.158894386959, 2421.3462365161395, 2431.927042188728, 2436.062116085302, 2029.5839352932614, 2122.1299267300333, 2349.6240601503678, 2417.311066346083, 2433.1848830641757, 10865.728356791064, 11085.944570277097, 11158.944205279004, 11170.329780213133, 11179.44102794857, 5322.547583455411, 6412.903806442907, 6420.454261387741, 6425.22897252328, 6434.163558737381, 3475.8609655613745, 3712.1833196696684, 4054.979725101385, 4104.261232978063, 4149.211649786531, 982.0326977926736, 1214.908881833857, 1252.7431876465394, 1272.4019710736031, 1276.7893297605883, 12667.746645067047, 14582.927085364612, 14982.550523484313, 15111.168885711282, 15191.62020949474, 5160.174372100446, 5289.735513224324, 5335.679859208382, 5431.131019037014, 5443.42844001382, 11441.084713222923, 11453.942730286295, 11508.36703981289, 11546.653600392001, 11599.362035088152, 5202.4277329493725, 6223.37766223374, 6244.781432649836, 6276.968615156895, 6344.936550634435, 5689.374168841424, 5758.712064396764, 5783.2192653992015, 5822.505087067647, 5907.291125064934, 3628.618995005539, 4273.67947403946, 4298.957010429918, 4332.978335108367, 4334.41485399467, 1264.968375790594, 1266.3541593787052, 1274.4774642396574, 1281.6603600045996, 1282.6152154353842, 745.9627018649046, 747.7607165706921, 771.4946709905021, 777.3547955197173, 778.1284960843891, 5965.55258355625, 6236.095766113979, 6258.74965001404, 6314.8421289467215, 6352.936470635327, 563.7096895099028, 564.5963136357442, 567.1322875999728, 571.7084287013653, 585.1486087742325, 3022.3653032862903, 3049.359634476785, 3172.460681684119, 3606.206634540397, 3791.9241615168094, 13506.324683765772, 14099.647508812157, 14231.64420889486, 14273.0, 14285.285735713172, 13524.12093213938, 14138.151710897379, 14178.291085445893, 14197.36111874968, 14206.934479914047, 9656.613735450645, 10107.241956853266, 10305.639302624371, 10369.429681367446, 10385.792284154275, 5281.55106815925, 6049.576529643059, 6280.026595877646, 6455.096286519797, 6480.287168411565, 10580.788384232426, 12231.633051008484, 12622.684432888884, 12689.111762176559, 12869.22784632925, 10711.94644026775, 11072.833907491233, 12693.80959285593, 12811.679708007374, 13039.804402933774, 8220.506769593843, 8299.253067223979, 8354.87467687973, 8372.87440688378, 8393.034800997719, 9328.440293582407, 9423.764405889908, 10157.54291056919, 10172.440515771703, 10266.178705703376, 8488.193621605938, 8617.741467755977, 8712.433691810265, 8771.298296136167, 8900.020997690119, 8464.153584641486, 8531.274841638531, 8562.657493700182, 8574.27118694918, 8578.528180950108, 7826.139124696393, 7847.489913155627, 7926.920730792618, 7927.652299109281, 7950.324222441157, 5811.593188476766, 5858.297004359504, 5900.203472531153, 5999.370066143167, 6067.605605635619, 5853.795117170878, 5904.881902361843, 5987.970060149845, 6147.538934579835, 6213.565050446426], "value": 5041.417876848284, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [284.4581073055829, 356.69324381032294, 379.5938345969812, 396.3836234655111, 403.46943768943845, 5985.551083668721, 6184.783532576355, 6207.658578778165, 6247.812565623033, 6263.467605253559, 4365.410669559608, 5249.527542521172, 6115.235595550556, 6122.1428999939935, 6128.662923539204, 4436.979494716217, 4446.577575130374, 4464.799084041218, 4482.238019536687, 4489.236829738952, 3699.889003329891, 4287.678424118204, 4451.5103338632725, 4453.28747400416, 4490.730556166641, 3656.8902932912056, 4153.11033479766, 4390.560943905616, 4404.801783919731, 4406.184855801687, 3429.3141371725505, 3665.7617254878346, 4393.802278897441, 4422.933655995179, 4424.358468022151, 3319.319539494422, 3687.1703866630064, 3733.775973441602, 3816.790076545789, 3851.287511810324, 4928.950710492885, 5022.89954200914, 5570.888582228333, 5905.379935106838, 5974.6713930733795, 4379.912401751947, 4811.278308253755, 5252.474752524755, 5254.264402983586, 5255.448177941299, 6261.436470717612, 6464.450521705614, 6485.93514064858, 6514.7621951829, 6540.574862633961, 3785.905352366213, 3796.8860934171744, 4304.720193187432, 4345.630621397185, 4352.521222665504, 6630.535862489628, 6750.493712971498, 6808.5914845109455, 6918.446524278046, 6967.303269672992, 4348.891277718082, 4353.608175264241, 4357.694961352675, 4385.9692972151515, 4401.273789824707, 3757.323681737259, 4458.331250312479, 4460.687751857339, 4464.027015955802, 4497.437820272466, 5087.481696560227, 5214.765335559909, 5247.344081989751, 5287.576993840484, 5289.735513224324, 6579.111819904348, 6587.341265873471, 6593.241777195684, 6599.1091202687985, 6629.5359324846795, 1406.5709958462767, 1508.3891024135244, 1518.5899807052035, 1518.8860835437386, 1523.9847601523843, 902.8194361127801, 944.6599224279254, 1002.3284399452384, 1003.267614641316, 1016.7356487313352, 6177.227846519185, 6197.17183430889, 6232.376762323822, 6238.189035425366, 6272.773165526264, 6417.326180750954, 6731.225909020427, 6743.831404214836, 6772.492063095287, 6821.21556021054, 6234.9688251558455, 6272.1219029335925, 6302.432781049728, 6313.463355614732, 6363.268224154189, 2657.9601305980427, 3248.642649308574, 3560.839762210707, 3570.1610121621397, 3597.7661452005536, 6483.513736469784, 6710.563813352116, 6958.686859091353, 7015.36861682451, 7036.331548502884, 6875.415589674833, 6959.82600434983, 7010.509264351446, 7042.0, 7068.5758854468895, 6639.668016599151, 6898.206706228848, 6915.715035358266, 6953.443724502028, 7155.534890232014, 6656.267810540739, 6827.829304267234, 6853.211880633791, 6866.4506839453725, 6882.208546017072, 5280.920786188287, 6551.44312733423, 6576.684663067502, 6670.332966703291, 6769.830754231184, 6232.407921247474, 7039.60653377854, 7062.8940565890525, 7064.293570642894, 7088.326608972139, 4132.090939993197, 4201.97899010503, 4396.27461468854, 4397.956020439755, 4398.032432864765, 6533.607983521004, 6566.785144748237, 6688.699008544724, 6867.450603951772, 7036.663034023519, 5164.992826398816, 5934.406559344031, 5974.641521508724, 6129.908051379144, 6614.735410583523, 6386.393292637378, 6530.771423000172, 6593.340665933369, 6617.404433600999, 6618.801435956736, 6387.265464471459, 6416.241016362822, 6416.582922110048, 6430.678466076771, 6442.581232219891, 6215.347388524321, 6580.440662543738, 6583.144191255106, 6602.537822352389, 6615.206175259, 6223.657698826608, 6336.352548337373, 6357.205349331333, 6357.884636528161, 6376.234851817811], "value": 4721.6629078816595, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [781.9491733037356, 819.1726356380057, 832.737687628397, 842.0400743152807, 842.6587232170973, 15430.845691543082, 15469.535913922586, 16003.83996160038, 16165.83834161658, 16242.83757162428, 14517.20155391453, 14887.553373398789, 14935.253237338144, 15083.92458037711, 15144.924275378607, 969.9951500242506, 1001.5042553935812, 1001.7195185348114, 1002.9247806414512, 1006.6476733143414, 962.3456049886074, 991.6281394477071, 1003.3478239144541, 1005.3465247589089, 1007.5214273220236, 1065.1585247654343, 1069.4706120470378, 1080.6703955293633, 1080.7406222506581, 1083.6911480228136, 1057.9682609521687, 1068.8610480637506, 1071.4910417551678, 1075.4622688655672, 1076.7039064257312, 783.4046124945025, 793.0, 799.9200079992013, 800.4436916343144, 803.4375936844233, 13789.586312410644, 13811.309434528233, 15963.600909977227, 16104.436344727877, 16575.83969122162, 14570.708585828224, 14900.0, 14911.254437278092, 15063.397464101423, 15690.529284121381, 13119.540816071487, 13310.334483275894, 13475.528356507573, 13583.592492225249, 13610.659733506642, 3332.583427071616, 3371.544841446422, 3392.2537041850755, 3404.382918113901, 3471.444568868994, 79319.20680793175, 87881.0, 97877.0, 103167.48416257945, 103736.0, 11210.775784484427, 11331.0, 11482.0, 11885.28688278706, 12069.793020698036, 24428.0, 24584.754152458605, 24651.50696986086, 24730.752692473205, 24758.13346532863, 6732.2931092235585, 7763.0, 8210.425270231146, 8283.0, 8317.376196785266, 4170.085380832345, 4193.454850869368, 4201.474815648044, 4258.488981322261, 4321.438213032286, 3641.780003698738, 4022.8591999279884, 4072.470578824734, 4169.228692691861, 4172.624463798273, 899.6986009686829, 915.1443400420628, 919.2783664823082, 919.6689191890914, 920.9171174594319, 544.5045009041753, 615.8244900203421, 618.329112912495, 624.4848000399597, 642.7396904253785, 9668.806623867484, 10006.38302116367, 10038.598456061822, 10182.541785619665, 10193.898061019296, 528.6854321678595, 571.6455797405636, 634.6223996721943, 655.8655475627485, 670.0351493848842, 4221.852235171754, 4404.933925991113, 4674.205385084544, 4738.431388233434, 4820.1805693031565, 94430.0, 94803.0, 96665.033349667, 97783.53324700135, 99237.0, 65128.0, 76276.85584716234, 81009.16467923712, 86197.56901215453, 89021.55489222512, 70810.0, 71167.64416177887, 71904.2809571908, 74524.0, 76446.47107057828, 8274.379421543528, 10903.945480272549, 10964.671059868217, 11089.833652495381, 11096.547409812547, 34318.48522272218, 34549.82725086459, 36146.81926590455, 37676.0, 40254.597454026254, 39826.60173398229, 50613.0, 50789.74605126951, 50922.0, 50924.745376272884, 13292.601221963356, 13448.0, 13566.457341706617, 13651.249181295125, 14047.297635118408, 14297.285135742963, 14342.0, 14437.927810361301, 14478.927605362327, 14782.113073215642, 13442.529511467052, 13673.79489307681, 13923.651908702364, 14055.862017322554, 14498.927505362828, 12886.226826390446, 13463.730725385241, 13480.932595337354, 13813.266206158405, 14165.008449408442, 12997.805032924703, 13788.517401890886, 13809.102408343426, 13810.0, 13823.170609763447, 8164.0, 9759.51202439861, 9876.111149996535, 10027.49862506857, 10047.992648784631, 11041.165124033687, 11087.944560277147, 11492.425378731197, 11497.425128743696, 11539.423028848356], "value": 7633.960010406807, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1630.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 123.0, 123.0, 125.0, 142.0, 182.0, 158.0, 122.0, 126.0, 123.0], "value": 133.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 119.0, 116.0, 160.0, 136.0, 147.0, 118.0, 144.0, 152.0, 145.0], "value": 139.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [221.0, 230.0, 217.0, 235.0, 248.0, 211.0, 213.0, 209.0, 211.0, 224.0], "value": 221.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 49.0, 75.0, 105.0, 88.0, 86.0, 87.0, 85.0, 78.0, 63.0], "value": 80.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 71.0, 89.0, 73.0, 71.0, 73.0, 84.0, 71.0, 74.0, 86.0], "value": 77.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 94.0, 93.0, 93.0, 92.0, 93.0, 94.0, 87.0, 139.0, 87.0], "value": 96.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 141.0, 158.0, 101.0, 102.0, 102.0, 104.0, 102.0, 102.0, 102.0], "value": 114.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 101.0, 101.0, 101.0, 98.0, 159.0, 158.0, 102.0, 103.0, 103.0], "value": 118.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 54.0, 54.0, 79.0, 42.0, 45.0, 73.0, 78.0, 54.0], "value": 58.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 66.0, 62.0, 65.0, 66.0, 65.0, 62.0, 61.0, 60.0, 62.0], "value": 62.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 87.0, 85.0, 87.0, 90.0, 86.0, 89.0, 88.0, 87.0, 92.0], "value": 89.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 160.0, 161.0, 160.0, 168.0, 144.0, 136.0, 220.0, 177.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [198.0, 197.0, 198.0, 208.0, 198.0, 193.0, 199.0, 198.0, 198.0, 197.0], "value": 198.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 85.0, 71.0, 71.0, 71.0, 77.0, 78.0, 72.0, 72.0, 69.0], "value": 74.5, "unit": "score"}]}]} 13:19:27 INFO - Return code: 0 13:19:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:19:28 ERROR - # TBPL SUCCESS # 13:19:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:19:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:19:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:19:28 INFO - 2017-04-04 13:19:28.079 screenresolution[1653:10527] starting screenresolution argv=screenresolution get 13:19:28 INFO - 2017-04-04 13:19:28.082 screenresolution[1653:10527] Display 0: 1600x1200x32@60 13:19:28 INFO - 2017-04-04 13:19:28.088 screenresolution[1654:10530] starting screenresolution argv=screenresolution list 13:19:28 INFO - Available Modes on Display 0 13:19:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:19:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:19:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:19:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:19:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:19:28 INFO - Intel Iris: 13:19:28 INFO - Chipset Model: Intel Iris 13:19:28 INFO - Type: GPU 13:19:28 INFO - Bus: Built-In 13:19:28 INFO - VRAM (Dynamic, Max): 1536 MB 13:19:28 INFO - Vendor: Intel (0x8086) 13:19:28 INFO - Device ID: 0x0a2e 13:19:28 INFO - Revision ID: 0x0009 13:19:28 INFO - Displays: 13:19:28 INFO - Display: 13:19:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:19:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:19:28 INFO - Display Serial Number: 1600x1200 60 13:19:28 INFO - Main Display: Yes 13:19:28 INFO - Mirror: Off 13:19:28 INFO - Online: Yes 13:19:28 INFO - Rotation: Supported 13:19:28 INFO - Return code: 0 13:19:28 INFO - Running post-action listener: _resource_record_post_action 13:19:28 INFO - [mozharness: 2017-04-04 20:19:28.339979Z] Finished run-tests step (success) 13:19:28 INFO - Running post-run listener: _resource_record_post_run 13:19:28 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 40282624; Write bytes: 522637312; Read time: 436; Write time: 2021 13:19:28 INFO - TinderboxPrint: CPU usage
54.4% 13:19:28 INFO - TinderboxPrint: I/O read bytes / time
40,282,624 / 436 13:19:28 INFO - TinderboxPrint: I/O write bytes / time
522,637,312 / 2,021 13:19:28 INFO - TinderboxPrint: CPU idle
2,192.9 (45.6%) 13:19:28 INFO - TinderboxPrint: CPU system
976.0 (20.3%) 13:19:28 INFO - TinderboxPrint: CPU user
1,640.7 (34.1%) 13:19:28 INFO - TinderboxPrint: Swap in / out
247,259,136 / 0 13:19:28 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206373376; Write bytes: 204589056; Read time: 15939; Write time: 426 13:19:28 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 35482112; Write bytes: 310814720; Read time: 399; Write time: 1566 13:19:28 INFO - Running post-run listener: _upload_blobber_files 13:19:28 INFO - Blob upload gear active. 13:19:28 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:19:28 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:19:28 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:19:28 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:19:29 INFO - (blobuploader) - INFO - Open directory for files ... 13:19:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:19:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:19:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:19:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:19:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:19:30 INFO - (blobuploader) - INFO - Done attempting. 13:19:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:19:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:19:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:19:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:19:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:19:31 INFO - (blobuploader) - INFO - Done attempting. 13:19:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:19:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:19:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:19:32 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:19:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:19:32 INFO - (blobuploader) - INFO - Done attempting. 13:19:32 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:19:32 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:19:32 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:19:34 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:19:34 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:19:34 INFO - (blobuploader) - INFO - Done attempting. 13:19:34 INFO - (blobuploader) - INFO - Iteration through files over. 13:19:34 INFO - Return code: 0 13:19:34 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:19:34 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:19:34 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77cdb1fa296cfff02dd594398d32820e553dbf82486b9b0127edaa8c95394ed760c005385da8b5891cf7bcd0a7517348fd14524d1046b5bce088ea04ab97accb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f5cda820298c0c2bf24b33817b7cda6a821d314800c43e3e1f6b56cf2877a5c394fbe57e71d3c86b6ac74cca39a230a8acfd9d616d95ef25f2e3783e2d96121", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17b3e8b5fef642e28e7f8143bda48ee171c2f600479dc55327c028f37949be5ca195b2f26d4892cff54f1c4320f648e74cb03f0ed879950a37ab359179005838", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f28ba7d6fcbfdee36e589e13ff81cf71ffe0506e959adbef92f68d945f95e6fb6e62de3020ec2d62cf4bc6b85fe3e6f54de3a127f2e91eae2ef401072444436"} 13:19:34 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:19:34 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:19:34 INFO - Contents: 13:19:34 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77cdb1fa296cfff02dd594398d32820e553dbf82486b9b0127edaa8c95394ed760c005385da8b5891cf7bcd0a7517348fd14524d1046b5bce088ea04ab97accb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f5cda820298c0c2bf24b33817b7cda6a821d314800c43e3e1f6b56cf2877a5c394fbe57e71d3c86b6ac74cca39a230a8acfd9d616d95ef25f2e3783e2d96121", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17b3e8b5fef642e28e7f8143bda48ee171c2f600479dc55327c028f37949be5ca195b2f26d4892cff54f1c4320f648e74cb03f0ed879950a37ab359179005838", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f28ba7d6fcbfdee36e589e13ff81cf71ffe0506e959adbef92f68d945f95e6fb6e62de3020ec2d62cf4bc6b85fe3e6f54de3a127f2e91eae2ef401072444436"} 13:19:34 INFO - Running post-run listener: copy_logs_to_upload_dir 13:19:34 INFO - Copying logs to upload dir... 13:19:34 INFO - mkdir: /builds/slave/test/build/upload/logs 13:19:34 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.543098 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-04 13:19:34.935704) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 13:19:34.939675) ========= 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.q7AginveNb/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.f4oa5WtQRO/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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/Firefox/sha512/77cdb1fa296cfff02dd594398d32820e553dbf82486b9b0127edaa8c95394ed760c005385da8b5891cf7bcd0a7517348fd14524d1046b5bce088ea04ab97accb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f5cda820298c0c2bf24b33817b7cda6a821d314800c43e3e1f6b56cf2877a5c394fbe57e71d3c86b6ac74cca39a230a8acfd9d616d95ef25f2e3783e2d96121", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17b3e8b5fef642e28e7f8143bda48ee171c2f600479dc55327c028f37949be5ca195b2f26d4892cff54f1c4320f648e74cb03f0ed879950a37ab359179005838", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f28ba7d6fcbfdee36e589e13ff81cf71ffe0506e959adbef92f68d945f95e6fb6e62de3020ec2d62cf4bc6b85fe3e6f54de3a127f2e91eae2ef401072444436"} build_url:https://queue.taskcluster.net/v1/task/Dv7IC06yT-aEuB-OSR2lug/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011069 build_url: 'https://queue.taskcluster.net/v1/task/Dv7IC06yT-aEuB-OSR2lug/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77cdb1fa296cfff02dd594398d32820e553dbf82486b9b0127edaa8c95394ed760c005385da8b5891cf7bcd0a7517348fd14524d1046b5bce088ea04ab97accb", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2f5cda820298c0c2bf24b33817b7cda6a821d314800c43e3e1f6b56cf2877a5c394fbe57e71d3c86b6ac74cca39a230a8acfd9d616d95ef25f2e3783e2d96121", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/17b3e8b5fef642e28e7f8143bda48ee171c2f600479dc55327c028f37949be5ca195b2f26d4892cff54f1c4320f648e74cb03f0ed879950a37ab359179005838", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6f28ba7d6fcbfdee36e589e13ff81cf71ffe0506e959adbef92f68d945f95e6fb6e62de3020ec2d62cf4bc6b85fe3e6f54de3a127f2e91eae2ef401072444436"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 13:19:34.979030) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 13:19:34.979407) ========= 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.q7AginveNb/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.f4oa5WtQRO/Listeners TMPDIR=/var/folders/5l/t8nv3hh175356x_rn1rqp56r00000w/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.005128 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 13:19:35.030747) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 13:19:35.031543) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 13:19:35.032336) ========= ========= Total master_lag: 0.21 =========