builder: pine_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0252 starttime: 1491447774.23 results: success (0) buildid: 20170405153820 builduid: bbdb8229e3a24badbc089af6bb2f60e1 revision: df0cf9a32b4bca1a7d3e24b0db7acc962fb3891b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 20:02:54.225860) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 20:02:54.226346) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 20:02:54.226651) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 20:02:54.253342) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 20:02:54.253724) ========= 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.oAvlJmaF3L/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.rFuIAt6t8r/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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-05 20:02:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 168M=0s 2017-04-05 20:02:54 (168 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.140273 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 20:02:54.418978) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 20:02:54.419368) ========= 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.oAvlJmaF3L/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.rFuIAt6t8r/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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.026044 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 20:02:54.468089) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-05 20:02:54.468501) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev df0cf9a32b4bca1a7d3e24b0db7acc962fb3891b --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/pine --rev df0cf9a32b4bca1a7d3e24b0db7acc962fb3891b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oAvlJmaF3L/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.rFuIAt6t8r/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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-05 20:02:54,576 truncating revision to first 12 chars 2017-04-05 20:02:54,576 Setting DEBUG logging. 2017-04-05 20:02:54,576 attempt 1/10 2017-04-05 20:02:54,576 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/df0cf9a32b4b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-05 20:02:55,700 unpacking tar archive at: pine-df0cf9a32b4b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.405658 ========= master_lag: 0.27 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-05 20:02:56.147664) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 20:02:56.148000) ========= script_repo_revision: df0cf9a32b4bca1a7d3e24b0db7acc962fb3891b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 20:02:56.148399) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 20:02:56.148666) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 20:02:56.168823) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-05 20:02:56.169097) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 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', 'Pine', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Pine'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.oAvlJmaF3L/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.rFuIAt6t8r/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 20:02:56 INFO - MultiFileLogger online at 20170405 20:02:56 in /builds/slave/test 20:02:56 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 20:02:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:02:56 INFO - {'append_to_log': False, 20:02:56 INFO - 'base_work_dir': '/builds/slave/test', 20:02:56 INFO - 'blob_upload_branch': 'Pine', 20:02:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:02:56 INFO - 'branch': 'Pine', 20:02:56 INFO - 'buildbot_json_path': 'buildprops.json', 20:02:56 INFO - 'config_files': ('talos/mac_config.py',), 20:02:56 INFO - 'default_actions': ('clobber', 20:02:56 INFO - 'read-buildbot-config', 20:02:56 INFO - 'download-and-extract', 20:02:56 INFO - 'populate-webroot', 20:02:56 INFO - 'create-virtualenv', 20:02:56 INFO - 'install', 20:02:56 INFO - 'run-tests'), 20:02:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:02:56 INFO - 'download_minidump_stackwalk': True, 20:02:56 INFO - 'download_symbols': 'ondemand', 20:02:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:02:56 INFO - 'tooltool.py': '/tools/tooltool.py', 20:02:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:02:56 INFO - '/tools/misc-python/virtualenv.py')}, 20:02:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:02:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:02:56 INFO - 'gecko_profile': False, 20:02:56 INFO - 'gecko_profile_interval': 0, 20:02:56 INFO - 'installer_path': 'installer.exe', 20:02:56 INFO - 'log_level': 'info', 20:02:56 INFO - 'log_name': 'talos', 20:02:56 INFO - 'log_to_console': True, 20:02:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:02:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:02:56 INFO - 'opt_config_files': (), 20:02:56 INFO - 'pip_index': False, 20:02:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:02:56 INFO - 'cmd': ('bash', 20:02:56 INFO - '-c', 20:02:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:02:56 INFO - 'enabled': True, 20:02:56 INFO - 'halt_on_failure': False, 20:02:56 INFO - 'name': 'check_screen_resolution'},), 20:02:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:02:56 INFO - 'cmd': ('bash', 20:02:56 INFO - '-c', 20:02:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:02:56 INFO - 'enabled': True, 20:02:56 INFO - 'halt_on_failure': False, 20:02:56 INFO - 'name': 'check_screen_resolution'},), 20:02:56 INFO - 'run_cmd_checks_enabled': True, 20:02:56 INFO - 'suite': 'dromaeojs-e10s', 20:02:56 INFO - 'system_bits': '32', 20:02:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:02:56 INFO - 'title': 't-yosemite-r7-0252', 20:02:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:02:56 INFO - 'use_talos_json': True, 20:02:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:02:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:02:56 INFO - 'work_dir': 'build'} 20:02:56 INFO - [mozharness: 2017-04-06 03:02:56.382314Z] Running clobber step. 20:02:56 INFO - Running pre-action listener: _resource_record_pre_action 20:02:56 INFO - Running main action method: clobber 20:02:56 INFO - rmtree: /builds/slave/test/build 20:02:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:02:58 INFO - Running post-action listener: _resource_record_post_action 20:02:58 INFO - [mozharness: 2017-04-06 03:02:58.875736Z] Finished clobber step (success) 20:02:58 INFO - [mozharness: 2017-04-06 03:02:58.875987Z] Running read-buildbot-config step. 20:02:58 INFO - Running pre-action listener: _resource_record_pre_action 20:02:58 INFO - Running main action method: read_buildbot_config 20:02:58 INFO - Using buildbot properties: 20:02:58 INFO - { 20:02:58 INFO - "project": "", 20:02:58 INFO - "product": "firefox", 20:02:58 INFO - "script_repo_revision": "default", 20:02:58 INFO - "builddir": "pine_yosemite_r7_test-dromaeojs-e10s", 20:02:58 INFO - "repository": "", 20:02:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 pine talos dromaeojs-e10s", 20:02:58 INFO - "buildid": "20170405153820", 20:02:58 INFO - "pgo_build": "False", 20:02:58 INFO - "basedir": "/builds/slave/test", 20:02:58 INFO - "buildnumber": 5, 20:02:58 INFO - "slavename": "t-yosemite-r7-0252", 20:02:58 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 20:02:58 INFO - "platform": "yosemite_r7", 20:02:58 INFO - "scheduler": "tests-pine-macosx64-talos", 20:02:58 INFO - "branch": "pine", 20:02:58 INFO - "repo_path": "projects/pine", 20:02:58 INFO - "revision": "df0cf9a32b4bca1a7d3e24b0db7acc962fb3891b", 20:02:58 INFO - "stage_platform": "macosx64", 20:02:58 INFO - "builduid": "bbdb8229e3a24badbc089af6bb2f60e1", 20:02:58 INFO - "slavebuilddir": "test" 20:02:58 INFO - } 20:02:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/K9fLYI_ISjqDygQPuB1ieg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 20:02:58 INFO - Running post-action listener: _resource_record_post_action 20:02:58 INFO - [mozharness: 2017-04-06 03:02:58.881795Z] Finished read-buildbot-config step (success) 20:02:58 INFO - [mozharness: 2017-04-06 03:02:58.882023Z] Running download-and-extract step. 20:02:58 INFO - Running pre-action listener: _resource_record_pre_action 20:02:58 INFO - Running main action method: download_and_extract 20:02:58 INFO - mkdir: /builds/slave/test/build/tests 20:02:58 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')]} 20:02:58 INFO - trying https://queue.taskcluster.net/v1/task/K9fLYI_ISjqDygQPuB1ieg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 20:02:58 INFO - Downloading https://queue.taskcluster.net/v1/task/K9fLYI_ISjqDygQPuB1ieg/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 20:02:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K9fLYI_ISjqDygQPuB1ieg/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 20:03:00 INFO - Downloaded 1325 bytes. 20:03:00 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 20:03:00 INFO - Using the following test package requirements: 20:03:00 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 20:03:00 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 20:03:00 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 20:03:00 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 20:03:00 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 20:03:00 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 20:03:00 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 20:03:00 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 20:03:00 INFO - u'jsshell-mac.zip'], 20:03:00 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 20:03:00 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 20:03:00 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 20:03:00 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 20:03:00 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 20:03:00 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 20:03:00 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 20:03:00 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 20:03:00 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 20:03:00 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 20:03:00 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 20:03:00 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 20:03:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K9fLYI_ISjqDygQPuB1ieg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 20:03:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K9fLYI_ISjqDygQPuB1ieg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:03:00 INFO - Fetch https://queue.taskcluster.net/v1/task/K9fLYI_ISjqDygQPuB1ieg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 20:03:01 INFO - Expected file size: 52517706 20:03:01 INFO - Obtained file size: 52517706 20:03:17 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 20:03:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K9fLYI_ISjqDygQPuB1ieg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 20:03:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K9fLYI_ISjqDygQPuB1ieg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 20:03:17 INFO - Fetch https://queue.taskcluster.net/v1/task/K9fLYI_ISjqDygQPuB1ieg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 20:03:19 INFO - Expected file size: 52517706 20:03:19 INFO - Obtained file size: 52517706 20:03:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/K9fLYI_ISjqDygQPuB1ieg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 20:03:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/K9fLYI_ISjqDygQPuB1ieg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 20:03:35 INFO - Fetch https://queue.taskcluster.net/v1/task/K9fLYI_ISjqDygQPuB1ieg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 20:03:36 INFO - Expected file size: 14404152 20:03:36 INFO - Obtained file size: 14404152 20:03:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:37 INFO - trying https://queue.taskcluster.net/v1/task/K9fLYI_ISjqDygQPuB1ieg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 20:03:37 INFO - Downloading https://queue.taskcluster.net/v1/task/K9fLYI_ISjqDygQPuB1ieg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 20:03:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/K9fLYI_ISjqDygQPuB1ieg/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 20:03:39 INFO - Downloaded 70989468 bytes. 20:03:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/K9fLYI_ISjqDygQPuB1ieg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 20:03:39 INFO - mkdir: /builds/slave/test/properties 20:03:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:03:39 INFO - Writing to file /builds/slave/test/properties/build_url 20:03:39 INFO - Contents: 20:03:39 INFO - build_url:https://queue.taskcluster.net/v1/task/K9fLYI_ISjqDygQPuB1ieg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 20:03:41 INFO - Running post-action listener: _resource_record_post_action 20:03:41 INFO - Running post-action listener: set_extra_try_arguments 20:03:41 INFO - [mozharness: 2017-04-06 03:03:41.189545Z] Finished download-and-extract step (success) 20:03:41 INFO - [mozharness: 2017-04-06 03:03:41.189701Z] Running populate-webroot step. 20:03:41 INFO - Running pre-action listener: _resource_record_pre_action 20:03:41 INFO - Running main action method: populate_webroot 20:03:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:03:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:03:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:03:41 INFO - '--tppagecycles', 20:03:41 INFO - '7'], 20:03:41 INFO - 'tests': ['tsvgm']}}, 20:03:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:03:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:03:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:03:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:03:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:03:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:03:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 20:03:41 INFO - 'talos_options': ['--disable-e10s'], 20:03:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:03:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 20:03:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:03:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 20:03:41 INFO - 'talos_options': ['--disable-e10s'], 20:03:41 INFO - 'tests': ['damp', 'tps']}, 20:03:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 20:03:41 INFO - 'tests': ['damp', 'tps']}, 20:03:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:03:41 INFO - 'tests': ['dromaeo_dom']}, 20:03:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:03:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:03:41 INFO - 'tests': ['basic_compositor_video']}, 20:03:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:03:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:03:41 INFO - 'tests': ['a11yr', 20:03:41 INFO - 'ts_paint', 20:03:41 INFO - 'tpaint', 20:03:41 INFO - 'sessionrestore', 20:03:41 INFO - 'sessionrestore_no_auto_restore', 20:03:41 INFO - 'tabpaint']}, 20:03:41 INFO - 'other-e10s': {'tests': ['a11yr', 20:03:41 INFO - 'ts_paint', 20:03:41 INFO - 'tpaint', 20:03:41 INFO - 'sessionrestore', 20:03:41 INFO - 'sessionrestore_no_auto_restore', 20:03:41 INFO - 'tabpaint']}, 20:03:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:03:41 INFO - 'ts_paint', 20:03:41 INFO - 'tpaint', 20:03:41 INFO - 'sessionrestore', 20:03:41 INFO - 'sessionrestore_no_auto_restore', 20:03:41 INFO - 'tabpaint']}, 20:03:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:03:41 INFO - 'ts_paint', 20:03:41 INFO - 'tpaint', 20:03:41 INFO - 'sessionrestore', 20:03:41 INFO - 'sessionrestore_no_auto_restore', 20:03:41 INFO - 'tabpaint']}, 20:03:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:03:41 INFO - 'tests': ['a11yr', 20:03:41 INFO - 'ts_paint', 20:03:41 INFO - 'tpaint', 20:03:41 INFO - 'sessionrestore', 20:03:41 INFO - 'sessionrestore_no_auto_restore', 20:03:41 INFO - 'tabpaint']}, 20:03:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:03:41 INFO - 'tests': ['a11yr', 20:03:41 INFO - 'ts_paint', 20:03:41 INFO - 'tpaint', 20:03:41 INFO - 'sessionrestore', 20:03:41 INFO - 'sessionrestore_no_auto_restore', 20:03:41 INFO - 'tabpaint']}, 20:03:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:03:41 INFO - 'tests': ['tsvgx', 20:03:41 INFO - 'tsvgr_opacity', 20:03:41 INFO - 'tart', 20:03:41 INFO - 'tscrollx', 20:03:41 INFO - 'cart', 20:03:41 INFO - 'tsvg_static']}, 20:03:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:03:41 INFO - 'tsvgr_opacity', 20:03:41 INFO - 'tart', 20:03:41 INFO - 'tscrollx', 20:03:41 INFO - 'cart', 20:03:41 INFO - 'tsvg_static']}, 20:03:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 20:03:41 INFO - 'talos_options': ['--disable-e10s'], 20:03:41 INFO - 'tests': ['tp5o']}, 20:03:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 20:03:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 20:03:41 INFO - 'talos_options': ['--disable-e10s', 20:03:41 INFO - '--xperf_path', 20:03:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:03:41 INFO - 'tests': ['tp5n']}, 20:03:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 20:03:41 INFO - 'talos_options': ['--xperf_path', 20:03:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:03:41 INFO - 'tests': ['tp5n']}}, 20:03:41 INFO - 'talos.zip': {'path': '', 20:03:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:03:41 INFO - Running post-action listener: _resource_record_post_action 20:03:41 INFO - [mozharness: 2017-04-06 03:03:41.207933Z] Finished populate-webroot step (success) 20:03:41 INFO - [mozharness: 2017-04-06 03:03:41.208068Z] Running create-virtualenv step. 20:03:41 INFO - Running pre-action listener: _resource_record_pre_action 20:03:41 INFO - Running main action method: create_virtualenv 20:03:41 INFO - Creating virtualenv /builds/slave/test/build/venv 20:03:41 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 20:03:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:03:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:03:41 INFO - Using real prefix '/tools/python27' 20:03:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:03:42 INFO - Installing distribute.............................................................................................................................................................................................done. 20:03:44 INFO - Installing pip.................done. 20:03:44 INFO - Return code: 0 20:03:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 20:03:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 20:03:45 INFO - Reading from file tmpfile_stdout 20:03:45 INFO - Output received: 20:03:45 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) 20:03:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:45 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 0x104714b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104717768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff67359cd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044f2d30>, '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 0x104419db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7be8>, '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.oAvlJmaF3L/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.rFuIAt6t8r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 20:03:45 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 20:03:45 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 20:03:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oAvlJmaF3L/Render', 20:03:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:03:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:03:45 INFO - 'HOME': '/Users/cltbld', 20:03:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:03:45 INFO - 'LOGNAME': 'cltbld', 20:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:45 INFO - 'MOZ_NO_REMOTE': '1', 20:03:45 INFO - 'NO_EM_RESTART': '1', 20:03:45 INFO - 'PAGER': '/bin/cat', 20:03:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:45 INFO - 'PWD': '/builds/slave/test', 20:03:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:03:45 INFO - 'SHELL': '/bin/bash', 20:03:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rFuIAt6t8r/Listeners', 20:03:45 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 20:03:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:03:45 INFO - 'USER': 'cltbld', 20:03:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:03:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:45 INFO - 'XPC_FLAGS': '0x0', 20:03:45 INFO - 'XPC_SERVICE_NAME': '0', 20:03:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:45 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 20:03:45 INFO - Cleaning up... 20:03:45 INFO - Return code: 0 20:03:45 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:45 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 0x104714b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104717768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff67359cd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044f2d30>, '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 0x104419db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7be8>, '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.oAvlJmaF3L/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.rFuIAt6t8r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 20:03:45 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 20:03:45 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 20:03:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oAvlJmaF3L/Render', 20:03:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:03:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:03:45 INFO - 'HOME': '/Users/cltbld', 20:03:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:03:45 INFO - 'LOGNAME': 'cltbld', 20:03:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:45 INFO - 'MOZ_NO_REMOTE': '1', 20:03:45 INFO - 'NO_EM_RESTART': '1', 20:03:45 INFO - 'PAGER': '/bin/cat', 20:03:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:03:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:45 INFO - 'PWD': '/builds/slave/test', 20:03:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:03:45 INFO - 'SHELL': '/bin/bash', 20:03:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rFuIAt6t8r/Listeners', 20:03:45 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 20:03:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:03:45 INFO - 'USER': 'cltbld', 20:03:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:03:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:03:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:45 INFO - 'XPC_FLAGS': '0x0', 20:03:45 INFO - 'XPC_SERVICE_NAME': '0', 20:03:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:03:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:45 INFO - Downloading/unpacking psutil>=3.1.1 20:03:45 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 20:03:45 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 20:03:45 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 20:03:45 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 20:03:45 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 20:03:45 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 20:03:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:03:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:03:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:03:49 INFO - Installing collected packages: psutil 20:03:49 INFO - Running setup.py install for psutil 20:03:49 INFO - building 'psutil._psutil_osx' extension 20:03:49 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 20:03:49 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 20:03:50 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 20:03:50 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 20:03:50 INFO - building 'psutil._psutil_posix' extension 20:03:50 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 20:03:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:03:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:03:50 INFO - ^ 20:03:50 INFO - 1 warning generated. 20:03:50 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 20:03:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:03:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:03:50 INFO - Successfully installed psutil 20:03:50 INFO - Cleaning up... 20:03:50 INFO - Return code: 0 20:03:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:03:50 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')]} 20:03:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:50 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')]} 20:03:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:51 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 0x104714b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104717768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff67359cd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044f2d30>, '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 0x104419db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7be8>, '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.oAvlJmaF3L/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.rFuIAt6t8r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 20:03:51 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 20:03:51 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 20:03:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oAvlJmaF3L/Render', 20:03:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:03:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:03:51 INFO - 'HOME': '/Users/cltbld', 20:03:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:03:51 INFO - 'LOGNAME': 'cltbld', 20:03:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:51 INFO - 'MOZ_NO_REMOTE': '1', 20:03:51 INFO - 'NO_EM_RESTART': '1', 20:03:51 INFO - 'PAGER': '/bin/cat', 20:03:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:03:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:51 INFO - 'PWD': '/builds/slave/test', 20:03:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:03:51 INFO - 'SHELL': '/bin/bash', 20:03:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rFuIAt6t8r/Listeners', 20:03:51 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 20:03:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:03:51 INFO - 'USER': 'cltbld', 20:03:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:03:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:03:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:51 INFO - 'XPC_FLAGS': '0x0', 20:03:51 INFO - 'XPC_SERVICE_NAME': '0', 20:03:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:03:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:51 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:03:51 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 20:03:51 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 20:03:51 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 20:03:51 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 20:03:51 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 20:03:51 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 20:03:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:03:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:03:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:03:54 INFO - Installing collected packages: mozsystemmonitor 20:03:54 INFO - Running setup.py install for mozsystemmonitor 20:03:54 INFO - Successfully installed mozsystemmonitor 20:03:54 INFO - Cleaning up... 20:03:54 INFO - Return code: 0 20:03:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:03:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:54 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 0x104714b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104717768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff67359cd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044f2d30>, '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 0x104419db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7be8>, '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.oAvlJmaF3L/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.rFuIAt6t8r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 20:03:54 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 20:03:54 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 20:03:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oAvlJmaF3L/Render', 20:03:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:03:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:03:54 INFO - 'HOME': '/Users/cltbld', 20:03:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:03:54 INFO - 'LOGNAME': 'cltbld', 20:03:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:54 INFO - 'MOZ_NO_REMOTE': '1', 20:03:54 INFO - 'NO_EM_RESTART': '1', 20:03:54 INFO - 'PAGER': '/bin/cat', 20:03:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:03:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:54 INFO - 'PWD': '/builds/slave/test', 20:03:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:03:54 INFO - 'SHELL': '/bin/bash', 20:03:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rFuIAt6t8r/Listeners', 20:03:54 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 20:03:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:03:54 INFO - 'USER': 'cltbld', 20:03:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:03:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:03:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:54 INFO - 'XPC_FLAGS': '0x0', 20:03:54 INFO - 'XPC_SERVICE_NAME': '0', 20:03:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:03:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:55 INFO - Downloading/unpacking jsonschema==2.5.1 20:03:55 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 20:03:55 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 20:03:55 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 20:03:55 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 20:03:55 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 20:03:55 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 20:03:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:03:57 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:03:57 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 20:03:57 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 20:03:57 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 20:03:57 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 20:03:57 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 20:03:57 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 20:03:58 INFO - Downloading functools32-3.2.3-2.tar.gz 20:03:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:03:58 INFO - warning: no files found matching '*.txt' 20:03:58 INFO - no previously-included directories found matching 'build' 20:03:58 INFO - no previously-included directories found matching 'dist' 20:03:58 INFO - no previously-included directories found matching '.git*' 20:03:58 INFO - Installing collected packages: jsonschema, functools32 20:03:58 INFO - Running setup.py install for functools32 20:03:58 INFO - warning: no files found matching '*.txt' 20:03:58 INFO - no previously-included directories found matching 'build' 20:03:58 INFO - no previously-included directories found matching 'dist' 20:03:58 INFO - no previously-included directories found matching '.git*' 20:03:58 INFO - Successfully installed jsonschema functools32 20:03:58 INFO - Cleaning up... 20:03:58 INFO - Return code: 0 20:03:58 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:03:58 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')]} 20:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:58 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')]} 20:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:58 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 0x104714b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104717768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff67359cd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044f2d30>, '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 0x104419db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7be8>, '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.oAvlJmaF3L/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.rFuIAt6t8r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 20:03:58 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 20:03:58 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 20:03:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oAvlJmaF3L/Render', 20:03:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:03:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:03:58 INFO - 'HOME': '/Users/cltbld', 20:03:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:03:58 INFO - 'LOGNAME': 'cltbld', 20:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:58 INFO - 'MOZ_NO_REMOTE': '1', 20:03:58 INFO - 'NO_EM_RESTART': '1', 20:03:58 INFO - 'PAGER': '/bin/cat', 20:03:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:58 INFO - 'PWD': '/builds/slave/test', 20:03:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:03:58 INFO - 'SHELL': '/bin/bash', 20:03:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rFuIAt6t8r/Listeners', 20:03:58 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 20:03:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:03:58 INFO - 'USER': 'cltbld', 20:03:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:03:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:58 INFO - 'XPC_FLAGS': '0x0', 20:03:58 INFO - 'XPC_SERVICE_NAME': '0', 20:03:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:03:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:58 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:03:58 INFO - Cleaning up... 20:03:58 INFO - Return code: 0 20:03:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:03:58 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')]} 20:03:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:03:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:58 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')]} 20:03:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:03:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:03:58 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 0x104714b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104717768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff67359cd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044f2d30>, '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 0x104419db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7be8>, '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.oAvlJmaF3L/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.rFuIAt6t8r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 20:03:58 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 20:03:58 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 20:03:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oAvlJmaF3L/Render', 20:03:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:03:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:03:58 INFO - 'HOME': '/Users/cltbld', 20:03:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:03:58 INFO - 'LOGNAME': 'cltbld', 20:03:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:03:58 INFO - 'MOZ_NO_REMOTE': '1', 20:03:58 INFO - 'NO_EM_RESTART': '1', 20:03:58 INFO - 'PAGER': '/bin/cat', 20:03:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:03:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:03:58 INFO - 'PWD': '/builds/slave/test', 20:03:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:03:58 INFO - 'SHELL': '/bin/bash', 20:03:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rFuIAt6t8r/Listeners', 20:03:58 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 20:03:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:03:58 INFO - 'USER': 'cltbld', 20:03:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:03:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:03:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:03:58 INFO - 'XPC_FLAGS': '0x0', 20:03:58 INFO - 'XPC_SERVICE_NAME': '0', 20:03:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:03:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:03:59 INFO - Downloading/unpacking blobuploader==1.2.4 20:03:59 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 20:03:59 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 20:03:59 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 20:03:59 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 20:03:59 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 20:03:59 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 20:04:01 INFO - Downloading blobuploader-1.2.4.tar.gz 20:04:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:04:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:04:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:04:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:04:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:04:02 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04:02 INFO - Downloading docopt-0.6.1.tar.gz 20:04:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:04:03 INFO - Installing collected packages: blobuploader, requests, docopt 20:04:03 INFO - Running setup.py install for blobuploader 20:04:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:04:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:04:03 INFO - Running setup.py install for requests 20:04:03 INFO - Running setup.py install for docopt 20:04:03 INFO - Successfully installed blobuploader requests docopt 20:04:03 INFO - Cleaning up... 20:04:04 INFO - Return code: 0 20:04:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:04:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:04 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 0x104714b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104717768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff67359cd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044f2d30>, '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 0x104419db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7be8>, '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.oAvlJmaF3L/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.rFuIAt6t8r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 20:04:04 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 20:04:04 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 20:04:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oAvlJmaF3L/Render', 20:04:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:04 INFO - 'HOME': '/Users/cltbld', 20:04:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:04 INFO - 'LOGNAME': 'cltbld', 20:04:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:04 INFO - 'MOZ_NO_REMOTE': '1', 20:04:04 INFO - 'NO_EM_RESTART': '1', 20:04:04 INFO - 'PAGER': '/bin/cat', 20:04:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:04 INFO - 'PWD': '/builds/slave/test', 20:04:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:04 INFO - 'SHELL': '/bin/bash', 20:04:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rFuIAt6t8r/Listeners', 20:04:04 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 20:04:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:04 INFO - 'USER': 'cltbld', 20:04:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:04 INFO - 'XPC_FLAGS': '0x0', 20:04:04 INFO - 'XPC_SERVICE_NAME': '0', 20:04:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:04:04 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-QWqvOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:04:04 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-lzgqeE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:04:04 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-3WTYLm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:04:04 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-rCf1CU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:04:04 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-ExM16B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:04:04 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-Wku4F0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:04:04 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-Lt8DHD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:04:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:04:05 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-j8AkQq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:04:05 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-XR6XJv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:04:05 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-lxk9qJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:04:05 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-VnZSMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:04:05 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-zKZ5lV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:04:05 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-zr5rKV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:04:05 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-VI5ad2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:05 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-Zkdo3R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:04:05 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-dnhJ3e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:04:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:04:05 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-Pg3DfX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:04:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:04:06 INFO - Running setup.py install for manifestparser 20:04:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:04:06 INFO - Running setup.py install for mozcrash 20:04:06 INFO - Running setup.py install for mozdebug 20:04:06 INFO - Running setup.py install for mozdevice 20:04:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:04:06 INFO - Running setup.py install for mozfile 20:04:06 INFO - Running setup.py install for mozhttpd 20:04:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:04:06 INFO - Running setup.py install for mozinfo 20:04:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:04:07 INFO - Running setup.py install for mozInstall 20:04:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:04:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:04:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:04:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:04:07 INFO - Running setup.py install for mozleak 20:04:07 INFO - Running setup.py install for mozlog 20:04:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:04:07 INFO - Running setup.py install for moznetwork 20:04:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:04:07 INFO - Running setup.py install for mozprocess 20:04:07 INFO - Running setup.py install for mozprofile 20:04:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:04:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:04:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:04:07 INFO - Running setup.py install for mozrunner 20:04:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:04:08 INFO - Running setup.py install for mozscreenshot 20:04:08 INFO - Running setup.py install for moztest 20:04:08 INFO - Running setup.py install for mozversion 20:04:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:04:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:04:08 INFO - Cleaning up... 20:04:08 INFO - Return code: 0 20:04:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:08 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 0x104714b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104717768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff67359cd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044f2d30>, '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 0x104419db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7be8>, '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.oAvlJmaF3L/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.rFuIAt6t8r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 20:04:08 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 20:04:08 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 20:04:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oAvlJmaF3L/Render', 20:04:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:08 INFO - 'HOME': '/Users/cltbld', 20:04:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:08 INFO - 'LOGNAME': 'cltbld', 20:04:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:08 INFO - 'MOZ_NO_REMOTE': '1', 20:04:08 INFO - 'NO_EM_RESTART': '1', 20:04:08 INFO - 'PAGER': '/bin/cat', 20:04:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:08 INFO - 'PWD': '/builds/slave/test', 20:04:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:08 INFO - 'SHELL': '/bin/bash', 20:04:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rFuIAt6t8r/Listeners', 20:04:08 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 20:04:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:08 INFO - 'USER': 'cltbld', 20:04:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:08 INFO - 'XPC_FLAGS': '0x0', 20:04:08 INFO - 'XPC_SERVICE_NAME': '0', 20:04:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:04:08 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-au_JO3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:04:08 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)) 20:04:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:04:08 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-_FkjR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:04:09 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)) 20:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:04:09 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-RqlU7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:04:09 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)) 20:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:04:09 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-_f0Gs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:04:09 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)) 20:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:04:09 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-sLZj16-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:04:09 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)) 20:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:04:09 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-lFcv7C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:04:09 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)) 20:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:04:09 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-BS62w0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:04:09 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)) 20:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:04:09 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-hkYF4i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:04:09 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)) 20:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:04:09 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-gHQjHe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:04:09 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)) 20:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:04:09 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-LiH23T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:04:09 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)) 20:04:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:04:09 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-8r6y7D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:04:10 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)) 20:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:04:10 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-GMkfLD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:04:10 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)) 20:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:04:10 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-meWGjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:04:10 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)) 20:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:04:10 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-sFNHMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:04:10 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)) 20:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:10 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-nZ8dVs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:04:10 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)) 20:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:04:10 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-qeFrAa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:04:10 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)) 20:04:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:04:10 INFO - Running setup.py (path:/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/pip-e5MYw_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:04:10 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)) 20:04:10 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)) 20:04:10 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)) 20:04:10 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)) 20:04:10 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)) 20:04:10 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)) 20:04:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04: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 20:04:13 INFO - Downloading blessings-1.6.tar.gz 20:04:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:04:13 INFO - Installing collected packages: blessings 20:04:13 INFO - Running setup.py install for blessings 20:04:13 INFO - Successfully installed blessings 20:04:13 INFO - Cleaning up... 20:04:13 INFO - Return code: 0 20:04:13 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:04:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:04:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:04:13 INFO - Reading from file tmpfile_stdout 20:04:13 INFO - Current package versions: 20:04:13 INFO - blessings == 1.6 20:04:13 INFO - blobuploader == 1.2.4 20:04:13 INFO - docopt == 0.6.1 20:04:13 INFO - functools32 == 3.2.3-2 20:04:13 INFO - jsonschema == 2.5.1 20:04:13 INFO - manifestparser == 1.1 20:04:13 INFO - mozInstall == 1.12 20:04:13 INFO - mozcrash == 1.0 20:04:13 INFO - mozdebug == 0.1 20:04:13 INFO - mozdevice == 0.49 20:04:13 INFO - mozfile == 1.2 20:04:13 INFO - mozhttpd == 0.7 20:04:13 INFO - mozinfo == 0.9 20:04:13 INFO - mozleak == 0.1 20:04:13 INFO - mozlog == 3.4 20:04:13 INFO - moznetwork == 0.27 20:04:13 INFO - mozprocess == 0.25 20:04:13 INFO - mozprofile == 0.28 20:04:13 INFO - mozrunner == 6.13 20:04:13 INFO - mozscreenshot == 0.1 20:04:13 INFO - mozsystemmonitor == 0.3 20:04:13 INFO - moztest == 0.8 20:04:13 INFO - mozversion == 1.4 20:04:13 INFO - psutil == 3.1.1 20:04:13 INFO - requests == 1.2.3 20:04:13 INFO - wsgiref == 0.1.2 20:04:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:13 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 0x104714b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104717768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff67359cd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044f2d30>, '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 0x104419db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7be8>, '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.oAvlJmaF3L/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.rFuIAt6t8r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 20:04:13 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 20:04:13 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 20:04:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oAvlJmaF3L/Render', 20:04:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:13 INFO - 'HOME': '/Users/cltbld', 20:04:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:13 INFO - 'LOGNAME': 'cltbld', 20:04:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:13 INFO - 'MOZ_NO_REMOTE': '1', 20:04:13 INFO - 'NO_EM_RESTART': '1', 20:04:13 INFO - 'PAGER': '/bin/cat', 20:04:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:13 INFO - 'PWD': '/builds/slave/test', 20:04:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:13 INFO - 'SHELL': '/bin/bash', 20:04:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rFuIAt6t8r/Listeners', 20:04:13 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 20:04:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:13 INFO - 'USER': 'cltbld', 20:04:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:13 INFO - 'XPC_FLAGS': '0x0', 20:04:13 INFO - 'XPC_SERVICE_NAME': '0', 20:04:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:14 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)) 20:04:14 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)) 20:04:14 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)) 20:04:14 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)) 20:04:14 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)) 20:04:14 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)) 20:04:14 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)) 20:04:14 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)) 20:04:14 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)) 20:04:14 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)) 20:04:14 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)) 20:04:14 INFO - Cleaning up... 20:04:14 INFO - Return code: 0 20:04:14 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:04:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:04:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:04:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:04:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:04:14 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104714b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104717768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff67359cd90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1044f2d30>, '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 0x104419db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7be8>, '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.oAvlJmaF3L/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.rFuIAt6t8r/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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 20:04:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:04:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:04:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oAvlJmaF3L/Render', 20:04:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:14 INFO - 'HOME': '/Users/cltbld', 20:04:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:14 INFO - 'LOGNAME': 'cltbld', 20:04:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:14 INFO - 'MOZ_NO_REMOTE': '1', 20:04:14 INFO - 'NO_EM_RESTART': '1', 20:04:14 INFO - 'PAGER': '/bin/cat', 20:04:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:14 INFO - 'PWD': '/builds/slave/test', 20:04:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:14 INFO - 'SHELL': '/bin/bash', 20:04:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rFuIAt6t8r/Listeners', 20:04:14 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 20:04:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:14 INFO - 'USER': 'cltbld', 20:04:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:14 INFO - 'XPC_FLAGS': '0x0', 20:04:14 INFO - 'XPC_SERVICE_NAME': '0', 20:04:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:04:14 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:04:14 INFO - Cleaning up... 20:04:14 INFO - Return code: 0 20:04:14 INFO - Running post-action listener: _resource_record_post_action 20:04:14 INFO - Running post-action listener: _start_resource_monitoring 20:04:14 INFO - Starting resource monitoring. 20:04:14 INFO - [mozharness: 2017-04-06 03:04:14.425930Z] Finished create-virtualenv step (success) 20:04:14 INFO - [mozharness: 2017-04-06 03:04:14.426877Z] Running install step. 20:04:14 INFO - Running pre-action listener: _resource_record_pre_action 20:04:14 INFO - Running main action method: install 20:04:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:04:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:04:14 INFO - Reading from file tmpfile_stdout 20:04:14 INFO - Detecting whether we're running mozinstall >=1.0... 20:04:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:04:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:04:14 INFO - Reading from file tmpfile_stdout 20:04:14 INFO - Output received: 20:04:14 INFO - Usage: mozinstall [options] installer 20:04:14 INFO - Options: 20:04:14 INFO - -h, --help show this help message and exit 20:04:14 INFO - -d DEST, --destination=DEST 20:04:14 INFO - Directory to install application into. [default: 20:04:14 INFO - "/builds/slave/test"] 20:04:14 INFO - --app=APP Application being installed. [default: firefox] 20:04:14 INFO - mkdir: /builds/slave/test/build/application 20:04:14 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'] 20:04:14 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 20:04:35 INFO - Reading from file tmpfile_stdout 20:04:35 INFO - Output received: 20:04:35 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 20:04:35 INFO - Running post-action listener: _resource_record_post_action 20:04:35 INFO - [mozharness: 2017-04-06 03:04:35.037714Z] Finished install step (success) 20:04:35 INFO - [mozharness: 2017-04-06 03:04:35.037836Z] Running run-tests step. 20:04:35 INFO - Running pre-action listener: _resource_record_pre_action 20:04:35 INFO - Running main action method: run_tests 20:04:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:04:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:04:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:04:35 INFO - 2017-04-05 20:04:35.051 screenresolution[1628:7476] starting screenresolution argv=screenresolution get 20:04:35 INFO - 2017-04-05 20:04:35.053 screenresolution[1628:7476] Display 0: 1600x1200x32@60 20:04:35 INFO - 2017-04-05 20:04:35.059 screenresolution[1629:7478] starting screenresolution argv=screenresolution list 20:04:35 INFO - Available Modes on Display 0 20:04:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:04:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:04:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:04:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:04:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:04:35 INFO - Intel Iris: 20:04:35 INFO - Chipset Model: Intel Iris 20:04:35 INFO - Type: GPU 20:04:35 INFO - Bus: Built-In 20:04:35 INFO - VRAM (Dynamic, Max): 1536 MB 20:04:35 INFO - Vendor: Intel (0x8086) 20:04:35 INFO - Device ID: 0x0a2e 20:04:35 INFO - Revision ID: 0x0009 20:04:35 INFO - Displays: 20:04:35 INFO - Display: 20:04:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:04:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:04:35 INFO - Display Serial Number: 1600x1200 60 20:04:35 INFO - Main Display: Yes 20:04:35 INFO - Mirror: Off 20:04:35 INFO - Online: Yes 20:04:35 INFO - Rotation: Supported 20:04:35 INFO - Return code: 0 20:04:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:04:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:04:35 INFO - Python 2.7.3 20:04:35 INFO - Return code: 0 20:04:35 INFO - grabbing minidump binary from tooltool 20:04:35 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')]} 20:04:35 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 0x1044f2d30>, '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 0x104419db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1044e7be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:04:35 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 20:04:35 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 20:04:35 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 20:04:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:04:35 INFO - Return code: 0 20:04:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:04:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:04:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:04:35 INFO - ENV: RUST_BACKTRACE is now 1 20:04:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:04:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:04:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K9fLYI_ISjqDygQPuB1ieg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0252', '--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 20:04:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Pine --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/K9fLYI_ISjqDygQPuB1ieg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0252 --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 20:04:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.oAvlJmaF3L/Render', 20:04:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:04:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:04:35 INFO - 'HOME': '/Users/cltbld', 20:04:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:04:35 INFO - 'LOGNAME': 'cltbld', 20:04:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:04:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:04:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:04:35 INFO - 'MOZ_NO_REMOTE': '1', 20:04:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:04:35 INFO - 'NO_EM_RESTART': '1', 20:04:35 INFO - 'PAGER': '/bin/cat', 20:04:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:04:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:04:35 INFO - 'PWD': '/builds/slave/test', 20:04:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:04:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:04:35 INFO - 'RUST_BACKTRACE': '1', 20:04:35 INFO - 'SHELL': '/bin/bash', 20:04:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rFuIAt6t8r/Listeners', 20:04:35 INFO - 'TMPDIR': '/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/', 20:04:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:04:35 INFO - 'USER': 'cltbld', 20:04:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:04:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:04:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:04:35 INFO - 'XPC_FLAGS': '0x0', 20:04:35 INFO - 'XPC_SERVICE_NAME': '0', 20:04:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:04:35 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/K9fLYI_ISjqDygQPuB1ieg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0252', '--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 20:04:35 INFO - mozversion application_buildid: 20170405153820 20:04:35 INFO - mozversion application_changeset: df0cf9a32b4bca1a7d3e24b0db7acc962fb3891b 20:04:35 INFO - mozversion application_display_name: Nightly 20:04:35 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:04:35 INFO - mozversion application_name: Firefox 20:04:35 INFO - mozversion application_remotingname: firefox 20:04:35 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 20:04:35 INFO - mozversion application_vendor: Mozilla 20:04:35 INFO - mozversion application_version: 55.0a1 20:04:35 INFO - mozversion platform_buildid: 20170405153820 20:04:35 INFO - mozversion platform_changeset: df0cf9a32b4bca1a7d3e24b0db7acc962fb3891b 20:04:35 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 20:04:35 INFO - mozversion platform_version: 55.0a1 20:04:35 INFO - using testdate: 1491447875 20:04:35 INFO - actual date: 1491447875 20:04:35 INFO - starting webserver on 'localhost:49242' 20:04:35 INFO - SUITE-START | Running 2 tests 20:04:35 INFO - TEST-START | dromaeo_css 20:04:35 INFO - operating with platform_type : mac_ 20:04:35 INFO - Initialising browser for dromaeo_css test... 20:04:35 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmpfgUwB8/profile http://localhost:49242/getInfo.html) 20:04:38 INFO - PID 1639 | 2017-04-05 20:04:38.907 plugin-container[1641:7628] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4c47, name = 'com.apple.tsm.portname' 20:04:38 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:04:38 INFO - PID 1639 | 2017-04-05 20:04:38.909 plugin-container[1641:7628] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 20:04:38 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:04:38 INFO - PID 1639 | 2017-04-05 20:04:38.910 plugin-container[1641:7628] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:04:38 INFO - PID 1639 | __metrics Screen width/height:1600/1200 20:04:38 INFO - PID 1639 | colorDepth:24 20:04:38 INFO - PID 1639 | Browser inner width/height: 1024/689 20:04:38 INFO - PID 1639 | __metrics 20:04:39 ERROR - PID 1639 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 20:04:39 INFO - TEST-INFO | 1639: exit 0 20:04:39 INFO - Browser initialized. 20:04:39 INFO - Running cycle 1/1 for dromaeo_css test... 20:04:39 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmpfgUwB8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:04:42 INFO - PID 1642 | 2017-04-05 20:04:42.638 plugin-container[1643:7763] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 20:04:42 INFO - PID 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:04:42 INFO - PID 1642 | 2017-04-05 20:04:42.638 plugin-container[1643:7763] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x461b, name = 'com.apple.CFPasteboardClient' 20:04:42 INFO - PID 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:04:42 INFO - PID 1642 | 2017-04-05 20:04:42.638 plugin-container[1643:7763] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:04:52 INFO - PID 1642 | RSS: Main: 235331584 20:04:52 INFO - PID 1642 | 20:07:57 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 20:07:59 INFO - PID 1642 | RSS: Main: 254447616 20:07:59 INFO - PID 1642 | 20:09:40 INFO - PID 1642 | ************************* 20:09:40 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 20:09:40 INFO - PID 1642 | 20:09:40 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:09:40 INFO - PID 1642 | Full stack: 20:09:40 INFO - PID 1642 | ************************* 20:09:40 INFO - PID 1642 | ************************* 20:09:40 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 20:09:40 INFO - PID 1642 | 20:09:40 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:09:40 INFO - PID 1642 | Full stack: 20:09:40 INFO - PID 1642 | ************************* 20:09:40 INFO - PID 1642 | ************************* 20:09:40 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 20:09:40 INFO - PID 1642 | 20:09:40 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:09:40 INFO - PID 1642 | Full stack: 20:09:40 INFO - PID 1642 | ************************* 20:09:40 INFO - PID 1642 | ************************* 20:09:40 INFO - PID 1642 | A coding exception was thrown and uncaught in a Task. 20:09:40 INFO - PID 1642 | 20:09:40 ERROR - PID 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 20:09:40 INFO - PID 1642 | Full stack: 20:09:40 INFO - PID 1642 | ************************* 20:11:01 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 20:11:01 INFO - PID 1642 | RSS: Main: 260558848 20:11:01 INFO - PID 1642 | 20:14:03 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 20:14:03 INFO - PID 1642 | RSS: Main: 274878464 20:14:03 INFO - PID 1642 | 20:17:05 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 20:17:06 INFO - PID 1642 | RSS: Main: 267202560 20:17:06 INFO - PID 1642 | 20:20:09 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 20:20:09 INFO - PID 1642 | RSS: Main: 278638592 20:20:09 INFO - PID 1642 | 20:23:12 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 20:23:12 INFO - PID 1642 | RSS: Main: 272326656 20:23:12 INFO - PID 1642 | 20:23:12 INFO - PID 1642 | __start_tp_report 20:23:12 INFO - PID 1642 | _x_x_mozilla_page_load 20:23:12 INFO - PID 1642 | _x_x_mozilla_page_load_details 20:23:12 INFO - PID 1642 | |i|pagename|runs| 20:23:12 INFO - PID 1642 | |0;dojo.html;3149.653538110808;3596.2627661329448;3632.4551317302416;3650.981745091274;3655.92688146237;6144.402455361605;6256.811205870887;6269.435750782429;6292.811215663526;6320.589161704497;5112.872178195547;5771.595988280822;5990.670513121777;6189.381061893809;6222.191115155035;5540.335159780811;5554.833354999357;5621.959937411592;5656.462636049569;5708.457696518844;5503.642263252876;5597.496225339719;5754.223179870705;5782.3639399666;5795.565332600051;5027.673201241908;5502.119660854284;5630.408807075239;5683.2895888014;5695.943040569583;5580.804671836466;5584.274044374246;5597.832065038056;5608.327000759894;5661.46216109469;4699.919018625701;5492.517020404508;5530.751116199781;5533.557315414798;5540.972295138539;6145.293291271516;6178.876422471571;6238;6258.812235632939;6262;6824.0446337512785;6829.009793579953;6830.965845170792;6840.31596840317;6842.55523390978;6129.754809807602;6720.025596288559;6894.965525172342;6895.5173137880365;6919.273476285019;6207.81376558704;6211.2857021443115;6303.401176888188;6354.777582784581;6356.968215158987;7012.403945664573;7026.859462810818;7044.9432585112645;7064.046353742282;7110.431165506747;6430.517711171681;6442.903356449657;6540.6729663516635;6677.666116694146;6730.899036514456;6692.230393504809;6873.415759660485;6884.586924784428;6909.516333856582;6910.136232970879;5861.974154522942;6348.428641422294;6405.263394709668;6790.185177778698;6792.694328755218;6579.703913323912;6610.9669451652435;6731.663416829139;6754.324567543206;6799.422049125879;5437.444401131462;5445.237666726662;5455.890882182334;5462.8361149165585;5470.8085217017215;4843.733594652257;4844.4186697596515;4855.708657480563;4879.902401951941;4890.266460030953;5229.660072095302;6162.7843025494785;6332.4934005279465;6426.678666066678;6438.967805160944;6899.931000689929;6907.585544867324;6916.827079323057;6920.273371296042;6924.723011079601;6329.651869147149;6450.387213214737;6453.548251622341;6456.935430645727;6475.125858009108;5920;5984.611000284967;6055.6063855849225;6096.9390306096375;6141.508679305645;6971;7110.395616372666;7137.357637812622;7185.209626941137;7203.315685009916;6883.862322753617;6889.552179108342;6910.20532638753;6925.58446493212;6934.895976560457;7142.214356420894;7150.213476517683;7178.820529486805;7205.963970180115;7215.927840721735;6097.7865774697675;6495.350464953467;6580;6733;6781.796546103625;5132.153194722829;6884.208316043719;6912.135983002125;6920.688569014507;6927.965360173167;6344.651044192429;6478.190226221723;6609.041688955171;6680.3987641112535;6684.4652427804685;6350.1109844622715;6540.607563546202;6630.138082049302;6653.5009874260595;6662.500312476681;5638.126090455986;6301.968490157703;6355.3326900674765;6404.007378856285;6461.06314584392;6679.4990375721045;6688.565243259172;6688.632125233159;6689.130413046273;6693.431058360094;6450.903236451363;6489.221293444628;6496.7726129585235;6496.7726129585235;6502.447291980235 20:23:12 INFO - PID 1642 | |1;ext.html;755.4862693368507;805.6817557064958;834.5868794946502;1127.7631697343556;1139.9202055856094;36240.45639315409;37151.628483715154;37162;37354.4396834047;37570;39894.20211595766;40091;40178.79910600443;40186;40269.798651006706;8479.152084791533;8521.829563408728;8612.48325100493;8647.870281945776;8693.913060869374;8555.614997325136;8616.913830861673;8666.826663466727;8686.348523860735;8705.173008564208;8593.183647553473;8600.698975535857;8669.176428239307;8671.393002489829;8687.174718401742;8603.397762156652;8605.48367097973;8656.350773691967;8656.394052416334;8661.523616201106;8461.746147615582;8473.618687159093;8497.150284971514;8540.444871083422;8548.82902341956;27450.725492745016;38080.61919380799;38106.80946595277;38156.61843381559;38204.80897595522;3008.699130086996;3421.4525675891987;3423.0415483664615;3473.94789078164;3479.304139172176;30844.2288942776;30891.53662695039;30894.845525772453;30905.536416953764;30929.845350773103;3027.8788848446034;3047.817130972149;3065.708757668018;3081.984590077035;3087.289923317627;329797;345825;349983.75154360296;350998.4900150991;351863;49586.75206624016;49620.25569616459;49646;49661.25508117381;49789.751051244515;51500.7124821875;51834.74082629563;51867.703307417614;51870;51892.74053629783;13847.30763461843;14067.929660351632;14214.715705685829;14240.287985600678;14255.78616320756;11256.887431125748;11323.263987840764;11388.088952883749;11388.145889058354;11391.715207119889;13551.322433878464;13563.389647465889;13613.727725445435;13655.795163072562;13855.930720346536;5967.6419414835245;5969.582129250911;5974.940250597525;6024.789132380346;6030.849228769228;959.9952000239954;967.9951600241953;976.028851292968;976.9071938165863;1015.8628585141059;24028.92500074894;24107.638385424234;24216.636750448757;24260.87869560641;24275.028998839847;998.0219385002592;1061.8088744025995;1066.7973085113804;1101.124605938281;1103.5971870267294;10708.089812366035;11736.941315293368;12146.453409596412;12291.262524248574;12309.015278777677;450085.7495712566;452965;454829;455089.17366239533;457001.8599627989;42749.57250427518;44226;53538.73230633822;53813.192802108;53816.730916345165;1450.7751298548742;1452.7094581083825;1455.7306898223862;1462.5758530026385;1467.5744034229954;28316;28464;28963;29094.563581546718;29468.705312947455;32766.017019489453;36914.63085369112;36936;37005.81497092497;37133.25733485369;362362;362385;363800;364863;365163;31679.683203167675;31748;31769.36461270808;31830.204244894063;31837;37273;37359.25281494409;39662.61180858656;41053.79473102615;46297.53702463067;31827.840860795546;32993.01020969375;33423.33153336968;33714.15714607154;34111.317773644885;32463;32685.836570816995;33563.32873342568;33593.824216152316;33795;36386.45420318644;36878.26243475169;40655.59344406636;40695.38956915708;41104.38343424911;24383.293169478675;28061.298467538476;30466.39067218599;30501.389972199988;31100.37799243957;20770.584588307847;22845.65731514062;23508.529829402974;26014.089506867167;26303.342416439744 20:23:12 INFO - PID 1642 | |2;jquery.html;375.69071784829873;422.5162189293261;425.9723117997328;445.7414699474305;456.5183731163622;21466.570668586617;21643.242486512954;22360.776392236072;22586.54826903465;22872.88563557184;22009.559808803813;22793.77206227937;23075.42311442215;23106.30681079566;23422.06311747532;6171.969140154304;6231.22109736283;6426.710798014101;6432.42108210261;6434.806955791334;5740.971295143519;6394.944834102391;6398.584092034026;6409.134766806468;6409.647469389181;6082.148499210114;6263.968680156616;6319.273283572379;6349.142865713139;6362.777302794403;6286.811395658137;6328.240611126648;6329.272133704637;6336.841578960517;6352;5553.611247212697;5588.273524441837;5617.129344951539;5641.68970706611;5703.144528320744;27000.729992700017;27079.1876243713;27422;27498.725012749816;27598.034068807698;2188.7482939462006;2239.742429620598;2246.4608493961496;2247.449374903159;2253.256425379621;17165.914170429194;17665.646687066186;17875.642487150315;17890.373836915776;17942.013189274585;2104.3581707579183;2140.743110826695;2172.435166856613;2173.369722780392;2178.8692678439343;140128;140403;140706.29646851702;141548;141821.29089354488;12167.2699638022;12390.946769524511;12691.477022757328;12720.745585088247;12761.872381276069;13707;15911.204439778196;16107.033577985358;16139.596510087342;16147.919260403858;8611.397202195787;8803.295736341077;8852;8886.11138886119;8949.821003579891;7350.669219885011;8099;8318.70884519039;8343.791405214797;8488.74533763988;7669.233076692286;7836.764897053097;7904.9961014814;7930.484518506394;7975.7607271781935;2233.2754040071086;2234.3073647169103;2244.5510897820172;2250.6496102338465;2274.363178310076;818.3657665309314;932.7994481186578;970.6214576315243;999.2855108597242;1024.8975102489692;19381.51546211356;20593.691094633592;21094.472638183863;21098.367048988555;21126.04932777998;998.9450580218157;999.820032394176;1032.1175395037135;1035.7255327338262;1040.5265604150093;8889.888763904512;10675.354090689007;10824.404657743742;10986.230963832455;11043.282186657842;695662;712114;712955;729279;736698;149746;150346.58282805554;151015.24492377468;152007;152993;1189.9524019039316;1213.7269114449177;1232.3653318540958;1234.8888600025862;1236.4250623460134;17590.296388144332;18067.63864722672;18084.54788630295;18104.275828966693;18119;59109.5222619438;62074.20666070128;63146.36853631405;63278.36721632725;63745;67247.66376168087;83195.16804831874;84858;85728.57135714282;87511;8406.915930840612;8540.231379175904;8936.151065648754;8965.00476278344;8973.416727912665;13356.666083347995;13528;13635.25006124633;13717.862821372059;14073.014888957674;9691.2731545133;11634.243774154653;11716.297022178696;11765.47055382527;12014.519419223134;9810.068043535854;9947.05502977216;10653.680389588324;10681.57273709074;10786.460676966277;10214.693559193236;11475.655730328104;11854.703632408913;12017.339046352534;12176.147669663038;8247.628856701343;8513.82972340562;8528.829423411622;8661.740147795575;8701.912980870364;9186;9772.26707996889;10787.921207879463;11344.262622929484;11867.406629668309 20:23:12 INFO - PID 1642 | |3;mootools.html;1269.4731686350165;1285.7685616589015;1423.7721964485677;1439.7048605035975;1445.371263500378;11553.884461155387;11834.349110798903;11951.310955035124;12113.152079354437;12211.145219834616;10893.346399216032;11601.883981160207;12000.639980800568;12176.695582610417;12187;2137.700721898935;2180.563887222554;2190.0363839910387;2427.830051896368;2526.1916186820226;2163.080690706451;2336.9717324377307;2396.5805983952737;2426.1265944260053;2511.8116141289383;2228.65455854342;2380.071772008918;2484.8260621756485;2491.813114016456;2499.200255918107;2386.880655967195;2449.3998970252314;2452.730199678034;2464.852108873464;2479.355367604418;2181.8000099945125;2399.1003373734848;2489.166129346671;2490.066225165563;2507.059852555292;9508.572114254875;9830.21358291342;12069.879301206964;12083.516659333616;12084.577039803653;6464.482841372679;6672.2994085621285;6711.798646040578;6717.462602991749;6722.327767223287;3217.8069315841126;4135.441715368417;4198.454200953887;4213.094184750294;4223.239816832969;1229.3238718704765;1237.55448038706;1271.3071376100047;1273.7898246789268;1274.458355199046;15199.62000949974;15604.375824966988;16653.4171304005;16700.58248543784;16810.747838782427;4753.952460475351;5352.357717073976;5391.838244852661;5649.067903795828;5671.574631902624;12235;12301;12350.75298494043;12350.876491234972;12355.011599072053;6470.6441145737435;6503.674816259168;6525.314841941623;6536.934630653727;6541.738330466823;5974.671393073423;6110.480609148272;6169.321374648785;6199.690015499207;6251.6561589112125;4390.551118131009;4518.096380723869;4541.523140070245;4573.931391029138;4591.494935557086;1306.6994591243877;1313.5402609086743;1318.6044186743939;1330.1221194011905;1337.277869950216;668.3416834418094;759.0549765541936;761.5430741555023;781.6599779096111;821.8356328734277;4687.484376718558;6031.7587296507645;6089.756409743561;6314.873702525923;6408.935910640927;544.7466927878477;838.3963546246692;899.59967814322;900.6712549919232;919.9678011269707;4163.357855990609;4180.581941805795;4379.080393117417;4476.9104617908115;4494.5730155635165;15138.772918406232;15309.6172595686;15550.377984880479;15689.215539222992;15736.60658483547;15191.240437978056;15392.846071539141;15407.306671199598;15556.844431555766;15624.609384765472;9853.162481189036;10871.184661150446;10979.407985841848;11336.392629695216;11375.374354410587;6218.875622487615;6687.3647003536535;6813.625250611264;6887.724491020504;7146.32109949554;13704.794428083786;13966.860331396962;14145.080569763344;14285.28573571338;14296.141501604725;13293.468261269441;13920.860791391957;14135.787963180355;14460.566183014527;14584.854151458774;8056.677732890619;9607.423554586747;9614.230861531201;9684.176844968257;9713.36863103896;10733.463326833784;10829.24195306321;10836.837447438136;10880.020798128206;10891.564337426415;9087.09129087086;9140.040295769115;9203.677871274473;9236.445813251226;9382.390144640576;8940.910590894007;8942.86585701228;8946.194842464209;9008.234300084567;9033.954830225806;8055.7583272501915;8208.876866847122;8230.259276665129;8231.46495477816;8233.382496312921;5324.440933701905;5923.970380148072;6088.086786981989;6121.3572574879;6171.84570385744;4682.836100736458;6013.579049466495;6062.696865156637;6110.419510146529;6423.518236132215 20:23:12 INFO - PID 1642 | |4;prototype.html;337.1806510180262;360.56731921693955;375.16338565000046;383.67387720437625;383.90594304395427;6151.56939014268;6252.499800015999;6269.279032911217;6309.337519560443;6340.3025667176635;6025.457708806207;6061.605995610283;6116.26907586372;6130.601510901788;6172.691365431733;3815;4111.897202569945;4451.775761665535;4451.844185453509;4482.731036137842;4359.891002724941;4373.584509471611;4411.433940950948;4484.4842843072975;4502.819887204524;3419.81191034493;4386.40783494229;4398.538153493885;4401.691881568291;4407.515173330931;4173.373993900939;4415.094905544372;4428.0701052778795;4439.289713645801;4486.55134486552;3744.4570537271943;3773.1510410157493;3797.487339209199;3813.504244448232;3816.542014958195;4737.976310118427;4863.708177509361;5295.80844310031;5684.403137670526;5869.295684517842;4924.433690125646;5299.920501192485;5323.095073837457;5327.786888524454;5352.919706204371;4963.106640804654;6301.7164227609865;6415;6416.390442907917;6445.226572811246;3598.460230965376;4295.441592592974;4312.547182545819;4313.978430107861;4330.913381732347;5897.8820423591715;6562.44219241365;6751.223609284897;6855.880574338664;6948.583085014915;4199.70602057853;4328.761918094472;4369.541198174209;4372.366006929041;4391.6486681065435;3910.8240129194255;3910.9804450977563;4284.421603083606;4308.956910430856;4444.11117776446;5059.671121377099;5278.81524146653;5285.286486324297;5299;5300.946990530122;5894.616849904743;5896.616719913278;6198.698273362555;6541.411272985359;6642.96678516614;1280.7246442015012;1383.190833362474;1489.1511838252093;1496.6156305417662;1509.8414666460083;901.9439412896083;951.9333646644668;986.2307400227834;987.2398253345028;995.5868314649484;5537.889242215133;6226.40849119333;6227.314995350508;6231.626102433868;6269.310375858652;5770.19217309577;5896;6461.289258181596;6779.966100169566;6797.1843378794865;5278.445763194809;5438.238646589481;5457.508824205841;5752.338481074647;6004.42957918997;3301.7853839500835;3528.2414280929725;3554.804485753308;3569.196930690626;3571.9819851342245;6676.162630881856;6918.028361916829;7062.15254169503;7074.93875918606;7159.96420017907;6285.9057114143325;6559.737610495622;6943.236244013155;7010.894836577456;7036.753713619999;6304.959681652476;6674.2658307586125;6971.58170509771;7123.572585644878;7145.4998150128995;6759.817032019475;6773.424258938046;6783.21992970795;6795.38841504267;6838.14523184602;5715.542756579547;6054.424829641177;6424.293327734039;6721.563098398588;6742.595444273359;6351.809445716636;6793.626350550767;6896.069030680995;6992.510524263253;7055.964720176366;4138.213739389506;4339.826406943687;4354.412154359121;4356.847510337123;4365.541618130051;5655.717214139194;5687.60186786921;5721.342045664635;6273.62358258506;6914.4096857722;5827.475527202572;6465.286699024856;6560.245571759308;6590.80227593173;6597.80206593803;6042.184305118929;6256.748650270055;6551.312112228147;6571.408573228432;6577.059767368542;5482.753276102505;6125.571210015256;6363.7772677956045;6378.712957916998;6440.293322269696;6265.248170219603;6433.742650293936;6522.836929076811;6539.247986481616;6618.238902526271;5331.600129990344;6205.348438413902;6357.904631430625;6368.4586810121655;6407.711652975534 20:23:12 INFO - PID 1642 | |5;yui.html;788.5347644889514;822.1901427094315;836.1304243586669;842.7653487640605;850.5832142250299;15984;16305.338670682879;16347.83652163478;16808.66382672349;16902.57743556412;15185.848141518582;15316.004459710139;15459.768103478456;15669.921650391761;15817;963.8313295173334;983.7147227304073;983.8081574093055;987.7678745494838;990.6730778842965;948.250881803378;985.6796541124128;1005.1104772276515;1005.9547320370564;1006.6828948881116;1058.1059005140644;1068.9091427228695;1071.287593750155;1072.383379556754;1073.2433634287809;1052.489542571856;1057.1701214546583;1066.1470823341374;1066.9679909602723;1067.524951396629;772.7643068863994;780.4224873593556;782.9921700783033;789.8459800338936;790.8102055506637;16561;16948.406805761864;16977.405790797264;17013.65972680552;17185.91407042969;13593.864061359458;14470.625290597482;14801.185934773583;14819.925900370537;15031.849681503154;13217.405216765268;13443.126196797275;13723;13734.862651373458;13958.022938394317;3454.5509083818943;3501.124718820295;3502.439609662442;3507.94738078929;3520.06718219672;106686;109007;111293.63654996996;111981.44009279984;113249;8250.793730156794;11147.163962702829;11389.658310250707;11856.940715296369;11981.580644677395;23998.280051598478;24167.63748543773;24282.757172428403;24476.898539565405;24650.50698986046;8175.591220438954;8220.917790822015;8350.33197344211;8451.11263317355;8481.533515656698;4213.578642135762;4308.202982448257;4319.913601727948;4365.345198220292;4409.735415875058;4237.364395340724;4331.285337919208;4333.739975601411;4337.306031035019;4353.0423306872435;786.3944762532932;866.2420382165606;958.3148049144895;964.1900803325241;965.9468729219819;545.5880809988513;626.4236902050125;635.706337602985;647.355880898509;673.1787219592089;10287.948560257151;11019.944900275448;11066.612668556561;11358.864113588575;11501.827472587918;585.3707264690474;620.6245221640843;629.3926361061598;649.6459429610874;661.1966460750211;4550.908981820345;4678.204705200124;4844.4186697596515;4859.1496488114435;4865;96878;99292.50353748185;99507;100706;102081;88408;89486.65770013454;89621;90216;90230;73754.63122684459;75916;77610.22389776143;78928;79013.60493197497;9254.88941327018;9663.178629816262;9687.225021998082;9688.273379496424;9803.215742740706;38297.61702383052;38476.2304753909;39114.044297785564;39339.80330098446;39386.606133939444;69635.65182174057;71416.21459463554;71881;72548.54902902019;72862;13716.451341946211;13768.380422881195;13789.379477923718;13990.16059036461;14369.425222990963;15057.096574205583;15122.092674439129;15130.092194468367;15248.77126843076;15351.385944562538;13767.862321376659;13986.580402587939;14037.929810350883;14088.859111408754;14271.429142834171;13588.45646174142;13927.23400212998;14243.430262789372;14313.856861431252;14703.852961470677;11021.724456888642;11909.52361905514;13505.189688618715;13759.17444953266;13829.51596694111;8686.34852386061;8732.56337183151;9867.753306167404;10332.483375831329;10904.50929708181;10542.631007914686;11352.432378381212;11425.690582914847;11476.4261786912;11479.311241325548 20:23:12 INFO - PID 1642 | __end_tp_report 20:23:12 INFO - PID 1642 | __start_cc_report 20:23:12 INFO - PID 1642 | _x_x_mozilla_cycle_collect,425 20:23:12 INFO - PID 1642 | __end_cc_report 20:23:12 INFO - PID 1642 | __startTimestamp1491448992758__endTimestamp 20:23:12 INFO - PID 1642 | 20:23:12 INFO - PID 1642 | ------- Summary: start ------- 20:23:12 INFO - PID 1642 | Number of tests: 6 20:23:12 INFO - PID 1642 | 20:23:12 INFO - PID 1642 | [#0] dojo.html Cycles:165 Average:6234.55 Median:6430.52 stddev:765.13 (11.9%) stddev-sans-first:728.20 20:23:12 INFO - PID 1642 | Values: 3149.7 3596.3 3632.5 3651.0 3655.9 6144.4 6256.8 6269.4 6292.8 6320.6 5112.9 5771.6 5990.7 6189.4 6222.2 5540.3 5554.8 5622.0 5656.5 5708.5 5503.6 5597.5 5754.2 5782.4 5795.6 5027.7 5502.1 5630.4 5683.3 5695.9 5580.8 5584.3 5597.8 5608.3 5661.5 4699.9 5492.5 5530.8 5533.6 5541.0 6145.3 6178.9 6238.0 6258.8 6262.0 6824.0 6829.0 6831.0 6840.3 6842.6 6129.8 6720.0 6895.0 6895.5 6919.3 6207.8 6211.3 6303.4 6354.8 6357.0 7012.4 7026.9 7044.9 7064.0 7110.4 6430.5 6442.9 6540.7 6677.7 6730.9 6692.2 6873.4 6884.6 6909.5 6910.1 5862.0 6348.4 6405.3 6790.2 6792.7 6579.7 6611.0 6731.7 6754.3 6799.4 5437.4 5445.2 5455.9 5462.8 5470.8 4843.7 4844.4 4855.7 4879.9 4890.3 5229.7 6162.8 6332.5 6426.7 6439.0 6899.9 6907.6 6916.8 6920.3 6924.7 6329.7 6450.4 6453.5 6456.9 6475.1 5920.0 5984.6 6055.6 6096.9 6141.5 6971.0 7110.4 7137.4 7185.2 7203.3 6883.9 6889.6 6910.2 6925.6 6934.9 7142.2 7150.2 7178.8 7206.0 7215.9 6097.8 6495.4 6580.0 6733.0 6781.8 5132.2 6884.2 6912.1 6920.7 6928.0 6344.7 6478.2 6609.0 6680.4 6684.5 6350.1 6540.6 6630.1 6653.5 6662.5 5638.1 6302.0 6355.3 6404.0 6461.1 6679.5 6688.6 6688.6 6689.1 6693.4 6450.9 6489.2 6496.8 6496.8 6502.4 20:23:12 INFO - PID 1642 | 20:23:12 INFO - PID 1642 | [#1] ext.html Cycles:180 Average:52474.89 Median:199312.73 stddev:103481.49 (51.9%) stddev-sans-first:103698.92 20:23:12 INFO - PID 1642 | Values: 755.5 805.7 834.6 1127.8 1139.9 36240.5 37151.6 37162.0 37354.4 37570.0 39894.2 40091.0 40178.8 40186.0 40269.8 8479.2 8521.8 8612.5 8647.9 8693.9 8555.6 8616.9 8666.8 8686.3 8705.2 8593.2 8600.7 8669.2 8671.4 8687.2 8603.4 8605.5 8656.4 8656.4 8661.5 8461.7 8473.6 8497.2 8540.4 8548.8 27450.7 38080.6 38106.8 38156.6 38204.8 3008.7 3421.5 3423.0 3473.9 3479.3 30844.2 30891.5 30894.8 30905.5 30929.8 3027.9 3047.8 3065.7 3082.0 3087.3 329797.0 345825.0 349983.8 350998.5 351863.0 49586.8 49620.3 49646.0 49661.3 49789.8 51500.7 51834.7 51867.7 51870.0 51892.7 13847.3 14067.9 14214.7 14240.3 14255.8 11256.9 11323.3 11388.1 11388.1 11391.7 13551.3 13563.4 13613.7 13655.8 13855.9 5967.6 5969.6 5974.9 6024.8 6030.8 960.0 968.0 976.0 976.9 1015.9 24028.9 24107.6 24216.6 24260.9 24275.0 998.0 1061.8 1066.8 1101.1 1103.6 10708.1 11736.9 12146.5 12291.3 12309.0 450085.7 452965.0 454829.0 455089.2 457001.9 42749.6 44226.0 53538.7 53813.2 53816.7 1450.8 1452.7 1455.7 1462.6 1467.6 28316.0 28464.0 28963.0 29094.6 29468.7 32766.0 36914.6 36936.0 37005.8 37133.3 362362.0 362385.0 363800.0 364863.0 365163.0 31679.7 31748.0 31769.4 31830.2 31837.0 37273.0 37359.3 39662.6 41053.8 46297.5 31827.8 32993.0 33423.3 33714.2 34111.3 32463.0 32685.8 33563.3 33593.8 33795.0 36386.5 36878.3 40655.6 40695.4 41104.4 24383.3 28061.3 30466.4 30501.4 31100.4 20770.6 22845.7 23508.5 26014.1 26303.3 20:23:12 INFO - PID 1642 | 20:23:12 INFO - PID 1642 | [#2] jquery.html Cycles:180 Average:40599.19 Median:23090.86 stddev:119748.58 (518.6%) stddev-sans-first:120046.42 20:23:12 INFO - PID 1642 | Values: 375.7 422.5 426.0 445.7 456.5 21466.6 21643.2 22360.8 22586.5 22872.9 22009.6 22793.8 23075.4 23106.3 23422.1 6172.0 6231.2 6426.7 6432.4 6434.8 5741.0 6394.9 6398.6 6409.1 6409.6 6082.1 6264.0 6319.3 6349.1 6362.8 6286.8 6328.2 6329.3 6336.8 6352.0 5553.6 5588.3 5617.1 5641.7 5703.1 27000.7 27079.2 27422.0 27498.7 27598.0 2188.7 2239.7 2246.5 2247.4 2253.3 17165.9 17665.6 17875.6 17890.4 17942.0 2104.4 2140.7 2172.4 2173.4 2178.9 140128.0 140403.0 140706.3 141548.0 141821.3 12167.3 12390.9 12691.5 12720.7 12761.9 13707.0 15911.2 16107.0 16139.6 16147.9 8611.4 8803.3 8852.0 8886.1 8949.8 7350.7 8099.0 8318.7 8343.8 8488.7 7669.2 7836.8 7905.0 7930.5 7975.8 2233.3 2234.3 2244.6 2250.6 2274.4 818.4 932.8 970.6 999.3 1024.9 19381.5 20593.7 21094.5 21098.4 21126.0 998.9 999.8 1032.1 1035.7 1040.5 8889.9 10675.4 10824.4 10986.2 11043.3 695662.0 712114.0 712955.0 729279.0 736698.0 149746.0 150346.6 151015.2 152007.0 152993.0 1190.0 1213.7 1232.4 1234.9 1236.4 17590.3 18067.6 18084.5 18104.3 18119.0 59109.5 62074.2 63146.4 63278.4 63745.0 67247.7 83195.2 84858.0 85728.6 87511.0 8406.9 8540.2 8936.2 8965.0 8973.4 13356.7 13528.0 13635.3 13717.9 14073.0 9691.3 11634.2 11716.3 11765.5 12014.5 9810.1 9947.1 10653.7 10681.6 10786.5 10214.7 11475.7 11854.7 12017.3 12176.1 8247.6 8513.8 8528.8 8661.7 8701.9 9186.0 9772.3 10787.9 11344.3 11867.4 20:23:12 INFO - PID 1642 | 20:23:12 INFO - PID 1642 | [#3] mootools.html Cycles:180 Average:7202.39 Median:2519.00 stddev:4664.37 (185.2%) stddev-sans-first:4656.15 20:23:12 INFO - PID 1642 | Values: 1269.5 1285.8 1423.8 1439.7 1445.4 11553.9 11834.3 11951.3 12113.2 12211.1 10893.3 11601.9 12000.6 12176.7 12187.0 2137.7 2180.6 2190.0 2427.8 2526.2 2163.1 2337.0 2396.6 2426.1 2511.8 2228.7 2380.1 2484.8 2491.8 2499.2 2386.9 2449.4 2452.7 2464.9 2479.4 2181.8 2399.1 2489.2 2490.1 2507.1 9508.6 9830.2 12069.9 12083.5 12084.6 6464.5 6672.3 6711.8 6717.5 6722.3 3217.8 4135.4 4198.5 4213.1 4223.2 1229.3 1237.6 1271.3 1273.8 1274.5 15199.6 15604.4 16653.4 16700.6 16810.7 4754.0 5352.4 5391.8 5649.1 5671.6 12235.0 12301.0 12350.8 12350.9 12355.0 6470.6 6503.7 6525.3 6536.9 6541.7 5974.7 6110.5 6169.3 6199.7 6251.7 4390.6 4518.1 4541.5 4573.9 4591.5 1306.7 1313.5 1318.6 1330.1 1337.3 668.3 759.1 761.5 781.7 821.8 4687.5 6031.8 6089.8 6314.9 6408.9 544.7 838.4 899.6 900.7 920.0 4163.4 4180.6 4379.1 4476.9 4494.6 15138.8 15309.6 15550.4 15689.2 15736.6 15191.2 15392.8 15407.3 15556.8 15624.6 9853.2 10871.2 10979.4 11336.4 11375.4 6218.9 6687.4 6813.6 6887.7 7146.3 13704.8 13966.9 14145.1 14285.3 14296.1 13293.5 13920.9 14135.8 14460.6 14584.9 8056.7 9607.4 9614.2 9684.2 9713.4 10733.5 10829.2 10836.8 10880.0 10891.6 9087.1 9140.0 9203.7 9236.4 9382.4 8940.9 8942.9 8946.2 9008.2 9034.0 8055.8 8208.9 8230.3 8231.5 8233.4 5324.4 5924.0 6088.1 6121.4 6171.8 4682.8 6013.6 6062.7 6110.4 6423.5 20:23:12 INFO - PID 1642 | 20:23:12 INFO - PID 1642 | [#4] prototype.html Cycles:180 Average:5211.09 Median:5896.31 stddev:1668.47 (28.3%) stddev-sans-first:1632.56 20:23:12 INFO - PID 1642 | Values: 337.2 360.6 375.2 383.7 383.9 6151.6 6252.5 6269.3 6309.3 6340.3 6025.5 6061.6 6116.3 6130.6 6172.7 3815.0 4111.9 4451.8 4451.8 4482.7 4359.9 4373.6 4411.4 4484.5 4502.8 3419.8 4386.4 4398.5 4401.7 4407.5 4173.4 4415.1 4428.1 4439.3 4486.6 3744.5 3773.2 3797.5 3813.5 3816.5 4738.0 4863.7 5295.8 5684.4 5869.3 4924.4 5299.9 5323.1 5327.8 5352.9 4963.1 6301.7 6415.0 6416.4 6445.2 3598.5 4295.4 4312.5 4314.0 4330.9 5897.9 6562.4 6751.2 6855.9 6948.6 4199.7 4328.8 4369.5 4372.4 4391.6 3910.8 3911.0 4284.4 4309.0 4444.1 5059.7 5278.8 5285.3 5299.0 5300.9 5894.6 5896.6 6198.7 6541.4 6643.0 1280.7 1383.2 1489.2 1496.6 1509.8 901.9 951.9 986.2 987.2 995.6 5537.9 6226.4 6227.3 6231.6 6269.3 5770.2 5896.0 6461.3 6780.0 6797.2 5278.4 5438.2 5457.5 5752.3 6004.4 3301.8 3528.2 3554.8 3569.2 3572.0 6676.2 6918.0 7062.2 7074.9 7160.0 6285.9 6559.7 6943.2 7010.9 7036.8 6305.0 6674.3 6971.6 7123.6 7145.5 6759.8 6773.4 6783.2 6795.4 6838.1 5715.5 6054.4 6424.3 6721.6 6742.6 6351.8 6793.6 6896.1 6992.5 7056.0 4138.2 4339.8 4354.4 4356.8 4365.5 5655.7 5687.6 5721.3 6273.6 6914.4 5827.5 6465.3 6560.2 6590.8 6597.8 6042.2 6256.7 6551.3 6571.4 6577.1 5482.8 6125.6 6363.8 6378.7 6440.3 6265.2 6433.7 6522.8 6539.2 6618.2 5331.6 6205.3 6357.9 6368.5 6407.7 20:23:12 INFO - PID 1642 | 20:23:12 INFO - PID 1642 | [#5] yui.html Cycles:180 Average:20680.52 Median:14052.53 stddev:29354.66 (208.9%) stddev-sans-first:29399.01 20:23:12 INFO - PID 1642 | Values: 788.5 822.2 836.1 842.8 850.6 15984.0 16305.3 16347.8 16808.7 16902.6 15185.8 15316.0 15459.8 15669.9 15817.0 963.8 983.7 983.8 987.8 990.7 948.3 985.7 1005.1 1006.0 1006.7 1058.1 1068.9 1071.3 1072.4 1073.2 1052.5 1057.2 1066.1 1067.0 1067.5 772.8 780.4 783.0 789.8 790.8 16561.0 16948.4 16977.4 17013.7 17185.9 13593.9 14470.6 14801.2 14819.9 15031.8 13217.4 13443.1 13723.0 13734.9 13958.0 3454.6 3501.1 3502.4 3507.9 3520.1 106686.0 109007.0 111293.6 111981.4 113249.0 8250.8 11147.2 11389.7 11856.9 11981.6 23998.3 24167.6 24282.8 24476.9 24650.5 8175.6 8220.9 8350.3 8451.1 8481.5 4213.6 4308.2 4319.9 4365.3 4409.7 4237.4 4331.3 4333.7 4337.3 4353.0 786.4 866.2 958.3 964.2 965.9 545.6 626.4 635.7 647.4 673.2 10287.9 11019.9 11066.6 11358.9 11501.8 585.4 620.6 629.4 649.6 661.2 4550.9 4678.2 4844.4 4859.1 4865.0 96878.0 99292.5 99507.0 100706.0 102081.0 88408.0 89486.7 89621.0 90216.0 90230.0 73754.6 75916.0 77610.2 78928.0 79013.6 9254.9 9663.2 9687.2 9688.3 9803.2 38297.6 38476.2 39114.0 39339.8 39386.6 69635.7 71416.2 71881.0 72548.5 72862.0 13716.5 13768.4 13789.4 13990.2 14369.4 15057.1 15122.1 15130.1 15248.8 15351.4 13767.9 13986.6 14037.9 14088.9 14271.4 13588.5 13927.2 14243.4 14313.9 14703.9 11021.7 11909.5 13505.2 13759.2 13829.5 8686.3 8732.6 9867.8 10332.5 10904.5 10542.6 11352.4 11425.7 11476.4 11479.3 20:23:12 INFO - PID 1642 | -------- Summary: end -------- 20:23:12 INFO - PID 1642 | 20:23:13 INFO - TEST-INFO | 1642: exit 0 20:23:13 INFO - TEST-OK | dromaeo_css | took 1117769ms 20:23:13 INFO - TEST-START | kraken 20:23:13 INFO - operating with platform_type : mac_ 20:23:13 INFO - Initialising browser for kraken test... 20:23:13 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmpxid3Yc/profile http://localhost:49242/getInfo.html) 20:23:16 INFO - PID 1652 | 2017-04-05 20:23:16.107 plugin-container[1653:10208] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 20:23:16 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:23:16 INFO - PID 1652 | 2017-04-05 20:23:16.111 plugin-container[1653:10208] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x900b, name = 'com.apple.CFPasteboardClient' 20:23:16 INFO - PID 1652 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:23:16 INFO - PID 1652 | 2017-04-05 20:23:16.111 plugin-container[1653:10208] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:23:16 INFO - PID 1652 | __metrics Screen width/height:1600/1200 20:23:16 INFO - PID 1652 | colorDepth:24 20:23:16 INFO - PID 1652 | Browser inner width/height: 1024/689 20:23:16 INFO - PID 1652 | __metrics 20:23:16 ERROR - PID 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 20:23:17 INFO - TEST-INFO | 1652: exit 0 20:23:17 INFO - Browser initialized. 20:23:17 INFO - Running cycle 1/1 for kraken test... 20:23:17 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/T/tmpxid3Yc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:23:19 INFO - PID 1654 | 2017-04-05 20:23:19.959 plugin-container[1655:10332] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4643, name = 'com.apple.tsm.portname' 20:23:19 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:23:19 INFO - PID 1654 | 2017-04-05 20:23:19.960 plugin-container[1655:10332] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 20:23:19 INFO - PID 1654 | See /usr/include/servers/bootstrap_defs.h for the error codes. 20:23:19 INFO - PID 1654 | 2017-04-05 20:23:19.960 plugin-container[1655:10332] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 20:23:29 INFO - PID 1654 | RSS: Main: 250368000 20:23:29 INFO - PID 1654 | 20:23:32 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 20:23:33 INFO - PID 1654 | RSS: Main: 260030464 20:23:33 INFO - PID 1654 | 20:23:36 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 20:23:36 INFO - PID 1654 | RSS: Main: 266731520 20:23:36 INFO - PID 1654 | 20:23:40 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 20:23:41 INFO - PID 1654 | RSS: Main: 262778880 20:23:41 INFO - PID 1654 | 20:23:43 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 20:23:43 INFO - PID 1654 | RSS: Main: 264720384 20:23:43 INFO - PID 1654 | 20:23:45 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:23:46 INFO - PID 1654 | RSS: Main: 265416704 20:23:46 INFO - PID 1654 | 20:23:49 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 20:23:50 INFO - PID 1654 | RSS: Main: 271155200 20:23:50 INFO - PID 1654 | 20:23:53 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 20:23:53 INFO - PID 1654 | RSS: Main: 271523840 20:23:53 INFO - PID 1654 | 20:23:57 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 20:23:57 INFO - PID 1654 | RSS: Main: 271339520 20:23:57 INFO - PID 1654 | 20:23:59 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:23:59 INFO - PID 1654 | RSS: Main: 270987264 20:23:59 INFO - PID 1654 | 20:24:01 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:24:02 INFO - PID 1654 | RSS: Main: 270983168 20:24:02 INFO - PID 1654 | 20:24:04 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:24:05 INFO - PID 1654 | RSS: Main: 271036416 20:24:05 INFO - PID 1654 | 20:24:08 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:24:09 INFO - PID 1654 | RSS: Main: 271585280 20:24:09 INFO - PID 1654 | 20:24:12 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:24:13 INFO - PID 1654 | RSS: Main: 271065088 20:24:13 INFO - PID 1654 | 20:24:14 INFO - PID 1654 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 20:24:15 INFO - PID 1654 | RSS: Main: 274247680 20:24:15 INFO - PID 1654 | 20:24:15 INFO - PID 1654 | __start_tp_report 20:24:15 INFO - PID 1654 | _x_x_mozilla_page_load 20:24:15 INFO - PID 1654 | _x_x_mozilla_page_load_details 20:24:15 INFO - PID 1654 | |i|pagename|runs| 20:24:15 INFO - PID 1654 | |0;ai-astar;111;124;125;124;121;123;125;126;122;123 20:24:15 INFO - PID 1654 | |1;audio-beat-detection;159;128;157;196;152;119;119;121;142;119 20:24:15 INFO - PID 1654 | |2;audio-dft;220;247;252;229;232;218;222;277;238;213 20:24:15 INFO - PID 1654 | |3;audio-fft;81;59;62;88;60;60;62;59;97;85 20:24:15 INFO - PID 1654 | |4;audio-oscillator;94;74;87;74;72;74;86;72;71;85 20:24:15 INFO - PID 1654 | |5;imaging-gaussian-blur;93;85;136;134;93;93;94;93;93;93 20:24:15 INFO - PID 1654 | |6;imaging-darkroom;102;103;127;138;102;104;103;103;102;104 20:24:15 INFO - PID 1654 | |7;imaging-desaturate;104;102;102;103;103;103;102;101;154;104 20:24:15 INFO - PID 1654 | |8;json-parse-financial;51;52;52;52;53;54;53;54;53;53 20:24:15 INFO - PID 1654 | |9;json-stringify-tinderbox;58;64;72;72;65;59;60;58;59;60 20:24:15 INFO - PID 1654 | |10;stanford-crypto-aes;88;87;87;88;111;80;114;105;111;87 20:24:15 INFO - PID 1654 | |11;stanford-crypto-ccm;160;169;185;186;166;156;142;159;202;163 20:24:15 INFO - PID 1654 | |12;stanford-crypto-pbkdf2;194;197;195;193;196;198;195;223;190;196 20:24:15 INFO - PID 1654 | |13;stanford-crypto-sha256-iterative;72;72;70;71;72;72;70;69;69;74 20:24:15 INFO - PID 1654 | __end_tp_report 20:24:15 INFO - PID 1654 | __start_cc_report 20:24:15 INFO - PID 1654 | _x_x_mozilla_cycle_collect,1023 20:24:15 INFO - PID 1654 | __end_cc_report 20:24:15 INFO - PID 1654 | __startTimestamp1491449055196__endTimestamp 20:24:15 INFO - PID 1654 | 20:24:15 INFO - PID 1654 | ------- Summary: start ------- 20:24:15 INFO - PID 1654 | Number of tests: 14 20:24:15 INFO - PID 1654 | 20:24:15 INFO - PID 1654 | [#0] ai-astar Cycles:10 Average:122.40 Median:124.00 stddev:4.27 (3.4%) stddev-sans-first:1.58 20:24:15 INFO - PID 1654 | Values: 111.0 124.0 125.0 124.0 121.0 123.0 125.0 126.0 122.0 123.0 20:24:15 INFO - PID 1654 | 20:24:15 INFO - PID 1654 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:147.00 stddev:25.27 (17.2%) stddev-sans-first:25.97 20:24:15 INFO - PID 1654 | Values: 159.0 128.0 157.0 196.0 152.0 119.0 119.0 121.0 142.0 119.0 20:24:15 INFO - PID 1654 | 20:24:15 INFO - PID 1654 | [#2] audio-dft Cycles:10 Average:234.80 Median:235.00 stddev:19.49 (8.3%) stddev-sans-first:19.92 20:24:15 INFO - PID 1654 | Values: 220.0 247.0 252.0 229.0 232.0 218.0 222.0 277.0 238.0 213.0 20:24:15 INFO - PID 1654 | 20:24:15 INFO - PID 1654 | [#3] audio-fft Cycles:10 Average:71.30 Median:71.50 stddev:14.73 (20.6%) stddev-sans-first:15.20 20:24:15 INFO - PID 1654 | Values: 81.0 59.0 62.0 88.0 60.0 60.0 62.0 59.0 97.0 85.0 20:24:15 INFO - PID 1654 | 20:24:15 INFO - PID 1654 | [#4] audio-oscillator Cycles:10 Average:78.90 Median:79.50 stddev:8.24 (10.4%) stddev-sans-first:6.69 20:24:15 INFO - PID 1654 | Values: 94.0 74.0 87.0 74.0 72.0 74.0 86.0 72.0 71.0 85.0 20:24:15 INFO - PID 1654 | 20:24:15 INFO - PID 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:100.70 Median:93.00 stddev:18.26 (19.6%) stddev-sans-first:19.16 20:24:15 INFO - PID 1654 | Values: 93.0 85.0 136.0 134.0 93.0 93.0 94.0 93.0 93.0 93.0 20:24:15 INFO - PID 1654 | 20:24:15 INFO - PID 1654 | [#6] imaging-darkroom Cycles:10 Average:108.80 Median:103.50 stddev:12.78 (12.3%) stddev-sans-first:13.31 20:24:15 INFO - PID 1654 | Values: 102.0 103.0 127.0 138.0 102.0 104.0 103.0 103.0 102.0 104.0 20:24:15 INFO - PID 1654 | 20:24:15 INFO - PID 1654 | [#7] imaging-desaturate Cycles:10 Average:107.80 Median:103.00 stddev:16.26 (15.8%) stddev-sans-first:17.19 20:24:15 INFO - PID 1654 | Values: 104.0 102.0 102.0 103.0 103.0 103.0 102.0 101.0 154.0 104.0 20:24:15 INFO - PID 1654 | 20:24:15 INFO - PID 1654 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:53.00 stddev:0.95 (1.8%) stddev-sans-first:0.78 20:24:15 INFO - PID 1654 | Values: 51.0 52.0 52.0 52.0 53.0 54.0 53.0 54.0 53.0 53.0 20:24:15 INFO - PID 1654 | 20:24:15 INFO - PID 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:62.70 Median:62.00 stddev:5.44 (8.8%) stddev-sans-first:5.49 20:24:15 INFO - PID 1654 | Values: 58.0 64.0 72.0 72.0 65.0 59.0 60.0 58.0 59.0 60.0 20:24:15 INFO - PID 1654 | 20:24:15 INFO - PID 1654 | [#10] stanford-crypto-aes Cycles:10 Average:95.80 Median:87.00 stddev:12.83 (14.7%) stddev-sans-first:13.29 20:24:15 INFO - PID 1654 | Values: 88.0 87.0 87.0 88.0 111.0 80.0 114.0 105.0 111.0 87.0 20:24:15 INFO - PID 1654 | 20:24:15 INFO - PID 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:168.80 Median:167.50 stddev:17.50 (10.5%) stddev-sans-first:18.27 20:24:15 INFO - PID 1654 | Values: 160.0 169.0 185.0 186.0 166.0 156.0 142.0 159.0 202.0 163.0 20:24:15 INFO - PID 1654 | 20:24:15 INFO - PID 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.70 Median:196.00 stddev:9.17 (4.7%) stddev-sans-first:9.62 20:24:15 INFO - PID 1654 | Values: 194.0 197.0 195.0 193.0 196.0 198.0 195.0 223.0 190.0 196.0 20:24:15 INFO - PID 1654 | 20:24:15 INFO - PID 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.10 Median:72.00 stddev:1.60 (2.2%) stddev-sans-first:1.66 20:24:15 INFO - PID 1654 | Values: 72.0 72.0 70.0 71.0 72.0 72.0 70.0 69.0 69.0 74.0 20:24:15 INFO - PID 1654 | -------- Summary: end -------- 20:24:15 INFO - PID 1654 | 20:24:16 INFO - TEST-INFO | 1654: exit 0 20:24:16 INFO - TEST-OK | kraken | took 62886ms 20:24:16 INFO - SUITE-END | took 1180s 20:24:16 INFO - Completed test suite (00:19:40) 20:24:16 INFO - javascript benchmark 20:24:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7830.137027913321, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3149.653538110808, 3596.2627661329448, 3632.4551317302416, 3650.981745091274, 3655.92688146237, 6144.402455361605, 6256.811205870887, 6269.435750782429, 6292.811215663526, 6320.589161704497, 5112.872178195547, 5771.595988280822, 5990.670513121777, 6189.381061893809, 6222.191115155035, 5540.335159780811, 5554.833354999357, 5621.959937411592, 5656.462636049569, 5708.457696518844, 5503.642263252876, 5597.496225339719, 5754.223179870705, 5782.3639399666, 5795.565332600051, 5027.673201241908, 5502.119660854284, 5630.408807075239, 5683.2895888014, 5695.943040569583, 5580.804671836466, 5584.274044374246, 5597.832065038056, 5608.327000759894, 5661.46216109469, 4699.919018625701, 5492.517020404508, 5530.751116199781, 5533.557315414798, 5540.972295138539, 6145.293291271516, 6178.876422471571, 6238.0, 6258.812235632939, 6262.0, 6824.0446337512785, 6829.009793579953, 6830.965845170792, 6840.31596840317, 6842.55523390978, 6129.754809807602, 6720.025596288559, 6894.965525172342, 6895.5173137880365, 6919.273476285019, 6207.81376558704, 6211.2857021443115, 6303.401176888188, 6354.777582784581, 6356.968215158987, 7012.403945664573, 7026.859462810818, 7044.9432585112645, 7064.046353742282, 7110.431165506747, 6430.517711171681, 6442.903356449657, 6540.6729663516635, 6677.666116694146, 6730.899036514456, 6692.230393504809, 6873.415759660485, 6884.586924784428, 6909.516333856582, 6910.136232970879, 5861.974154522942, 6348.428641422294, 6405.263394709668, 6790.185177778698, 6792.694328755218, 6579.703913323912, 6610.9669451652435, 6731.663416829139, 6754.324567543206, 6799.422049125879, 5437.444401131462, 5445.237666726662, 5455.890882182334, 5462.8361149165585, 5470.8085217017215, 4843.733594652257, 4844.4186697596515, 4855.708657480563, 4879.902401951941, 4890.266460030953, 5229.660072095302, 6162.7843025494785, 6332.4934005279465, 6426.678666066678, 6438.967805160944, 6899.931000689929, 6907.585544867324, 6916.827079323057, 6920.273371296042, 6924.723011079601, 6329.651869147149, 6450.387213214737, 6453.548251622341, 6456.935430645727, 6475.125858009108, 5920.0, 5984.611000284967, 6055.6063855849225, 6096.9390306096375, 6141.508679305645, 6971.0, 7110.395616372666, 7137.357637812622, 7185.209626941137, 7203.315685009916, 6883.862322753617, 6889.552179108342, 6910.20532638753, 6925.58446493212, 6934.895976560457, 7142.214356420894, 7150.213476517683, 7178.820529486805, 7205.963970180115, 7215.927840721735, 6097.7865774697675, 6495.350464953467, 6580.0, 6733.0, 6781.796546103625, 5132.153194722829, 6884.208316043719, 6912.135983002125, 6920.688569014507, 6927.965360173167, 6344.651044192429, 6478.190226221723, 6609.041688955171, 6680.3987641112535, 6684.4652427804685, 6350.1109844622715, 6540.607563546202, 6630.138082049302, 6653.5009874260595, 6662.500312476681, 5638.126090455986, 6301.968490157703, 6355.3326900674765, 6404.007378856285, 6461.06314584392, 6679.4990375721045, 6688.565243259172, 6688.632125233159, 6689.130413046273, 6693.431058360094, 6450.903236451363, 6489.221293444628, 6496.7726129585235, 6496.7726129585235, 6502.447291980235], "value": 6183.642489890024, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [755.4862693368507, 805.6817557064958, 834.5868794946502, 1127.7631697343556, 1139.9202055856094, 36240.45639315409, 37151.628483715154, 37162.0, 37354.4396834047, 37570.0, 39894.20211595766, 40091.0, 40178.79910600443, 40186.0, 40269.798651006706, 8479.152084791533, 8521.829563408728, 8612.48325100493, 8647.870281945776, 8693.913060869374, 8555.614997325136, 8616.913830861673, 8666.826663466727, 8686.348523860735, 8705.173008564208, 8593.183647553473, 8600.698975535857, 8669.176428239307, 8671.393002489829, 8687.174718401742, 8603.397762156652, 8605.48367097973, 8656.350773691967, 8656.394052416334, 8661.523616201106, 8461.746147615582, 8473.618687159093, 8497.150284971514, 8540.444871083422, 8548.82902341956, 27450.725492745016, 38080.61919380799, 38106.80946595277, 38156.61843381559, 38204.80897595522, 3008.699130086996, 3421.4525675891987, 3423.0415483664615, 3473.94789078164, 3479.304139172176, 30844.2288942776, 30891.53662695039, 30894.845525772453, 30905.536416953764, 30929.845350773103, 3027.8788848446034, 3047.817130972149, 3065.708757668018, 3081.984590077035, 3087.289923317627, 329797.0, 345825.0, 349983.75154360296, 350998.4900150991, 351863.0, 49586.75206624016, 49620.25569616459, 49646.0, 49661.25508117381, 49789.751051244515, 51500.7124821875, 51834.74082629563, 51867.703307417614, 51870.0, 51892.74053629783, 13847.30763461843, 14067.929660351632, 14214.715705685829, 14240.287985600678, 14255.78616320756, 11256.887431125748, 11323.263987840764, 11388.088952883749, 11388.145889058354, 11391.715207119889, 13551.322433878464, 13563.389647465889, 13613.727725445435, 13655.795163072562, 13855.930720346536, 5967.6419414835245, 5969.582129250911, 5974.940250597525, 6024.789132380346, 6030.849228769228, 959.9952000239954, 967.9951600241953, 976.028851292968, 976.9071938165863, 1015.8628585141059, 24028.92500074894, 24107.638385424234, 24216.636750448757, 24260.87869560641, 24275.028998839847, 998.0219385002592, 1061.8088744025995, 1066.7973085113804, 1101.124605938281, 1103.5971870267294, 10708.089812366035, 11736.941315293368, 12146.453409596412, 12291.262524248574, 12309.015278777677, 450085.7495712566, 452965.0, 454829.0, 455089.17366239533, 457001.8599627989, 42749.57250427518, 44226.0, 53538.73230633822, 53813.192802108, 53816.730916345165, 1450.7751298548742, 1452.7094581083825, 1455.7306898223862, 1462.5758530026385, 1467.5744034229954, 28316.0, 28464.0, 28963.0, 29094.563581546718, 29468.705312947455, 32766.017019489453, 36914.63085369112, 36936.0, 37005.81497092497, 37133.25733485369, 362362.0, 362385.0, 363800.0, 364863.0, 365163.0, 31679.683203167675, 31748.0, 31769.36461270808, 31830.204244894063, 31837.0, 37273.0, 37359.25281494409, 39662.61180858656, 41053.79473102615, 46297.53702463067, 31827.840860795546, 32993.01020969375, 33423.33153336968, 33714.15714607154, 34111.317773644885, 32463.0, 32685.836570816995, 33563.32873342568, 33593.824216152316, 33795.0, 36386.45420318644, 36878.26243475169, 40655.59344406636, 40695.38956915708, 41104.38343424911, 24383.293169478675, 28061.298467538476, 30466.39067218599, 30501.389972199988, 31100.37799243957, 20770.584588307847, 22845.65731514062, 23508.529829402974, 26014.089506867167, 26303.342416439744], "value": 17892.952369767285, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.69071784829873, 422.5162189293261, 425.9723117997328, 445.7414699474305, 456.5183731163622, 21466.570668586617, 21643.242486512954, 22360.776392236072, 22586.54826903465, 22872.88563557184, 22009.559808803813, 22793.77206227937, 23075.42311442215, 23106.30681079566, 23422.06311747532, 6171.969140154304, 6231.22109736283, 6426.710798014101, 6432.42108210261, 6434.806955791334, 5740.971295143519, 6394.944834102391, 6398.584092034026, 6409.134766806468, 6409.647469389181, 6082.148499210114, 6263.968680156616, 6319.273283572379, 6349.142865713139, 6362.777302794403, 6286.811395658137, 6328.240611126648, 6329.272133704637, 6336.841578960517, 6352.0, 5553.611247212697, 5588.273524441837, 5617.129344951539, 5641.68970706611, 5703.144528320744, 27000.729992700017, 27079.1876243713, 27422.0, 27498.725012749816, 27598.034068807698, 2188.7482939462006, 2239.742429620598, 2246.4608493961496, 2247.449374903159, 2253.256425379621, 17165.914170429194, 17665.646687066186, 17875.642487150315, 17890.373836915776, 17942.013189274585, 2104.3581707579183, 2140.743110826695, 2172.435166856613, 2173.369722780392, 2178.8692678439343, 140128.0, 140403.0, 140706.29646851702, 141548.0, 141821.29089354488, 12167.2699638022, 12390.946769524511, 12691.477022757328, 12720.745585088247, 12761.872381276069, 13707.0, 15911.204439778196, 16107.033577985358, 16139.596510087342, 16147.919260403858, 8611.397202195787, 8803.295736341077, 8852.0, 8886.11138886119, 8949.821003579891, 7350.669219885011, 8099.0, 8318.70884519039, 8343.791405214797, 8488.74533763988, 7669.233076692286, 7836.764897053097, 7904.9961014814, 7930.484518506394, 7975.7607271781935, 2233.2754040071086, 2234.3073647169103, 2244.5510897820172, 2250.6496102338465, 2274.363178310076, 818.3657665309314, 932.7994481186578, 970.6214576315243, 999.2855108597242, 1024.8975102489692, 19381.51546211356, 20593.691094633592, 21094.472638183863, 21098.367048988555, 21126.04932777998, 998.9450580218157, 999.820032394176, 1032.1175395037135, 1035.7255327338262, 1040.5265604150093, 8889.888763904512, 10675.354090689007, 10824.404657743742, 10986.230963832455, 11043.282186657842, 695662.0, 712114.0, 712955.0, 729279.0, 736698.0, 149746.0, 150346.58282805554, 151015.24492377468, 152007.0, 152993.0, 1189.9524019039316, 1213.7269114449177, 1232.3653318540958, 1234.8888600025862, 1236.4250623460134, 17590.296388144332, 18067.63864722672, 18084.54788630295, 18104.275828966693, 18119.0, 59109.5222619438, 62074.20666070128, 63146.36853631405, 63278.36721632725, 63745.0, 67247.66376168087, 83195.16804831874, 84858.0, 85728.57135714282, 87511.0, 8406.915930840612, 8540.231379175904, 8936.151065648754, 8965.00476278344, 8973.416727912665, 13356.666083347995, 13528.0, 13635.25006124633, 13717.862821372059, 14073.014888957674, 9691.2731545133, 11634.243774154653, 11716.297022178696, 11765.47055382527, 12014.519419223134, 9810.068043535854, 9947.05502977216, 10653.680389588324, 10681.57273709074, 10786.460676966277, 10214.693559193236, 11475.655730328104, 11854.703632408913, 12017.339046352534, 12176.147669663038, 8247.628856701343, 8513.82972340562, 8528.829423411622, 8661.740147795575, 8701.912980870364, 9186.0, 9772.26707996889, 10787.921207879463, 11344.262622929484, 11867.406629668309], "value": 10504.27702386652, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1269.4731686350165, 1285.7685616589015, 1423.7721964485677, 1439.7048605035975, 1445.371263500378, 11553.884461155387, 11834.349110798903, 11951.310955035124, 12113.152079354437, 12211.145219834616, 10893.346399216032, 11601.883981160207, 12000.639980800568, 12176.695582610417, 12187.0, 2137.700721898935, 2180.563887222554, 2190.0363839910387, 2427.830051896368, 2526.1916186820226, 2163.080690706451, 2336.9717324377307, 2396.5805983952737, 2426.1265944260053, 2511.8116141289383, 2228.65455854342, 2380.071772008918, 2484.8260621756485, 2491.813114016456, 2499.200255918107, 2386.880655967195, 2449.3998970252314, 2452.730199678034, 2464.852108873464, 2479.355367604418, 2181.8000099945125, 2399.1003373734848, 2489.166129346671, 2490.066225165563, 2507.059852555292, 9508.572114254875, 9830.21358291342, 12069.879301206964, 12083.516659333616, 12084.577039803653, 6464.482841372679, 6672.2994085621285, 6711.798646040578, 6717.462602991749, 6722.327767223287, 3217.8069315841126, 4135.441715368417, 4198.454200953887, 4213.094184750294, 4223.239816832969, 1229.3238718704765, 1237.55448038706, 1271.3071376100047, 1273.7898246789268, 1274.458355199046, 15199.62000949974, 15604.375824966988, 16653.4171304005, 16700.58248543784, 16810.747838782427, 4753.952460475351, 5352.357717073976, 5391.838244852661, 5649.067903795828, 5671.574631902624, 12235.0, 12301.0, 12350.75298494043, 12350.876491234972, 12355.011599072053, 6470.6441145737435, 6503.674816259168, 6525.314841941623, 6536.934630653727, 6541.738330466823, 5974.671393073423, 6110.480609148272, 6169.321374648785, 6199.690015499207, 6251.6561589112125, 4390.551118131009, 4518.096380723869, 4541.523140070245, 4573.931391029138, 4591.494935557086, 1306.6994591243877, 1313.5402609086743, 1318.6044186743939, 1330.1221194011905, 1337.277869950216, 668.3416834418094, 759.0549765541936, 761.5430741555023, 781.6599779096111, 821.8356328734277, 4687.484376718558, 6031.7587296507645, 6089.756409743561, 6314.873702525923, 6408.935910640927, 544.7466927878477, 838.3963546246692, 899.59967814322, 900.6712549919232, 919.9678011269707, 4163.357855990609, 4180.581941805795, 4379.080393117417, 4476.9104617908115, 4494.5730155635165, 15138.772918406232, 15309.6172595686, 15550.377984880479, 15689.215539222992, 15736.60658483547, 15191.240437978056, 15392.846071539141, 15407.306671199598, 15556.844431555766, 15624.609384765472, 9853.162481189036, 10871.184661150446, 10979.407985841848, 11336.392629695216, 11375.374354410587, 6218.875622487615, 6687.3647003536535, 6813.625250611264, 6887.724491020504, 7146.32109949554, 13704.794428083786, 13966.860331396962, 14145.080569763344, 14285.28573571338, 14296.141501604725, 13293.468261269441, 13920.860791391957, 14135.787963180355, 14460.566183014527, 14584.854151458774, 8056.677732890619, 9607.423554586747, 9614.230861531201, 9684.176844968257, 9713.36863103896, 10733.463326833784, 10829.24195306321, 10836.837447438136, 10880.020798128206, 10891.564337426415, 9087.09129087086, 9140.040295769115, 9203.677871274473, 9236.445813251226, 9382.390144640576, 8940.910590894007, 8942.86585701228, 8946.194842464209, 9008.234300084567, 9033.954830225806, 8055.7583272501915, 8208.876866847122, 8230.259276665129, 8231.46495477816, 8233.382496312921, 5324.440933701905, 5923.970380148072, 6088.086786981989, 6121.3572574879, 6171.84570385744, 4682.836100736458, 6013.579049466495, 6062.696865156637, 6110.419510146529, 6423.518236132215], "value": 5368.534115473195, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [337.1806510180262, 360.56731921693955, 375.16338565000046, 383.67387720437625, 383.90594304395427, 6151.56939014268, 6252.499800015999, 6269.279032911217, 6309.337519560443, 6340.3025667176635, 6025.457708806207, 6061.605995610283, 6116.26907586372, 6130.601510901788, 6172.691365431733, 3815.0, 4111.897202569945, 4451.775761665535, 4451.844185453509, 4482.731036137842, 4359.891002724941, 4373.584509471611, 4411.433940950948, 4484.4842843072975, 4502.819887204524, 3419.81191034493, 4386.40783494229, 4398.538153493885, 4401.691881568291, 4407.515173330931, 4173.373993900939, 4415.094905544372, 4428.0701052778795, 4439.289713645801, 4486.55134486552, 3744.4570537271943, 3773.1510410157493, 3797.487339209199, 3813.504244448232, 3816.542014958195, 4737.976310118427, 4863.708177509361, 5295.80844310031, 5684.403137670526, 5869.295684517842, 4924.433690125646, 5299.920501192485, 5323.095073837457, 5327.786888524454, 5352.919706204371, 4963.106640804654, 6301.7164227609865, 6415.0, 6416.390442907917, 6445.226572811246, 3598.460230965376, 4295.441592592974, 4312.547182545819, 4313.978430107861, 4330.913381732347, 5897.8820423591715, 6562.44219241365, 6751.223609284897, 6855.880574338664, 6948.583085014915, 4199.70602057853, 4328.761918094472, 4369.541198174209, 4372.366006929041, 4391.6486681065435, 3910.8240129194255, 3910.9804450977563, 4284.421603083606, 4308.956910430856, 4444.11117776446, 5059.671121377099, 5278.81524146653, 5285.286486324297, 5299.0, 5300.946990530122, 5894.616849904743, 5896.616719913278, 6198.698273362555, 6541.411272985359, 6642.96678516614, 1280.7246442015012, 1383.190833362474, 1489.1511838252093, 1496.6156305417662, 1509.8414666460083, 901.9439412896083, 951.9333646644668, 986.2307400227834, 987.2398253345028, 995.5868314649484, 5537.889242215133, 6226.40849119333, 6227.314995350508, 6231.626102433868, 6269.310375858652, 5770.19217309577, 5896.0, 6461.289258181596, 6779.966100169566, 6797.1843378794865, 5278.445763194809, 5438.238646589481, 5457.508824205841, 5752.338481074647, 6004.42957918997, 3301.7853839500835, 3528.2414280929725, 3554.804485753308, 3569.196930690626, 3571.9819851342245, 6676.162630881856, 6918.028361916829, 7062.15254169503, 7074.93875918606, 7159.96420017907, 6285.9057114143325, 6559.737610495622, 6943.236244013155, 7010.894836577456, 7036.753713619999, 6304.959681652476, 6674.2658307586125, 6971.58170509771, 7123.572585644878, 7145.4998150128995, 6759.817032019475, 6773.424258938046, 6783.21992970795, 6795.38841504267, 6838.14523184602, 5715.542756579547, 6054.424829641177, 6424.293327734039, 6721.563098398588, 6742.595444273359, 6351.809445716636, 6793.626350550767, 6896.069030680995, 6992.510524263253, 7055.964720176366, 4138.213739389506, 4339.826406943687, 4354.412154359121, 4356.847510337123, 4365.541618130051, 5655.717214139194, 5687.60186786921, 5721.342045664635, 6273.62358258506, 6914.4096857722, 5827.475527202572, 6465.286699024856, 6560.245571759308, 6590.80227593173, 6597.80206593803, 6042.184305118929, 6256.748650270055, 6551.312112228147, 6571.408573228432, 6577.059767368542, 5482.753276102505, 6125.571210015256, 6363.7772677956045, 6378.712957916998, 6440.293322269696, 6265.248170219603, 6433.742650293936, 6522.836929076811, 6539.247986481616, 6618.238902526271, 5331.600129990344, 6205.348438413902, 6357.904631430625, 6368.4586810121655, 6407.711652975534], "value": 4678.588391308796, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [788.5347644889514, 822.1901427094315, 836.1304243586669, 842.7653487640605, 850.5832142250299, 15984.0, 16305.338670682879, 16347.83652163478, 16808.66382672349, 16902.57743556412, 15185.848141518582, 15316.004459710139, 15459.768103478456, 15669.921650391761, 15817.0, 963.8313295173334, 983.7147227304073, 983.8081574093055, 987.7678745494838, 990.6730778842965, 948.250881803378, 985.6796541124128, 1005.1104772276515, 1005.9547320370564, 1006.6828948881116, 1058.1059005140644, 1068.9091427228695, 1071.287593750155, 1072.383379556754, 1073.2433634287809, 1052.489542571856, 1057.1701214546583, 1066.1470823341374, 1066.9679909602723, 1067.524951396629, 772.7643068863994, 780.4224873593556, 782.9921700783033, 789.8459800338936, 790.8102055506637, 16561.0, 16948.406805761864, 16977.405790797264, 17013.65972680552, 17185.91407042969, 13593.864061359458, 14470.625290597482, 14801.185934773583, 14819.925900370537, 15031.849681503154, 13217.405216765268, 13443.126196797275, 13723.0, 13734.862651373458, 13958.022938394317, 3454.5509083818943, 3501.124718820295, 3502.439609662442, 3507.94738078929, 3520.06718219672, 106686.0, 109007.0, 111293.63654996996, 111981.44009279984, 113249.0, 8250.793730156794, 11147.163962702829, 11389.658310250707, 11856.940715296369, 11981.580644677395, 23998.280051598478, 24167.63748543773, 24282.757172428403, 24476.898539565405, 24650.50698986046, 8175.591220438954, 8220.917790822015, 8350.33197344211, 8451.11263317355, 8481.533515656698, 4213.578642135762, 4308.202982448257, 4319.913601727948, 4365.345198220292, 4409.735415875058, 4237.364395340724, 4331.285337919208, 4333.739975601411, 4337.306031035019, 4353.0423306872435, 786.3944762532932, 866.2420382165606, 958.3148049144895, 964.1900803325241, 965.9468729219819, 545.5880809988513, 626.4236902050125, 635.706337602985, 647.355880898509, 673.1787219592089, 10287.948560257151, 11019.944900275448, 11066.612668556561, 11358.864113588575, 11501.827472587918, 585.3707264690474, 620.6245221640843, 629.3926361061598, 649.6459429610874, 661.1966460750211, 4550.908981820345, 4678.204705200124, 4844.4186697596515, 4859.1496488114435, 4865.0, 96878.0, 99292.50353748185, 99507.0, 100706.0, 102081.0, 88408.0, 89486.65770013454, 89621.0, 90216.0, 90230.0, 73754.63122684459, 75916.0, 77610.22389776143, 78928.0, 79013.60493197497, 9254.88941327018, 9663.178629816262, 9687.225021998082, 9688.273379496424, 9803.215742740706, 38297.61702383052, 38476.2304753909, 39114.044297785564, 39339.80330098446, 39386.606133939444, 69635.65182174057, 71416.21459463554, 71881.0, 72548.54902902019, 72862.0, 13716.451341946211, 13768.380422881195, 13789.379477923718, 13990.16059036461, 14369.425222990963, 15057.096574205583, 15122.092674439129, 15130.092194468367, 15248.77126843076, 15351.385944562538, 13767.862321376659, 13986.580402587939, 14037.929810350883, 14088.859111408754, 14271.429142834171, 13588.45646174142, 13927.23400212998, 14243.430262789372, 14313.856861431252, 14703.852961470677, 11021.724456888642, 11909.52361905514, 13505.189688618715, 13759.17444953266, 13829.51596694111, 8686.34852386061, 8732.56337183151, 9867.753306167404, 10332.483375831329, 10904.50929708181, 10542.631007914686, 11352.432378381212, 11425.690582914847, 11476.4261786912, 11479.311241325548], "value": 7894.439180388473, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1614.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 124.0, 125.0, 124.0, 121.0, 123.0, 125.0, 126.0, 122.0, 123.0], "value": 122.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 128.0, 157.0, 196.0, 152.0, 119.0, 119.0, 121.0, 142.0, 119.0], "value": 141.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [220.0, 247.0, 252.0, 229.0, 232.0, 218.0, 222.0, 277.0, 238.0, 213.0], "value": 234.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 59.0, 62.0, 88.0, 60.0, 60.0, 62.0, 59.0, 97.0, 85.0], "value": 71.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 74.0, 87.0, 74.0, 72.0, 74.0, 86.0, 72.0, 71.0, 85.0], "value": 78.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 85.0, 136.0, 134.0, 93.0, 93.0, 94.0, 93.0, 93.0, 93.0], "value": 100.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 103.0, 127.0, 138.0, 102.0, 104.0, 103.0, 103.0, 102.0, 104.0], "value": 108.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 102.0, 102.0, 103.0, 103.0, 103.0, 102.0, 101.0, 154.0, 104.0], "value": 107.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 52.0, 52.0, 52.0, 53.0, 54.0, 53.0, 54.0, 53.0, 53.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 64.0, 72.0, 72.0, 65.0, 59.0, 60.0, 58.0, 59.0, 60.0], "value": 62.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 87.0, 87.0, 88.0, 111.0, 80.0, 114.0, 105.0, 111.0, 87.0], "value": 95.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 169.0, 185.0, 186.0, 166.0, 156.0, 142.0, 159.0, 202.0, 163.0], "value": 168.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 197.0, 195.0, 193.0, 196.0, 198.0, 195.0, 223.0, 190.0, 196.0], "value": 197.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 70.0, 71.0, 72.0, 72.0, 70.0, 69.0, 69.0, 74.0], "value": 71.1, "unit": "score"}]}]} 20:24:16 INFO - Return code: 0 20:24:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:24:16 ERROR - # TBPL SUCCESS # 20:24:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:24:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:24:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:24:16 INFO - 2017-04-05 20:24:16.510 screenresolution[1659:10735] starting screenresolution argv=screenresolution get 20:24:16 INFO - 2017-04-05 20:24:16.513 screenresolution[1659:10735] Display 0: 1600x1200x32@60 20:24:16 INFO - 2017-04-05 20:24:16.518 screenresolution[1660:10738] starting screenresolution argv=screenresolution list 20:24:16 INFO - Available Modes on Display 0 20:24:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:24:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:24:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:24:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:24:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:24:16 INFO - Intel Iris: 20:24:16 INFO - Chipset Model: Intel Iris 20:24:16 INFO - Type: GPU 20:24:16 INFO - Bus: Built-In 20:24:16 INFO - VRAM (Dynamic, Max): 1536 MB 20:24:16 INFO - Vendor: Intel (0x8086) 20:24:16 INFO - Device ID: 0x0a2e 20:24:16 INFO - Revision ID: 0x0009 20:24:16 INFO - Displays: 20:24:16 INFO - Display: 20:24:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:24:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:24:16 INFO - Display Serial Number: 1600x1200 60 20:24:16 INFO - Main Display: Yes 20:24:16 INFO - Mirror: Off 20:24:16 INFO - Online: Yes 20:24:16 INFO - Rotation: Supported 20:24:16 INFO - Return code: 0 20:24:16 INFO - Running post-action listener: _resource_record_post_action 20:24:16 INFO - [mozharness: 2017-04-06 03:24:16.760724Z] Finished run-tests step (success) 20:24:16 INFO - Running post-run listener: _resource_record_post_run 20:24:16 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 39320064; Write bytes: 518608896; Read time: 250; Write time: 1654 20:24:16 INFO - TinderboxPrint: CPU usage
54.4% 20:24:16 INFO - TinderboxPrint: I/O read bytes / time
39,320,064 / 250 20:24:16 INFO - TinderboxPrint: I/O write bytes / time
518,608,896 / 1,654 20:24:16 INFO - TinderboxPrint: CPU idle
2,192.0 (45.6%) 20:24:16 INFO - TinderboxPrint: CPU system
968.7 (20.2%) 20:24:16 INFO - TinderboxPrint: CPU user
1,645.0 (34.2%) 20:24:16 INFO - TinderboxPrint: Swap in / out
245,972,992 / 0 20:24:16 INFO - install - Wall time: 21s; CPU: 55.0%; Read bytes: 208179200; Write bytes: 202280960; Read time: 15839; Write time: 442 20:24:16 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 32150016; Write bytes: 309532672; Read time: 188; Write time: 1185 20:24:17 INFO - Running post-run listener: _upload_blobber_files 20:24:17 INFO - Blob upload gear active. 20:24:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:24:17 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 20:24:17 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', 'Pine', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 20:24:17 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 Pine -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 20:24:17 INFO - (blobuploader) - INFO - Open directory for files ... 20:24:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:24:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:24:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:24:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:18 INFO - (blobuploader) - INFO - Done attempting. 20:24:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:24:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:24:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:24:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:19 INFO - (blobuploader) - INFO - Done attempting. 20:24:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 20:24:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:24:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 20:24:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:20 INFO - (blobuploader) - INFO - Done attempting. 20:24:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:24:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:24:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:24:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:24:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:24:22 INFO - (blobuploader) - INFO - Done attempting. 20:24:22 INFO - (blobuploader) - INFO - Iteration through files over. 20:24:22 INFO - Return code: 0 20:24:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:24:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:24:22 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/0daaf39d0b901d5711e9cb548c3bbcfdd6912b93f8c8ad7e629562d4e29953c76a68c0e1db4e1b7954a92803c3a9dea236c81d0af64e78721b7ebf0f33507ad5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/59610d97960e98ae682eae8bdb59fce91b0d1ecf031aa877da799818428578e3fc1d52284dfc3a4548c54d7acd76577f1e89d72ce0f091b43c61a0a756f890ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/18a90d86baca5a92bbe4a9221a1c878a2e35f9335d26a46eeab1c13f4e46a12b778dbfcfd6dc4a01f3676023c69fa83baf6860e185441bb1a15f5c8d181a753c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/92b821ad08c9b7fc6329122fb9c2f5cd79e6e2aab6269834ba53160e9790fed349f55d584d75dcc7c9aa25ba165c02c544b6d737ca333e13803fc518a5ff5c0d"} 20:24:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:24:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:24:22 INFO - Contents: 20:24:22 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/0daaf39d0b901d5711e9cb548c3bbcfdd6912b93f8c8ad7e629562d4e29953c76a68c0e1db4e1b7954a92803c3a9dea236c81d0af64e78721b7ebf0f33507ad5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/59610d97960e98ae682eae8bdb59fce91b0d1ecf031aa877da799818428578e3fc1d52284dfc3a4548c54d7acd76577f1e89d72ce0f091b43c61a0a756f890ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/18a90d86baca5a92bbe4a9221a1c878a2e35f9335d26a46eeab1c13f4e46a12b778dbfcfd6dc4a01f3676023c69fa83baf6860e185441bb1a15f5c8d181a753c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/92b821ad08c9b7fc6329122fb9c2f5cd79e6e2aab6269834ba53160e9790fed349f55d584d75dcc7c9aa25ba165c02c544b6d737ca333e13803fc518a5ff5c0d"} 20:24:22 INFO - Running post-run listener: copy_logs_to_upload_dir 20:24:22 INFO - Copying logs to upload dir... 20:24:22 INFO - mkdir: /builds/slave/test/build/upload/logs 20:24:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.157596 ========= master_lag: 0.57 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-05 20:24:22.894739) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 20:24:22.898740) ========= 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.oAvlJmaF3L/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.rFuIAt6t8r/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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/Pine/sha512/0daaf39d0b901d5711e9cb548c3bbcfdd6912b93f8c8ad7e629562d4e29953c76a68c0e1db4e1b7954a92803c3a9dea236c81d0af64e78721b7ebf0f33507ad5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/59610d97960e98ae682eae8bdb59fce91b0d1ecf031aa877da799818428578e3fc1d52284dfc3a4548c54d7acd76577f1e89d72ce0f091b43c61a0a756f890ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/18a90d86baca5a92bbe4a9221a1c878a2e35f9335d26a46eeab1c13f4e46a12b778dbfcfd6dc4a01f3676023c69fa83baf6860e185441bb1a15f5c8d181a753c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/92b821ad08c9b7fc6329122fb9c2f5cd79e6e2aab6269834ba53160e9790fed349f55d584d75dcc7c9aa25ba165c02c544b6d737ca333e13803fc518a5ff5c0d"} build_url:https://queue.taskcluster.net/v1/task/K9fLYI_ISjqDygQPuB1ieg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010836 build_url: 'https://queue.taskcluster.net/v1/task/K9fLYI_ISjqDygQPuB1ieg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/0daaf39d0b901d5711e9cb548c3bbcfdd6912b93f8c8ad7e629562d4e29953c76a68c0e1db4e1b7954a92803c3a9dea236c81d0af64e78721b7ebf0f33507ad5", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/59610d97960e98ae682eae8bdb59fce91b0d1ecf031aa877da799818428578e3fc1d52284dfc3a4548c54d7acd76577f1e89d72ce0f091b43c61a0a756f890ca", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/18a90d86baca5a92bbe4a9221a1c878a2e35f9335d26a46eeab1c13f4e46a12b778dbfcfd6dc4a01f3676023c69fa83baf6860e185441bb1a15f5c8d181a753c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/92b821ad08c9b7fc6329122fb9c2f5cd79e6e2aab6269834ba53160e9790fed349f55d584d75dcc7c9aa25ba165c02c544b6d737ca333e13803fc518a5ff5c0d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 20:24:22.933469) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 20:24:22.933829) ========= 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.oAvlJmaF3L/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.rFuIAt6t8r/Listeners TMPDIR=/var/folders/c_/gxd8chw13618g2dtm2y0dy8000000w/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.005084 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 20:24:22.982406) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 20:24:22.982747) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 20:24:22.983094) ========= ========= Total master_lag: 0.96 =========