builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0075 starttime: 1494274647.3 results: success (0) buildid: 20170508121942 builduid: 105deb4c388f4e1cbf5b267c9b8bcc14 revision: 910e97516eb77e23f0c1461be92f396d5db12f8f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 13:17:27.297453) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 13:17:27.298159) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 13:17:27.298672) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 13:17:27.329777) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 13:17:27.330409) ========= 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.o46SdqAIA1/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.866AC47cXc/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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-05-08 13:17:27-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 28.5M=0s 2017-05-08 13:17:27 (28.5 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.098606 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 13:17:27.455563) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 13:17:27.455895) ========= 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.o46SdqAIA1/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.866AC47cXc/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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.027590 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 13:17:27.506650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-08 13:17:27.507017) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 910e97516eb77e23f0c1461be92f396d5db12f8f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 910e97516eb77e23f0c1461be92f396d5db12f8f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.o46SdqAIA1/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.866AC47cXc/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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-05-08 13:17:27,608 truncating revision to first 12 chars 2017-05-08 13:17:27,608 Setting DEBUG logging. 2017-05-08 13:17:27,608 attempt 1/10 2017-05-08 13:17:27,608 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/910e97516eb7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-08 13:17:28,999 unpacking tar archive at: mozilla-beta-910e97516eb7/testing/mozharness/ program finished with exit code 0 elapsedTime=1.664183 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-08 13:17:29.198382) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 13:17:29.199068) ========= script_repo_revision: 910e97516eb77e23f0c1461be92f396d5db12f8f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 13:17:29.199917) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 13:17:29.200432) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 13:17:29.223791) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2017-05-08 13:17:29.224492) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.o46SdqAIA1/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.866AC47cXc/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 13:17:29 INFO - MultiFileLogger online at 20170508 13:17:29 in /builds/slave/test 13:17:29 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:17:29 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:17:29 INFO - {'append_to_log': False, 13:17:29 INFO - 'base_work_dir': '/builds/slave/test', 13:17:29 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:17:29 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:17:29 INFO - 'branch': 'Mozilla-Beta', 13:17:29 INFO - 'buildbot_json_path': 'buildprops.json', 13:17:29 INFO - 'config_files': ('talos/mac_config.py',), 13:17:29 INFO - 'default_actions': ('clobber', 13:17:29 INFO - 'read-buildbot-config', 13:17:29 INFO - 'download-and-extract', 13:17:29 INFO - 'populate-webroot', 13:17:29 INFO - 'create-virtualenv', 13:17:29 INFO - 'install', 13:17:29 INFO - 'run-tests'), 13:17:29 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:17:29 INFO - 'download_minidump_stackwalk': True, 13:17:29 INFO - 'download_symbols': 'ondemand', 13:17:29 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:17:29 INFO - 'tooltool.py': '/tools/tooltool.py', 13:17:29 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:17:29 INFO - '/tools/misc-python/virtualenv.py')}, 13:17:29 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:17:29 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:17:29 INFO - 'gecko_profile': False, 13:17:29 INFO - 'gecko_profile_interval': 0, 13:17:29 INFO - 'installer_path': 'installer.exe', 13:17:29 INFO - 'log_level': 'info', 13:17:29 INFO - 'log_name': 'talos', 13:17:29 INFO - 'log_to_console': True, 13:17:29 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:17:29 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:17:29 INFO - 'opt_config_files': (), 13:17:29 INFO - 'pip_index': False, 13:17:29 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:17:29 INFO - 'cmd': ('bash', 13:17:29 INFO - '-c', 13:17:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:17:29 INFO - 'enabled': True, 13:17:29 INFO - 'halt_on_failure': False, 13:17:29 INFO - 'name': 'check_screen_resolution'},), 13:17:29 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:17:29 INFO - 'cmd': ('bash', 13:17:29 INFO - '-c', 13:17:29 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:17:29 INFO - 'enabled': True, 13:17:29 INFO - 'halt_on_failure': False, 13:17:29 INFO - 'name': 'check_screen_resolution'},), 13:17:29 INFO - 'run_cmd_checks_enabled': True, 13:17:29 INFO - 'suite': 'dromaeojs-e10s', 13:17:29 INFO - 'system_bits': '32', 13:17:29 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:17:29 INFO - 'title': 't-yosemite-r7-0075', 13:17:29 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:17:29 INFO - 'use_talos_json': True, 13:17:29 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:17:29 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:17:29 INFO - 'work_dir': 'build'} 13:17:29 INFO - [mozharness: 2017-05-08 20:17:29.443243Z] Running clobber step. 13:17:29 INFO - Running pre-action listener: _resource_record_pre_action 13:17:29 INFO - Running main action method: clobber 13:17:29 INFO - rmtree: /builds/slave/test/build 13:17:29 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:17:34 INFO - Running post-action listener: _resource_record_post_action 13:17:34 INFO - [mozharness: 2017-05-08 20:17:34.213902Z] Finished clobber step (success) 13:17:34 INFO - [mozharness: 2017-05-08 20:17:34.214148Z] Running read-buildbot-config step. 13:17:34 INFO - Running pre-action listener: _resource_record_pre_action 13:17:34 INFO - Running main action method: read_buildbot_config 13:17:34 INFO - Using buildbot properties: 13:17:34 INFO - { 13:17:34 INFO - "project": "", 13:17:34 INFO - "product": "firefox", 13:17:34 INFO - "script_repo_revision": "production", 13:17:34 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 13:17:34 INFO - "repository": "", 13:17:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 13:17:34 INFO - "buildid": "20170508121942", 13:17:34 INFO - "pgo_build": "False", 13:17:34 INFO - "basedir": "/builds/slave/test", 13:17:34 INFO - "buildnumber": 25, 13:17:34 INFO - "slavename": "t-yosemite-r7-0075", 13:17:34 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 13:17:34 INFO - "platform": "yosemite_r7", 13:17:34 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:17:34 INFO - "branch": "mozilla-beta", 13:17:34 INFO - "repo_path": "releases/mozilla-beta", 13:17:34 INFO - "revision": "910e97516eb77e23f0c1461be92f396d5db12f8f", 13:17:34 INFO - "stage_platform": "macosx64", 13:17:34 INFO - "builduid": "105deb4c388f4e1cbf5b267c9b8bcc14", 13:17:34 INFO - "slavebuilddir": "test" 13:17:34 INFO - } 13:17:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/BXmsGQRlSBm7jriOX2j-zw/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 13:17:34 INFO - Running post-action listener: _resource_record_post_action 13:17:34 INFO - [mozharness: 2017-05-08 20:17:34.219731Z] Finished read-buildbot-config step (success) 13:17:34 INFO - [mozharness: 2017-05-08 20:17:34.219885Z] Running download-and-extract step. 13:17:34 INFO - Running pre-action listener: _resource_record_pre_action 13:17:34 INFO - Running main action method: download_and_extract 13:17:34 INFO - mkdir: /builds/slave/test/build/tests 13:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:17:34 INFO - trying https://queue.taskcluster.net/v1/task/BXmsGQRlSBm7jriOX2j-zw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 13:17:34 INFO - Downloading https://queue.taskcluster.net/v1/task/BXmsGQRlSBm7jriOX2j-zw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 13:17:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BXmsGQRlSBm7jriOX2j-zw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 13:17:35 INFO - Downloaded 1287 bytes. 13:17:35 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 13:17:35 INFO - Using the following test package requirements: 13:17:35 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:17:35 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 13:17:35 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 13:17:35 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:17:35 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 13:17:35 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:17:35 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 13:17:35 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:17:35 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:17:35 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 13:17:35 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 13:17:35 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:17:35 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 13:17:35 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:17:35 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 13:17:35 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:17:35 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 13:17:35 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 13:17:35 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 13:17:35 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 13:17:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BXmsGQRlSBm7jriOX2j-zw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 13:17:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BXmsGQRlSBm7jriOX2j-zw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 13:17:35 INFO - Fetch https://queue.taskcluster.net/v1/task/BXmsGQRlSBm7jriOX2j-zw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 13:17:37 INFO - Expected file size: 51223574 13:17:37 INFO - Obtained file size: 51223574 13:17:53 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 13:17:53 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BXmsGQRlSBm7jriOX2j-zw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 13:17:53 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BXmsGQRlSBm7jriOX2j-zw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 13:17:53 INFO - Fetch https://queue.taskcluster.net/v1/task/BXmsGQRlSBm7jriOX2j-zw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 13:17:54 INFO - Expected file size: 51223574 13:17:54 INFO - Obtained file size: 51223574 13:18:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/BXmsGQRlSBm7jriOX2j-zw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 13:18:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/BXmsGQRlSBm7jriOX2j-zw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 13:18:09 INFO - Fetch https://queue.taskcluster.net/v1/task/BXmsGQRlSBm7jriOX2j-zw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 13:18:11 INFO - Expected file size: 14404449 13:18:11 INFO - Obtained file size: 14404449 13:18:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:11 INFO - trying https://queue.taskcluster.net/v1/task/BXmsGQRlSBm7jriOX2j-zw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 13:18:11 INFO - Downloading https://queue.taskcluster.net/v1/task/BXmsGQRlSBm7jriOX2j-zw/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 13:18:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/BXmsGQRlSBm7jriOX2j-zw/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 13:18:13 INFO - Downloaded 59570943 bytes. 13:18:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/BXmsGQRlSBm7jriOX2j-zw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 13:18:13 INFO - mkdir: /builds/slave/test/properties 13:18:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:18:13 INFO - Writing to file /builds/slave/test/properties/build_url 13:18:13 INFO - Contents: 13:18:13 INFO - build_url:https://queue.taskcluster.net/v1/task/BXmsGQRlSBm7jriOX2j-zw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 13:18:13 INFO - Running post-action listener: _resource_record_post_action 13:18:13 INFO - Running post-action listener: set_extra_try_arguments 13:18:13 INFO - [mozharness: 2017-05-08 20:18:13.791063Z] Finished download-and-extract step (success) 13:18:13 INFO - [mozharness: 2017-05-08 20:18:13.791216Z] Running populate-webroot step. 13:18:13 INFO - Running pre-action listener: _resource_record_pre_action 13:18:13 INFO - Running main action method: populate_webroot 13:18:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:18:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:18:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:18:13 INFO - '--tppagecycles', 13:18:13 INFO - '7'], 13:18:13 INFO - 'tests': ['tsvgm']}}, 13:18:13 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:18:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:18:13 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:18:13 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:18:13 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:18:13 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:18:13 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:18:13 INFO - 'talos_options': ['--disable-e10s'], 13:18:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:18:13 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:18:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:18:13 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:18:13 INFO - 'talos_options': ['--disable-e10s'], 13:18:13 INFO - 'tests': ['damp', 'tps']}, 13:18:13 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:18:13 INFO - 'tests': ['damp', 'tps']}, 13:18:13 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:18:13 INFO - 'tests': ['dromaeo_dom']}, 13:18:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:18:13 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:18:13 INFO - 'tests': ['basic_compositor_video']}, 13:18:13 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:18:13 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:18:13 INFO - 'tests': ['a11yr', 13:18:13 INFO - 'ts_paint', 13:18:13 INFO - 'tpaint', 13:18:13 INFO - 'sessionrestore', 13:18:13 INFO - 'sessionrestore_no_auto_restore', 13:18:13 INFO - 'tabpaint']}, 13:18:13 INFO - 'other-e10s': {'tests': ['a11yr', 13:18:13 INFO - 'ts_paint', 13:18:13 INFO - 'tpaint', 13:18:13 INFO - 'sessionrestore', 13:18:13 INFO - 'sessionrestore_no_auto_restore', 13:18:13 INFO - 'tabpaint']}, 13:18:13 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:18:13 INFO - 'ts_paint', 13:18:13 INFO - 'tpaint', 13:18:13 INFO - 'sessionrestore', 13:18:13 INFO - 'sessionrestore_no_auto_restore', 13:18:13 INFO - 'tabpaint']}, 13:18:13 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:18:13 INFO - 'ts_paint', 13:18:13 INFO - 'tpaint', 13:18:13 INFO - 'sessionrestore', 13:18:13 INFO - 'sessionrestore_no_auto_restore', 13:18:13 INFO - 'tabpaint']}, 13:18:13 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:18:13 INFO - 'tests': ['a11yr', 13:18:13 INFO - 'ts_paint', 13:18:13 INFO - 'tpaint', 13:18:13 INFO - 'sessionrestore', 13:18:13 INFO - 'sessionrestore_no_auto_restore', 13:18:13 INFO - 'tabpaint']}, 13:18:13 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:18:13 INFO - 'tests': ['a11yr', 13:18:13 INFO - 'ts_paint', 13:18:13 INFO - 'tpaint', 13:18:13 INFO - 'sessionrestore', 13:18:13 INFO - 'sessionrestore_no_auto_restore', 13:18:13 INFO - 'tabpaint']}, 13:18:13 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:18:13 INFO - 'tests': ['tsvgx', 13:18:13 INFO - 'tsvgr_opacity', 13:18:13 INFO - 'tart', 13:18:13 INFO - 'tscrollx', 13:18:13 INFO - 'cart', 13:18:13 INFO - 'tsvg_static']}, 13:18:13 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:18:13 INFO - 'tsvgr_opacity', 13:18:13 INFO - 'tart', 13:18:13 INFO - 'tscrollx', 13:18:13 INFO - 'cart', 13:18:13 INFO - 'tsvg_static']}, 13:18:13 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:18:13 INFO - 'talos_options': ['--disable-e10s'], 13:18:13 INFO - 'tests': ['tp5o']}, 13:18:13 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:18:13 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:18:13 INFO - 'talos_options': ['--disable-e10s', 13:18:13 INFO - '--xperf_path', 13:18:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:18:13 INFO - 'tests': ['tp5n']}, 13:18:13 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:18:13 INFO - 'talos_options': ['--xperf_path', 13:18:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:18:13 INFO - 'tests': ['tp5n']}}, 13:18:13 INFO - 'talos.zip': {'path': '', 13:18:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:18:13 INFO - Running post-action listener: _resource_record_post_action 13:18:13 INFO - [mozharness: 2017-05-08 20:18:13.809740Z] Finished populate-webroot step (success) 13:18:13 INFO - [mozharness: 2017-05-08 20:18:13.809878Z] Running create-virtualenv step. 13:18:13 INFO - Running pre-action listener: _resource_record_pre_action 13:18:13 INFO - Running main action method: create_virtualenv 13:18:13 INFO - Creating virtualenv /builds/slave/test/build/venv 13:18:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 13:18:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:18:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:18:13 INFO - Using real prefix '/tools/python27' 13:18:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:18:14 INFO - Installing distribute.............................................................................................................................................................................................done. 13:18:17 INFO - Installing pip.................done. 13:18:17 INFO - Return code: 0 13:18:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:18:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:18:17 INFO - Reading from file tmpfile_stdout 13:18:17 INFO - Output received: 13:18:17 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 13:18:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a434b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a437768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb92bdef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a212d30>, '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 0x10a139db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a207be8>, '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.o46SdqAIA1/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.866AC47cXc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:18:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 13:18:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 13:18:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o46SdqAIA1/Render', 13:18:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:17 INFO - 'HOME': '/Users/cltbld', 13:18:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:17 INFO - 'LOGNAME': 'cltbld', 13:18:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:17 INFO - 'MOZ_NO_REMOTE': '1', 13:18:17 INFO - 'NO_EM_RESTART': '1', 13:18:17 INFO - 'PAGER': '/bin/cat', 13:18:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:17 INFO - 'PWD': '/builds/slave/test', 13:18:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:17 INFO - 'SHELL': '/bin/bash', 13:18:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.866AC47cXc/Listeners', 13:18:17 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 13:18:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:17 INFO - 'USER': 'cltbld', 13:18:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:17 INFO - 'XPC_FLAGS': '0x0', 13:18:17 INFO - 'XPC_SERVICE_NAME': '0', 13:18:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:18 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 13:18:18 INFO - Cleaning up... 13:18:18 INFO - Return code: 0 13:18:18 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:18 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 0x10a434b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a437768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb92bdef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a212d30>, '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 0x10a139db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a207be8>, '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.o46SdqAIA1/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.866AC47cXc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:18:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 13:18:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 13:18:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o46SdqAIA1/Render', 13:18:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:18 INFO - 'HOME': '/Users/cltbld', 13:18:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:18 INFO - 'LOGNAME': 'cltbld', 13:18:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:18 INFO - 'MOZ_NO_REMOTE': '1', 13:18:18 INFO - 'NO_EM_RESTART': '1', 13:18:18 INFO - 'PAGER': '/bin/cat', 13:18:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:18 INFO - 'PWD': '/builds/slave/test', 13:18:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:18 INFO - 'SHELL': '/bin/bash', 13:18:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.866AC47cXc/Listeners', 13:18:18 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 13:18:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:18 INFO - 'USER': 'cltbld', 13:18:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:18 INFO - 'XPC_FLAGS': '0x0', 13:18:18 INFO - 'XPC_SERVICE_NAME': '0', 13:18:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:18 INFO - Downloading/unpacking psutil>=3.1.1 13:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:18:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:18:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:18:20 INFO - Installing collected packages: psutil 13:18:20 INFO - Running setup.py install for psutil 13:18:20 INFO - building 'psutil._psutil_osx' extension 13:18:20 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 13:18:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 13:18:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 13:18:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 13:18:21 INFO - building 'psutil._psutil_posix' extension 13:18:21 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 13:18:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:18:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:18:21 INFO - ^ 13:18:21 INFO - 1 warning generated. 13:18:21 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 13:18:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:18:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:18:21 INFO - Successfully installed psutil 13:18:21 INFO - Cleaning up... 13:18:21 INFO - Return code: 0 13:18:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:21 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 0x10a434b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a437768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb92bdef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a212d30>, '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 0x10a139db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a207be8>, '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.o46SdqAIA1/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.866AC47cXc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:18:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 13:18:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 13:18:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o46SdqAIA1/Render', 13:18:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:21 INFO - 'HOME': '/Users/cltbld', 13:18:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:21 INFO - 'LOGNAME': 'cltbld', 13:18:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:21 INFO - 'MOZ_NO_REMOTE': '1', 13:18:21 INFO - 'NO_EM_RESTART': '1', 13:18:21 INFO - 'PAGER': '/bin/cat', 13:18:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:21 INFO - 'PWD': '/builds/slave/test', 13:18:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:21 INFO - 'SHELL': '/bin/bash', 13:18:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.866AC47cXc/Listeners', 13:18:21 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 13:18:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:21 INFO - 'USER': 'cltbld', 13:18:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:21 INFO - 'XPC_FLAGS': '0x0', 13:18:21 INFO - 'XPC_SERVICE_NAME': '0', 13:18:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:22 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:23 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:18:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:18:23 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:18:23 INFO - Installing collected packages: mozsystemmonitor 13:18:23 INFO - Running setup.py install for mozsystemmonitor 13:18:23 INFO - Successfully installed mozsystemmonitor 13:18:23 INFO - Cleaning up... 13:18:23 INFO - Return code: 0 13:18:23 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:18:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:24 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 0x10a434b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a437768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb92bdef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a212d30>, '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 0x10a139db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a207be8>, '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.o46SdqAIA1/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.866AC47cXc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:18:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 13:18:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 13:18:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o46SdqAIA1/Render', 13:18:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:24 INFO - 'HOME': '/Users/cltbld', 13:18:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:24 INFO - 'LOGNAME': 'cltbld', 13:18:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:24 INFO - 'MOZ_NO_REMOTE': '1', 13:18:24 INFO - 'NO_EM_RESTART': '1', 13:18:24 INFO - 'PAGER': '/bin/cat', 13:18:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:24 INFO - 'PWD': '/builds/slave/test', 13:18:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:24 INFO - 'SHELL': '/bin/bash', 13:18:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.866AC47cXc/Listeners', 13:18:24 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 13:18:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:24 INFO - 'USER': 'cltbld', 13:18:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:24 INFO - 'XPC_FLAGS': '0x0', 13:18:24 INFO - 'XPC_SERVICE_NAME': '0', 13:18:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:24 INFO - Downloading/unpacking jsonschema==2.5.1 13:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:18:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:26 INFO - Downloading functools32-3.2.3-2.tar.gz 13:18:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:18:26 INFO - warning: no files found matching '*.txt' 13:18:26 INFO - no previously-included directories found matching 'build' 13:18:26 INFO - no previously-included directories found matching 'dist' 13:18:26 INFO - no previously-included directories found matching '.git*' 13:18:26 INFO - Installing collected packages: jsonschema, functools32 13:18:26 INFO - Running setup.py install for functools32 13:18:26 INFO - warning: no files found matching '*.txt' 13:18:26 INFO - no previously-included directories found matching 'build' 13:18:26 INFO - no previously-included directories found matching 'dist' 13:18:26 INFO - no previously-included directories found matching '.git*' 13:18:26 INFO - Successfully installed jsonschema functools32 13:18:26 INFO - Cleaning up... 13:18:26 INFO - Return code: 0 13:18:26 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:26 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 0x10a434b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a437768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb92bdef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a212d30>, '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 0x10a139db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a207be8>, '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.o46SdqAIA1/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.866AC47cXc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:18:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:18:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:18:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o46SdqAIA1/Render', 13:18:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:26 INFO - 'HOME': '/Users/cltbld', 13:18:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:26 INFO - 'LOGNAME': 'cltbld', 13:18:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:26 INFO - 'MOZ_NO_REMOTE': '1', 13:18:26 INFO - 'NO_EM_RESTART': '1', 13:18:26 INFO - 'PAGER': '/bin/cat', 13:18:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:26 INFO - 'PWD': '/builds/slave/test', 13:18:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:26 INFO - 'SHELL': '/bin/bash', 13:18:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.866AC47cXc/Listeners', 13:18:26 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 13:18:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:26 INFO - 'USER': 'cltbld', 13:18:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:26 INFO - 'XPC_FLAGS': '0x0', 13:18:26 INFO - 'XPC_SERVICE_NAME': '0', 13:18:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:18:27 INFO - Cleaning up... 13:18:27 INFO - Return code: 0 13:18:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:27 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 0x10a434b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a437768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb92bdef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a212d30>, '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 0x10a139db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a207be8>, '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.o46SdqAIA1/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.866AC47cXc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:18:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:18:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:18:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o46SdqAIA1/Render', 13:18:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:27 INFO - 'HOME': '/Users/cltbld', 13:18:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:27 INFO - 'LOGNAME': 'cltbld', 13:18:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:27 INFO - 'MOZ_NO_REMOTE': '1', 13:18:27 INFO - 'NO_EM_RESTART': '1', 13:18:27 INFO - 'PAGER': '/bin/cat', 13:18:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:27 INFO - 'PWD': '/builds/slave/test', 13:18:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:27 INFO - 'SHELL': '/bin/bash', 13:18:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.866AC47cXc/Listeners', 13:18:27 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 13:18:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:27 INFO - 'USER': 'cltbld', 13:18:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:27 INFO - 'XPC_FLAGS': '0x0', 13:18:27 INFO - 'XPC_SERVICE_NAME': '0', 13:18:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:27 INFO - Downloading/unpacking blobuploader==1.2.4 13:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:28 INFO - Downloading blobuploader-1.2.4.tar.gz 13:18:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:18:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:18:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:29 INFO - Downloading docopt-0.6.1.tar.gz 13:18:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:18:29 INFO - Installing collected packages: blobuploader, requests, docopt 13:18:29 INFO - Running setup.py install for blobuploader 13:18:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:18:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:18:29 INFO - Running setup.py install for requests 13:18:30 INFO - Running setup.py install for docopt 13:18:30 INFO - Successfully installed blobuploader requests docopt 13:18:30 INFO - Cleaning up... 13:18:30 INFO - Return code: 0 13:18:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:30 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 0x10a434b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a437768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb92bdef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a212d30>, '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 0x10a139db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a207be8>, '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.o46SdqAIA1/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.866AC47cXc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:18:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:18:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:18:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o46SdqAIA1/Render', 13:18:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:30 INFO - 'HOME': '/Users/cltbld', 13:18:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:30 INFO - 'LOGNAME': 'cltbld', 13:18:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:30 INFO - 'MOZ_NO_REMOTE': '1', 13:18:30 INFO - 'NO_EM_RESTART': '1', 13:18:30 INFO - 'PAGER': '/bin/cat', 13:18:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:30 INFO - 'PWD': '/builds/slave/test', 13:18:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:30 INFO - 'SHELL': '/bin/bash', 13:18:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.866AC47cXc/Listeners', 13:18:30 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 13:18:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:30 INFO - 'USER': 'cltbld', 13:18:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:30 INFO - 'XPC_FLAGS': '0x0', 13:18:30 INFO - 'XPC_SERVICE_NAME': '0', 13:18:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:18:30 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-ZP04l5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:18:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:18:30 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-2HwRZO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:18:31 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-ixuaGU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:18:31 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-KWBmI_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:18:31 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-3BHMEU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:18:31 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-XBVocT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:18:31 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-gtR2M1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:18:31 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-eKt80F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:18:31 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-_5bLJj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:18:31 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-W3WB71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:18:31 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-o4kxOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:18:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:18:31 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-o3n1b4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:18:32 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-S5WEfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:18:32 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-T_IEuq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:18:32 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-KgNWa7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:18:32 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-NeM75b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:18:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:18:32 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-ZFrYdU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:18:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:18:32 INFO - Running setup.py install for manifestparser 13:18:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:18:32 INFO - Running setup.py install for mozcrash 13:18:32 INFO - Running setup.py install for mozdebug 13:18:33 INFO - Running setup.py install for mozdevice 13:18:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:18:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:18:33 INFO - Running setup.py install for mozfile 13:18:33 INFO - Running setup.py install for mozhttpd 13:18:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:18:33 INFO - Running setup.py install for mozinfo 13:18:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:18:33 INFO - Running setup.py install for mozInstall 13:18:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:18:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:18:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:18:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:18:33 INFO - Running setup.py install for mozleak 13:18:33 INFO - Running setup.py install for mozlog 13:18:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:18:34 INFO - Running setup.py install for moznetwork 13:18:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:18:34 INFO - Running setup.py install for mozprocess 13:18:34 INFO - Running setup.py install for mozprofile 13:18:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:18:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:18:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:18:34 INFO - Running setup.py install for mozrunner 13:18:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:18:34 INFO - Running setup.py install for mozscreenshot 13:18:34 INFO - Running setup.py install for moztest 13:18:35 INFO - Running setup.py install for mozversion 13:18:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:18:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:18:35 INFO - Cleaning up... 13:18:35 INFO - Return code: 0 13:18:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:18: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')]} 13:18:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18: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')]} 13:18:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:35 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 0x10a434b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a437768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb92bdef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a212d30>, '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 0x10a139db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a207be8>, '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.o46SdqAIA1/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.866AC47cXc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:18:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 13:18:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:18:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o46SdqAIA1/Render', 13:18:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:35 INFO - 'HOME': '/Users/cltbld', 13:18:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:35 INFO - 'LOGNAME': 'cltbld', 13:18:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:35 INFO - 'MOZ_NO_REMOTE': '1', 13:18:35 INFO - 'NO_EM_RESTART': '1', 13:18:35 INFO - 'PAGER': '/bin/cat', 13:18:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:35 INFO - 'PWD': '/builds/slave/test', 13:18:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:35 INFO - 'SHELL': '/bin/bash', 13:18:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.866AC47cXc/Listeners', 13:18:35 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 13:18:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:35 INFO - 'USER': 'cltbld', 13:18:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:35 INFO - 'XPC_FLAGS': '0x0', 13:18:35 INFO - 'XPC_SERVICE_NAME': '0', 13:18:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:18:35 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-lOVpLd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 13:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:18:35 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-sE_SOk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:18:35 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-zFVteU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:18:35 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-AES2x7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:18:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:18:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:18:35 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-DIdmXM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 13:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:18:36 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-akdDnn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 13:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:18:36 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-6em5Bc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 13:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:18:36 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-oQxooC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 13:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:18:36 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-FaBZX4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 13:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:18:36 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-9_OP0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:18:36 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-wmmISx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 13:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:18:36 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-iLvbOy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:18:36 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)) 13:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:18:36 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-LkbLGQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 13:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:18:36 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-zK4Jmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:18:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 13:18:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:18:36 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-oquXjk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 13:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:18:37 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-jqiaBs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 13:18:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:18:37 INFO - Running setup.py (path:/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/pip-tIpgSs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 13:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 13:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 13:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:18:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 13:18:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:18:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:18:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:18:38 INFO - Downloading blessings-1.6.tar.gz 13:18:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:18:38 INFO - Installing collected packages: blessings 13:18:38 INFO - Running setup.py install for blessings 13:18:38 INFO - Successfully installed blessings 13:18:38 INFO - Cleaning up... 13:18:39 INFO - Return code: 0 13:18:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:18:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:18:39 INFO - Reading from file tmpfile_stdout 13:18:39 INFO - Current package versions: 13:18:39 INFO - blessings == 1.6 13:18:39 INFO - blobuploader == 1.2.4 13:18:39 INFO - docopt == 0.6.1 13:18:39 INFO - functools32 == 3.2.3-2 13:18:39 INFO - jsonschema == 2.5.1 13:18:39 INFO - manifestparser == 1.1 13:18:39 INFO - mozInstall == 1.12 13:18:39 INFO - mozcrash == 1.0 13:18:39 INFO - mozdebug == 0.1 13:18:39 INFO - mozdevice == 0.49 13:18:39 INFO - mozfile == 1.2 13:18:39 INFO - mozhttpd == 0.7 13:18:39 INFO - mozinfo == 0.9 13:18:39 INFO - mozleak == 0.1 13:18:39 INFO - mozlog == 3.4 13:18:39 INFO - moznetwork == 0.27 13:18:39 INFO - mozprocess == 0.25 13:18:39 INFO - mozprofile == 0.28 13:18:39 INFO - mozrunner == 6.13 13:18:39 INFO - mozscreenshot == 0.1 13:18:39 INFO - mozsystemmonitor == 0.3 13:18:39 INFO - moztest == 0.8 13:18:39 INFO - mozversion == 1.4 13:18:39 INFO - psutil == 3.1.1 13:18:39 INFO - requests == 1.2.3 13:18:39 INFO - wsgiref == 0.1.2 13:18:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:39 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 0x10a434b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a437768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb92bdef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a212d30>, '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 0x10a139db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a207be8>, '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.o46SdqAIA1/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.866AC47cXc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:18:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 13:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 13:18:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o46SdqAIA1/Render', 13:18:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:39 INFO - 'HOME': '/Users/cltbld', 13:18:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:39 INFO - 'LOGNAME': 'cltbld', 13:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:39 INFO - 'MOZ_NO_REMOTE': '1', 13:18:39 INFO - 'NO_EM_RESTART': '1', 13:18:39 INFO - 'PAGER': '/bin/cat', 13:18:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:39 INFO - 'PWD': '/builds/slave/test', 13:18:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:39 INFO - 'SHELL': '/bin/bash', 13:18:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.866AC47cXc/Listeners', 13:18:39 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 13:18:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:39 INFO - 'USER': 'cltbld', 13:18:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:39 INFO - 'XPC_FLAGS': '0x0', 13:18:39 INFO - 'XPC_SERVICE_NAME': '0', 13:18:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 13:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 13:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 13:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 13:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 13:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 13:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 13:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 13:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 13:18:39 INFO - Cleaning up... 13:18:39 INFO - Return code: 0 13:18:39 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:18:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:18:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:18:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a434b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a437768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb92bdef180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a212d30>, '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 0x10a139db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a207be8>, '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.o46SdqAIA1/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.866AC47cXc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:18:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 13:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 13:18:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o46SdqAIA1/Render', 13:18:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:39 INFO - 'HOME': '/Users/cltbld', 13:18:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:39 INFO - 'LOGNAME': 'cltbld', 13:18:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:39 INFO - 'MOZ_NO_REMOTE': '1', 13:18:39 INFO - 'NO_EM_RESTART': '1', 13:18:39 INFO - 'PAGER': '/bin/cat', 13:18:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:39 INFO - 'PWD': '/builds/slave/test', 13:18:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:39 INFO - 'SHELL': '/bin/bash', 13:18:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.866AC47cXc/Listeners', 13:18:39 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 13:18:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:39 INFO - 'USER': 'cltbld', 13:18:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:39 INFO - 'XPC_FLAGS': '0x0', 13:18:39 INFO - 'XPC_SERVICE_NAME': '0', 13:18:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:18:39 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:18:39 INFO - Cleaning up... 13:18:39 INFO - Return code: 0 13:18:39 INFO - Running post-action listener: _resource_record_post_action 13:18:39 INFO - Running post-action listener: _start_resource_monitoring 13:18:39 INFO - Starting resource monitoring. 13:18:39 INFO - [mozharness: 2017-05-08 20:18:39.920989Z] Finished create-virtualenv step (success) 13:18:39 INFO - [mozharness: 2017-05-08 20:18:39.921989Z] Running install step. 13:18:39 INFO - Running pre-action listener: _resource_record_pre_action 13:18:39 INFO - Running main action method: install 13:18:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:18:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:18:40 INFO - Reading from file tmpfile_stdout 13:18:40 INFO - Detecting whether we're running mozinstall >=1.0... 13:18:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:18:40 INFO - Reading from file tmpfile_stdout 13:18:40 INFO - Output received: 13:18:40 INFO - Usage: mozinstall [options] installer 13:18:40 INFO - Options: 13:18:40 INFO - -h, --help show this help message and exit 13:18:40 INFO - -d DEST, --destination=DEST 13:18:40 INFO - Directory to install application into. [default: 13:18:40 INFO - "/builds/slave/test"] 13:18:40 INFO - --app=APP Application being installed. [default: firefox] 13:18:40 INFO - mkdir: /builds/slave/test/build/application 13:18:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 13:18:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 13:18:55 INFO - Reading from file tmpfile_stdout 13:18:55 INFO - Output received: 13:18:55 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:18:55 INFO - Running post-action listener: _resource_record_post_action 13:18:55 INFO - [mozharness: 2017-05-08 20:18:55.074265Z] Finished install step (success) 13:18:55 INFO - [mozharness: 2017-05-08 20:18:55.074443Z] Running run-tests step. 13:18:55 INFO - Running pre-action listener: _resource_record_pre_action 13:18:55 INFO - Running main action method: run_tests 13:18:55 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:18:55 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:18:55 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:18:55 INFO - 2017-05-08 13:18:55.088 screenresolution[1618:7693] starting screenresolution argv=screenresolution get 13:18:55 INFO - 2017-05-08 13:18:55.091 screenresolution[1618:7693] Display 0: 1600x1200x32@60 13:18:55 INFO - 2017-05-08 13:18:55.097 screenresolution[1619:7695] starting screenresolution argv=screenresolution list 13:18:55 INFO - Available Modes on Display 0 13:18:55 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:18:55 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:18:55 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:18:55 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:18:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:18:55 INFO - Intel Iris: 13:18:55 INFO - Chipset Model: Intel Iris 13:18:55 INFO - Type: GPU 13:18:55 INFO - Bus: Built-In 13:18:55 INFO - VRAM (Dynamic, Max): 1536 MB 13:18:55 INFO - Vendor: Intel (0x8086) 13:18:55 INFO - Device ID: 0x0a2e 13:18:55 INFO - Revision ID: 0x0009 13:18:55 INFO - Displays: 13:18:55 INFO - Display: 13:18:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:18:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:18:55 INFO - Display Serial Number: 1600x1200 60 13:18:55 INFO - Main Display: Yes 13:18:55 INFO - Mirror: Off 13:18:55 INFO - Online: Yes 13:18:55 INFO - Rotation: Supported 13:18:55 INFO - Return code: 0 13:18:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:18:55 INFO - Python 2.7.3 13:18:55 INFO - Return code: 0 13:18:55 INFO - grabbing minidump binary from tooltool 13:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:18:55 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 0x10a212d30>, '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 0x10a139db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a207be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:18:55 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 13:18:55 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 13:18:55 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 13:18:55 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:18:55 INFO - Return code: 0 13:18:55 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:18:55 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:18:55 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:18:55 INFO - ENV: RUST_BACKTRACE is now 1 13:18:55 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:18:55 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:18:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BXmsGQRlSBm7jriOX2j-zw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0075', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:18:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/BXmsGQRlSBm7jriOX2j-zw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0075 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:18:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.o46SdqAIA1/Render', 13:18:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:18:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:18:55 INFO - 'HOME': '/Users/cltbld', 13:18:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:18:55 INFO - 'LOGNAME': 'cltbld', 13:18:55 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:18:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:18:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:18:55 INFO - 'MOZ_NO_REMOTE': '1', 13:18:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:18:55 INFO - 'NO_EM_RESTART': '1', 13:18:55 INFO - 'PAGER': '/bin/cat', 13:18:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:18:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:18:55 INFO - 'PWD': '/builds/slave/test', 13:18:55 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:18:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:18:55 INFO - 'RUST_BACKTRACE': '1', 13:18:55 INFO - 'SHELL': '/bin/bash', 13:18:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.866AC47cXc/Listeners', 13:18:55 INFO - 'TMPDIR': '/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/', 13:18:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:18:55 INFO - 'USER': 'cltbld', 13:18:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:18:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:18:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:18:55 INFO - 'XPC_FLAGS': '0x0', 13:18:55 INFO - 'XPC_SERVICE_NAME': '0', 13:18:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:18:55 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/BXmsGQRlSBm7jriOX2j-zw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0075', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:18:55 INFO - mozversion application_buildid: 20170508121942 13:18:55 INFO - mozversion application_changeset: 910e97516eb77e23f0c1461be92f396d5db12f8f 13:18:55 INFO - mozversion application_display_name: Firefox 13:18:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:18:55 INFO - mozversion application_name: Firefox 13:18:55 INFO - mozversion application_remotingname: firefox 13:18:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:18:55 INFO - mozversion application_vendor: Mozilla 13:18:55 INFO - mozversion application_version: 54.0 13:18:55 INFO - mozversion platform_buildid: 20170508121942 13:18:55 INFO - mozversion platform_changeset: 910e97516eb77e23f0c1461be92f396d5db12f8f 13:18:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:18:55 INFO - mozversion platform_version: 54.0 13:18:55 INFO - using testdate: 1494274735 13:18:55 INFO - actual date: 1494274735 13:18:55 INFO - starting webserver on 'localhost:49240' 13:18:55 INFO - SUITE-START | Running 2 tests 13:18:55 INFO - TEST-START | dromaeo_css 13:18:55 INFO - operating with platform_type : mac_ 13:18:55 INFO - Initialising browser for dromaeo_css test... 13:18:55 INFO - TEST-INFO | started process 1629 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpZdCKS0/profile http://localhost:49240/getInfo.html) 13:18:58 INFO - PROCESS | 1629 | 2017-05-08 13:18:58.379 plugin-container[1632:7861] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e43, name = 'com.apple.tsm.portname' 13:18:58 INFO - PROCESS | 1629 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:18:58 INFO - PROCESS | 1629 | 2017-05-08 13:18:58.380 plugin-container[1632:7861] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b23, name = 'com.apple.CFPasteboardClient' 13:18:58 INFO - PROCESS | 1629 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:18:58 INFO - PROCESS | 1629 | 2017-05-08 13:18:58.380 plugin-container[1632:7861] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:18:58 INFO - PROCESS | 1629 | __metrics Screen width/height:1600/1200 13:18:58 INFO - PROCESS | 1629 | colorDepth:24 13:18:58 INFO - PROCESS | 1629 | Browser inner width/height: 1024/689 13:18:58 INFO - PROCESS | 1629 | __metrics 13:18:58 ERROR - PROCESS | 1629 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 13:18:59 INFO - TEST-INFO | 1629: exit 0 13:18:59 INFO - Browser initialized. 13:18:59 INFO - Running cycle 1/1 for dromaeo_css test... 13:18:59 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpZdCKS0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:19:01 INFO - PROCESS | 1633 | 2017-05-08 13:19:01.596 plugin-container[1634:8000] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8547, name = 'com.apple.tsm.portname' 13:19:01 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:19:01 INFO - PROCESS | 1633 | 2017-05-08 13:19:01.596 plugin-container[1634:8000] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b17, name = 'com.apple.CFPasteboardClient' 13:19:01 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:19:01 INFO - PROCESS | 1633 | 2017-05-08 13:19:01.596 plugin-container[1634:8000] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:19:11 INFO - PROCESS | 1633 | RSS: Main: 174440448 13:19:11 INFO - PROCESS | 1633 | 13:22:14 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 13:22:16 INFO - PROCESS | 1633 | RSS: Main: 189485056 13:22:16 INFO - PROCESS | 1633 | 13:25:18 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 13:25:18 INFO - PROCESS | 1633 | RSS: Main: 201666560 13:25:18 INFO - PROCESS | 1633 | 13:28:20 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 13:28:21 INFO - PROCESS | 1633 | RSS: Main: 203825152 13:28:21 INFO - PROCESS | 1633 | 13:31:23 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 13:31:23 INFO - PROCESS | 1633 | RSS: Main: 206893056 13:31:23 INFO - PROCESS | 1633 | 13:34:26 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 13:34:27 INFO - PROCESS | 1633 | RSS: Main: 209375232 13:34:27 INFO - PROCESS | 1633 | 13:37:30 INFO - PROCESS | 1633 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 13:37:30 INFO - PROCESS | 1633 | RSS: Main: 207921152 13:37:30 INFO - PROCESS | 1633 | 13:37:30 INFO - PROCESS | 1633 | __start_tp_report 13:37:30 INFO - PROCESS | 1633 | _x_x_mozilla_page_load 13:37:30 INFO - PROCESS | 1633 | _x_x_mozilla_page_load_details 13:37:30 INFO - PROCESS | 1633 | |i|pagename|runs| 13:37:30 INFO - PROCESS | 1633 | |0;dojo.html;3578.3022310649435;3602.8198590070497;3628.2743451309743;3636.39999400099;3640.4357324614693;6166.3525329840395;6171.2903016153095;6182.103594978726;6194.7212375443105;6213.627182369061;6140.7850725224625;6178.41305076017;6182.412670796267;6222.12890195373;6224.190855188819;5388.838334849961;5490.752916118784;5527.751251193686;5554.666719996793;5555.2778138842095;5572.164175373706;5618.101103823389;5623.128415095646;5623.26897503326;5688.544916406699;5354.839354819343;5370.7046112463795;5515.7242137892945;5613.270274864262;5614.775408983635;5616.5787565932715;5630.634008789416;5638.971805140968;5680.460356266148;5687.459691329317;5431.8098866539485;5564.387917329091;5569.387367389584;5582.665040097567;5635.492805647511;5864.824055278348;5978.8206353809455;6008.879822403571;6180.567360284782;6240.937590624081;6354.904676429811;6364.331745166737;6381.52138589603;6411.647359395231;6490.415862572391;6595.241547222083;6611.966940165316;6616.27221005689;6619.900701489481;6636.900446493307;5173.534381905646;5202.193659982709;6231.376862313732;6259.937400625936;6297.4962003039645;6500.317466666026;6504.121943537656;6689.866202676017;6708.865822683519;6737.989301604798;6425.710843012076;6442.194725659293;6446.774362897276;6465.547411681137;6476.870462590722;6081.331053584191;6305.558610897285;6584.012398140318;6637.103990961255;6645.401913827779;6231.844203894848;6255.937440625627;6393.968030159819;6498.805035848932;6558.409743123142;6213.689315534205;6272.968635156795;6504.642244676494;6532.444742196966;6546.476281897437;4961.950380496149;5264.341957255343;5271.551918087006;5304.071787437183;5319.840404787863;4722.173619616553;4728.905421891543;4739.4075740532435;4756.548127927841;4765.9046819064115;6161.815145545641;6169.5064394849205;6170.10533472644;6199.659018754011;6254.34329395416;5621.634593751393;6645.06969024337;6664.900026499607;6672.199336079701;6675.86648267032;6265.8746825063245;6268.185135932391;6281.528885333618;6283.6858157091965;6322.988321868479;5683.431656834367;5715.8571035724435;5802.158686990447;5920.407959204132;5967.582269241198;6652.7338906444165;6777.356151165632;6807.693653785691;6807.795766127024;6838.965805171141;6625.867482650417;6631.933680663132;6656.933430665631;6686.1642294713165;6690.163729533809;6848.589084654936;6863.794086177422;6894.827629309308;6913.41235994926;6934.16789985205;6274.309825919237;6308.589941653778;6453.806385808245;6462.224533056064;6583.210014798064;6662.83342916431;6665.766698165541;6679.666016699049;6681.365270299314;6702.994550817416;6436.292007879223;6465.1595292611655;6478.449331806849;6489.1888513935755;6498.707558159988;6135.44703110649;6168.9691551541955;6330.841728956813;6351.650659213788;6504.707288171949;5079.644424890223;6246.312905580292;6322.399372059831;6331.702001089673;6333.841653958688;6169.81490555284;6210.161628180319;6275.5920865145445;6429.9678501607195;6457.483401327976;6248.562600617913;6316.115743795965;6319.925612645953;6334.809955701337;6336 13:37:30 INFO - PROCESS | 1633 | |1;ext.html;807.8868958345832;835.3484282259838;862.2886118951866;993.781368099018;997.7405874472639;32506.349873002524;39050.80474597627;41431.549895753655;41530.79234603823;41633.54282600113;39447.0138246544;39490.407643885366;39755;39793.60206397935;39840.60159398405;8379.287760540346;8505.277051450603;9765.218782497383;11181.664550063511;11421.600243991463;11090.500927458284;11161.162912781534;11196.272242304265;11197.608083717072;11216.887831121667;11227.157963152755;11248.887511124907;11257.324560526353;11265.549378024869;11284.717882052973;11187;11201.943990280037;11203.21577489576;11208.495617697183;11209.551617935273;10989.450527473675;11049.447527623586;11064.889351106467;11067.778644427066;11083;27490.312742181406;34571.48142777835;34970.65029349699;35043.4743478848;35194.64805351939;3924.274009308287;3957.5053118360206;3982.1040265940223;3993.920121597581;4013.919721605581;21820.672689909665;25878.482430351287;26124.608130878052;26412.86793566039;27458.17625471239;3192.170035790688;3243.8053716777067;3257.8859739909226;3278.7704860659765;3400.2349471368993;326706;354432;358967;383944;387007;43685.56314436815;43865.78067109644;43956.560434395884;43961.34057989133;43982;44968.55031449644;45266;45336.77331613321;45436.182552698185;45494.54505454969;14074.225917574631;14210.715785684228;14275.286235688174;14293.571192864023;14299;12497.687557811127;12555.372231388394;12555.435005424777;12588.181768185039;12608.739126087317;11823.704407389883;11847.822282665767;11916.344601047025;12063.21589096706;12122.39388030595;5835.949529084721;5843.912341314884;5852.912206316909;5870.530357571384;5872.265966754156;847.3221422861686;987.1115995604014;992.7392211890858;1000.7197984564334;1043.186314674555;25212.865421056096;27525;27949.021784237862;28431;28566.71433285682;1017.7710015246511;1086.120242603478;1090.9127269818396;1123.719070232442;1133.7845809296207;13024.153430027018;14568.344424500923;14594.781078283835;14595.343209555596;14794.334254958552;385190;472178;473739;473821;478869.63391097623;47948.7602561985;48213.75893120512;48462.5153748458;48469.515304847206;48624.5137548627;1442.293276294629;1480.7334679757746;1489.5680252726588;1492.7089217602463;1496.940122395092;23109.422264443525;24473.776311184727;25077.247682569552;26317.34206644849;26761;32358.67641323651;41241.58758412377;41469.170616588104;41494.58505414907;41540.79229603833;409898;410065.84901227104;411180;411238;411252;26552.468950621267;29362.412751745273;29568.852155739085;31491.52762708607;32638.51042234416;39490.802545987084;40551.3917291235;40835.38746918739;40940.59059409368;41885;28146.85926570354;28373.290667733472;28954.42091158207;29350.853245733633;29419;28108.78057276521;28466.430671386042;28577.85688572517;28626.854925802734;28985.42029159363;33112.33775324432;33123.171920702174;33182.17044573905;33246;33420.331593368486;23720.932558034583;26428.73571264263;27388.726112739416;27901.441971160057;28859.42281154407;21303.615265007724;21335.573288533833;22027.449313767283;23069;23467.882660586587 13:37:30 INFO - PROCESS | 1633 | |2;jquery.html;430.63180980261853;442.3850847322221;442.6436718441654;452.3824978903796;453.22046080741154;20351.491212719688;21304;22533.436664083405;22611.434714132156;22730.431739206528;19595;22617.321480355615;22915.885420572915;23895.16366927158;24125.87937060312;6754.831129221784;6875.965620171892;6981.755638552651;7165.749198778018;7174.892376614355;6929.792106236821;7019.964900175492;7053.929460705404;7086.07880975475;7112.786616401516;6732.091167692348;7055.4002909752735;7083.610401427919;7123.323284287984;7137.928620713804;6700.698468568926;7005.299470053005;7035.577865328071;7094.432445404355;7113.502054856162;6886.827829304258;6892.207396149457;6917.7232910683515;6920.169579650475;6954.165500139965;27205.183844484698;27682;28095.57856632152;28254.576181357297;28539;3017.6529699084667;3019.3961207758534;3033.514637657986;3039.4832878410725;3051.3287076843058;13941.58175254744;16636.251368688438;17151.571210719707;17217.311307547807;17472.213750381263;2100.8214301784365;2127.095984206706;2138.4012476506605;2208.3485371815354;2246.674232236333;126326;131431;134739.32630336884;135535;135738;22138.557228855334;22162.778372216395;22555.98498067591;22742;22761.658575121386;35820.641793582254;36336.636633633854;36537.08657283536;36538.72114476034;36594.634053659654;9377.578008989612;11434.085273178292;11705.239159454608;11729.472173752201;11809.881901180877;8066.5563394012715;9557.283203759745;9611.231101511863;9613.423194608346;9636;9954.800903982024;10108.534262531892;10929.234953553334;11031.83452248217;11155.832662510069;3730.6082861299715;3832.850144956502;4275.786210689515;4397.670174736908;4432.202203603318;950.9444516586583;1019.9337043092175;1089.5420844320613;1105.9889401106047;1131.4342828585707;20944.685829712565;22399.32802015942;22890.198843040413;22918.96864641095;23176.65235021476;1032.5405194688292;1092.595739576362;1095.835624656308;1098.6978580890159;1137.6587023892964;10225.335353202017;11461.942690286494;12093.45579448927;12315.815262771066;12323.445444955;699043;719396;737251;743937;744414;132082;138829;139141;162484.1875790637;173695;1097.550004498152;1279.1621487925424;1295.1452041652465;1302.2186687987132;1354.7358265138203;20191;20608.381748547567;21100.05049772733;21256.893715531944;21383;51261.74369128131;52054.73972630112;66952.33047669461;68156;68750;95117;95382;96152.0384796143;96423;97751.02248977419;11934.820977685167;11996.400179990791;12130.636080917586;12238.449269782703;12429.564965226175;13755.862441375459;13903.582892513241;14168.858311417167;14185.077969931921;14388.928055359656;9917.107460328605;11625.88374116282;12021.338826364634;12061.035117190779;12163.2702037878;9914.553845077133;11157.944210278896;11194.832077519006;11387.658370248906;11533.308001519936;11641.126915481203;11795.705107372385;12105.757884842078;12146.878531214928;12162.209456385306;11483.598074067368;11905.285682859056;12064.698382540155;12221.572244971383;12244.44899979521;10175.185985121025;11750.88249117532;11751.353675547585;11859.16985810985;11985.101117416054 13:37:30 INFO - PROCESS | 1633 | |3;mootools.html;1648.4972083514538;1673.3306677329067;1681.957951051224;1683.4023921507865;1683.5706894741838;10982.011618954293;11421.428928553581;11700.356480393575;11709.531618735251;11735.11986601004;11298.887011129907;11622.593209237679;11743;11745.119116066286;11779.7055073623;2057.794220577945;2521.773040426361;2526.7725904668578;2529.5067461844947;2530.455951970326;2040.9591108534605;2485.652008718781;2502.6621406110125;2505.7368976257503;2515.4591762771;2297.9540409191804;2326.2439707095177;2351.2358483492935;2359.6106642403984;2382.5711371953043;1851.7592712947364;2280.065173278956;2482.9751702482927;2485.527749727555;2501;2304.101400453824;2473.1467643663086;2486.6643003194517;2488.5645012122804;2493.6633554470095;10223.539940702687;10961.342319460859;11581.884181158164;11651.941740291244;11659.825102623467;5959.582829201958;6050.425209605124;6069.939300606981;6089.512838972872;6111.572189946705;3650.2152037312107;3705.4627079073384;3710.9814450927574;3783.1298801275584;3790.3177428062936;1270.84749830021;1279.8400199975003;1300.2978391668487;1319.7954317080869;1322.2397121655088;12916.741665166737;14406.567802965928;14674.486392976194;15474.690506189812;15508;4909.68087074339;5045.697258164522;5168.224766285012;5183.067047931333;5206.401263854629;13679;13701.383437745326;13711.314434278247;13715;13731.862681373259;6201.224846894138;6208.255009398901;6212.596181248205;6216.751329946752;6221.191245138103;5418.810341638024;5435.864103397367;5464.836054918359;5491.9725401373535;5506.972465137729;4223.669544093601;4264.1471705659;4282.293421585466;4333.826646934151;4334.978325108417;1152.6168597682815;1178.057553956831;1195.193244559936;1195.7010747313172;1196.1029228078942;973.2797729680127;997.07272236819;1002.8345323021765;1010.7675234695914;1018.4703953943907;6675.732970681215;6687.063811066455;6785.762498312535;6844.349786770348;6869.725210991604;933.4119504711988;1027.9691609251734;1033.6743925663393;1036.8496567997597;1113.9387333696563;4395.208862404734;4458.77706114693;4479.529649386833;4636.072785442925;4640.767961601907;13674.589762307147;13779.379927903268;14169.574912752634;14180.64548386278;14182.93627977885;13774.724505509834;14187.858121418654;14188.574342769733;14198.787018194735;14218.217998010208;8767.298616110696;8833.867491987625;8970.013298537157;10640.946795265974;10719.19606029551;6668.966655166693;7034.894476582957;7319.74380896666;7327.340539351484;7330.376917962033;11937.582184623496;11963.64109076729;11987;12081.75836483283;12140.878591213976;12776.552820651232;12880.484780608671;12924.870751292367;12931.870681293067;13091.214527128403;8337.541435221121;8649.481031138152;8793.076726943578;8903.688370906988;8935.419197752126;10300.021497957681;10386.272960892666;10511.474426278808;10528;10547.525361358605;7428.480006399716;8478.279346255636;9005.054469280893;9300.860487092563;9354;8917.821643566962;8959.969603495421;8960.283177345666;9027.052159523419;9233.353665243369;8191.590420479071;8207.95896020516;8227.794305142419;8266.173382661926;8305.667773289;5928.79249226275;5974;5984.1921340618455;6136.048912418582;6190.7214175363115;5999.6700181488695;6020.8795824084145;6212.81361559154;6262.279837818527;6313.96843015782 13:37:30 INFO - PROCESS | 1633 | |4;prototype.html;313.46867060332715;386.7544109490474;387.43628021229114;396.58160640524244;404.55498951153714;4769.308450274712;5249.580033597313;5273.888405840553;5331.573474122066;5392.40683524812;4163.605192260588;4672;5134;5183.974080129594;5221.765020574074;4247.25673007224;4346.9347959780625;4347.152305300468;4349.41282926804;4353.41228934093;4318;4330.588594083557;4333.458317710286;4351.21600143941;4354.956450435503;3786.1982133221495;3920.470736450571;4188.183304255671;4334.566543345656;4362.280223763075;3833.0034191110512;3958.7228893977435;4257.574242575718;4379.75911324877;4379.846705365313;3396.8301584920655;3791.6018818023986;3958.0209895052476;3972.443857859902;4037.313656678372;4282.657387409;4348.173846969097;4497.9100417991785;5047.889464317845;5049.545540901337;4217.789110544491;4663.48701642819;5004.324416203803;5019.272205530214;5047.9495205048215;5271.626159258078;5547.3343198816;5583.3300003999375;5591.384947655754;5641.266635337421;4052.027513396793;4088.5298190708154;4234.597713217239;4509.458864936196;4566.835456958487;5199.350081239845;5284.524392804666;5990.700464976778;6009.978303688384;6024.397560243984;4033.51597808259;4047.838086476508;4074.3684728867074;4539.84110556129;4559.361689363492;4090.734102283342;4643.628509719214;4649.67452278344;4681.695689780154;4710.505396933341;3846.942295865564;4310.956890431118;4953.2168419369;4987.501249874984;5000.649694643512;4887.853364399002;5114.9514349558995;5438.809641662523;5544.950277347442;5622.85942851432;1510.2750679673818;1566.4595714478487;1577.8639379646866;1582.2800625715272;1602.4952140075839;985.7289245457556;1007.7654872780931;1017.4200705597887;1152.7233463968587;1200.6398080575966;4714.020111553156;4776.498467660915;5335.466453354634;5344;5374.946250537523;5025.296458495814;5153.871153221125;5196.350456192976;5657.434256574392;5815.651060936358;4406.3170208617075;4840.249761287007;4890.682105663121;5050.823221187241;5302.594812374724;2742.2321749909656;2855.671597766242;3008.2028262510453;3019.6225471816024;3047.420990011891;4773.539184091506;5537.169424586345;6019.367966363557;6062;6074.301455332693;4736.550027747358;5539.806106786243;5609.298837645294;5908.150930578782;6213.068039794067;5706.514946229617;5784.537237021113;6086.573939824259;6117.510599152057;6241.251049874044;5397.86505337354;5627.650133122934;5678.716064196691;5772.268319504216;5812.622179558315;5696.1455781633085;5696.487316141567;5716.885662286814;5737.622970487137;5753.309602847517;4953.504649535162;5008.9248661269385;5488.341399032141;5577.5537956962535;5696.373398926197;4024.7182697212083;4408.382826404242;4504.07666428388;4552.453705555355;4580.88547786308;4861.805527778849;5024.623153263593;5083.415407228216;5338.172583249602;5768.577197576944;5126.7183204198955;5252.921206181833;5262.236975638588;5425.593080519056;5663.290544693233;4831.685940413862;5075.619328550448;5085.067674283749;5362.892742145214;5657.3776884543495;5157.922631160611;5213.6350455467755;5517.179330820739;5532.30846144232;5565.77736890536;4683.625309975126;5375.81184658535;5618.831435056954;5650.29371328584;5750.971245143747;5038.445770965264;5262.368815592204;5565.972170139124;5573.9655025914435;5626.902753962938 13:37:30 INFO - PROCESS | 1633 | |5;yui.html;704.130398957288;775.8603451378749;804.2962407893093;867.7223288547665;883.7834730491029;16436;17397.217125229363;17416.477505674833;17418.651626967483;17420.65158696827;15722.449714260003;15764.211789410512;15765.211739413013;16289.674206515863;16585.91707041466;1001.3441196016621;1021.724134483689;1027.014066496161;1028.8250997330435;1028.9434081125535;999.1008092716577;1019.4596863662271;1020.4081632653043;1022.5551884930042;1045.2683121814723;1089.9182561307894;1090.2749671468464;1090.5910283643634;1092.1426680056159;1092.344593244051;1069.1126365116972;1078.282941843673;1085.8968398002178;1086.8261078227524;1087.1574529739437;661.9437347825441;804.891339669143;810.0117856215408;810.3031393002013;811.2698571285831;17083.06043167625;17209.881357711707;17248.482545523653;18141.45575632733;18467.907660461748;14410.567682969422;14770.852291477055;14771.113733176044;14924.328405221791;14945.40218391274;12179;12197.268163910194;12197.573084942072;12224.877751222462;12422.378881056002;3816.25090158429;3936.2914675358425;3951.604839516054;3961.108750531136;4076.1032572834224;86878.56560717156;119383;120101.79898200993;120292.39853800675;123914.38042809819;10843.45782710877;11214.046806021579;11230.382328971986;11672.533098675958;11999;22095.779042209695;22268.554628907656;22338.888305558692;22372.44068898258;22640.867956602433;6108.664023478751;7953;8108.310793582494;8178.877316840252;8192.54940978252;4555.339475775994;4571.2000399929875;4641.2109941310055;4660.1145782301255;4778.354922085474;2877.2519145022443;3326.1185785766306;3401.8809341672923;3407.7784943978563;3420.931581368359;541.7426722306951;617.3301967365459;626.6584711332334;629.0564153769346;632.0740115730385;630.7477009196358;672.5897202706345;680.9829754256183;689.3175756001623;704.1972151747012;8967.865482017774;9151.588178531982;10378;10589.523471443803;10605.73485662849;650.9934900651027;675.2302375292171;684.1482354468718;691.9688614012382;696.1993707236718;4767.308740232716;5075.264086707407;5437.858049809505;5583.916241256385;5838.416158384128;106692.39961400586;108407;108634.9948983404;109275.45362273138;109630.45184774185;61077;70348.29651703418;70562.64718676374;83159;96557.0344296548;76346.61826690943;78605.60697196591;79171.4511534966;79338.6033069831;79581;11225.129639398525;11314.773704525698;11329.150313726339;11461.885381146081;11481.770364592829;48752.5124748748;50207.74896125496;51347;51452.22821657603;53010.73494632502;64489.71020579468;65142;65177;65346;66948.99576506259;13071.477140914258;13459.192448453125;13469.461221551028;13731.862681373457;13910.652233694238;13411.329433528479;15288.082715037133;15301.6174595636;15540.766888496455;16137.19314034317;14015.439382424589;14386.35261413218;14549.41802327895;14634.268286585415;14817.851821481647;14250;14581.343839527035;14592.124472531683;14656.706865862836;14795.926020369829;13896.305184740924;14047.297635118408;14291.642708931944;14396.712065758835;14784.260786960824;9318.161365477139;9748.463834489172;9854.901450985684;10049.447280399356;10495.265331427032;10036.954104099848;10924.828524066264;11569.421528923689;11718.414079295831;11751.471183796579 13:37:30 INFO - PROCESS | 1633 | __end_tp_report 13:37:30 INFO - PROCESS | 1633 | __start_cc_report 13:37:30 INFO - PROCESS | 1633 | _x_x_mozilla_cycle_collect,395 13:37:30 INFO - PROCESS | 1633 | __end_cc_report 13:37:30 INFO - PROCESS | 1633 | __startTimestamp1494275850462__endTimestamp 13:37:30 INFO - PROCESS | 1633 | 13:37:30 INFO - PROCESS | 1633 | ------- Summary: start ------- 13:37:30 INFO - PROCESS | 1633 | Number of tests: 6 13:37:30 INFO - PROCESS | 1633 | 13:37:30 INFO - PROCESS | 1633 | [#0] dojo.html Cycles:165 Average:6080.32 Median:6268.19 stddev:667.81 (10.7%) stddev-sans-first:640.37 13:37:30 INFO - PROCESS | 1633 | Values: 3578.3 3602.8 3628.3 3636.4 3640.4 6166.4 6171.3 6182.1 6194.7 6213.6 6140.8 6178.4 6182.4 6222.1 6224.2 5388.8 5490.8 5527.8 5554.7 5555.3 5572.2 5618.1 5623.1 5623.3 5688.5 5354.8 5370.7 5515.7 5613.3 5614.8 5616.6 5630.6 5639.0 5680.5 5687.5 5431.8 5564.4 5569.4 5582.7 5635.5 5864.8 5978.8 6008.9 6180.6 6240.9 6354.9 6364.3 6381.5 6411.6 6490.4 6595.2 6612.0 6616.3 6619.9 6636.9 5173.5 5202.2 6231.4 6259.9 6297.5 6500.3 6504.1 6689.9 6708.9 6738.0 6425.7 6442.2 6446.8 6465.5 6476.9 6081.3 6305.6 6584.0 6637.1 6645.4 6231.8 6255.9 6394.0 6498.8 6558.4 6213.7 6273.0 6504.6 6532.4 6546.5 4962.0 5264.3 5271.6 5304.1 5319.8 4722.2 4728.9 4739.4 4756.5 4765.9 6161.8 6169.5 6170.1 6199.7 6254.3 5621.6 6645.1 6664.9 6672.2 6675.9 6265.9 6268.2 6281.5 6283.7 6323.0 5683.4 5715.9 5802.2 5920.4 5967.6 6652.7 6777.4 6807.7 6807.8 6839.0 6625.9 6631.9 6656.9 6686.2 6690.2 6848.6 6863.8 6894.8 6913.4 6934.2 6274.3 6308.6 6453.8 6462.2 6583.2 6662.8 6665.8 6679.7 6681.4 6703.0 6436.3 6465.2 6478.4 6489.2 6498.7 6135.4 6169.0 6330.8 6351.7 6504.7 5079.6 6246.3 6322.4 6331.7 6333.8 6169.8 6210.2 6275.6 6430.0 6457.5 6248.6 6316.1 6319.9 6334.8 6336.0 13:37:30 INFO - PROCESS | 1633 | 13:37:30 INFO - PROCESS | 1633 | [#1] ext.html Cycles:180 Average:53693.12 Median:29390.71 stddev:109418.38 (372.3%) stddev-sans-first:109653.28 13:37:30 INFO - PROCESS | 1633 | Values: 807.9 835.3 862.3 993.8 997.7 32506.3 39050.8 41431.5 41530.8 41633.5 39447.0 39490.4 39755.0 39793.6 39840.6 8379.3 8505.3 9765.2 11181.7 11421.6 11090.5 11161.2 11196.3 11197.6 11216.9 11227.2 11248.9 11257.3 11265.5 11284.7 11187.0 11201.9 11203.2 11208.5 11209.6 10989.5 11049.4 11064.9 11067.8 11083.0 27490.3 34571.5 34970.7 35043.5 35194.6 3924.3 3957.5 3982.1 3993.9 4013.9 21820.7 25878.5 26124.6 26412.9 27458.2 3192.2 3243.8 3257.9 3278.8 3400.2 326706.0 354432.0 358967.0 383944.0 387007.0 43685.6 43865.8 43956.6 43961.3 43982.0 44968.6 45266.0 45336.8 45436.2 45494.5 14074.2 14210.7 14275.3 14293.6 14299.0 12497.7 12555.4 12555.4 12588.2 12608.7 11823.7 11847.8 11916.3 12063.2 12122.4 5835.9 5843.9 5852.9 5870.5 5872.3 847.3 987.1 992.7 1000.7 1043.2 25212.9 27525.0 27949.0 28431.0 28566.7 1017.8 1086.1 1090.9 1123.7 1133.8 13024.2 14568.3 14594.8 14595.3 14794.3 385190.0 472178.0 473739.0 473821.0 478869.6 47948.8 48213.8 48462.5 48469.5 48624.5 1442.3 1480.7 1489.6 1492.7 1496.9 23109.4 24473.8 25077.2 26317.3 26761.0 32358.7 41241.6 41469.2 41494.6 41540.8 409898.0 410065.8 411180.0 411238.0 411252.0 26552.5 29362.4 29568.9 31491.5 32638.5 39490.8 40551.4 40835.4 40940.6 41885.0 28146.9 28373.3 28954.4 29350.9 29419.0 28108.8 28466.4 28577.9 28626.9 28985.4 33112.3 33123.2 33182.2 33246.0 33420.3 23720.9 26428.7 27388.7 27901.4 28859.4 21303.6 21335.6 22027.4 23069.0 23467.9 13:37:30 INFO - PROCESS | 1633 | 13:37:30 INFO - PROCESS | 1633 | [#2] jquery.html Cycles:180 Average:42634.91 Median:12323.00 stddev:121198.23 (983.5%) stddev-sans-first:121496.79 13:37:30 INFO - PROCESS | 1633 | Values: 430.6 442.4 442.6 452.4 453.2 20351.5 21304.0 22533.4 22611.4 22730.4 19595.0 22617.3 22915.9 23895.2 24125.9 6754.8 6876.0 6981.8 7165.7 7174.9 6929.8 7020.0 7053.9 7086.1 7112.8 6732.1 7055.4 7083.6 7123.3 7137.9 6700.7 7005.3 7035.6 7094.4 7113.5 6886.8 6892.2 6917.7 6920.2 6954.2 27205.2 27682.0 28095.6 28254.6 28539.0 3017.7 3019.4 3033.5 3039.5 3051.3 13941.6 16636.3 17151.6 17217.3 17472.2 2100.8 2127.1 2138.4 2208.3 2246.7 126326.0 131431.0 134739.3 135535.0 135738.0 22138.6 22162.8 22556.0 22742.0 22761.7 35820.6 36336.6 36537.1 36538.7 36594.6 9377.6 11434.1 11705.2 11729.5 11809.9 8066.6 9557.3 9611.2 9613.4 9636.0 9954.8 10108.5 10929.2 11031.8 11155.8 3730.6 3832.9 4275.8 4397.7 4432.2 950.9 1019.9 1089.5 1106.0 1131.4 20944.7 22399.3 22890.2 22919.0 23176.7 1032.5 1092.6 1095.8 1098.7 1137.7 10225.3 11461.9 12093.5 12315.8 12323.4 699043.0 719396.0 737251.0 743937.0 744414.0 132082.0 138829.0 139141.0 162484.2 173695.0 1097.6 1279.2 1295.1 1302.2 1354.7 20191.0 20608.4 21100.1 21256.9 21383.0 51261.7 52054.7 66952.3 68156.0 68750.0 95117.0 95382.0 96152.0 96423.0 97751.0 11934.8 11996.4 12130.6 12238.4 12429.6 13755.9 13903.6 14168.9 14185.1 14388.9 9917.1 11625.9 12021.3 12061.0 12163.3 9914.6 11157.9 11194.8 11387.7 11533.3 11641.1 11795.7 12105.8 12146.9 12162.2 11483.6 11905.3 12064.7 12221.6 12244.4 10175.2 11750.9 11751.4 11859.2 11985.1 13:37:30 INFO - PROCESS | 1633 | 13:37:30 INFO - PROCESS | 1633 | [#3] mootools.html Cycles:180 Average:6946.86 Median:2497.33 stddev:4297.60 (172.1%) stddev-sans-first:4291.22 13:37:30 INFO - PROCESS | 1633 | Values: 1648.5 1673.3 1682.0 1683.4 1683.6 10982.0 11421.4 11700.4 11709.5 11735.1 11298.9 11622.6 11743.0 11745.1 11779.7 2057.8 2521.8 2526.8 2529.5 2530.5 2041.0 2485.7 2502.7 2505.7 2515.5 2298.0 2326.2 2351.2 2359.6 2382.6 1851.8 2280.1 2483.0 2485.5 2501.0 2304.1 2473.1 2486.7 2488.6 2493.7 10223.5 10961.3 11581.9 11651.9 11659.8 5959.6 6050.4 6069.9 6089.5 6111.6 3650.2 3705.5 3711.0 3783.1 3790.3 1270.8 1279.8 1300.3 1319.8 1322.2 12916.7 14406.6 14674.5 15474.7 15508.0 4909.7 5045.7 5168.2 5183.1 5206.4 13679.0 13701.4 13711.3 13715.0 13731.9 6201.2 6208.3 6212.6 6216.8 6221.2 5418.8 5435.9 5464.8 5492.0 5507.0 4223.7 4264.1 4282.3 4333.8 4335.0 1152.6 1178.1 1195.2 1195.7 1196.1 973.3 997.1 1002.8 1010.8 1018.5 6675.7 6687.1 6785.8 6844.3 6869.7 933.4 1028.0 1033.7 1036.8 1113.9 4395.2 4458.8 4479.5 4636.1 4640.8 13674.6 13779.4 14169.6 14180.6 14182.9 13774.7 14187.9 14188.6 14198.8 14218.2 8767.3 8833.9 8970.0 10640.9 10719.2 6669.0 7034.9 7319.7 7327.3 7330.4 11937.6 11963.6 11987.0 12081.8 12140.9 12776.6 12880.5 12924.9 12931.9 13091.2 8337.5 8649.5 8793.1 8903.7 8935.4 10300.0 10386.3 10511.5 10528.0 10547.5 7428.5 8478.3 9005.1 9300.9 9354.0 8917.8 8960.0 8960.3 9027.1 9233.4 8191.6 8208.0 8227.8 8266.2 8305.7 5928.8 5974.0 5984.2 6136.0 6190.7 5999.7 6020.9 6212.8 6262.3 6314.0 13:37:30 INFO - PROCESS | 1633 | 13:37:30 INFO - PROCESS | 1633 | [#4] prototype.html Cycles:180 Average:4619.41 Median:5014.10 stddev:1300.98 (25.9%) stddev-sans-first:1263.85 13:37:30 INFO - PROCESS | 1633 | Values: 313.5 386.8 387.4 396.6 404.6 4769.3 5249.6 5273.9 5331.6 5392.4 4163.6 4672.0 5134.0 5184.0 5221.8 4247.3 4346.9 4347.2 4349.4 4353.4 4318.0 4330.6 4333.5 4351.2 4355.0 3786.2 3920.5 4188.2 4334.6 4362.3 3833.0 3958.7 4257.6 4379.8 4379.8 3396.8 3791.6 3958.0 3972.4 4037.3 4282.7 4348.2 4497.9 5047.9 5049.5 4217.8 4663.5 5004.3 5019.3 5047.9 5271.6 5547.3 5583.3 5591.4 5641.3 4052.0 4088.5 4234.6 4509.5 4566.8 5199.4 5284.5 5990.7 6010.0 6024.4 4033.5 4047.8 4074.4 4539.8 4559.4 4090.7 4643.6 4649.7 4681.7 4710.5 3846.9 4311.0 4953.2 4987.5 5000.6 4887.9 5115.0 5438.8 5545.0 5622.9 1510.3 1566.5 1577.9 1582.3 1602.5 985.7 1007.8 1017.4 1152.7 1200.6 4714.0 4776.5 5335.5 5344.0 5374.9 5025.3 5153.9 5196.4 5657.4 5815.7 4406.3 4840.2 4890.7 5050.8 5302.6 2742.2 2855.7 3008.2 3019.6 3047.4 4773.5 5537.2 6019.4 6062.0 6074.3 4736.6 5539.8 5609.3 5908.2 6213.1 5706.5 5784.5 6086.6 6117.5 6241.3 5397.9 5627.7 5678.7 5772.3 5812.6 5696.1 5696.5 5716.9 5737.6 5753.3 4953.5 5008.9 5488.3 5577.6 5696.4 4024.7 4408.4 4504.1 4552.5 4580.9 4861.8 5024.6 5083.4 5338.2 5768.6 5126.7 5252.9 5262.2 5425.6 5663.3 4831.7 5075.6 5085.1 5362.9 5657.4 5157.9 5213.6 5517.2 5532.3 5565.8 4683.6 5375.8 5618.8 5650.3 5751.0 5038.4 5262.4 5566.0 5574.0 5626.9 13:37:30 INFO - PROCESS | 1633 | 13:37:30 INFO - PROCESS | 1633 | [#5] yui.html Cycles:180 Average:20907.60 Median:17229.18 stddev:29798.63 (173.0%) stddev-sans-first:29843.61 13:37:30 INFO - PROCESS | 1633 | Values: 704.1 775.9 804.3 867.7 883.8 16436.0 17397.2 17416.5 17418.7 17420.7 15722.4 15764.2 15765.2 16289.7 16585.9 1001.3 1021.7 1027.0 1028.8 1028.9 999.1 1019.5 1020.4 1022.6 1045.3 1089.9 1090.3 1090.6 1092.1 1092.3 1069.1 1078.3 1085.9 1086.8 1087.2 661.9 804.9 810.0 810.3 811.3 17083.1 17209.9 17248.5 18141.5 18467.9 14410.6 14770.9 14771.1 14924.3 14945.4 12179.0 12197.3 12197.6 12224.9 12422.4 3816.3 3936.3 3951.6 3961.1 4076.1 86878.6 119383.0 120101.8 120292.4 123914.4 10843.5 11214.0 11230.4 11672.5 11999.0 22095.8 22268.6 22338.9 22372.4 22640.9 6108.7 7953.0 8108.3 8178.9 8192.5 4555.3 4571.2 4641.2 4660.1 4778.4 2877.3 3326.1 3401.9 3407.8 3420.9 541.7 617.3 626.7 629.1 632.1 630.7 672.6 681.0 689.3 704.2 8967.9 9151.6 10378.0 10589.5 10605.7 651.0 675.2 684.1 692.0 696.2 4767.3 5075.3 5437.9 5583.9 5838.4 106692.4 108407.0 108635.0 109275.5 109630.5 61077.0 70348.3 70562.6 83159.0 96557.0 76346.6 78605.6 79171.5 79338.6 79581.0 11225.1 11314.8 11329.2 11461.9 11481.8 48752.5 50207.7 51347.0 51452.2 53010.7 64489.7 65142.0 65177.0 65346.0 66949.0 13071.5 13459.2 13469.5 13731.9 13910.7 13411.3 15288.1 15301.6 15540.8 16137.2 14015.4 14386.4 14549.4 14634.3 14817.9 14250.0 14581.3 14592.1 14656.7 14795.9 13896.3 14047.3 14291.6 14396.7 14784.3 9318.2 9748.5 9854.9 10049.4 10495.3 10037.0 10924.8 11569.4 11718.4 11751.5 13:37:30 INFO - PROCESS | 1633 | -------- Summary: end -------- 13:37:30 INFO - PROCESS | 1633 | 13:37:31 INFO - TEST-INFO | 1633: exit 0 13:37:31 INFO - TEST-OK | dromaeo_css | took 1115361ms 13:37:31 INFO - TEST-START | kraken 13:37:31 INFO - operating with platform_type : mac_ 13:37:31 INFO - Initialising browser for kraken test... 13:37:31 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpIwaotI/profile http://localhost:49240/getInfo.html) 13:37:33 INFO - PROCESS | 1646 | 2017-05-08 13:37:33.634 plugin-container[1648:10588] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4647, name = 'com.apple.tsm.portname' 13:37:33 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:37:33 INFO - PROCESS | 1646 | 2017-05-08 13:37:33.635 plugin-container[1648:10588] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8c0b, name = 'com.apple.CFPasteboardClient' 13:37:33 INFO - PROCESS | 1646 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:37:33 INFO - PROCESS | 1646 | 2017-05-08 13:37:33.635 plugin-container[1648:10588] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:37:33 INFO - PROCESS | 1646 | __metrics Screen width/height:1600/1200 13:37:33 INFO - PROCESS | 1646 | colorDepth:24 13:37:33 INFO - PROCESS | 1646 | Browser inner width/height: 1024/689 13:37:33 INFO - PROCESS | 1646 | __metrics 13:37:33 ERROR - PROCESS | 1646 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 13:37:34 INFO - TEST-INFO | 1646: exit 0 13:37:34 INFO - Browser initialized. 13:37:34 INFO - Running cycle 1/1 for kraken test... 13:37:34 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/tmpIwaotI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:37:37 INFO - PROCESS | 1649 | 2017-05-08 13:37:37.105 plugin-container[1650:10713] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x842f, name = 'com.apple.tsm.portname' 13:37:37 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:37:37 INFO - PROCESS | 1649 | 2017-05-08 13:37:37.105 plugin-container[1650:10713] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 13:37:37 INFO - PROCESS | 1649 | See /usr/include/servers/bootstrap_defs.h for the error codes. 13:37:37 INFO - PROCESS | 1649 | 2017-05-08 13:37:37.105 plugin-container[1650:10713] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 13:37:46 INFO - PROCESS | 1649 | RSS: Main: 174026752 13:37:46 INFO - PROCESS | 1649 | 13:37:50 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 13:37:51 INFO - PROCESS | 1649 | RSS: Main: 187666432 13:37:51 INFO - PROCESS | 1649 | 13:37:53 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 13:37:54 INFO - PROCESS | 1649 | RSS: Main: 195747840 13:37:54 INFO - PROCESS | 1649 | 13:37:57 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 13:37:58 INFO - PROCESS | 1649 | RSS: Main: 199512064 13:37:58 INFO - PROCESS | 1649 | 13:38:00 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 13:38:00 INFO - PROCESS | 1649 | RSS: Main: 200859648 13:38:00 INFO - PROCESS | 1649 | 13:38:02 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:38:03 INFO - PROCESS | 1649 | RSS: Main: 201179136 13:38:03 INFO - PROCESS | 1649 | 13:38:06 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 13:38:06 INFO - PROCESS | 1649 | RSS: Main: 204738560 13:38:06 INFO - PROCESS | 1649 | 13:38:09 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 13:38:10 INFO - PROCESS | 1649 | RSS: Main: 203964416 13:38:10 INFO - PROCESS | 1649 | 13:38:13 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 13:38:14 INFO - PROCESS | 1649 | RSS: Main: 204357632 13:38:14 INFO - PROCESS | 1649 | 13:38:15 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:38:16 INFO - PROCESS | 1649 | RSS: Main: 203878400 13:38:16 INFO - PROCESS | 1649 | 13:38:18 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:38:19 INFO - PROCESS | 1649 | RSS: Main: 203862016 13:38:19 INFO - PROCESS | 1649 | 13:38:21 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:38:21 INFO - PROCESS | 1649 | RSS: Main: 203902976 13:38:21 INFO - PROCESS | 1649 | 13:38:24 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:38:25 INFO - PROCESS | 1649 | RSS: Main: 204312576 13:38:25 INFO - PROCESS | 1649 | 13:38:28 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:38:28 INFO - PROCESS | 1649 | RSS: Main: 204292096 13:38:28 INFO - PROCESS | 1649 | 13:38:30 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 13:38:30 INFO - PROCESS | 1649 | RSS: Main: 206094336 13:38:30 INFO - PROCESS | 1649 | 13:38:30 INFO - PROCESS | 1649 | __start_tp_report 13:38:30 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 13:38:30 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 13:38:30 INFO - PROCESS | 1649 | |i|pagename|runs| 13:38:30 INFO - PROCESS | 1649 | |0;ai-astar;106;118;157;178;158;119;121;118;127;143 13:38:30 INFO - PROCESS | 1649 | |1;audio-beat-detection;132;109;113;142;106;110;110;110;125;111 13:38:30 INFO - PROCESS | 1649 | |2;audio-dft;199;197;193;233;273;229;193;196;200;193 13:38:30 INFO - PROCESS | 1649 | |3;audio-fft;83;62;85;113;83;80;60;66;96;77 13:38:30 INFO - PROCESS | 1649 | |4;audio-oscillator;89;71;85;72;73;71;95;71;71;81 13:38:30 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;89;90;90;135;113;90;93;87;89;85 13:38:30 INFO - PROCESS | 1649 | |6;imaging-darkroom;119;96;98;98;96;97;100;96;96;96 13:38:30 INFO - PROCESS | 1649 | |7;imaging-desaturate;91;97;92;120;144;90;92;91;91;91 13:38:30 INFO - PROCESS | 1649 | |8;json-parse-financial;54;59;100;102;103;104;102;86;68;69 13:38:30 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;55;67;72;89;98;60;57;58;57;58 13:38:30 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;83;76;89;100;103;101;77;84;79;85 13:38:30 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;135;135;150;138;144;137;140;138;175;135 13:38:30 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;164;162;163;160;167;165;162;168;163;164 13:38:30 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;64;62;66;64;65;68;77;85;82;83 13:38:30 INFO - PROCESS | 1649 | __end_tp_report 13:38:30 INFO - PROCESS | 1649 | __start_cc_report 13:38:30 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,976 13:38:30 INFO - PROCESS | 1649 | __end_cc_report 13:38:30 INFO - PROCESS | 1649 | __startTimestamp1494275910924__endTimestamp 13:38:30 INFO - PROCESS | 1649 | 13:38:30 INFO - PROCESS | 1649 | ------- Summary: start ------- 13:38:30 INFO - PROCESS | 1649 | Number of tests: 14 13:38:30 INFO - PROCESS | 1649 | 13:38:30 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:134.50 Median:135.00 stddev:23.23 (17.2%) stddev-sans-first:22.24 13:38:30 INFO - PROCESS | 1649 | Values: 106.0 118.0 157.0 178.0 158.0 119.0 121.0 118.0 127.0 143.0 13:38:30 INFO - PROCESS | 1649 | 13:38:30 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:116.80 Median:112.00 stddev:12.01 (10.7%) stddev-sans-first:11.41 13:38:30 INFO - PROCESS | 1649 | Values: 132.0 109.0 113.0 142.0 106.0 110.0 110.0 110.0 125.0 111.0 13:38:30 INFO - PROCESS | 1649 | 13:38:30 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:210.60 Median:199.50 stddev:26.48 (13.3%) stddev-sans-first:27.75 13:38:30 INFO - PROCESS | 1649 | Values: 199.0 197.0 193.0 233.0 273.0 229.0 193.0 196.0 200.0 193.0 13:38:30 INFO - PROCESS | 1649 | 13:38:30 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:80.50 Median:81.50 stddev:16.04 (19.7%) stddev-sans-first:16.98 13:38:30 INFO - PROCESS | 1649 | Values: 83.0 62.0 85.0 113.0 83.0 80.0 60.0 66.0 96.0 77.0 13:38:30 INFO - PROCESS | 1649 | 13:38:30 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:77.90 Median:77.00 stddev:8.97 (11.7%) stddev-sans-first:8.57 13:38:30 INFO - PROCESS | 1649 | Values: 89.0 71.0 85.0 72.0 73.0 71.0 95.0 71.0 71.0 81.0 13:38:30 INFO - PROCESS | 1649 | 13:38:30 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:96.10 Median:89.50 stddev:15.73 (17.6%) stddev-sans-first:16.47 13:38:30 INFO - PROCESS | 1649 | Values: 89.0 90.0 90.0 135.0 113.0 90.0 93.0 87.0 89.0 85.0 13:38:30 INFO - PROCESS | 1649 | 13:38:30 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:99.20 Median:96.00 stddev:7.08 (7.4%) stddev-sans-first:1.41 13:38:30 INFO - PROCESS | 1649 | Values: 119.0 96.0 98.0 98.0 96.0 97.0 100.0 96.0 96.0 96.0 13:38:30 INFO - PROCESS | 1649 | 13:38:30 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:99.90 Median:91.00 stddev:17.94 (19.7%) stddev-sans-first:18.74 13:38:30 INFO - PROCESS | 1649 | Values: 91.0 97.0 92.0 120.0 144.0 90.0 92.0 91.0 91.0 91.0 13:38:30 INFO - PROCESS | 1649 | 13:38:30 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:84.70 Median:56.50 stddev:20.19 (35.7%) stddev-sans-first:18.11 13:38:30 INFO - PROCESS | 1649 | Values: 54.0 59.0 100.0 102.0 103.0 104.0 102.0 86.0 68.0 69.0 13:38:30 INFO - PROCESS | 1649 | 13:38:30 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:63.50 stddev:15.00 (23.6%) stddev-sans-first:15.26 13:38:30 INFO - PROCESS | 1649 | Values: 55.0 67.0 72.0 89.0 98.0 60.0 57.0 58.0 57.0 58.0 13:38:30 INFO - PROCESS | 1649 | 13:38:30 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:87.70 Median:81.00 stddev:10.19 (12.6%) stddev-sans-first:10.66 13:38:30 INFO - PROCESS | 1649 | Values: 83.0 76.0 89.0 100.0 103.0 101.0 77.0 84.0 79.0 85.0 13:38:30 INFO - PROCESS | 1649 | 13:38:30 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:142.70 Median:139.00 stddev:12.29 (8.8%) stddev-sans-first:12.72 13:38:30 INFO - PROCESS | 1649 | Values: 135.0 135.0 150.0 138.0 144.0 137.0 140.0 138.0 175.0 135.0 13:38:30 INFO - PROCESS | 1649 | 13:38:30 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:163.80 Median:164.00 stddev:2.39 (1.5%) stddev-sans-first:2.54 13:38:30 INFO - PROCESS | 1649 | Values: 164.0 162.0 163.0 160.0 167.0 165.0 162.0 168.0 163.0 164.0 13:38:30 INFO - PROCESS | 1649 | 13:38:30 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:72.50 stddev:9.08 (12.5%) stddev-sans-first:9.21 13:38:30 INFO - PROCESS | 1649 | Values: 64.0 62.0 66.0 64.0 65.0 68.0 77.0 85.0 82.0 83.0 13:38:30 INFO - PROCESS | 1649 | -------- Summary: end -------- 13:38:30 INFO - PROCESS | 1649 | 13:38:31 INFO - TEST-INFO | 1649: exit 0 13:38:31 INFO - TEST-OK | kraken | took 60719ms 13:38:31 INFO - SUITE-END | took 1176s 13:38:32 INFO - Completed test suite (00:19:36) 13:38:32 INFO - javascript benchmark 13:38:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7878.0329873227065, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3578.3022310649435, 3602.8198590070497, 3628.2743451309743, 3636.39999400099, 3640.4357324614693, 6166.3525329840395, 6171.2903016153095, 6182.103594978726, 6194.7212375443105, 6213.627182369061, 6140.7850725224625, 6178.41305076017, 6182.412670796267, 6222.12890195373, 6224.190855188819, 5388.838334849961, 5490.752916118784, 5527.751251193686, 5554.666719996793, 5555.2778138842095, 5572.164175373706, 5618.101103823389, 5623.128415095646, 5623.26897503326, 5688.544916406699, 5354.839354819343, 5370.7046112463795, 5515.7242137892945, 5613.270274864262, 5614.775408983635, 5616.5787565932715, 5630.634008789416, 5638.971805140968, 5680.460356266148, 5687.459691329317, 5431.8098866539485, 5564.387917329091, 5569.387367389584, 5582.665040097567, 5635.492805647511, 5864.824055278348, 5978.8206353809455, 6008.879822403571, 6180.567360284782, 6240.937590624081, 6354.904676429811, 6364.331745166737, 6381.52138589603, 6411.647359395231, 6490.415862572391, 6595.241547222083, 6611.966940165316, 6616.27221005689, 6619.900701489481, 6636.900446493307, 5173.534381905646, 5202.193659982709, 6231.376862313732, 6259.937400625936, 6297.4962003039645, 6500.317466666026, 6504.121943537656, 6689.866202676017, 6708.865822683519, 6737.989301604798, 6425.710843012076, 6442.194725659293, 6446.774362897276, 6465.547411681137, 6476.870462590722, 6081.331053584191, 6305.558610897285, 6584.012398140318, 6637.103990961255, 6645.401913827779, 6231.844203894848, 6255.937440625627, 6393.968030159819, 6498.805035848932, 6558.409743123142, 6213.689315534205, 6272.968635156795, 6504.642244676494, 6532.444742196966, 6546.476281897437, 4961.950380496149, 5264.341957255343, 5271.551918087006, 5304.071787437183, 5319.840404787863, 4722.173619616553, 4728.905421891543, 4739.4075740532435, 4756.548127927841, 4765.9046819064115, 6161.815145545641, 6169.5064394849205, 6170.10533472644, 6199.659018754011, 6254.34329395416, 5621.634593751393, 6645.06969024337, 6664.900026499607, 6672.199336079701, 6675.86648267032, 6265.8746825063245, 6268.185135932391, 6281.528885333618, 6283.6858157091965, 6322.988321868479, 5683.431656834367, 5715.8571035724435, 5802.158686990447, 5920.407959204132, 5967.582269241198, 6652.7338906444165, 6777.356151165632, 6807.693653785691, 6807.795766127024, 6838.965805171141, 6625.867482650417, 6631.933680663132, 6656.933430665631, 6686.1642294713165, 6690.163729533809, 6848.589084654936, 6863.794086177422, 6894.827629309308, 6913.41235994926, 6934.16789985205, 6274.309825919237, 6308.589941653778, 6453.806385808245, 6462.224533056064, 6583.210014798064, 6662.83342916431, 6665.766698165541, 6679.666016699049, 6681.365270299314, 6702.994550817416, 6436.292007879223, 6465.1595292611655, 6478.449331806849, 6489.1888513935755, 6498.707558159988, 6135.44703110649, 6168.9691551541955, 6330.841728956813, 6351.650659213788, 6504.707288171949, 5079.644424890223, 6246.312905580292, 6322.399372059831, 6331.702001089673, 6333.841653958688, 6169.81490555284, 6210.161628180319, 6275.5920865145445, 6429.9678501607195, 6457.483401327976, 6248.562600617913, 6316.115743795965, 6319.925612645953, 6334.809955701337, 6336.0], "value": 6039.690374599992, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.8868958345832, 835.3484282259838, 862.2886118951866, 993.781368099018, 997.7405874472639, 32506.349873002524, 39050.80474597627, 41431.549895753655, 41530.79234603823, 41633.54282600113, 39447.0138246544, 39490.407643885366, 39755.0, 39793.60206397935, 39840.60159398405, 8379.287760540346, 8505.277051450603, 9765.218782497383, 11181.664550063511, 11421.600243991463, 11090.500927458284, 11161.162912781534, 11196.272242304265, 11197.608083717072, 11216.887831121667, 11227.157963152755, 11248.887511124907, 11257.324560526353, 11265.549378024869, 11284.717882052973, 11187.0, 11201.943990280037, 11203.21577489576, 11208.495617697183, 11209.551617935273, 10989.450527473675, 11049.447527623586, 11064.889351106467, 11067.778644427066, 11083.0, 27490.312742181406, 34571.48142777835, 34970.65029349699, 35043.4743478848, 35194.64805351939, 3924.274009308287, 3957.5053118360206, 3982.1040265940223, 3993.920121597581, 4013.919721605581, 21820.672689909665, 25878.482430351287, 26124.608130878052, 26412.86793566039, 27458.17625471239, 3192.170035790688, 3243.8053716777067, 3257.8859739909226, 3278.7704860659765, 3400.2349471368993, 326706.0, 354432.0, 358967.0, 383944.0, 387007.0, 43685.56314436815, 43865.78067109644, 43956.560434395884, 43961.34057989133, 43982.0, 44968.55031449644, 45266.0, 45336.77331613321, 45436.182552698185, 45494.54505454969, 14074.225917574631, 14210.715785684228, 14275.286235688174, 14293.571192864023, 14299.0, 12497.687557811127, 12555.372231388394, 12555.435005424777, 12588.181768185039, 12608.739126087317, 11823.704407389883, 11847.822282665767, 11916.344601047025, 12063.21589096706, 12122.39388030595, 5835.949529084721, 5843.912341314884, 5852.912206316909, 5870.530357571384, 5872.265966754156, 847.3221422861686, 987.1115995604014, 992.7392211890858, 1000.7197984564334, 1043.186314674555, 25212.865421056096, 27525.0, 27949.021784237862, 28431.0, 28566.71433285682, 1017.7710015246511, 1086.120242603478, 1090.9127269818396, 1123.719070232442, 1133.7845809296207, 13024.153430027018, 14568.344424500923, 14594.781078283835, 14595.343209555596, 14794.334254958552, 385190.0, 472178.0, 473739.0, 473821.0, 478869.63391097623, 47948.7602561985, 48213.75893120512, 48462.5153748458, 48469.515304847206, 48624.5137548627, 1442.293276294629, 1480.7334679757746, 1489.5680252726588, 1492.7089217602463, 1496.940122395092, 23109.422264443525, 24473.776311184727, 25077.247682569552, 26317.34206644849, 26761.0, 32358.67641323651, 41241.58758412377, 41469.170616588104, 41494.58505414907, 41540.79229603833, 409898.0, 410065.84901227104, 411180.0, 411238.0, 411252.0, 26552.468950621267, 29362.412751745273, 29568.852155739085, 31491.52762708607, 32638.51042234416, 39490.802545987084, 40551.3917291235, 40835.38746918739, 40940.59059409368, 41885.0, 28146.85926570354, 28373.290667733472, 28954.42091158207, 29350.853245733633, 29419.0, 28108.78057276521, 28466.430671386042, 28577.85688572517, 28626.854925802734, 28985.42029159363, 33112.33775324432, 33123.171920702174, 33182.17044573905, 33246.0, 33420.331593368486, 23720.932558034583, 26428.73571264263, 27388.726112739416, 27901.441971160057, 28859.42281154407, 21303.615265007724, 21335.573288533833, 22027.449313767283, 23069.0, 23467.882660586587], "value": 18222.617245557627, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [430.63180980261853, 442.3850847322221, 442.6436718441654, 452.3824978903796, 453.22046080741154, 20351.491212719688, 21304.0, 22533.436664083405, 22611.434714132156, 22730.431739206528, 19595.0, 22617.321480355615, 22915.885420572915, 23895.16366927158, 24125.87937060312, 6754.831129221784, 6875.965620171892, 6981.755638552651, 7165.749198778018, 7174.892376614355, 6929.792106236821, 7019.964900175492, 7053.929460705404, 7086.07880975475, 7112.786616401516, 6732.091167692348, 7055.4002909752735, 7083.610401427919, 7123.323284287984, 7137.928620713804, 6700.698468568926, 7005.299470053005, 7035.577865328071, 7094.432445404355, 7113.502054856162, 6886.827829304258, 6892.207396149457, 6917.7232910683515, 6920.169579650475, 6954.165500139965, 27205.183844484698, 27682.0, 28095.57856632152, 28254.576181357297, 28539.0, 3017.6529699084667, 3019.3961207758534, 3033.514637657986, 3039.4832878410725, 3051.3287076843058, 13941.58175254744, 16636.251368688438, 17151.571210719707, 17217.311307547807, 17472.213750381263, 2100.8214301784365, 2127.095984206706, 2138.4012476506605, 2208.3485371815354, 2246.674232236333, 126326.0, 131431.0, 134739.32630336884, 135535.0, 135738.0, 22138.557228855334, 22162.778372216395, 22555.98498067591, 22742.0, 22761.658575121386, 35820.641793582254, 36336.636633633854, 36537.08657283536, 36538.72114476034, 36594.634053659654, 9377.578008989612, 11434.085273178292, 11705.239159454608, 11729.472173752201, 11809.881901180877, 8066.5563394012715, 9557.283203759745, 9611.231101511863, 9613.423194608346, 9636.0, 9954.800903982024, 10108.534262531892, 10929.234953553334, 11031.83452248217, 11155.832662510069, 3730.6082861299715, 3832.850144956502, 4275.786210689515, 4397.670174736908, 4432.202203603318, 950.9444516586583, 1019.9337043092175, 1089.5420844320613, 1105.9889401106047, 1131.4342828585707, 20944.685829712565, 22399.32802015942, 22890.198843040413, 22918.96864641095, 23176.65235021476, 1032.5405194688292, 1092.595739576362, 1095.835624656308, 1098.6978580890159, 1137.6587023892964, 10225.335353202017, 11461.942690286494, 12093.45579448927, 12315.815262771066, 12323.445444955, 699043.0, 719396.0, 737251.0, 743937.0, 744414.0, 132082.0, 138829.0, 139141.0, 162484.1875790637, 173695.0, 1097.550004498152, 1279.1621487925424, 1295.1452041652465, 1302.2186687987132, 1354.7358265138203, 20191.0, 20608.381748547567, 21100.05049772733, 21256.893715531944, 21383.0, 51261.74369128131, 52054.73972630112, 66952.33047669461, 68156.0, 68750.0, 95117.0, 95382.0, 96152.0384796143, 96423.0, 97751.02248977419, 11934.820977685167, 11996.400179990791, 12130.636080917586, 12238.449269782703, 12429.564965226175, 13755.862441375459, 13903.582892513241, 14168.858311417167, 14185.077969931921, 14388.928055359656, 9917.107460328605, 11625.88374116282, 12021.338826364634, 12061.035117190779, 12163.2702037878, 9914.553845077133, 11157.944210278896, 11194.832077519006, 11387.658370248906, 11533.308001519936, 11641.126915481203, 11795.705107372385, 12105.757884842078, 12146.878531214928, 12162.209456385306, 11483.598074067368, 11905.285682859056, 12064.698382540155, 12221.572244971383, 12244.44899979521, 10175.185985121025, 11750.88249117532, 11751.353675547585, 11859.16985810985, 11985.101117416054], "value": 12126.498804021307, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1648.4972083514538, 1673.3306677329067, 1681.957951051224, 1683.4023921507865, 1683.5706894741838, 10982.011618954293, 11421.428928553581, 11700.356480393575, 11709.531618735251, 11735.11986601004, 11298.887011129907, 11622.593209237679, 11743.0, 11745.119116066286, 11779.7055073623, 2057.794220577945, 2521.773040426361, 2526.7725904668578, 2529.5067461844947, 2530.455951970326, 2040.9591108534605, 2485.652008718781, 2502.6621406110125, 2505.7368976257503, 2515.4591762771, 2297.9540409191804, 2326.2439707095177, 2351.2358483492935, 2359.6106642403984, 2382.5711371953043, 1851.7592712947364, 2280.065173278956, 2482.9751702482927, 2485.527749727555, 2501.0, 2304.101400453824, 2473.1467643663086, 2486.6643003194517, 2488.5645012122804, 2493.6633554470095, 10223.539940702687, 10961.342319460859, 11581.884181158164, 11651.941740291244, 11659.825102623467, 5959.582829201958, 6050.425209605124, 6069.939300606981, 6089.512838972872, 6111.572189946705, 3650.2152037312107, 3705.4627079073384, 3710.9814450927574, 3783.1298801275584, 3790.3177428062936, 1270.84749830021, 1279.8400199975003, 1300.2978391668487, 1319.7954317080869, 1322.2397121655088, 12916.741665166737, 14406.567802965928, 14674.486392976194, 15474.690506189812, 15508.0, 4909.68087074339, 5045.697258164522, 5168.224766285012, 5183.067047931333, 5206.401263854629, 13679.0, 13701.383437745326, 13711.314434278247, 13715.0, 13731.862681373259, 6201.224846894138, 6208.255009398901, 6212.596181248205, 6216.751329946752, 6221.191245138103, 5418.810341638024, 5435.864103397367, 5464.836054918359, 5491.9725401373535, 5506.972465137729, 4223.669544093601, 4264.1471705659, 4282.293421585466, 4333.826646934151, 4334.978325108417, 1152.6168597682815, 1178.057553956831, 1195.193244559936, 1195.7010747313172, 1196.1029228078942, 973.2797729680127, 997.07272236819, 1002.8345323021765, 1010.7675234695914, 1018.4703953943907, 6675.732970681215, 6687.063811066455, 6785.762498312535, 6844.349786770348, 6869.725210991604, 933.4119504711988, 1027.9691609251734, 1033.6743925663393, 1036.8496567997597, 1113.9387333696563, 4395.208862404734, 4458.77706114693, 4479.529649386833, 4636.072785442925, 4640.767961601907, 13674.589762307147, 13779.379927903268, 14169.574912752634, 14180.64548386278, 14182.93627977885, 13774.724505509834, 14187.858121418654, 14188.574342769733, 14198.787018194735, 14218.217998010208, 8767.298616110696, 8833.867491987625, 8970.013298537157, 10640.946795265974, 10719.19606029551, 6668.966655166693, 7034.894476582957, 7319.74380896666, 7327.340539351484, 7330.376917962033, 11937.582184623496, 11963.64109076729, 11987.0, 12081.75836483283, 12140.878591213976, 12776.552820651232, 12880.484780608671, 12924.870751292367, 12931.870681293067, 13091.214527128403, 8337.541435221121, 8649.481031138152, 8793.076726943578, 8903.688370906988, 8935.419197752126, 10300.021497957681, 10386.272960892666, 10511.474426278808, 10528.0, 10547.525361358605, 7428.480006399716, 8478.279346255636, 9005.054469280893, 9300.860487092563, 9354.0, 8917.821643566962, 8959.969603495421, 8960.283177345666, 9027.052159523419, 9233.353665243369, 8191.590420479071, 8207.95896020516, 8227.794305142419, 8266.173382661926, 8305.667773289, 5928.79249226275, 5974.0, 5984.1921340618455, 6136.048912418582, 6190.7214175363115, 5999.6700181488695, 6020.8795824084145, 6212.81361559154, 6262.279837818527, 6313.96843015782], "value": 5332.635367344871, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [313.46867060332715, 386.7544109490474, 387.43628021229114, 396.58160640524244, 404.55498951153714, 4769.308450274712, 5249.580033597313, 5273.888405840553, 5331.573474122066, 5392.40683524812, 4163.605192260588, 4672.0, 5134.0, 5183.974080129594, 5221.765020574074, 4247.25673007224, 4346.9347959780625, 4347.152305300468, 4349.41282926804, 4353.41228934093, 4318.0, 4330.588594083557, 4333.458317710286, 4351.21600143941, 4354.956450435503, 3786.1982133221495, 3920.470736450571, 4188.183304255671, 4334.566543345656, 4362.280223763075, 3833.0034191110512, 3958.7228893977435, 4257.574242575718, 4379.75911324877, 4379.846705365313, 3396.8301584920655, 3791.6018818023986, 3958.0209895052476, 3972.443857859902, 4037.313656678372, 4282.657387409, 4348.173846969097, 4497.9100417991785, 5047.889464317845, 5049.545540901337, 4217.789110544491, 4663.48701642819, 5004.324416203803, 5019.272205530214, 5047.9495205048215, 5271.626159258078, 5547.3343198816, 5583.3300003999375, 5591.384947655754, 5641.266635337421, 4052.027513396793, 4088.5298190708154, 4234.597713217239, 4509.458864936196, 4566.835456958487, 5199.350081239845, 5284.524392804666, 5990.700464976778, 6009.978303688384, 6024.397560243984, 4033.51597808259, 4047.838086476508, 4074.3684728867074, 4539.84110556129, 4559.361689363492, 4090.734102283342, 4643.628509719214, 4649.67452278344, 4681.695689780154, 4710.505396933341, 3846.942295865564, 4310.956890431118, 4953.2168419369, 4987.501249874984, 5000.649694643512, 4887.853364399002, 5114.9514349558995, 5438.809641662523, 5544.950277347442, 5622.85942851432, 1510.2750679673818, 1566.4595714478487, 1577.8639379646866, 1582.2800625715272, 1602.4952140075839, 985.7289245457556, 1007.7654872780931, 1017.4200705597887, 1152.7233463968587, 1200.6398080575966, 4714.020111553156, 4776.498467660915, 5335.466453354634, 5344.0, 5374.946250537523, 5025.296458495814, 5153.871153221125, 5196.350456192976, 5657.434256574392, 5815.651060936358, 4406.3170208617075, 4840.249761287007, 4890.682105663121, 5050.823221187241, 5302.594812374724, 2742.2321749909656, 2855.671597766242, 3008.2028262510453, 3019.6225471816024, 3047.420990011891, 4773.539184091506, 5537.169424586345, 6019.367966363557, 6062.0, 6074.301455332693, 4736.550027747358, 5539.806106786243, 5609.298837645294, 5908.150930578782, 6213.068039794067, 5706.514946229617, 5784.537237021113, 6086.573939824259, 6117.510599152057, 6241.251049874044, 5397.86505337354, 5627.650133122934, 5678.716064196691, 5772.268319504216, 5812.622179558315, 5696.1455781633085, 5696.487316141567, 5716.885662286814, 5737.622970487137, 5753.309602847517, 4953.504649535162, 5008.9248661269385, 5488.341399032141, 5577.5537956962535, 5696.373398926197, 4024.7182697212083, 4408.382826404242, 4504.07666428388, 4552.453705555355, 4580.88547786308, 4861.805527778849, 5024.623153263593, 5083.415407228216, 5338.172583249602, 5768.577197576944, 5126.7183204198955, 5252.921206181833, 5262.236975638588, 5425.593080519056, 5663.290544693233, 4831.685940413862, 5075.619328550448, 5085.067674283749, 5362.892742145214, 5657.3776884543495, 5157.922631160611, 5213.6350455467755, 5517.179330820739, 5532.30846144232, 5565.77736890536, 4683.625309975126, 5375.81184658535, 5618.831435056954, 5650.29371328584, 5750.971245143747, 5038.445770965264, 5262.368815592204, 5565.972170139124, 5573.9655025914435, 5626.902753962938], "value": 4237.496747929216, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [704.130398957288, 775.8603451378749, 804.2962407893093, 867.7223288547665, 883.7834730491029, 16436.0, 17397.217125229363, 17416.477505674833, 17418.651626967483, 17420.65158696827, 15722.449714260003, 15764.211789410512, 15765.211739413013, 16289.674206515863, 16585.91707041466, 1001.3441196016621, 1021.724134483689, 1027.014066496161, 1028.8250997330435, 1028.9434081125535, 999.1008092716577, 1019.4596863662271, 1020.4081632653043, 1022.5551884930042, 1045.2683121814723, 1089.9182561307894, 1090.2749671468464, 1090.5910283643634, 1092.1426680056159, 1092.344593244051, 1069.1126365116972, 1078.282941843673, 1085.8968398002178, 1086.8261078227524, 1087.1574529739437, 661.9437347825441, 804.891339669143, 810.0117856215408, 810.3031393002013, 811.2698571285831, 17083.06043167625, 17209.881357711707, 17248.482545523653, 18141.45575632733, 18467.907660461748, 14410.567682969422, 14770.852291477055, 14771.113733176044, 14924.328405221791, 14945.40218391274, 12179.0, 12197.268163910194, 12197.573084942072, 12224.877751222462, 12422.378881056002, 3816.25090158429, 3936.2914675358425, 3951.604839516054, 3961.108750531136, 4076.1032572834224, 86878.56560717156, 119383.0, 120101.79898200993, 120292.39853800675, 123914.38042809819, 10843.45782710877, 11214.046806021579, 11230.382328971986, 11672.533098675958, 11999.0, 22095.779042209695, 22268.554628907656, 22338.888305558692, 22372.44068898258, 22640.867956602433, 6108.664023478751, 7953.0, 8108.310793582494, 8178.877316840252, 8192.54940978252, 4555.339475775994, 4571.2000399929875, 4641.2109941310055, 4660.1145782301255, 4778.354922085474, 2877.2519145022443, 3326.1185785766306, 3401.8809341672923, 3407.7784943978563, 3420.931581368359, 541.7426722306951, 617.3301967365459, 626.6584711332334, 629.0564153769346, 632.0740115730385, 630.7477009196358, 672.5897202706345, 680.9829754256183, 689.3175756001623, 704.1972151747012, 8967.865482017774, 9151.588178531982, 10378.0, 10589.523471443803, 10605.73485662849, 650.9934900651027, 675.2302375292171, 684.1482354468718, 691.9688614012382, 696.1993707236718, 4767.308740232716, 5075.264086707407, 5437.858049809505, 5583.916241256385, 5838.416158384128, 106692.39961400586, 108407.0, 108634.9948983404, 109275.45362273138, 109630.45184774185, 61077.0, 70348.29651703418, 70562.64718676374, 83159.0, 96557.0344296548, 76346.61826690943, 78605.60697196591, 79171.4511534966, 79338.6033069831, 79581.0, 11225.129639398525, 11314.773704525698, 11329.150313726339, 11461.885381146081, 11481.770364592829, 48752.5124748748, 50207.74896125496, 51347.0, 51452.22821657603, 53010.73494632502, 64489.71020579468, 65142.0, 65177.0, 65346.0, 66948.99576506259, 13071.477140914258, 13459.192448453125, 13469.461221551028, 13731.862681373457, 13910.652233694238, 13411.329433528479, 15288.082715037133, 15301.6174595636, 15540.766888496455, 16137.19314034317, 14015.439382424589, 14386.35261413218, 14549.41802327895, 14634.268286585415, 14817.851821481647, 14250.0, 14581.343839527035, 14592.124472531683, 14656.706865862836, 14795.926020369829, 13896.305184740924, 14047.297635118408, 14291.642708931944, 14396.712065758835, 14784.260786960824, 9318.161365477139, 9748.463834489172, 9854.901450985684, 10049.447280399356, 10495.265331427032, 10036.954104099848, 10924.828524066264, 11569.421528923689, 11718.414079295831, 11751.471183796579], "value": 7926.0196501724895, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1533.1, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 157.0, 178.0, 158.0, 119.0, 121.0, 118.0, 127.0, 143.0], "value": 134.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 109.0, 113.0, 142.0, 106.0, 110.0, 110.0, 110.0, 125.0, 111.0], "value": 116.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 197.0, 193.0, 233.0, 273.0, 229.0, 193.0, 196.0, 200.0, 193.0], "value": 210.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 62.0, 85.0, 113.0, 83.0, 80.0, 60.0, 66.0, 96.0, 77.0], "value": 80.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 71.0, 85.0, 72.0, 73.0, 71.0, 95.0, 71.0, 71.0, 81.0], "value": 77.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 90.0, 135.0, 113.0, 90.0, 93.0, 87.0, 89.0, 85.0], "value": 96.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 96.0, 98.0, 98.0, 96.0, 97.0, 100.0, 96.0, 96.0, 96.0], "value": 99.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 97.0, 92.0, 120.0, 144.0, 90.0, 92.0, 91.0, 91.0, 91.0], "value": 99.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 59.0, 100.0, 102.0, 103.0, 104.0, 102.0, 86.0, 68.0, 69.0], "value": 84.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 67.0, 72.0, 89.0, 98.0, 60.0, 57.0, 58.0, 57.0, 58.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 76.0, 89.0, 100.0, 103.0, 101.0, 77.0, 84.0, 79.0, 85.0], "value": 87.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 135.0, 150.0, 138.0, 144.0, 137.0, 140.0, 138.0, 175.0, 135.0], "value": 142.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 160.0, 167.0, 165.0, 162.0, 168.0, 163.0, 164.0], "value": 163.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 66.0, 64.0, 65.0, 68.0, 77.0, 85.0, 82.0, 83.0], "value": 71.6, "unit": "score"}]}]} 13:38:32 INFO - Return code: 0 13:38:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 13:38:32 ERROR - # TBPL SUCCESS # 13:38:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:38:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:38:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:38:32 INFO - 2017-05-08 13:38:32.234 screenresolution[1654:11096] starting screenresolution argv=screenresolution get 13:38:32 INFO - 2017-05-08 13:38:32.236 screenresolution[1654:11096] Display 0: 1600x1200x32@60 13:38:32 INFO - 2017-05-08 13:38:32.242 screenresolution[1655:11099] starting screenresolution argv=screenresolution list 13:38:32 INFO - Available Modes on Display 0 13:38:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:38:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:38:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:38:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:38:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:38:32 INFO - Intel Iris: 13:38:32 INFO - Chipset Model: Intel Iris 13:38:32 INFO - Type: GPU 13:38:32 INFO - Bus: Built-In 13:38:32 INFO - VRAM (Dynamic, Max): 1536 MB 13:38:32 INFO - Vendor: Intel (0x8086) 13:38:32 INFO - Device ID: 0x0a2e 13:38:32 INFO - Revision ID: 0x0009 13:38:32 INFO - Displays: 13:38:32 INFO - Display: 13:38:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:38:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:38:32 INFO - Display Serial Number: 1600x1200 60 13:38:32 INFO - Main Display: Yes 13:38:32 INFO - Mirror: Off 13:38:32 INFO - Online: Yes 13:38:32 INFO - Rotation: Supported 13:38:32 INFO - Return code: 0 13:38:32 INFO - Running post-action listener: _resource_record_post_action 13:38:32 INFO - [mozharness: 2017-05-08 20:38:32.486130Z] Finished run-tests step (success) 13:38:32 INFO - Running post-run listener: _resource_record_post_run 13:38:32 INFO - Total resource usage - Wall time: 1192s; CPU: 55.0%; Read bytes: 47011840; Write bytes: 427143168; Read time: 508; Write time: 1651 13:38:32 INFO - TinderboxPrint: CPU usage
54.5% 13:38:32 INFO - TinderboxPrint: I/O read bytes / time
47,011,840 / 508 13:38:32 INFO - TinderboxPrint: I/O write bytes / time
427,143,168 / 1,651 13:38:32 INFO - TinderboxPrint: CPU idle
2,169.0 (45.5%) 13:38:32 INFO - TinderboxPrint: CPU system
959.0 (20.1%) 13:38:32 INFO - TinderboxPrint: CPU user
1,641.6 (34.4%) 13:38:32 INFO - TinderboxPrint: Swap in / out
163,184,640 / 0 13:38:32 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 121733632; Write bytes: 116865024; Read time: 11081; Write time: 290 13:38:32 INFO - run-tests - Wall time: 1177s; CPU: 55.0%; Read bytes: 41928704; Write bytes: 300062720; Read time: 473; Write time: 1332 13:38:33 INFO - Running post-run listener: _upload_blobber_files 13:38:33 INFO - Blob upload gear active. 13:38:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:38:33 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 13:38:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 13:38:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 13:38:33 INFO - (blobuploader) - INFO - Open directory for files ... 13:38:33 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:38:33 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:33 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:38:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:35 INFO - (blobuploader) - INFO - Done attempting. 13:38:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:38:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:38:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:36 INFO - (blobuploader) - INFO - Done attempting. 13:38:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 13:38:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 13:38:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:37 INFO - (blobuploader) - INFO - Done attempting. 13:38:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 13:38:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:38:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:38:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 13:38:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:38:39 INFO - (blobuploader) - INFO - Done attempting. 13:38:39 INFO - (blobuploader) - INFO - Iteration through files over. 13:38:39 INFO - Return code: 0 13:38:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:38:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:38:39 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f3d06a525fa6c6e5701476cb38b68c558e83f3fe82597ded9185ea02729f4a12941f5ff1585ae8f81857cb4b6f3ea605f642aaa0031fd010f99fb35cedcb31f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b9ae8e35ab911187a7b54c94fe823918707d85ba7c03cffa11a895840d6f1294747d2d7a5905575022e3ea6f8b2389c92c8319e2f2b97c3aeb7bf23d7ce8fed6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/07cb7b2f5147cb2be3c1b01ad3c91b574fed91e3e9b13473482f70b5a4fbcf9ab2ac0daf7a96e23424df691a6702302c5860468455c5b6358041d52b77585bd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d2beabec716df015c17093b01eaab5c5560acc90bab61912600b43670622d681e92c951ed6d984c9c7a97b7f3775621666d070c0cfa15f46e218e8e844b1e447"} 13:38:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:38:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:38:39 INFO - Contents: 13:38:39 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f3d06a525fa6c6e5701476cb38b68c558e83f3fe82597ded9185ea02729f4a12941f5ff1585ae8f81857cb4b6f3ea605f642aaa0031fd010f99fb35cedcb31f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b9ae8e35ab911187a7b54c94fe823918707d85ba7c03cffa11a895840d6f1294747d2d7a5905575022e3ea6f8b2389c92c8319e2f2b97c3aeb7bf23d7ce8fed6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/07cb7b2f5147cb2be3c1b01ad3c91b574fed91e3e9b13473482f70b5a4fbcf9ab2ac0daf7a96e23424df691a6702302c5860468455c5b6358041d52b77585bd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d2beabec716df015c17093b01eaab5c5560acc90bab61912600b43670622d681e92c951ed6d984c9c7a97b7f3775621666d070c0cfa15f46e218e8e844b1e447"} 13:38:39 INFO - Running post-run listener: copy_logs_to_upload_dir 13:38:39 INFO - Copying logs to upload dir... 13:38:39 INFO - mkdir: /builds/slave/test/build/upload/logs 13:38:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1270.061651 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2017-05-08 13:38:39.330811) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 13:38:39.336816) ========= 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.o46SdqAIA1/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.866AC47cXc/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f3d06a525fa6c6e5701476cb38b68c558e83f3fe82597ded9185ea02729f4a12941f5ff1585ae8f81857cb4b6f3ea605f642aaa0031fd010f99fb35cedcb31f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b9ae8e35ab911187a7b54c94fe823918707d85ba7c03cffa11a895840d6f1294747d2d7a5905575022e3ea6f8b2389c92c8319e2f2b97c3aeb7bf23d7ce8fed6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/07cb7b2f5147cb2be3c1b01ad3c91b574fed91e3e9b13473482f70b5a4fbcf9ab2ac0daf7a96e23424df691a6702302c5860468455c5b6358041d52b77585bd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d2beabec716df015c17093b01eaab5c5560acc90bab61912600b43670622d681e92c951ed6d984c9c7a97b7f3775621666d070c0cfa15f46e218e8e844b1e447"} build_url:https://queue.taskcluster.net/v1/task/BXmsGQRlSBm7jriOX2j-zw/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011156 build_url: 'https://queue.taskcluster.net/v1/task/BXmsGQRlSBm7jriOX2j-zw/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/5f3d06a525fa6c6e5701476cb38b68c558e83f3fe82597ded9185ea02729f4a12941f5ff1585ae8f81857cb4b6f3ea605f642aaa0031fd010f99fb35cedcb31f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/b9ae8e35ab911187a7b54c94fe823918707d85ba7c03cffa11a895840d6f1294747d2d7a5905575022e3ea6f8b2389c92c8319e2f2b97c3aeb7bf23d7ce8fed6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/07cb7b2f5147cb2be3c1b01ad3c91b574fed91e3e9b13473482f70b5a4fbcf9ab2ac0daf7a96e23424df691a6702302c5860468455c5b6358041d52b77585bd7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d2beabec716df015c17093b01eaab5c5560acc90bab61912600b43670622d681e92c951ed6d984c9c7a97b7f3775621666d070c0cfa15f46e218e8e844b1e447"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 13:38:39.372851) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 13:38:39.373268) ========= 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.o46SdqAIA1/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.866AC47cXc/Listeners TMPDIR=/var/folders/d8/n42hj_ld0q5d1pgs8tfpv7hr00000w/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.005329 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 13:38:39.422347) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 13:38:39.422700) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 13:38:39.423069) ========= ========= Total master_lag: 0.19 =========