builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0341 starttime: 1492654786.91 results: success (0) buildid: 20170419171727 builduid: 936fd57733e04b0295dc5b431687b5c2 revision: 9edc76120a27a6c407e9f45d0b7a9b0877b80f57 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-19 19:19:46.911186) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-19 19:19:46.911700) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-19 19:19:46.912032) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-19 19:19:46.939389) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 19:19:46.940015) ========= 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.VHq44xafGo/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.xGASsDO1Hi/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-19 19:19:46-- 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% 61.1M=0s 2017-04-19 19:19:47 (61.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.149937 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 19:19:47.119149) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 19:19:47.119960) ========= 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.VHq44xafGo/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.xGASsDO1Hi/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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.027229 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 19:19:47.174086) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-19 19:19:47.177323) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 9edc76120a27a6c407e9f45d0b7a9b0877b80f57 --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 9edc76120a27a6c407e9f45d0b7a9b0877b80f57 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.VHq44xafGo/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.xGASsDO1Hi/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-19 19:19:47,290 truncating revision to first 12 chars 2017-04-19 19:19:47,290 Setting DEBUG logging. 2017-04-19 19:19:47,290 attempt 1/10 2017-04-19 19:19:47,290 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/9edc76120a27?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-19 19:19:48,549 unpacking tar archive at: mozilla-beta-9edc76120a27/testing/mozharness/ program finished with exit code 0 elapsedTime=1.540084 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-19 19:19:48.746462) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-19 19:19:48.747763) ========= script_repo_revision: 9edc76120a27a6c407e9f45d0b7a9b0877b80f57 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-19 19:19:48.748596) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-19 19:19:48.749106) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-19 19:19:48.769309) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-04-19 19:19:48.769759) ========= /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.VHq44xafGo/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.xGASsDO1Hi/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 19:19:48 INFO - MultiFileLogger online at 20170419 19:19:48 in /builds/slave/test 19:19:48 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 19:19:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:19:48 INFO - {'append_to_log': False, 19:19:48 INFO - 'base_work_dir': '/builds/slave/test', 19:19:48 INFO - 'blob_upload_branch': 'Mozilla-Beta', 19:19:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:19:48 INFO - 'branch': 'Mozilla-Beta', 19:19:48 INFO - 'buildbot_json_path': 'buildprops.json', 19:19:48 INFO - 'config_files': ('talos/mac_config.py',), 19:19:48 INFO - 'default_actions': ('clobber', 19:19:48 INFO - 'read-buildbot-config', 19:19:48 INFO - 'download-and-extract', 19:19:48 INFO - 'populate-webroot', 19:19:48 INFO - 'create-virtualenv', 19:19:48 INFO - 'install', 19:19:48 INFO - 'run-tests'), 19:19:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:19:48 INFO - 'download_minidump_stackwalk': True, 19:19:48 INFO - 'download_symbols': 'ondemand', 19:19:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:19:48 INFO - 'tooltool.py': '/tools/tooltool.py', 19:19:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:19:48 INFO - '/tools/misc-python/virtualenv.py')}, 19:19:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:19:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:19:48 INFO - 'gecko_profile': False, 19:19:48 INFO - 'gecko_profile_interval': 0, 19:19:48 INFO - 'installer_path': 'installer.exe', 19:19:48 INFO - 'log_level': 'info', 19:19:48 INFO - 'log_name': 'talos', 19:19:48 INFO - 'log_to_console': True, 19:19:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 19:19:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 19:19:48 INFO - 'opt_config_files': (), 19:19:48 INFO - 'pip_index': False, 19:19:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:19:48 INFO - 'cmd': ('bash', 19:19:48 INFO - '-c', 19:19:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:19:48 INFO - 'enabled': True, 19:19:48 INFO - 'halt_on_failure': False, 19:19:48 INFO - 'name': 'check_screen_resolution'},), 19:19:48 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 19:19:48 INFO - 'cmd': ('bash', 19:19:48 INFO - '-c', 19:19:48 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 19:19:48 INFO - 'enabled': True, 19:19:48 INFO - 'halt_on_failure': False, 19:19:48 INFO - 'name': 'check_screen_resolution'},), 19:19:48 INFO - 'run_cmd_checks_enabled': True, 19:19:48 INFO - 'suite': 'dromaeojs-e10s', 19:19:48 INFO - 'system_bits': '32', 19:19:48 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:19:48 INFO - 'title': 't-yosemite-r7-0341', 19:19:48 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:19:48 INFO - 'use_talos_json': True, 19:19:48 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:19:48 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:19:48 INFO - 'work_dir': 'build'} 19:19:48 INFO - [mozharness: 2017-04-20 02:19:48.988714Z] Running clobber step. 19:19:48 INFO - Running pre-action listener: _resource_record_pre_action 19:19:48 INFO - Running main action method: clobber 19:19:48 INFO - rmtree: /builds/slave/test/build 19:19:48 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:19:51 INFO - Running post-action listener: _resource_record_post_action 19:19:51 INFO - [mozharness: 2017-04-20 02:19:51.561948Z] Finished clobber step (success) 19:19:51 INFO - [mozharness: 2017-04-20 02:19:51.562101Z] Running read-buildbot-config step. 19:19:51 INFO - Running pre-action listener: _resource_record_pre_action 19:19:51 INFO - Running main action method: read_buildbot_config 19:19:51 INFO - Using buildbot properties: 19:19:51 INFO - { 19:19:51 INFO - "project": "", 19:19:51 INFO - "product": "firefox", 19:19:51 INFO - "script_repo_revision": "production", 19:19:51 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 19:19:51 INFO - "repository": "", 19:19:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 19:19:51 INFO - "buildid": "20170419171727", 19:19:51 INFO - "pgo_build": "False", 19:19:51 INFO - "basedir": "/builds/slave/test", 19:19:51 INFO - "buildnumber": 40, 19:19:51 INFO - "slavename": "t-yosemite-r7-0341", 19:19:51 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 19:19:51 INFO - "platform": "yosemite_r7", 19:19:51 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 19:19:51 INFO - "branch": "mozilla-beta", 19:19:51 INFO - "repo_path": "releases/mozilla-beta", 19:19:51 INFO - "revision": "9edc76120a27a6c407e9f45d0b7a9b0877b80f57", 19:19:51 INFO - "stage_platform": "macosx64", 19:19:51 INFO - "builduid": "936fd57733e04b0295dc5b431687b5c2", 19:19:51 INFO - "slavebuilddir": "test" 19:19:51 INFO - } 19:19:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 19:19:51 INFO - Running post-action listener: _resource_record_post_action 19:19:51 INFO - [mozharness: 2017-04-20 02:19:51.566185Z] Finished read-buildbot-config step (success) 19:19:51 INFO - [mozharness: 2017-04-20 02:19:51.566341Z] Running download-and-extract step. 19:19:51 INFO - Running pre-action listener: _resource_record_pre_action 19:19:51 INFO - Running main action method: download_and_extract 19:19:51 INFO - mkdir: /builds/slave/test/build/tests 19:19:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:19:51 INFO - trying https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 19:19:51 INFO - Downloading https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/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 19:19:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/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 19:19:52 INFO - Downloaded 1165 bytes. 19:19:52 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 19:19:52 INFO - Using the following test package requirements: 19:19:52 INFO - {u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 19:19:52 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:19:52 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 19:19:52 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:19:52 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 19:19:52 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 19:19:52 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:19:52 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 19:19:52 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 19:19:52 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:19:52 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 19:19:52 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:19:52 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 19:19:52 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:19:52 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 19:19:52 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 19:19:52 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 19:19:52 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 19:19:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 19:19:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 19:19:52 INFO - Fetch https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 19:19:54 INFO - Expected file size: 51220783 19:19:54 INFO - Obtained file size: 51220783 19:20:10 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 19:20:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 19:20:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 19:20:10 INFO - Fetch https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 19:20:12 INFO - Expected file size: 51220783 19:20:12 INFO - Obtained file size: 51220783 19:20:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 19:20:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 19:20:27 INFO - Fetch https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 19:20:28 INFO - Expected file size: 14404424 19:20:28 INFO - Obtained file size: 14404424 19:20:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:20:28 INFO - trying https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 19:20:28 INFO - Downloading https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 19:20:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/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 19:20:30 INFO - Downloaded 59193643 bytes. 19:20:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 19:20:30 INFO - mkdir: /builds/slave/test/properties 19:20:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:20:30 INFO - Writing to file /builds/slave/test/properties/build_url 19:20:30 INFO - Contents: 19:20:30 INFO - build_url:https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.dmg 19:20:31 INFO - Running post-action listener: _resource_record_post_action 19:20:31 INFO - Running post-action listener: set_extra_try_arguments 19:20:31 INFO - [mozharness: 2017-04-20 02:20:31.126038Z] Finished download-and-extract step (success) 19:20:31 INFO - [mozharness: 2017-04-20 02:20:31.126157Z] Running populate-webroot step. 19:20:31 INFO - Running pre-action listener: _resource_record_pre_action 19:20:31 INFO - Running main action method: populate_webroot 19:20:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:20:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:20:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:20:31 INFO - '--tppagecycles', 19:20:31 INFO - '7'], 19:20:31 INFO - 'tests': ['tsvgm']}}, 19:20:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 19:20:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:20:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 19:20:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 19:20:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 19:20:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 19:20:31 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 19:20:31 INFO - 'talos_options': ['--disable-e10s'], 19:20:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:20:31 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 19:20:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:20:31 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 19:20:31 INFO - 'talos_options': ['--disable-e10s'], 19:20:31 INFO - 'tests': ['damp', 'tps']}, 19:20:31 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 19:20:31 INFO - 'tests': ['damp', 'tps']}, 19:20:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 19:20:31 INFO - 'tests': ['dromaeo_dom']}, 19:20:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:20:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 19:20:31 INFO - 'tests': ['basic_compositor_video']}, 19:20:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 19:20:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 19:20:31 INFO - 'tests': ['a11yr', 19:20:31 INFO - 'ts_paint', 19:20:31 INFO - 'tpaint', 19:20:31 INFO - 'sessionrestore', 19:20:31 INFO - 'sessionrestore_no_auto_restore', 19:20:31 INFO - 'tabpaint']}, 19:20:31 INFO - 'other-e10s': {'tests': ['a11yr', 19:20:31 INFO - 'ts_paint', 19:20:31 INFO - 'tpaint', 19:20:31 INFO - 'sessionrestore', 19:20:31 INFO - 'sessionrestore_no_auto_restore', 19:20:31 INFO - 'tabpaint']}, 19:20:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 19:20:31 INFO - 'ts_paint', 19:20:31 INFO - 'tpaint', 19:20:31 INFO - 'sessionrestore', 19:20:31 INFO - 'sessionrestore_no_auto_restore', 19:20:31 INFO - 'tabpaint']}, 19:20:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 19:20:31 INFO - 'ts_paint', 19:20:31 INFO - 'tpaint', 19:20:31 INFO - 'sessionrestore', 19:20:31 INFO - 'sessionrestore_no_auto_restore', 19:20:31 INFO - 'tabpaint']}, 19:20:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 19:20:31 INFO - 'tests': ['a11yr', 19:20:31 INFO - 'ts_paint', 19:20:31 INFO - 'tpaint', 19:20:31 INFO - 'sessionrestore', 19:20:31 INFO - 'sessionrestore_no_auto_restore', 19:20:31 INFO - 'tabpaint']}, 19:20:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 19:20:31 INFO - 'tests': ['a11yr', 19:20:31 INFO - 'ts_paint', 19:20:31 INFO - 'tpaint', 19:20:31 INFO - 'sessionrestore', 19:20:31 INFO - 'sessionrestore_no_auto_restore', 19:20:31 INFO - 'tabpaint']}, 19:20:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 19:20:31 INFO - 'tests': ['tsvgx', 19:20:31 INFO - 'tsvgr_opacity', 19:20:31 INFO - 'tart', 19:20:31 INFO - 'tscrollx', 19:20:31 INFO - 'cart', 19:20:31 INFO - 'tsvg_static']}, 19:20:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 19:20:31 INFO - 'tsvgr_opacity', 19:20:31 INFO - 'tart', 19:20:31 INFO - 'tscrollx', 19:20:31 INFO - 'cart', 19:20:31 INFO - 'tsvg_static']}, 19:20:31 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 19:20:31 INFO - 'talos_options': ['--disable-e10s'], 19:20:31 INFO - 'tests': ['tp5o']}, 19:20:31 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 19:20:31 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 19:20:31 INFO - 'talos_options': ['--disable-e10s', 19:20:31 INFO - '--xperf_path', 19:20:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:20:31 INFO - 'tests': ['tp5n']}, 19:20:31 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 19:20:31 INFO - 'talos_options': ['--xperf_path', 19:20:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:20:31 INFO - 'tests': ['tp5n']}}, 19:20:31 INFO - 'talos.zip': {'path': '', 19:20:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:20:31 INFO - Running post-action listener: _resource_record_post_action 19:20:31 INFO - [mozharness: 2017-04-20 02:20:31.145019Z] Finished populate-webroot step (success) 19:20:31 INFO - [mozharness: 2017-04-20 02:20:31.145161Z] Running create-virtualenv step. 19:20:31 INFO - Running pre-action listener: _resource_record_pre_action 19:20:31 INFO - Running main action method: create_virtualenv 19:20:31 INFO - Creating virtualenv /builds/slave/test/build/venv 19:20:31 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 19:20:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:20:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:20:31 INFO - Using real prefix '/tools/python27' 19:20:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:20:31 INFO - Installing distribute.............................................................................................................................................................................................done. 19:20:34 INFO - Installing pip.................done. 19:20:34 INFO - Return code: 0 19:20:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 19:20:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 19:20:35 INFO - Reading from file tmpfile_stdout 19:20:35 INFO - Output received: 19:20:35 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) 19:20:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:20: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')]} 19:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:20: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')]} 19:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:20:35 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 0x102584b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102587768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc258c893d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102362d30>, '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 0x102289db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102357be8>, '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.VHq44xafGo/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.xGASsDO1Hi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 19:20:35 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 19:20:35 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 19:20:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VHq44xafGo/Render', 19:20:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:20:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:20:35 INFO - 'HOME': '/Users/cltbld', 19:20:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:20:35 INFO - 'LOGNAME': 'cltbld', 19:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:20:35 INFO - 'MOZ_NO_REMOTE': '1', 19:20:35 INFO - 'NO_EM_RESTART': '1', 19:20:35 INFO - 'PAGER': '/bin/cat', 19:20:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:20:35 INFO - 'PWD': '/builds/slave/test', 19:20:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:20:35 INFO - 'SHELL': '/bin/bash', 19:20:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xGASsDO1Hi/Listeners', 19:20:35 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 19:20:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:20:35 INFO - 'USER': 'cltbld', 19:20:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:20:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:20:35 INFO - 'XPC_FLAGS': '0x0', 19:20:35 INFO - 'XPC_SERVICE_NAME': '0', 19:20:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:20:35 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 19:20:35 INFO - Cleaning up... 19:20:35 INFO - Return code: 0 19:20:35 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 19:20: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')]} 19:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:20:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:20: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')]} 19:20:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:20:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:20:35 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 0x102584b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102587768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc258c893d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102362d30>, '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 0x102289db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102357be8>, '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.VHq44xafGo/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.xGASsDO1Hi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 19:20:35 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 19:20:35 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 19:20:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VHq44xafGo/Render', 19:20:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:20:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:20:35 INFO - 'HOME': '/Users/cltbld', 19:20:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:20:35 INFO - 'LOGNAME': 'cltbld', 19:20:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:20:35 INFO - 'MOZ_NO_REMOTE': '1', 19:20:35 INFO - 'NO_EM_RESTART': '1', 19:20:35 INFO - 'PAGER': '/bin/cat', 19:20:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:20:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:20:35 INFO - 'PWD': '/builds/slave/test', 19:20:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:20:35 INFO - 'SHELL': '/bin/bash', 19:20:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xGASsDO1Hi/Listeners', 19:20:35 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 19:20:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:20:35 INFO - 'USER': 'cltbld', 19:20:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:20:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:20:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:20:35 INFO - 'XPC_FLAGS': '0x0', 19:20:35 INFO - 'XPC_SERVICE_NAME': '0', 19:20:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:20:35 INFO - Downloading/unpacking psutil>=3.1.1 19:20:35 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 19:20:35 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 19:20:35 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 19:20:35 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 19:20:35 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 19:20:35 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 19:20:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:20:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:20:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:20:39 INFO - Installing collected packages: psutil 19:20:39 INFO - Running setup.py install for psutil 19:20:39 INFO - building 'psutil._psutil_osx' extension 19:20:39 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 19:20:39 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 19:20:39 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 19:20:39 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 19:20:39 INFO - building 'psutil._psutil_posix' extension 19:20:39 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 19:20:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 19:20:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 19:20:40 INFO - ^ 19:20:40 INFO - 1 warning generated. 19:20:40 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 19:20:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:20:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:20:40 INFO - Successfully installed psutil 19:20:40 INFO - Cleaning up... 19:20:40 INFO - Return code: 0 19:20:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 19:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:20:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:20:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:20:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:20:40 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 0x102584b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102587768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc258c893d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102362d30>, '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 0x102289db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102357be8>, '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.VHq44xafGo/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.xGASsDO1Hi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 19:20:40 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 19:20:40 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 19:20:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VHq44xafGo/Render', 19:20:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:20:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:20:40 INFO - 'HOME': '/Users/cltbld', 19:20:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:20:40 INFO - 'LOGNAME': 'cltbld', 19:20:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:20:40 INFO - 'MOZ_NO_REMOTE': '1', 19:20:40 INFO - 'NO_EM_RESTART': '1', 19:20:40 INFO - 'PAGER': '/bin/cat', 19:20:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:20:40 INFO - 'PWD': '/builds/slave/test', 19:20:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:20:40 INFO - 'SHELL': '/bin/bash', 19:20:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xGASsDO1Hi/Listeners', 19:20:40 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 19:20:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:20:40 INFO - 'USER': 'cltbld', 19:20:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:20:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:20:40 INFO - 'XPC_FLAGS': '0x0', 19:20:40 INFO - 'XPC_SERVICE_NAME': '0', 19:20:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:20:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:20:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 19:20:40 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 19:20:40 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 19:20:40 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 19:20:40 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 19:20:40 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 19:20:40 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 19:20:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 19:20:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:20:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 19:20:43 INFO - Installing collected packages: mozsystemmonitor 19:20:43 INFO - Running setup.py install for mozsystemmonitor 19:20:43 INFO - Successfully installed mozsystemmonitor 19:20:43 INFO - Cleaning up... 19:20:43 INFO - Return code: 0 19:20:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 19:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:20:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:20:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:20:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:20:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:20:44 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 0x102584b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102587768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc258c893d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102362d30>, '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 0x102289db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102357be8>, '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.VHq44xafGo/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.xGASsDO1Hi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 19:20:44 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 19:20:44 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 19:20:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VHq44xafGo/Render', 19:20:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:20:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:20:44 INFO - 'HOME': '/Users/cltbld', 19:20:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:20:44 INFO - 'LOGNAME': 'cltbld', 19:20:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:20:44 INFO - 'MOZ_NO_REMOTE': '1', 19:20:44 INFO - 'NO_EM_RESTART': '1', 19:20:44 INFO - 'PAGER': '/bin/cat', 19:20:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:20:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:20:44 INFO - 'PWD': '/builds/slave/test', 19:20:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:20:44 INFO - 'SHELL': '/bin/bash', 19:20:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xGASsDO1Hi/Listeners', 19:20:44 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 19:20:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:20:44 INFO - 'USER': 'cltbld', 19:20:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:20:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:20:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:20:44 INFO - 'XPC_FLAGS': '0x0', 19:20:44 INFO - 'XPC_SERVICE_NAME': '0', 19:20:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:20:44 INFO - Downloading/unpacking jsonschema==2.5.1 19:20:44 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 19:20:44 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 19:20:44 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 19:20:44 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 19:20:44 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 19:20:44 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 19:20:47 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:20:47 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 19:20:47 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 19:20:47 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 19:20:47 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 19:20:47 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 19:20:47 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 19:20:47 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 19:20:47 INFO - Downloading functools32-3.2.3-2.tar.gz 19:20:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:20:48 INFO - warning: no files found matching '*.txt' 19:20:48 INFO - no previously-included directories found matching 'build' 19:20:48 INFO - no previously-included directories found matching 'dist' 19:20:48 INFO - no previously-included directories found matching '.git*' 19:20:48 INFO - Installing collected packages: jsonschema, functools32 19:20:48 INFO - Running setup.py install for functools32 19:20:48 INFO - warning: no files found matching '*.txt' 19:20:48 INFO - no previously-included directories found matching 'build' 19:20:48 INFO - no previously-included directories found matching 'dist' 19:20:48 INFO - no previously-included directories found matching '.git*' 19:20:48 INFO - Successfully installed jsonschema functools32 19:20:48 INFO - Cleaning up... 19:20:48 INFO - Return code: 0 19:20:48 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 19:20:48 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')]} 19:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:20:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:20:48 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')]} 19:20:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:20:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:20:48 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 0x102584b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102587768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc258c893d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102362d30>, '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 0x102289db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102357be8>, '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.VHq44xafGo/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.xGASsDO1Hi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 19:20:48 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 19:20:48 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 19:20:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VHq44xafGo/Render', 19:20:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:20:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:20:48 INFO - 'HOME': '/Users/cltbld', 19:20:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:20:48 INFO - 'LOGNAME': 'cltbld', 19:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:20:48 INFO - 'MOZ_NO_REMOTE': '1', 19:20:48 INFO - 'NO_EM_RESTART': '1', 19:20:48 INFO - 'PAGER': '/bin/cat', 19:20:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:20:48 INFO - 'PWD': '/builds/slave/test', 19:20:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:20:48 INFO - 'SHELL': '/bin/bash', 19:20:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xGASsDO1Hi/Listeners', 19:20:48 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 19:20:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:20:48 INFO - 'USER': 'cltbld', 19:20:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:20:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:20:48 INFO - 'XPC_FLAGS': '0x0', 19:20:48 INFO - 'XPC_SERVICE_NAME': '0', 19:20:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:20:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:20:48 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 19:20:48 INFO - Cleaning up... 19:20:48 INFO - Return code: 0 19:20:48 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:20:48 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')]} 19:20:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:20:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:20:48 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')]} 19:20:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:20:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:20:48 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 0x102584b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102587768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc258c893d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102362d30>, '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 0x102289db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102357be8>, '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.VHq44xafGo/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.xGASsDO1Hi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 19:20:48 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 19:20:48 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 19:20:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VHq44xafGo/Render', 19:20:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:20:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:20:48 INFO - 'HOME': '/Users/cltbld', 19:20:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:20:48 INFO - 'LOGNAME': 'cltbld', 19:20:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:20:48 INFO - 'MOZ_NO_REMOTE': '1', 19:20:48 INFO - 'NO_EM_RESTART': '1', 19:20:48 INFO - 'PAGER': '/bin/cat', 19:20:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:20:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:20:48 INFO - 'PWD': '/builds/slave/test', 19:20:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:20:48 INFO - 'SHELL': '/bin/bash', 19:20:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xGASsDO1Hi/Listeners', 19:20:48 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 19:20:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:20:48 INFO - 'USER': 'cltbld', 19:20:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:20:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:20:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:20:48 INFO - 'XPC_FLAGS': '0x0', 19:20:48 INFO - 'XPC_SERVICE_NAME': '0', 19:20:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:20:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:20:48 INFO - Downloading/unpacking blobuploader==1.2.4 19:20:48 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 19:20:48 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 19:20:48 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 19:20:48 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 19:20:48 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 19:20:48 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 19:20:51 INFO - Downloading blobuploader-1.2.4.tar.gz 19:20:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:20:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:20:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:20:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:20:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:20:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:20:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:20:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:20:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:20:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:20:52 INFO - Downloading docopt-0.6.1.tar.gz 19:20:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:20:52 INFO - Installing collected packages: blobuploader, requests, docopt 19:20:52 INFO - Running setup.py install for blobuploader 19:20:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:20:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:20:52 INFO - Running setup.py install for requests 19:20:53 INFO - Running setup.py install for docopt 19:20:53 INFO - Successfully installed blobuploader requests docopt 19:20:53 INFO - Cleaning up... 19:20:53 INFO - Return code: 0 19:20:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:20:53 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')]} 19:20:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:20:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:20:53 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')]} 19:20:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:20:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:20:53 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 0x102584b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102587768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc258c893d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102362d30>, '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 0x102289db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102357be8>, '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.VHq44xafGo/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.xGASsDO1Hi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 19:20:53 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 19:20:53 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 19:20:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VHq44xafGo/Render', 19:20:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:20:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:20:53 INFO - 'HOME': '/Users/cltbld', 19:20:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:20:53 INFO - 'LOGNAME': 'cltbld', 19:20:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:20:53 INFO - 'MOZ_NO_REMOTE': '1', 19:20:53 INFO - 'NO_EM_RESTART': '1', 19:20:53 INFO - 'PAGER': '/bin/cat', 19:20:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:20:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:20:53 INFO - 'PWD': '/builds/slave/test', 19:20:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:20:53 INFO - 'SHELL': '/bin/bash', 19:20:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xGASsDO1Hi/Listeners', 19:20:53 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 19:20:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:20:53 INFO - 'USER': 'cltbld', 19:20:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:20:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:20:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:20:53 INFO - 'XPC_FLAGS': '0x0', 19:20:53 INFO - 'XPC_SERVICE_NAME': '0', 19:20:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:20:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:20:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:20:53 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-OfYGV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:20:54 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-slKokf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:20:54 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-b8IBGI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:20:54 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-It2e7Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:20:54 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-ZiN73q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:20:54 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-HRV86t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:20:54 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-HxObpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:20:54 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-_QXoau-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:20:54 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-Vc1KIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:20:54 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-6qTYtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:20:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:20:54 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-YRBrGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:20:55 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-_Ae8US-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:20:55 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-_pVPpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:20:55 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-1txIvp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:20:55 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-_UVqhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:20:55 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-IgtcMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:20:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:20:55 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-qu8NmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:20:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:20:55 INFO - Running setup.py install for manifestparser 19:20:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:20:55 INFO - Running setup.py install for mozcrash 19:20:55 INFO - Running setup.py install for mozdebug 19:20:56 INFO - Running setup.py install for mozdevice 19:20:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:20:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:20:56 INFO - Running setup.py install for mozfile 19:20:56 INFO - Running setup.py install for mozhttpd 19:20:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:20:56 INFO - Running setup.py install for mozinfo 19:20:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:20:56 INFO - Running setup.py install for mozInstall 19:20:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:20:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:20:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:20:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:20:56 INFO - Running setup.py install for mozleak 19:20:56 INFO - Running setup.py install for mozlog 19:20:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:20:57 INFO - Running setup.py install for moznetwork 19:20:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:20:57 INFO - Running setup.py install for mozprocess 19:20:57 INFO - Running setup.py install for mozprofile 19:20:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:20:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:20:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:20:57 INFO - Running setup.py install for mozrunner 19:20:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:20:57 INFO - Running setup.py install for mozscreenshot 19:20:57 INFO - Running setup.py install for moztest 19:20:58 INFO - Running setup.py install for mozversion 19:20:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:20:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:20:58 INFO - Cleaning up... 19:20:58 INFO - Return code: 0 19:20:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:20:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:20:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:20:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:20:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:20:58 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 0x102584b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102587768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc258c893d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102362d30>, '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 0x102289db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102357be8>, '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.VHq44xafGo/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.xGASsDO1Hi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 19:20:58 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 19:20:58 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 19:20:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VHq44xafGo/Render', 19:20:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:20:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:20:58 INFO - 'HOME': '/Users/cltbld', 19:20:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:20:58 INFO - 'LOGNAME': 'cltbld', 19:20:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:20:58 INFO - 'MOZ_NO_REMOTE': '1', 19:20:58 INFO - 'NO_EM_RESTART': '1', 19:20:58 INFO - 'PAGER': '/bin/cat', 19:20:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:20:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:20:58 INFO - 'PWD': '/builds/slave/test', 19:20:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:20:58 INFO - 'SHELL': '/bin/bash', 19:20:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xGASsDO1Hi/Listeners', 19:20:58 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 19:20:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:20:58 INFO - 'USER': 'cltbld', 19:20:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:20:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:20:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:20:58 INFO - 'XPC_FLAGS': '0x0', 19:20:58 INFO - 'XPC_SERVICE_NAME': '0', 19:20:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:20:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:20:58 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-tWKrZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:20:58 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)) 19:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:20:58 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-HBft69-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:20:58 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)) 19:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:20:58 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-1Q5TWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:20:58 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)) 19:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:20:58 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-uWnKsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:20:58 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)) 19:20:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:20:58 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-m_xPoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:20:59 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)) 19:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:20:59 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-RcxW0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:20:59 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)) 19:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:20:59 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-SyT0yF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:20:59 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)) 19:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:20:59 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-UdVSxz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:20:59 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)) 19:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:20:59 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-4C0Isd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:20:59 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)) 19:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:20:59 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-RBtPWE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:20:59 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)) 19:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:20:59 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-DrWgaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:20:59 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)) 19:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:20:59 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-1wvEjh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:20:59 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)) 19:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:20:59 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-hsy3vg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:20:59 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)) 19:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:20:59 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-hv7Myk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:20:59 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)) 19:20:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:20:59 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-DmLFFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:21:00 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)) 19:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:21:00 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-hQ8Flb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:21:00 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)) 19:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:21:00 INFO - Running setup.py (path:/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/pip-Zm66kd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:21:00 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)) 19:21:00 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)) 19:21:00 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)) 19:21:00 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)) 19:21:00 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)) 19:21:00 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)) 19:21:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:21:00 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 19:21:00 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 19:21:00 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 19:21:00 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 19:21:00 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 19:21:00 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 19:21:02 INFO - Downloading blessings-1.6.tar.gz 19:21:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:21:02 INFO - Installing collected packages: blessings 19:21:02 INFO - Running setup.py install for blessings 19:21:03 INFO - Successfully installed blessings 19:21:03 INFO - Cleaning up... 19:21:03 INFO - Return code: 0 19:21:03 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:21:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:21:03 INFO - Reading from file tmpfile_stdout 19:21:03 INFO - Current package versions: 19:21:03 INFO - blessings == 1.6 19:21:03 INFO - blobuploader == 1.2.4 19:21:03 INFO - docopt == 0.6.1 19:21:03 INFO - functools32 == 3.2.3-2 19:21:03 INFO - jsonschema == 2.5.1 19:21:03 INFO - manifestparser == 1.1 19:21:03 INFO - mozInstall == 1.12 19:21:03 INFO - mozcrash == 1.0 19:21:03 INFO - mozdebug == 0.1 19:21:03 INFO - mozdevice == 0.49 19:21:03 INFO - mozfile == 1.2 19:21:03 INFO - mozhttpd == 0.7 19:21:03 INFO - mozinfo == 0.9 19:21:03 INFO - mozleak == 0.1 19:21:03 INFO - mozlog == 3.4 19:21:03 INFO - moznetwork == 0.27 19:21:03 INFO - mozprocess == 0.25 19:21:03 INFO - mozprofile == 0.28 19:21:03 INFO - mozrunner == 6.13 19:21:03 INFO - mozscreenshot == 0.1 19:21:03 INFO - mozsystemmonitor == 0.3 19:21:03 INFO - moztest == 0.8 19:21:03 INFO - mozversion == 1.4 19:21:03 INFO - psutil == 3.1.1 19:21:03 INFO - requests == 1.2.3 19:21:03 INFO - wsgiref == 0.1.2 19:21:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:03 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 0x102584b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102587768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc258c893d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102362d30>, '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 0x102289db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102357be8>, '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.VHq44xafGo/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.xGASsDO1Hi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 19:21:03 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 19:21:03 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 19:21:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VHq44xafGo/Render', 19:21:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:21:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:21:03 INFO - 'HOME': '/Users/cltbld', 19:21:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:21:03 INFO - 'LOGNAME': 'cltbld', 19:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:03 INFO - 'MOZ_NO_REMOTE': '1', 19:21:03 INFO - 'NO_EM_RESTART': '1', 19:21:03 INFO - 'PAGER': '/bin/cat', 19:21:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:03 INFO - 'PWD': '/builds/slave/test', 19:21:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:21:03 INFO - 'SHELL': '/bin/bash', 19:21:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xGASsDO1Hi/Listeners', 19:21:03 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 19:21:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:21:03 INFO - 'USER': 'cltbld', 19:21:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:21:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:03 INFO - 'XPC_FLAGS': '0x0', 19:21:03 INFO - 'XPC_SERVICE_NAME': '0', 19:21:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:03 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)) 19:21:03 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)) 19:21:03 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)) 19:21:03 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)) 19:21:03 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)) 19:21:03 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)) 19:21:03 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)) 19:21:03 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)) 19:21:03 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)) 19:21:03 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)) 19:21:03 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)) 19:21:03 INFO - Cleaning up... 19:21:03 INFO - Return code: 0 19:21:03 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:21:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102584b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102587768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc258c893d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102362d30>, '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 0x102289db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102357be8>, '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.VHq44xafGo/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.xGASsDO1Hi/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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 19:21:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:21:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:21:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VHq44xafGo/Render', 19:21:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:21:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:21:03 INFO - 'HOME': '/Users/cltbld', 19:21:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:21:03 INFO - 'LOGNAME': 'cltbld', 19:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:03 INFO - 'MOZ_NO_REMOTE': '1', 19:21:03 INFO - 'NO_EM_RESTART': '1', 19:21:03 INFO - 'PAGER': '/bin/cat', 19:21:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:03 INFO - 'PWD': '/builds/slave/test', 19:21:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:21:03 INFO - 'SHELL': '/bin/bash', 19:21:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xGASsDO1Hi/Listeners', 19:21:03 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 19:21:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:21:03 INFO - 'USER': 'cltbld', 19:21:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:21:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:03 INFO - 'XPC_FLAGS': '0x0', 19:21:03 INFO - 'XPC_SERVICE_NAME': '0', 19:21:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:21:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 19:21:04 INFO - Cleaning up... 19:21:04 INFO - Return code: 0 19:21:04 INFO - Running post-action listener: _resource_record_post_action 19:21:04 INFO - Running post-action listener: _start_resource_monitoring 19:21:04 INFO - Starting resource monitoring. 19:21:04 INFO - [mozharness: 2017-04-20 02:21:04.149588Z] Finished create-virtualenv step (success) 19:21:04 INFO - [mozharness: 2017-04-20 02:21:04.150542Z] Running install step. 19:21:04 INFO - Running pre-action listener: _resource_record_pre_action 19:21:04 INFO - Running main action method: install 19:21:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:21:04 INFO - Reading from file tmpfile_stdout 19:21:04 INFO - Detecting whether we're running mozinstall >=1.0... 19:21:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:21:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:21:04 INFO - Reading from file tmpfile_stdout 19:21:04 INFO - Output received: 19:21:04 INFO - Usage: mozinstall [options] installer 19:21:04 INFO - Options: 19:21:04 INFO - -h, --help show this help message and exit 19:21:04 INFO - -d DEST, --destination=DEST 19:21:04 INFO - Directory to install application into. [default: 19:21:04 INFO - "/builds/slave/test"] 19:21:04 INFO - --app=APP Application being installed. [default: firefox] 19:21:04 INFO - mkdir: /builds/slave/test/build/application 19:21:04 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'] 19:21:04 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 19:21:19 INFO - Reading from file tmpfile_stdout 19:21:19 INFO - Output received: 19:21:19 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 19:21:19 INFO - Running post-action listener: _resource_record_post_action 19:21:19 INFO - [mozharness: 2017-04-20 02:21:19.253663Z] Finished install step (success) 19:21:19 INFO - [mozharness: 2017-04-20 02:21:19.253831Z] Running run-tests step. 19:21:19 INFO - Running pre-action listener: _resource_record_pre_action 19:21:19 INFO - Running main action method: run_tests 19:21:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:21:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:21:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:21:19 INFO - 2017-04-19 19:21:19.268 screenresolution[1622:7365] starting screenresolution argv=screenresolution get 19:21:19 INFO - 2017-04-19 19:21:19.270 screenresolution[1622:7365] Display 0: 1600x1200x32@60 19:21:19 INFO - 2017-04-19 19:21:19.276 screenresolution[1623:7367] starting screenresolution argv=screenresolution list 19:21:19 INFO - Available Modes on Display 0 19:21:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:21:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:21:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:21:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:21:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:21:19 INFO - Intel Iris: 19:21:19 INFO - Chipset Model: Intel Iris 19:21:19 INFO - Type: GPU 19:21:19 INFO - Bus: Built-In 19:21:19 INFO - VRAM (Dynamic, Max): 1536 MB 19:21:19 INFO - Vendor: Intel (0x8086) 19:21:19 INFO - Device ID: 0x0a2e 19:21:19 INFO - Revision ID: 0x0009 19:21:19 INFO - Displays: 19:21:19 INFO - Display: 19:21:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:21:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:21:19 INFO - Display Serial Number: 1600x1200 60 19:21:19 INFO - Main Display: Yes 19:21:19 INFO - Mirror: Off 19:21:19 INFO - Online: Yes 19:21:19 INFO - Rotation: Supported 19:21:19 INFO - Return code: 0 19:21:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:21:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:21:19 INFO - Python 2.7.3 19:21:19 INFO - Return code: 0 19:21:19 INFO - grabbing minidump binary from tooltool 19:21:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 19:21:19 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 0x102362d30>, '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 0x102289db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102357be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:21:19 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 19:21:19 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 19:21:19 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 19:21:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:21:19 INFO - Return code: 0 19:21:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 19:21:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:21:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:21:19 INFO - ENV: RUST_BACKTRACE is now 1 19:21:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 19:21:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:21:19 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/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0341', '--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 19:21:19 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/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0341 --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 19:21:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.VHq44xafGo/Render', 19:21:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 19:21:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 19:21:19 INFO - 'HOME': '/Users/cltbld', 19:21:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 19:21:19 INFO - 'LOGNAME': 'cltbld', 19:21:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:21:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 19:21:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:21:19 INFO - 'MOZ_NO_REMOTE': '1', 19:21:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:21:19 INFO - 'NO_EM_RESTART': '1', 19:21:19 INFO - 'PAGER': '/bin/cat', 19:21:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 19:21:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:21:19 INFO - 'PWD': '/builds/slave/test', 19:21:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:21:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 19:21:19 INFO - 'RUST_BACKTRACE': '1', 19:21:19 INFO - 'SHELL': '/bin/bash', 19:21:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xGASsDO1Hi/Listeners', 19:21:19 INFO - 'TMPDIR': '/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/', 19:21:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 19:21:19 INFO - 'USER': 'cltbld', 19:21:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 19:21:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 19:21:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:21:19 INFO - 'XPC_FLAGS': '0x0', 19:21:19 INFO - 'XPC_SERVICE_NAME': '0', 19:21:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 19:21:19 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/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0341', '--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 19:21:19 INFO - mozversion application_buildid: 20170419171727 19:21:19 INFO - mozversion application_changeset: 9edc76120a27a6c407e9f45d0b7a9b0877b80f57 19:21:19 INFO - mozversion application_display_name: Firefox 19:21:19 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:21:19 INFO - mozversion application_name: Firefox 19:21:19 INFO - mozversion application_remotingname: firefox 19:21:19 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 19:21:19 INFO - mozversion application_vendor: Mozilla 19:21:19 INFO - mozversion application_version: 54.0 19:21:19 INFO - mozversion platform_buildid: 20170419171727 19:21:19 INFO - mozversion platform_changeset: 9edc76120a27a6c407e9f45d0b7a9b0877b80f57 19:21:19 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 19:21:19 INFO - mozversion platform_version: 54.0 19:21:19 INFO - using testdate: 1492654879 19:21:19 INFO - actual date: 1492654879 19:21:19 INFO - starting webserver on 'localhost:49242' 19:21:19 INFO - SUITE-START | Running 2 tests 19:21:19 INFO - TEST-START | dromaeo_css 19:21:19 INFO - operating with platform_type : mac_ 19:21:19 INFO - Initialising browser for dromaeo_css test... 19:21:19 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpKXuwZb/profile http://localhost:49242/getInfo.html) 19:21:22 INFO - PROCESS | 1633 | 2017-04-19 19:21:22.766 plugin-container[1637:7548] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d43, name = 'com.apple.tsm.portname' 19:21:22 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:21:22 INFO - PROCESS | 1633 | 2017-04-19 19:21:22.767 plugin-container[1637:7548] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9303, name = 'com.apple.CFPasteboardClient' 19:21:22 INFO - PROCESS | 1633 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:21:22 INFO - PROCESS | 1633 | 2017-04-19 19:21:22.767 plugin-container[1637:7548] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:21:22 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 19:21:22 INFO - PROCESS | 1633 | colorDepth:24 19:21:22 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 19:21:22 INFO - PROCESS | 1633 | __metrics 19:21:22 ERROR - PROCESS | 1633 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 19:21:23 INFO - TEST-INFO | 1633: exit 0 19:21:23 INFO - Browser initialized. 19:21:23 INFO - Running cycle 1/1 for dromaeo_css test... 19:21:23 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpKXuwZb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:21:25 INFO - PROCESS | 1638 | 2017-04-19 19:21:25.780 plugin-container[1639:7680] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4347, name = 'com.apple.tsm.portname' 19:21:25 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:21:25 INFO - PROCESS | 1638 | 2017-04-19 19:21:25.781 plugin-container[1639:7680] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 19:21:25 INFO - PROCESS | 1638 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:21:25 INFO - PROCESS | 1638 | 2017-04-19 19:21:25.781 plugin-container[1639:7680] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:21:35 INFO - PROCESS | 1638 | RSS: Main: 174862336 19:21:35 INFO - PROCESS | 1638 | 19:24:38 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 19:24:40 INFO - PROCESS | 1638 | RSS: Main: 189128704 19:24:40 INFO - PROCESS | 1638 | 19:27:42 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 19:27:42 INFO - PROCESS | 1638 | RSS: Main: 202772480 19:27:42 INFO - PROCESS | 1638 | 19:30:44 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 19:30:45 INFO - PROCESS | 1638 | RSS: Main: 205721600 19:30:45 INFO - PROCESS | 1638 | 19:33:47 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 19:33:47 INFO - PROCESS | 1638 | RSS: Main: 208826368 19:33:47 INFO - PROCESS | 1638 | 19:36:50 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 19:36:51 INFO - PROCESS | 1638 | RSS: Main: 211259392 19:36:51 INFO - PROCESS | 1638 | 19:39:54 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 19:39:54 INFO - PROCESS | 1638 | RSS: Main: 209248256 19:39:54 INFO - PROCESS | 1638 | 19:39:54 INFO - PROCESS | 1638 | __start_tp_report 19:39:54 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 19:39:54 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 19:39:54 INFO - PROCESS | 1638 | |i|pagename|runs| 19:39:54 INFO - PROCESS | 1638 | |0;dojo.html;3685.2445248724016;3688.557373115225;3699.278640665068;3739.326921154193;3739.3643080676284;5209.947900520993;5661.943380566193;5732.76745499718;6277.403646653572;6288.8742225155465;5185.896282074356;6260.906086408708;6291.4337709606125;6325.968370158154;6344.777932772354;5432.972835135829;5714.228579141804;5747.59766816323;5750.137479378106;5828.47543721065;5799.420057994209;5813.447722466359;5824.708764561776;5830.795922142725;5847.239858818348;5559.555235581144;5566.805161819337;5834.445727655866;5843.2695913010875;5899.203607512974;5707.457791509821;5737.913931291034;5745.6265342753;5779.2775903012125;5784.479396854261;5597;5726.484616384545;5728.455796699307;5737.110747834051;5785.971070144665;6110.236220472441;6218.626882387026;6285.96857015712;6388.808335749888;6421.903671444932;6544.541882068257;6547.985062315349;6636.601803891782;6643.534952553323;6703.262641109474;6910.3089691031;6912.412444942186;6922.89233722602;6926.688299026556;6937.375636192767;6364.49084073273;6369.71336289868;6415;6421.839454013687;6427.903581446282;6671.666416679147;6729.293424190488;6743.932560674429;6920.377166054978;7021.087258656444;6689.832754181184;6721.596704197764;6737.292584278678;6745.6289904054765;6767.35710107539;6827.112475378269;6848.486363522756;6867.313268673092;6884.793456196322;6892.1729392472225;5475.0418676731415;6429.839254018687;6749.797506074826;6757.93242067573;6801.693923773442;6639.70121344531;6678;6685.197776266879;6691.464682825363;6712.95949127886;5417.18742188667;5429.212764149176;5444.210589464585;5444.8094316698725;5476.424975377528;3775.2653323767568;4708.599769019604;4811.326414302001;4844.491328410537;4888.535589119028;6249.031400132987;6289.7169627366875;6300.117983482316;6333.1766870306565;6348.365163483615;6900.102986611709;6911.5853048817235;6922.411595014481;6922.8615427692175;6937.68780404883;6237.719302631393;6296.811095667137;6305;6322.241331040304;6405.839854003687;5150.48495150482;6095.664738439428;6100.84084024034;6108.267007959073;6144.2319710036245;7069.9646501767165;7070.787876363717;7114.750983715752;7121.786346409616;7122.252163522963;6528.086067950396;6586.793424202946;6721.059051732859;6822.897656535255;6904.998775177672;5800.970995144998;7048.436125109876;7098.822529436806;7103.2541583133025;7114.501984861217;6738.35985581369;6756.223034351113;6759.662016899234;6763.086983257197;6768.830779230559;6494.577852439576;6539;6682.732690692318;6689.431398331197;6880.380765731108;6464.676766161579;6482.189726284215;6509.804705858832;6515.381038801306;6536.3136870629805;6583.275839657538;6598.10925525048;6598.3401659833635;6606.570572912745;6609.173853268341;6217.191765070512;6344.238691357066;6377.139086223486;6463.482921366185;6464.709088090953;6467.288598254282;6525.836854078686;6551.410373066256;6580.473562115115;6603.240627327918;5422.240886276003;6498.805035848932;6507.544471886922;6508.446782023581;6519.869602607826 19:39:54 INFO - PROCESS | 1638 | |1;ext.html;796.0805269913249;827.5696637748371;851.9829603407932;997.4912794474816;1001.8296889528775;30651.693483065163;32693.18267043322;36181.45727814081;36918.44622330661;38233;38776;38948.610513894855;39056.80471597638;39083.82748517549;39107;8167.305779008791;8329.125441828612;11067.944660276688;11353.205275630668;11484.196106272564;9492.857607135898;11347;11400.543978240901;11410;11428.142889283337;11406.5437382505;11413.201075924688;11435;11436.599719009837;11457.427128643534;11349.319040857534;11362.659120226406;11372.37451940143;11382.146339024606;11390.14573906952;11012.834807477895;11022;11083.944580277128;11095.778084438267;11109.333439993627;34174.14564635879;34199.829000854836;34320.31359372799;34401.483977740354;34435.31129377423;3987.900302492432;3999.7814869810927;4018.8191531380867;4042.454268673721;4065.26825171469;22767.77232227673;25556.616650750253;26105.477890442275;27360;27386.041488547806;2785.428987057648;2973.732364087221;3204.327091310804;3232.7575431842706;3244.659310772382;354338;356504;356710;357903.8419231627;358969;44469.11061778811;44924.77537612291;45047.64857054294;45057.873553160774;45059.77470112694;45779.542204578196;46023;46193.76903115463;46245;46365.072698546515;14338.211398373189;14540.054896431699;14776.482823101354;14789.556313310402;14822.777658335133;12537.74924501505;12648.74702505963;12653.87346126527;12660.240385576895;12663.240205587694;11757.706057348634;11977.161598688008;11985.940070299766;12018.218815777122;12095.818562721566;5661.631993920382;5707.086866101404;5733.140028995684;5743.712814359265;5757.683327417032;1015.3856916565519;1099.433791597328;1148.3454430974264;1165.454726566381;1206.638008597435;26887;27052.238805970337;27242.5913611296;27312.180634580993;27412.314692132855;955.5174636808506;1282.5254655777421;1313.7241179352252;1337.9866201338057;1356.4777560639225;10709.518071686793;13010.544630937871;14021.929890350688;14216.928915355356;14277.571672849832;350340;352261;352919;352994;353426;38169.42745858814;38248.61751382451;45308;45439;45662.315065274044;1459.9489017884323;1486.2123074770388;1487.3084015932643;1494.3275526013338;1500.0774523668083;26201.21396358112;26306.60540091862;26738;27092.864535677196;27258.318542036606;38843.41734874035;38997.805010974764;39052.6094739049;39077.63228286996;39125.02187445223;343503;345591;346073;346490;348252;28519.42961140807;28593.428131436838;28628.570571441862;28844;28949.7105028947;36270.09324766902;36443.63556364508;36479.635203647624;40233;41438.378424323055;24616.753832462164;28302.150935471967;29214.561781573717;29633.478556296937;29896.402071958004;28962.710372896003;29410.55884161782;29518.852405737834;29526.261843453227;29636.85181574078;34819.82590087033;34838.30323393569;35103;35135.64864351426;35200.82399587986;27457.15876108363;28082.438351233268;29378.265543361587;29668.276202293524;30242.54636180415;24140.51718965646;24191.63712544278;24243.878780605985;24551.50896982086;24571.754282456946 19:39:54 INFO - PROCESS | 1638 | |2;jquery.html;391.89614752090694;428.3510481620348;428.36815696847134;437.92052590364744;438.9626881715054;19872.9006354968;20855.47861303468;22208.55582888341;22277.220297289598;22424.8878755606;18767.530811729714;21413.67879481809;22314.107435702554;23012.424689382773;23206.767932320672;6604.966975165117;6939.653017349112;6957.5129740918155;6986.266442023591;6988.231294557595;5142.485751424865;6644.235912870009;6816.591004539743;6820.31796820319;6977.6511174441075;6542.247641521215;6676.966615166917;6825.931740682604;6827.52207345486;6873.759418420356;6747.898781518281;6753.8986915196065;6777.8644427111185;6799.558028728166;6817.761378351734;6386.13787138735;6459.354064593503;6537.901931470984;6539.34606539347;6548.017797330391;26259.21222363332;27057.864710676517;27183.728162718515;27199.320016999536;27509.037183698474;2995.3859458811107;3020.9244768880735;3083.645380781194;3094.19550916761;3113.9532907006414;16994.490165294937;17054.40309589171;17495.912520437316;17497.912510437367;18013.909930450394;2141.5074532857375;2180.1061564758375;2208.2602328220064;2229.3869185973826;2240.283109404991;155739;161275;164903.175484123;167074.16462917608;169051;17114.77507923987;21479.67780483294;21844;21938.89030554837;22129.336119916105;33773.66226337754;33835.66164338325;34362.31275374479;34445.82777086098;34457.82771086128;9097.772555686028;9515.429074255568;10298.124659404035;11229.438528073728;11271.54913803455;7647.732329368446;9360.812783744423;9390.765230869283;9457.33798634089;9559;8123.268905798506;9805.950970245103;10070.244731645156;10112.949435252924;10142.645007424704;3494.4624365279196;3502.2295095079044;4083.91832163361;4197.328427451593;4200.642945349679;912.4761648047776;930.0978051290238;932.7714709896119;934.4066517761271;975.3855071305032;21457.46356341104;22403.775962240496;22416.775832241794;22467.876606169626;22490.66264006041;897.6499165325529;950.1828427552299;958.5734348215117;965.2490402353237;988.906053924876;11179.4969226385;11432.428378581038;11645.76708465843;11668;11702.414879256003;812520;814530;818134;836635;845177;145023.2748836249;173175.1341243286;177276;178245;178931;1262.236347010064;1306.9542566010143;1342.053852034333;1370.1915869636962;1371.5405339211277;16684.66630667404;21106.788932111096;21349.89325053365;21576.029078691183;21666.89166554157;51288.54922228205;65881.67059164673;66903;70405;72242.63878680574;98822.5058874701;99640;100771;102346;102514;11408.82886756716;11828.23116497425;11926.463309151282;12047.759044818878;12189.939050305047;11527.538898444303;13146.868531314565;13486.190828550318;13934.860651393356;14399.640008999859;11450.541978320774;11695.941520292685;11956.46195921203;12083.214591051554;12196.75606487883;9439.292053096182;11461.942690286494;11478;11486.36824974601;11633.069354451793;12036.217645852992;12087.274763514217;12226.266424014588;12229.3273869938;12320.383980801103;12268.509259629873;12291.139620226855;12304.26174429537;12602.621921342374;12659.87340126587;9481.146696797321;11891.464884080064;11918.225315354473;11967.64097077089;12047.494063242095 19:39:54 INFO - PROCESS | 1638 | |3;mootools.html;1623.1154021058521;1671.4400675773616;1672.4731709511502;1687.156421789105;1702.991485042575;9956.103950644441;10212.540435680394;11284;12026.939865300672;12057.698557536056;9571.569279382427;11234.269772464784;11605.535778568847;11613.012893904008;11632.534698612066;2515.283144303869;2528.734482879299;2544.2748816587277;2545.770880620744;2548.4648223872914;2479.070348619268;2513.54756143894;2514.069794176148;2532.620106983958;2534.2397280815776;2488.0794106180647;2492.4516606346574;2493.775560199582;2509.046562306321;2524.507720994407;2455.7667021633006;2463.027104293812;2467.592847180213;2469.2098528470897;2476.2818782553036;2432.3675844280615;2449.1672831237465;2450.105711415338;2461.4584791345874;2463.9137630183036;8647.610857511365;10945.890541094646;11519.36643484608;11592.072634189244;11798.587049453228;5988.401159884021;6057.121717351003;6144.508439324888;6152.477039451652;6153.753849846001;3178.7761711740914;3710.18375957289;3730.645588669099;3792.544894612664;3906.570277269498;1239.5723475400973;1249.650097972569;1292.1988367212296;1292.8383952006;1305.673581604599;16247.268872900748;16411.1794410279;16441.1779411029;16473;16478;4770.761461926959;4909.337239472697;4960.627952903546;4970.701757894538;4972.651914366032;11878.643640690792;11940.462679179458;12100.152989290842;12120.515179392725;12130.878691212974;5399.65008747813;5697.686627235459;6008.639481631116;6017.759289628366;6024.307204671519;5253.001929633358;5595.832125036255;5602.831915042555;5625.915611265835;5626.521745651666;3484.4599087141532;4023.396490526386;4125.711200216017;4151.232723941475;4176.519700234451;1079.794838980607;1083.553456136067;1083.9078678312273;1096.4956120184645;1097.308695521832;977.3061126600052;988.0860204311127;1001.3140998416109;1010.1716592394166;1022.4632068164274;5343.65266257692;6716.194056713128;6871.969204619247;6946.687399067054;6959.512834101665;911.48956584313;1030.7835354575623;1050.4117694091333;1062.8405739139037;1094.9178811589163;4347.586979236968;4461.910761784746;4529.162105010583;4625.098105869323;4667.439907211156;13967.231802250973;14680.92659536717;14689.118652880861;14709.338079786436;14727.410903563738;13638.249896255802;14088.71822563543;14361.712765744627;14391.280435978158;14391.496297629743;10349.534270957825;10545.57817687284;10577.735556611146;10598.682039538826;10622.36265824053;5863.824085277449;6720.529562930744;6841.760538381132;6985.7205711772995;6988.231294557493;11711.76576468483;11865.288082715064;11882.76234475323;11893;11938.28370297785;11787.292762434281;11876.762464750484;12005.699857503632;12064.638060858188;12143.392830358624;9420.434773913586;9687.806243875224;9953.651622193189;9970.40177589347;9979.950100249453;10795.514201861091;10839.620613278812;10917.727056823644;10934.781304374028;10942.124630029419;9167.266618670357;9267.953660231926;9315.580798863932;9334.486603236886;9438.95280523593;9081.228095611947;9118.22495087925;9119.452832830051;9150.22223111043;9205.263578913537;6872.175338959357;8433.28317093054;8545.74362769118;8550.760139779573;8558.058613552379;6115.4190351916495;6185.319614842274;6239.469645080219;6282.1519094921605;6363.172787537591;5754.280714910637;5982.833347497196;6002.2197114376595;6225.968870155621;6559.639219842955 19:39:54 INFO - PROCESS | 1638 | |4;prototype.html;356.964303569643;391.49888143176724;395.4680954116712;405.0946135387409;407.22017336800013;4284.286285485799;4740.573348398643;4823.372961515007;5280.993222575421;5288.391834938983;4773.284007398892;4928.975355123228;5336.439673834249;5340.359156901168;5351.50157955772;3631.364511210541;4285.2929266671035;4415.8233670653135;4435.246008178618;4458.888527786815;4451.777411129447;4452.7328360298325;4468.938776937808;4470.575295346936;4482.775861206943;3756.812159392033;3918.5689574146822;4425.181341451842;4434.851255608522;4488.124815660947;4139.855105071308;4176.498820141572;4378.846740364103;4409.536998615147;4474.306482495218;3616.0236736081374;4054.959450405517;4065.532463766675;4082.6529744971417;4117.5676553962;4413.933790993137;4886.800939577169;5112.923306150411;5255;5288.550473209782;4359.651227901792;4634.606058485033;4765.950641224272;4888.364512613373;5141.614378921596;4637.652176086807;5020.447750747415;5118.97440512795;5577.549837042398;5620.690862002588;4054.6553542948886;4114.7119701620895;4572.817087316536;4585.770711464414;4591.655625828076;5309.442508536626;5741.827745167651;6027.819165425044;6045.72794224261;6084.756609735561;4130.483689538808;4574.879154607076;4686.742229177428;4694.319323698045;4702.224133018082;4151.543330233671;4215.629920275923;4434.578715022068;4454.732716037048;4722.669413141116;4184.560621134798;4976.253561965734;5019.171836646985;5113.463086375951;5171.534561889448;5688.146777983336;5694.715264236772;5727.570432217517;5737.942620573825;5741.5119714824705;1556.9688606227812;1769.6106856491551;1799.442172926397;1802.97295540567;1806.67479853625;1060.233488597015;1255.7237407770276;1257.0258050011314;1351.6012776231034;1468.5961360625913;4496.0558282760985;5078.796848126033;5238.423773384925;5249.711265880337;5262.368515778131;5103.2855400244;5108.770105345268;5460.781568737206;5810.477057064884;5915.881682366415;4477.597016268552;4630.560096790799;4698.154332220165;4795.954568848806;5090.567301779391;2563.679540057493;3016.9547456788164;3051.9847400762856;3052.8015678981237;3068.5243787213017;5311.901798789457;5717.685527296038;5894.292684877756;6085.604435711664;6132.601380910227;5778.27771528559;6004.584338342144;6041.6375017499095;6045.939540604538;6068.241469816273;5228.816991405359;5379.009766386462;5828.94171058284;5988.970055149784;6094.603850749687;5038.976614031551;5489.780408783604;5888.941110588839;5890.378781442217;5896.169838477469;5437.797691934773;5792.420757924174;5799.333076696234;5799.420057994167;5803.3616302207565;5751.166080918159;5887.7056147193325;6033.79766385275;6085.756569737161;6092.482139018056;4323.589259020388;4451.041541721632;4563.429571303587;5041.596672266283;5123.462036486116;5365.256291705134;5638;5922.822315330547;5935.5548333875995;5942.851428714143;5013.899722005613;5736.2217712509255;5742.8751361994655;5743.942560574508;5762.740676669476;4970.303063604859;5068.695878247169;5324.307839980933;5633.8591535211945;5772.105323674838;5062.797488100435;5179.974100129475;5601.6358936668985;5608.971955140199;5622.522085622768;5100.183970564692;5301.098813201842;5517.613767036269;5687.60186786921;5706.2367009321715;4596.448426188745;5386.192071189196;5400.540954018952;5523.420040895809;5596.300462442195 19:39:54 INFO - PROCESS | 1638 | |5;yui.html;775.5346791924842;783.7256960063978;804.1355542791497;913.1690161952622;923.0815338737955;13199.93400033001;17391.652166956686;17544.0350780707;17934.64130717385;18355;13565.660858478519;16248.75626865598;16629.584260393465;16817.327306907708;16818.32726690934;988.5996171550515;1010.7978404319128;1011.3881101933334;1012.4886932099316;1014.0467960117503;968.8449848024318;997.4763249294106;1022.6829682798357;1026.3431403901473;1031.3966329697137;1061.9681409557725;1074.4198133008167;1077.849101125843;1078.7033565769436;1080.1358912869673;1073.6349641121978;1075.93544387337;1077.0629552289479;1077.709018564987;1079.8974097460728;794.972175973844;797.8204903896577;798.4450806689354;800.4276941986508;801.1147681811573;14728.852711472855;14955.102693838404;14955.626109347353;16117.677646447122;16168.272427740661;11991.400429978466;14991.925040374837;15018.699626007528;15209.771853422208;15473.613159670986;10691.893081069245;12003.279803211835;12399.318037507934;12506.81239781404;12536.623901282976;3764.8682296119505;3859.826307816155;3873.225354928997;3940.980295098535;4042.514898212204;117274.41362793217;127201;129783;131100;132650.3367483166;11096.667099986851;11129.332240065622;11539.134564907665;11807.645770626896;12200.75598488043;23640.29079127629;24454.51090978206;24536;24786.50426991486;24878;8162.224588664068;8173.427860049858;8202.26179643823;8267.421280510307;8343.997440614208;3885.378339465672;4513;4543.5002149763495;4710.670253082251;4751.786169622375;3422.19578399076;3478.060923550627;3484.007057988461;3501.649835016529;3517.1558825881602;562.4235158962097;591.3997292747864;593.6378808926552;602.5059451249933;613.3590398034065;687.9105716256854;713.9607321597362;724.8296650287178;727.5271073802071;758.1167939350595;10370.740731481774;10698.572057117784;10978.231523793258;11035.779284414266;11127.944360278309;696.8362434827811;710.1903829634222;739.474972769329;740.1710084705164;747.7083937264471;4837.733924634109;5041.621878359138;5113.565346945551;5151.330327057459;5174.896502069938;92993;105848.47075764726;107465.92534074716;108800;109802;83381;88811;94819;95562.08875822445;97708;58437.4156258432;63111;75351.62324188344;81719.59140204261;84159.5792021036;10304.55736196948;10325.483725813829;11268.436578170895;11547.191696581158;11563.537458501902;49893.25160122528;51255;51633.483665162865;52093.739531302104;53318;64353;65974.67012664906;67027.66486167538;67543;67692;10818.51316690735;13416.262105584286;13581.524646637321;13702.246376449391;13851.37668804886;12924.676883077998;15237.3905043797;15484.767728484307;15627.687446251239;15854.9207253963;14298.714025719635;14299.785503217669;14527.491537796126;15041.924790376415;15130.470433534774;14145.929270353583;14244.572662820132;14285.857141428869;14313.856861431668;14393.64015899611;12312.199707019015;13529.932350338186;14247.501337453139;14332;14529.273536323353;10273.486325683836;10784.838227426439;10884;11157.10743140563;11290.379029153475;11229.831552526883;11279.928172386339;11659.650210493699;11666.475008624462;11681.824772628248 19:39:54 INFO - PROCESS | 1638 | __end_tp_report 19:39:54 INFO - PROCESS | 1638 | __start_cc_report 19:39:54 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,403 19:39:54 INFO - PROCESS | 1638 | __end_cc_report 19:39:54 INFO - PROCESS | 1638 | __startTimestamp1492655994487__endTimestamp 19:39:54 INFO - PROCESS | 1638 | 19:39:54 INFO - PROCESS | 1638 | ------- Summary: start ------- 19:39:54 INFO - PROCESS | 1638 | Number of tests: 6 19:39:54 INFO - PROCESS | 1638 | 19:39:54 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:6242.02 Median:6463.48 stddev:722.95 (11.2%) stddev-sans-first:696.79 19:39:54 INFO - PROCESS | 1638 | Values: 3685.2 3688.6 3699.3 3739.3 3739.4 5209.9 5661.9 5732.8 6277.4 6288.9 5185.9 6260.9 6291.4 6326.0 6344.8 5433.0 5714.2 5747.6 5750.1 5828.5 5799.4 5813.4 5824.7 5830.8 5847.2 5559.6 5566.8 5834.4 5843.3 5899.2 5707.5 5737.9 5745.6 5779.3 5784.5 5597.0 5726.5 5728.5 5737.1 5786.0 6110.2 6218.6 6286.0 6388.8 6421.9 6544.5 6548.0 6636.6 6643.5 6703.3 6910.3 6912.4 6922.9 6926.7 6937.4 6364.5 6369.7 6415.0 6421.8 6427.9 6671.7 6729.3 6743.9 6920.4 7021.1 6689.8 6721.6 6737.3 6745.6 6767.4 6827.1 6848.5 6867.3 6884.8 6892.2 5475.0 6429.8 6749.8 6757.9 6801.7 6639.7 6678.0 6685.2 6691.5 6713.0 5417.2 5429.2 5444.2 5444.8 5476.4 3775.3 4708.6 4811.3 4844.5 4888.5 6249.0 6289.7 6300.1 6333.2 6348.4 6900.1 6911.6 6922.4 6922.9 6937.7 6237.7 6296.8 6305.0 6322.2 6405.8 5150.5 6095.7 6100.8 6108.3 6144.2 7070.0 7070.8 7114.8 7121.8 7122.3 6528.1 6586.8 6721.1 6822.9 6905.0 5801.0 7048.4 7098.8 7103.3 7114.5 6738.4 6756.2 6759.7 6763.1 6768.8 6494.6 6539.0 6682.7 6689.4 6880.4 6464.7 6482.2 6509.8 6515.4 6536.3 6583.3 6598.1 6598.3 6606.6 6609.2 6217.2 6344.2 6377.1 6463.5 6464.7 6467.3 6525.8 6551.4 6580.5 6603.2 5422.2 6498.8 6507.5 6508.4 6519.9 19:39:54 INFO - PROCESS | 1638 | 19:39:54 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:48717.90 Median:29464.71 stddev:92654.00 (314.5%) stddev-sans-first:92844.06 19:39:54 INFO - PROCESS | 1638 | Values: 796.1 827.6 852.0 997.5 1001.8 30651.7 32693.2 36181.5 36918.4 38233.0 38776.0 38948.6 39056.8 39083.8 39107.0 8167.3 8329.1 11067.9 11353.2 11484.2 9492.9 11347.0 11400.5 11410.0 11428.1 11406.5 11413.2 11435.0 11436.6 11457.4 11349.3 11362.7 11372.4 11382.1 11390.1 11012.8 11022.0 11083.9 11095.8 11109.3 34174.1 34199.8 34320.3 34401.5 34435.3 3987.9 3999.8 4018.8 4042.5 4065.3 22767.8 25556.6 26105.5 27360.0 27386.0 2785.4 2973.7 3204.3 3232.8 3244.7 354338.0 356504.0 356710.0 357903.8 358969.0 44469.1 44924.8 45047.6 45057.9 45059.8 45779.5 46023.0 46193.8 46245.0 46365.1 14338.2 14540.1 14776.5 14789.6 14822.8 12537.7 12648.7 12653.9 12660.2 12663.2 11757.7 11977.2 11985.9 12018.2 12095.8 5661.6 5707.1 5733.1 5743.7 5757.7 1015.4 1099.4 1148.3 1165.5 1206.6 26887.0 27052.2 27242.6 27312.2 27412.3 955.5 1282.5 1313.7 1338.0 1356.5 10709.5 13010.5 14021.9 14216.9 14277.6 350340.0 352261.0 352919.0 352994.0 353426.0 38169.4 38248.6 45308.0 45439.0 45662.3 1459.9 1486.2 1487.3 1494.3 1500.1 26201.2 26306.6 26738.0 27092.9 27258.3 38843.4 38997.8 39052.6 39077.6 39125.0 343503.0 345591.0 346073.0 346490.0 348252.0 28519.4 28593.4 28628.6 28844.0 28949.7 36270.1 36443.6 36479.6 40233.0 41438.4 24616.8 28302.2 29214.6 29633.5 29896.4 28962.7 29410.6 29518.9 29526.3 29636.9 34819.8 34838.3 35103.0 35135.6 35200.8 27457.2 28082.4 29378.3 29668.3 30242.5 24140.5 24191.6 24243.9 24551.5 24571.8 19:39:54 INFO - PROCESS | 1638 | 19:39:54 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:46727.49 Median:22410.28 stddev:137776.81 (614.8%) stddev-sans-first:138119.38 19:39:54 INFO - PROCESS | 1638 | Values: 391.9 428.4 428.4 437.9 439.0 19872.9 20855.5 22208.6 22277.2 22424.9 18767.5 21413.7 22314.1 23012.4 23206.8 6605.0 6939.7 6957.5 6986.3 6988.2 5142.5 6644.2 6816.6 6820.3 6977.7 6542.2 6677.0 6825.9 6827.5 6873.8 6747.9 6753.9 6777.9 6799.6 6817.8 6386.1 6459.4 6537.9 6539.3 6548.0 26259.2 27057.9 27183.7 27199.3 27509.0 2995.4 3020.9 3083.6 3094.2 3114.0 16994.5 17054.4 17495.9 17497.9 18013.9 2141.5 2180.1 2208.3 2229.4 2240.3 155739.0 161275.0 164903.2 167074.2 169051.0 17114.8 21479.7 21844.0 21938.9 22129.3 33773.7 33835.7 34362.3 34445.8 34457.8 9097.8 9515.4 10298.1 11229.4 11271.5 7647.7 9360.8 9390.8 9457.3 9559.0 8123.3 9806.0 10070.2 10112.9 10142.6 3494.5 3502.2 4083.9 4197.3 4200.6 912.5 930.1 932.8 934.4 975.4 21457.5 22403.8 22416.8 22467.9 22490.7 897.6 950.2 958.6 965.2 988.9 11179.5 11432.4 11645.8 11668.0 11702.4 812520.0 814530.0 818134.0 836635.0 845177.0 145023.3 173175.1 177276.0 178245.0 178931.0 1262.2 1307.0 1342.1 1370.2 1371.5 16684.7 21106.8 21349.9 21576.0 21666.9 51288.5 65881.7 66903.0 70405.0 72242.6 98822.5 99640.0 100771.0 102346.0 102514.0 11408.8 11828.2 11926.5 12047.8 12189.9 11527.5 13146.9 13486.2 13934.9 14399.6 11450.5 11695.9 11956.5 12083.2 12196.8 9439.3 11461.9 11478.0 11486.4 11633.1 12036.2 12087.3 12226.3 12229.3 12320.4 12268.5 12291.1 12304.3 12602.6 12659.9 9481.1 11891.5 11918.2 11967.6 12047.5 19:39:54 INFO - PROCESS | 1638 | 19:39:54 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:6963.89 Median:2514.68 stddev:4348.39 (172.9%) stddev-sans-first:4342.07 19:39:54 INFO - PROCESS | 1638 | Values: 1623.1 1671.4 1672.5 1687.2 1703.0 9956.1 10212.5 11284.0 12026.9 12057.7 9571.6 11234.3 11605.5 11613.0 11632.5 2515.3 2528.7 2544.3 2545.8 2548.5 2479.1 2513.5 2514.1 2532.6 2534.2 2488.1 2492.5 2493.8 2509.0 2524.5 2455.8 2463.0 2467.6 2469.2 2476.3 2432.4 2449.2 2450.1 2461.5 2463.9 8647.6 10945.9 11519.4 11592.1 11798.6 5988.4 6057.1 6144.5 6152.5 6153.8 3178.8 3710.2 3730.6 3792.5 3906.6 1239.6 1249.7 1292.2 1292.8 1305.7 16247.3 16411.2 16441.2 16473.0 16478.0 4770.8 4909.3 4960.6 4970.7 4972.7 11878.6 11940.5 12100.2 12120.5 12130.9 5399.7 5697.7 6008.6 6017.8 6024.3 5253.0 5595.8 5602.8 5625.9 5626.5 3484.5 4023.4 4125.7 4151.2 4176.5 1079.8 1083.6 1083.9 1096.5 1097.3 977.3 988.1 1001.3 1010.2 1022.5 5343.7 6716.2 6872.0 6946.7 6959.5 911.5 1030.8 1050.4 1062.8 1094.9 4347.6 4461.9 4529.2 4625.1 4667.4 13967.2 14680.9 14689.1 14709.3 14727.4 13638.2 14088.7 14361.7 14391.3 14391.5 10349.5 10545.6 10577.7 10598.7 10622.4 5863.8 6720.5 6841.8 6985.7 6988.2 11711.8 11865.3 11882.8 11893.0 11938.3 11787.3 11876.8 12005.7 12064.6 12143.4 9420.4 9687.8 9953.7 9970.4 9980.0 10795.5 10839.6 10917.7 10934.8 10942.1 9167.3 9268.0 9315.6 9334.5 9439.0 9081.2 9118.2 9119.5 9150.2 9205.3 6872.2 8433.3 8545.7 8550.8 8558.1 6115.4 6185.3 6239.5 6282.2 6363.2 5754.3 5982.8 6002.2 6226.0 6559.6 19:39:54 INFO - PROCESS | 1638 | 19:39:54 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4724.60 Median:5073.75 stddev:1302.91 (25.7%) stddev-sans-first:1264.65 19:39:54 INFO - PROCESS | 1638 | Values: 357.0 391.5 395.5 405.1 407.2 4284.3 4740.6 4823.4 5281.0 5288.4 4773.3 4929.0 5336.4 5340.4 5351.5 3631.4 4285.3 4415.8 4435.2 4458.9 4451.8 4452.7 4468.9 4470.6 4482.8 3756.8 3918.6 4425.2 4434.9 4488.1 4139.9 4176.5 4378.8 4409.5 4474.3 3616.0 4055.0 4065.5 4082.7 4117.6 4413.9 4886.8 5112.9 5255.0 5288.6 4359.7 4634.6 4766.0 4888.4 5141.6 4637.7 5020.4 5119.0 5577.5 5620.7 4054.7 4114.7 4572.8 4585.8 4591.7 5309.4 5741.8 6027.8 6045.7 6084.8 4130.5 4574.9 4686.7 4694.3 4702.2 4151.5 4215.6 4434.6 4454.7 4722.7 4184.6 4976.3 5019.2 5113.5 5171.5 5688.1 5694.7 5727.6 5737.9 5741.5 1557.0 1769.6 1799.4 1803.0 1806.7 1060.2 1255.7 1257.0 1351.6 1468.6 4496.1 5078.8 5238.4 5249.7 5262.4 5103.3 5108.8 5460.8 5810.5 5915.9 4477.6 4630.6 4698.2 4796.0 5090.6 2563.7 3017.0 3052.0 3052.8 3068.5 5311.9 5717.7 5894.3 6085.6 6132.6 5778.3 6004.6 6041.6 6045.9 6068.2 5228.8 5379.0 5828.9 5989.0 6094.6 5039.0 5489.8 5888.9 5890.4 5896.2 5437.8 5792.4 5799.3 5799.4 5803.4 5751.2 5887.7 6033.8 6085.8 6092.5 4323.6 4451.0 4563.4 5041.6 5123.5 5365.3 5638.0 5922.8 5935.6 5942.9 5013.9 5736.2 5742.9 5743.9 5762.7 4970.3 5068.7 5324.3 5633.9 5772.1 5062.8 5180.0 5601.6 5609.0 5622.5 5100.2 5301.1 5517.6 5687.6 5706.2 4596.4 5386.2 5400.5 5523.4 5596.3 19:39:54 INFO - PROCESS | 1638 | 19:39:54 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:21507.48 Median:15986.30 stddev:31357.65 (196.2%) stddev-sans-first:31406.98 19:39:54 INFO - PROCESS | 1638 | Values: 775.5 783.7 804.1 913.2 923.1 13199.9 17391.7 17544.0 17934.6 18355.0 13565.7 16248.8 16629.6 16817.3 16818.3 988.6 1010.8 1011.4 1012.5 1014.0 968.8 997.5 1022.7 1026.3 1031.4 1062.0 1074.4 1077.8 1078.7 1080.1 1073.6 1075.9 1077.1 1077.7 1079.9 795.0 797.8 798.4 800.4 801.1 14728.9 14955.1 14955.6 16117.7 16168.3 11991.4 14991.9 15018.7 15209.8 15473.6 10691.9 12003.3 12399.3 12506.8 12536.6 3764.9 3859.8 3873.2 3941.0 4042.5 117274.4 127201.0 129783.0 131100.0 132650.3 11096.7 11129.3 11539.1 11807.6 12200.8 23640.3 24454.5 24536.0 24786.5 24878.0 8162.2 8173.4 8202.3 8267.4 8344.0 3885.4 4513.0 4543.5 4710.7 4751.8 3422.2 3478.1 3484.0 3501.6 3517.2 562.4 591.4 593.6 602.5 613.4 687.9 714.0 724.8 727.5 758.1 10370.7 10698.6 10978.2 11035.8 11127.9 696.8 710.2 739.5 740.2 747.7 4837.7 5041.6 5113.6 5151.3 5174.9 92993.0 105848.5 107465.9 108800.0 109802.0 83381.0 88811.0 94819.0 95562.1 97708.0 58437.4 63111.0 75351.6 81719.6 84159.6 10304.6 10325.5 11268.4 11547.2 11563.5 49893.3 51255.0 51633.5 52093.7 53318.0 64353.0 65974.7 67027.7 67543.0 67692.0 10818.5 13416.3 13581.5 13702.2 13851.4 12924.7 15237.4 15484.8 15627.7 15854.9 14298.7 14299.8 14527.5 15041.9 15130.5 14145.9 14244.6 14285.9 14313.9 14393.6 12312.2 13529.9 14247.5 14332.0 14529.3 10273.5 10784.8 10884.0 11157.1 11290.4 11229.8 11279.9 11659.7 11666.5 11681.8 19:39:54 INFO - PROCESS | 1638 | -------- Summary: end -------- 19:39:54 INFO - PROCESS | 1638 | 19:39:55 INFO - TEST-INFO | 1638: exit 0 19:39:55 INFO - TEST-OK | dromaeo_css | took 1115155ms 19:39:55 INFO - TEST-START | kraken 19:39:55 INFO - operating with platform_type : mac_ 19:39:55 INFO - Initialising browser for kraken test... 19:39:55 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpBjJkQn/profile http://localhost:49242/getInfo.html) 19:39:57 INFO - PROCESS | 1650 | 2017-04-19 19:39:57.538 plugin-container[1652:10091] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x863f, name = 'com.apple.tsm.portname' 19:39:57 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:39:57 INFO - PROCESS | 1650 | 2017-04-19 19:39:57.539 plugin-container[1652:10091] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8553, name = 'com.apple.CFPasteboardClient' 19:39:57 INFO - PROCESS | 1650 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:39:57 INFO - PROCESS | 1650 | 2017-04-19 19:39:57.539 plugin-container[1652:10091] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:39:57 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 19:39:57 INFO - PROCESS | 1650 | colorDepth:24 19:39:57 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 19:39:57 INFO - PROCESS | 1650 | __metrics 19:39:57 ERROR - PROCESS | 1650 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3360: TypeError: this.tabs is undefined 19:39:58 INFO - TEST-INFO | 1650: exit 0 19:39:58 INFO - Browser initialized. 19:39:58 INFO - Running cycle 1/1 for kraken test... 19:39:58 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/T/tmpBjJkQn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:40:00 INFO - PROCESS | 1653 | 2017-04-19 19:40:00.563 plugin-container[1654:10214] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4537, name = 'com.apple.tsm.portname' 19:40:00 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:40:00 INFO - PROCESS | 1653 | 2017-04-19 19:40:00.564 plugin-container[1654:10214] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8b0b, name = 'com.apple.CFPasteboardClient' 19:40:00 INFO - PROCESS | 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 19:40:00 INFO - PROCESS | 1653 | 2017-04-19 19:40:00.564 plugin-container[1654:10214] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 19:40:10 INFO - PROCESS | 1653 | RSS: Main: 174514176 19:40:10 INFO - PROCESS | 1653 | 19:40:13 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 19:40:14 INFO - PROCESS | 1653 | RSS: Main: 187617280 19:40:14 INFO - PROCESS | 1653 | 19:40:16 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 19:40:17 INFO - PROCESS | 1653 | RSS: Main: 195543040 19:40:17 INFO - PROCESS | 1653 | 19:40:20 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 19:40:21 INFO - PROCESS | 1653 | RSS: Main: 199143424 19:40:21 INFO - PROCESS | 1653 | 19:40:22 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 19:40:23 INFO - PROCESS | 1653 | RSS: Main: 199507968 19:40:23 INFO - PROCESS | 1653 | 19:40:25 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:40:26 INFO - PROCESS | 1653 | RSS: Main: 200929280 19:40:26 INFO - PROCESS | 1653 | 19:40:29 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 19:40:29 INFO - PROCESS | 1653 | RSS: Main: 205172736 19:40:29 INFO - PROCESS | 1653 | 19:40:32 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 19:40:33 INFO - PROCESS | 1653 | RSS: Main: 204922880 19:40:33 INFO - PROCESS | 1653 | 19:40:36 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 19:40:37 INFO - PROCESS | 1653 | RSS: Main: 204541952 19:40:37 INFO - PROCESS | 1653 | 19:40:38 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:40:39 INFO - PROCESS | 1653 | RSS: Main: 204103680 19:40:39 INFO - PROCESS | 1653 | 19:40:41 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:40:41 INFO - PROCESS | 1653 | RSS: Main: 204161024 19:40:41 INFO - PROCESS | 1653 | 19:40:43 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:40:44 INFO - PROCESS | 1653 | RSS: Main: 204099584 19:40:44 INFO - PROCESS | 1653 | 19:40:47 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:40:48 INFO - PROCESS | 1653 | RSS: Main: 204177408 19:40:48 INFO - PROCESS | 1653 | 19:40:51 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:40:51 INFO - PROCESS | 1653 | RSS: Main: 204554240 19:40:51 INFO - PROCESS | 1653 | 19:40:53 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 19:40:53 INFO - PROCESS | 1653 | RSS: Main: 206540800 19:40:53 INFO - PROCESS | 1653 | 19:40:53 INFO - PROCESS | 1653 | __start_tp_report 19:40:53 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 19:40:53 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 19:40:53 INFO - PROCESS | 1653 | |i|pagename|runs| 19:40:53 INFO - PROCESS | 1653 | |0;ai-astar;106;121;120;120;132;118;119;116;118;118 19:40:53 INFO - PROCESS | 1653 | |1;audio-beat-detection;134;109;109;141;109;116;112;110;124;114 19:40:53 INFO - PROCESS | 1653 | |2;audio-dft;195;195;223;263;195;199;192;192;193;192 19:40:53 INFO - PROCESS | 1653 | |3;audio-fft;75;59;61;88;59;63;63;61;72;60 19:40:53 INFO - PROCESS | 1653 | |4;audio-oscillator;86;70;85;72;72;70;84;85;66;77 19:40:53 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;95;90;89;89;90;85;90;85;135;119 19:40:53 INFO - PROCESS | 1653 | |6;imaging-darkroom;96;96;97;96;105;111;97;104;116;135 19:40:53 INFO - PROCESS | 1653 | |7;imaging-desaturate;90;111;146;140;91;89;91;90;89;84 19:40:53 INFO - PROCESS | 1653 | |8;json-parse-financial;65;64;66;67;68;67;81;99;104;80 19:40:53 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;58;64;65;64;63;55;55;55;56;59 19:40:53 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;82;85;86;84;92;83;84;83;86;86 19:40:53 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;153;166;143;133;138;134;156;145;190;175 19:40:53 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;165;165;170;163;166;165;165;161;170;172 19:40:53 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;63;66;62;63;65;66;65;64;63;64 19:40:53 INFO - PROCESS | 1653 | __end_tp_report 19:40:53 INFO - PROCESS | 1653 | __start_cc_report 19:40:53 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,976 19:40:53 INFO - PROCESS | 1653 | __end_cc_report 19:40:53 INFO - PROCESS | 1653 | __startTimestamp1492656053638__endTimestamp 19:40:53 INFO - PROCESS | 1653 | 19:40:53 INFO - PROCESS | 1653 | ------- Summary: start ------- 19:40:53 INFO - PROCESS | 1653 | Number of tests: 14 19:40:53 INFO - PROCESS | 1653 | 19:40:53 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:118.80 Median:119.50 stddev:6.29 (5.3%) stddev-sans-first:4.66 19:40:53 INFO - PROCESS | 1653 | Values: 106.0 121.0 120.0 120.0 132.0 118.0 119.0 116.0 118.0 118.0 19:40:53 INFO - PROCESS | 1653 | 19:40:53 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:117.80 Median:115.00 stddev:11.47 (10.0%) stddev-sans-first:10.56 19:40:53 INFO - PROCESS | 1653 | Values: 134.0 109.0 109.0 141.0 109.0 116.0 112.0 110.0 124.0 114.0 19:40:53 INFO - PROCESS | 1653 | 19:40:53 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:203.90 Median:195.00 stddev:22.76 (11.7%) stddev-sans-first:23.91 19:40:53 INFO - PROCESS | 1653 | Values: 195.0 195.0 223.0 263.0 195.0 199.0 192.0 192.0 193.0 192.0 19:40:53 INFO - PROCESS | 1653 | 19:40:53 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:66.10 Median:63.00 stddev:9.45 (15.0%) stddev-sans-first:9.45 19:40:53 INFO - PROCESS | 1653 | Values: 75.0 59.0 61.0 88.0 59.0 63.0 63.0 61.0 72.0 60.0 19:40:53 INFO - PROCESS | 1653 | 19:40:53 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:76.70 Median:80.50 stddev:7.65 (9.5%) stddev-sans-first:7.33 19:40:53 INFO - PROCESS | 1653 | Values: 86.0 70.0 85.0 72.0 72.0 70.0 84.0 85.0 66.0 77.0 19:40:53 INFO - PROCESS | 1653 | 19:40:53 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:96.70 Median:89.50 stddev:16.65 (18.6%) stddev-sans-first:17.65 19:40:53 INFO - PROCESS | 1653 | Values: 95.0 90.0 89.0 89.0 90.0 85.0 90.0 85.0 135.0 119.0 19:40:53 INFO - PROCESS | 1653 | 19:40:53 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:105.30 Median:96.00 stddev:12.60 (13.1%) stddev-sans-first:12.90 19:40:53 INFO - PROCESS | 1653 | Values: 96.0 96.0 97.0 96.0 105.0 111.0 97.0 104.0 116.0 135.0 19:40:53 INFO - PROCESS | 1653 | 19:40:53 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:102.10 Median:89.50 stddev:22.74 (25.4%) stddev-sans-first:23.69 19:40:53 INFO - PROCESS | 1653 | Values: 90.0 111.0 146.0 140.0 91.0 89.0 91.0 90.0 89.0 84.0 19:40:53 INFO - PROCESS | 1653 | 19:40:53 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:76.10 Median:67.50 stddev:14.70 (21.8%) stddev-sans-first:15.03 19:40:53 INFO - PROCESS | 1653 | Values: 65.0 64.0 66.0 67.0 68.0 67.0 81.0 99.0 104.0 80.0 19:40:53 INFO - PROCESS | 1653 | 19:40:53 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:61.00 stddev:4.20 (6.9%) stddev-sans-first:4.42 19:40:53 INFO - PROCESS | 1653 | Values: 58.0 64.0 65.0 64.0 63.0 55.0 55.0 55.0 56.0 59.0 19:40:53 INFO - PROCESS | 1653 | 19:40:53 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:85.10 Median:85.50 stddev:2.81 (3.3%) stddev-sans-first:2.74 19:40:53 INFO - PROCESS | 1653 | Values: 82.0 85.0 86.0 84.0 92.0 83.0 84.0 83.0 86.0 86.0 19:40:53 INFO - PROCESS | 1653 | 19:40:53 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:153.30 Median:154.50 stddev:18.80 (12.2%) stddev-sans-first:19.94 19:40:53 INFO - PROCESS | 1653 | Values: 153.0 166.0 143.0 133.0 138.0 134.0 156.0 145.0 190.0 175.0 19:40:53 INFO - PROCESS | 1653 | 19:40:53 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:166.20 Median:165.50 stddev:3.43 (2.1%) stddev-sans-first:3.61 19:40:53 INFO - PROCESS | 1653 | Values: 165.0 165.0 170.0 163.0 166.0 165.0 165.0 161.0 170.0 172.0 19:40:53 INFO - PROCESS | 1653 | 19:40:53 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.10 Median:64.50 stddev:1.37 (2.1%) stddev-sans-first:1.39 19:40:53 INFO - PROCESS | 1653 | Values: 63.0 66.0 62.0 63.0 65.0 66.0 65.0 64.0 63.0 64.0 19:40:53 INFO - PROCESS | 1653 | -------- Summary: end -------- 19:40:53 INFO - PROCESS | 1653 | 19:40:54 INFO - TEST-INFO | 1653: exit 0 19:40:54 INFO - TEST-OK | kraken | took 59537ms 19:40:54 INFO - SUITE-END | took 1174s 19:40:54 INFO - Completed test suite (00:19:34) 19:40:54 INFO - javascript benchmark 19:40:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7939.706597904817, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3685.2445248724016, 3688.557373115225, 3699.278640665068, 3739.326921154193, 3739.3643080676284, 5209.947900520993, 5661.943380566193, 5732.76745499718, 6277.403646653572, 6288.8742225155465, 5185.896282074356, 6260.906086408708, 6291.4337709606125, 6325.968370158154, 6344.777932772354, 5432.972835135829, 5714.228579141804, 5747.59766816323, 5750.137479378106, 5828.47543721065, 5799.420057994209, 5813.447722466359, 5824.708764561776, 5830.795922142725, 5847.239858818348, 5559.555235581144, 5566.805161819337, 5834.445727655866, 5843.2695913010875, 5899.203607512974, 5707.457791509821, 5737.913931291034, 5745.6265342753, 5779.2775903012125, 5784.479396854261, 5597.0, 5726.484616384545, 5728.455796699307, 5737.110747834051, 5785.971070144665, 6110.236220472441, 6218.626882387026, 6285.96857015712, 6388.808335749888, 6421.903671444932, 6544.541882068257, 6547.985062315349, 6636.601803891782, 6643.534952553323, 6703.262641109474, 6910.3089691031, 6912.412444942186, 6922.89233722602, 6926.688299026556, 6937.375636192767, 6364.49084073273, 6369.71336289868, 6415.0, 6421.839454013687, 6427.903581446282, 6671.666416679147, 6729.293424190488, 6743.932560674429, 6920.377166054978, 7021.087258656444, 6689.832754181184, 6721.596704197764, 6737.292584278678, 6745.6289904054765, 6767.35710107539, 6827.112475378269, 6848.486363522756, 6867.313268673092, 6884.793456196322, 6892.1729392472225, 5475.0418676731415, 6429.839254018687, 6749.797506074826, 6757.93242067573, 6801.693923773442, 6639.70121344531, 6678.0, 6685.197776266879, 6691.464682825363, 6712.95949127886, 5417.18742188667, 5429.212764149176, 5444.210589464585, 5444.8094316698725, 5476.424975377528, 3775.2653323767568, 4708.599769019604, 4811.326414302001, 4844.491328410537, 4888.535589119028, 6249.031400132987, 6289.7169627366875, 6300.117983482316, 6333.1766870306565, 6348.365163483615, 6900.102986611709, 6911.5853048817235, 6922.411595014481, 6922.8615427692175, 6937.68780404883, 6237.719302631393, 6296.811095667137, 6305.0, 6322.241331040304, 6405.839854003687, 5150.48495150482, 6095.664738439428, 6100.84084024034, 6108.267007959073, 6144.2319710036245, 7069.9646501767165, 7070.787876363717, 7114.750983715752, 7121.786346409616, 7122.252163522963, 6528.086067950396, 6586.793424202946, 6721.059051732859, 6822.897656535255, 6904.998775177672, 5800.970995144998, 7048.436125109876, 7098.822529436806, 7103.2541583133025, 7114.501984861217, 6738.35985581369, 6756.223034351113, 6759.662016899234, 6763.086983257197, 6768.830779230559, 6494.577852439576, 6539.0, 6682.732690692318, 6689.431398331197, 6880.380765731108, 6464.676766161579, 6482.189726284215, 6509.804705858832, 6515.381038801306, 6536.3136870629805, 6583.275839657538, 6598.10925525048, 6598.3401659833635, 6606.570572912745, 6609.173853268341, 6217.191765070512, 6344.238691357066, 6377.139086223486, 6463.482921366185, 6464.709088090953, 6467.288598254282, 6525.836854078686, 6551.410373066256, 6580.473562115115, 6603.240627327918, 5422.240886276003, 6498.805035848932, 6507.544471886922, 6508.446782023581, 6519.869602607826], "value": 6197.040798161207, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [796.0805269913249, 827.5696637748371, 851.9829603407932, 997.4912794474816, 1001.8296889528775, 30651.693483065163, 32693.18267043322, 36181.45727814081, 36918.44622330661, 38233.0, 38776.0, 38948.610513894855, 39056.80471597638, 39083.82748517549, 39107.0, 8167.305779008791, 8329.125441828612, 11067.944660276688, 11353.205275630668, 11484.196106272564, 9492.857607135898, 11347.0, 11400.543978240901, 11410.0, 11428.142889283337, 11406.5437382505, 11413.201075924688, 11435.0, 11436.599719009837, 11457.427128643534, 11349.319040857534, 11362.659120226406, 11372.37451940143, 11382.146339024606, 11390.14573906952, 11012.834807477895, 11022.0, 11083.944580277128, 11095.778084438267, 11109.333439993627, 34174.14564635879, 34199.829000854836, 34320.31359372799, 34401.483977740354, 34435.31129377423, 3987.900302492432, 3999.7814869810927, 4018.8191531380867, 4042.454268673721, 4065.26825171469, 22767.77232227673, 25556.616650750253, 26105.477890442275, 27360.0, 27386.041488547806, 2785.428987057648, 2973.732364087221, 3204.327091310804, 3232.7575431842706, 3244.659310772382, 354338.0, 356504.0, 356710.0, 357903.8419231627, 358969.0, 44469.11061778811, 44924.77537612291, 45047.64857054294, 45057.873553160774, 45059.77470112694, 45779.542204578196, 46023.0, 46193.76903115463, 46245.0, 46365.072698546515, 14338.211398373189, 14540.054896431699, 14776.482823101354, 14789.556313310402, 14822.777658335133, 12537.74924501505, 12648.74702505963, 12653.87346126527, 12660.240385576895, 12663.240205587694, 11757.706057348634, 11977.161598688008, 11985.940070299766, 12018.218815777122, 12095.818562721566, 5661.631993920382, 5707.086866101404, 5733.140028995684, 5743.712814359265, 5757.683327417032, 1015.3856916565519, 1099.433791597328, 1148.3454430974264, 1165.454726566381, 1206.638008597435, 26887.0, 27052.238805970337, 27242.5913611296, 27312.180634580993, 27412.314692132855, 955.5174636808506, 1282.5254655777421, 1313.7241179352252, 1337.9866201338057, 1356.4777560639225, 10709.518071686793, 13010.544630937871, 14021.929890350688, 14216.928915355356, 14277.571672849832, 350340.0, 352261.0, 352919.0, 352994.0, 353426.0, 38169.42745858814, 38248.61751382451, 45308.0, 45439.0, 45662.315065274044, 1459.9489017884323, 1486.2123074770388, 1487.3084015932643, 1494.3275526013338, 1500.0774523668083, 26201.21396358112, 26306.60540091862, 26738.0, 27092.864535677196, 27258.318542036606, 38843.41734874035, 38997.805010974764, 39052.6094739049, 39077.63228286996, 39125.02187445223, 343503.0, 345591.0, 346073.0, 346490.0, 348252.0, 28519.42961140807, 28593.428131436838, 28628.570571441862, 28844.0, 28949.7105028947, 36270.09324766902, 36443.63556364508, 36479.635203647624, 40233.0, 41438.378424323055, 24616.753832462164, 28302.150935471967, 29214.561781573717, 29633.478556296937, 29896.402071958004, 28962.710372896003, 29410.55884161782, 29518.852405737834, 29526.261843453227, 29636.85181574078, 34819.82590087033, 34838.30323393569, 35103.0, 35135.64864351426, 35200.82399587986, 27457.15876108363, 28082.438351233268, 29378.265543361587, 29668.276202293524, 30242.54636180415, 24140.51718965646, 24191.63712544278, 24243.878780605985, 24551.50896982086, 24571.754282456946], "value": 18089.729353720668, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.89614752090694, 428.3510481620348, 428.36815696847134, 437.92052590364744, 438.9626881715054, 19872.9006354968, 20855.47861303468, 22208.55582888341, 22277.220297289598, 22424.8878755606, 18767.530811729714, 21413.67879481809, 22314.107435702554, 23012.424689382773, 23206.767932320672, 6604.966975165117, 6939.653017349112, 6957.5129740918155, 6986.266442023591, 6988.231294557595, 5142.485751424865, 6644.235912870009, 6816.591004539743, 6820.31796820319, 6977.6511174441075, 6542.247641521215, 6676.966615166917, 6825.931740682604, 6827.52207345486, 6873.759418420356, 6747.898781518281, 6753.8986915196065, 6777.8644427111185, 6799.558028728166, 6817.761378351734, 6386.13787138735, 6459.354064593503, 6537.901931470984, 6539.34606539347, 6548.017797330391, 26259.21222363332, 27057.864710676517, 27183.728162718515, 27199.320016999536, 27509.037183698474, 2995.3859458811107, 3020.9244768880735, 3083.645380781194, 3094.19550916761, 3113.9532907006414, 16994.490165294937, 17054.40309589171, 17495.912520437316, 17497.912510437367, 18013.909930450394, 2141.5074532857375, 2180.1061564758375, 2208.2602328220064, 2229.3869185973826, 2240.283109404991, 155739.0, 161275.0, 164903.175484123, 167074.16462917608, 169051.0, 17114.77507923987, 21479.67780483294, 21844.0, 21938.89030554837, 22129.336119916105, 33773.66226337754, 33835.66164338325, 34362.31275374479, 34445.82777086098, 34457.82771086128, 9097.772555686028, 9515.429074255568, 10298.124659404035, 11229.438528073728, 11271.54913803455, 7647.732329368446, 9360.812783744423, 9390.765230869283, 9457.33798634089, 9559.0, 8123.268905798506, 9805.950970245103, 10070.244731645156, 10112.949435252924, 10142.645007424704, 3494.4624365279196, 3502.2295095079044, 4083.91832163361, 4197.328427451593, 4200.642945349679, 912.4761648047776, 930.0978051290238, 932.7714709896119, 934.4066517761271, 975.3855071305032, 21457.46356341104, 22403.775962240496, 22416.775832241794, 22467.876606169626, 22490.66264006041, 897.6499165325529, 950.1828427552299, 958.5734348215117, 965.2490402353237, 988.906053924876, 11179.4969226385, 11432.428378581038, 11645.76708465843, 11668.0, 11702.414879256003, 812520.0, 814530.0, 818134.0, 836635.0, 845177.0, 145023.2748836249, 173175.1341243286, 177276.0, 178245.0, 178931.0, 1262.236347010064, 1306.9542566010143, 1342.053852034333, 1370.1915869636962, 1371.5405339211277, 16684.66630667404, 21106.788932111096, 21349.89325053365, 21576.029078691183, 21666.89166554157, 51288.54922228205, 65881.67059164673, 66903.0, 70405.0, 72242.63878680574, 98822.5058874701, 99640.0, 100771.0, 102346.0, 102514.0, 11408.82886756716, 11828.23116497425, 11926.463309151282, 12047.759044818878, 12189.939050305047, 11527.538898444303, 13146.868531314565, 13486.190828550318, 13934.860651393356, 14399.640008999859, 11450.541978320774, 11695.941520292685, 11956.46195921203, 12083.214591051554, 12196.75606487883, 9439.292053096182, 11461.942690286494, 11478.0, 11486.36824974601, 11633.069354451793, 12036.217645852992, 12087.274763514217, 12226.266424014588, 12229.3273869938, 12320.383980801103, 12268.509259629873, 12291.139620226855, 12304.26174429537, 12602.621921342374, 12659.87340126587, 9481.146696797321, 11891.464884080064, 11918.225315354473, 11967.64097077089, 12047.494063242095], "value": 12006.048539352376, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1623.1154021058521, 1671.4400675773616, 1672.4731709511502, 1687.156421789105, 1702.991485042575, 9956.103950644441, 10212.540435680394, 11284.0, 12026.939865300672, 12057.698557536056, 9571.569279382427, 11234.269772464784, 11605.535778568847, 11613.012893904008, 11632.534698612066, 2515.283144303869, 2528.734482879299, 2544.2748816587277, 2545.770880620744, 2548.4648223872914, 2479.070348619268, 2513.54756143894, 2514.069794176148, 2532.620106983958, 2534.2397280815776, 2488.0794106180647, 2492.4516606346574, 2493.775560199582, 2509.046562306321, 2524.507720994407, 2455.7667021633006, 2463.027104293812, 2467.592847180213, 2469.2098528470897, 2476.2818782553036, 2432.3675844280615, 2449.1672831237465, 2450.105711415338, 2461.4584791345874, 2463.9137630183036, 8647.610857511365, 10945.890541094646, 11519.36643484608, 11592.072634189244, 11798.587049453228, 5988.401159884021, 6057.121717351003, 6144.508439324888, 6152.477039451652, 6153.753849846001, 3178.7761711740914, 3710.18375957289, 3730.645588669099, 3792.544894612664, 3906.570277269498, 1239.5723475400973, 1249.650097972569, 1292.1988367212296, 1292.8383952006, 1305.673581604599, 16247.268872900748, 16411.1794410279, 16441.1779411029, 16473.0, 16478.0, 4770.761461926959, 4909.337239472697, 4960.627952903546, 4970.701757894538, 4972.651914366032, 11878.643640690792, 11940.462679179458, 12100.152989290842, 12120.515179392725, 12130.878691212974, 5399.65008747813, 5697.686627235459, 6008.639481631116, 6017.759289628366, 6024.307204671519, 5253.001929633358, 5595.832125036255, 5602.831915042555, 5625.915611265835, 5626.521745651666, 3484.4599087141532, 4023.396490526386, 4125.711200216017, 4151.232723941475, 4176.519700234451, 1079.794838980607, 1083.553456136067, 1083.9078678312273, 1096.4956120184645, 1097.308695521832, 977.3061126600052, 988.0860204311127, 1001.3140998416109, 1010.1716592394166, 1022.4632068164274, 5343.65266257692, 6716.194056713128, 6871.969204619247, 6946.687399067054, 6959.512834101665, 911.48956584313, 1030.7835354575623, 1050.4117694091333, 1062.8405739139037, 1094.9178811589163, 4347.586979236968, 4461.910761784746, 4529.162105010583, 4625.098105869323, 4667.439907211156, 13967.231802250973, 14680.92659536717, 14689.118652880861, 14709.338079786436, 14727.410903563738, 13638.249896255802, 14088.71822563543, 14361.712765744627, 14391.280435978158, 14391.496297629743, 10349.534270957825, 10545.57817687284, 10577.735556611146, 10598.682039538826, 10622.36265824053, 5863.824085277449, 6720.529562930744, 6841.760538381132, 6985.7205711772995, 6988.231294557493, 11711.76576468483, 11865.288082715064, 11882.76234475323, 11893.0, 11938.28370297785, 11787.292762434281, 11876.762464750484, 12005.699857503632, 12064.638060858188, 12143.392830358624, 9420.434773913586, 9687.806243875224, 9953.651622193189, 9970.40177589347, 9979.950100249453, 10795.514201861091, 10839.620613278812, 10917.727056823644, 10934.781304374028, 10942.124630029419, 9167.266618670357, 9267.953660231926, 9315.580798863932, 9334.486603236886, 9438.95280523593, 9081.228095611947, 9118.22495087925, 9119.452832830051, 9150.22223111043, 9205.263578913537, 6872.175338959357, 8433.28317093054, 8545.74362769118, 8550.760139779573, 8558.058613552379, 6115.4190351916495, 6185.319614842274, 6239.469645080219, 6282.1519094921605, 6363.172787537591, 5754.280714910637, 5982.833347497196, 6002.2197114376595, 6225.968870155621, 6559.639219842955], "value": 5336.0227727461715, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.964303569643, 391.49888143176724, 395.4680954116712, 405.0946135387409, 407.22017336800013, 4284.286285485799, 4740.573348398643, 4823.372961515007, 5280.993222575421, 5288.391834938983, 4773.284007398892, 4928.975355123228, 5336.439673834249, 5340.359156901168, 5351.50157955772, 3631.364511210541, 4285.2929266671035, 4415.8233670653135, 4435.246008178618, 4458.888527786815, 4451.777411129447, 4452.7328360298325, 4468.938776937808, 4470.575295346936, 4482.775861206943, 3756.812159392033, 3918.5689574146822, 4425.181341451842, 4434.851255608522, 4488.124815660947, 4139.855105071308, 4176.498820141572, 4378.846740364103, 4409.536998615147, 4474.306482495218, 3616.0236736081374, 4054.959450405517, 4065.532463766675, 4082.6529744971417, 4117.5676553962, 4413.933790993137, 4886.800939577169, 5112.923306150411, 5255.0, 5288.550473209782, 4359.651227901792, 4634.606058485033, 4765.950641224272, 4888.364512613373, 5141.614378921596, 4637.652176086807, 5020.447750747415, 5118.97440512795, 5577.549837042398, 5620.690862002588, 4054.6553542948886, 4114.7119701620895, 4572.817087316536, 4585.770711464414, 4591.655625828076, 5309.442508536626, 5741.827745167651, 6027.819165425044, 6045.72794224261, 6084.756609735561, 4130.483689538808, 4574.879154607076, 4686.742229177428, 4694.319323698045, 4702.224133018082, 4151.543330233671, 4215.629920275923, 4434.578715022068, 4454.732716037048, 4722.669413141116, 4184.560621134798, 4976.253561965734, 5019.171836646985, 5113.463086375951, 5171.534561889448, 5688.146777983336, 5694.715264236772, 5727.570432217517, 5737.942620573825, 5741.5119714824705, 1556.9688606227812, 1769.6106856491551, 1799.442172926397, 1802.97295540567, 1806.67479853625, 1060.233488597015, 1255.7237407770276, 1257.0258050011314, 1351.6012776231034, 1468.5961360625913, 4496.0558282760985, 5078.796848126033, 5238.423773384925, 5249.711265880337, 5262.368515778131, 5103.2855400244, 5108.770105345268, 5460.781568737206, 5810.477057064884, 5915.881682366415, 4477.597016268552, 4630.560096790799, 4698.154332220165, 4795.954568848806, 5090.567301779391, 2563.679540057493, 3016.9547456788164, 3051.9847400762856, 3052.8015678981237, 3068.5243787213017, 5311.901798789457, 5717.685527296038, 5894.292684877756, 6085.604435711664, 6132.601380910227, 5778.27771528559, 6004.584338342144, 6041.6375017499095, 6045.939540604538, 6068.241469816273, 5228.816991405359, 5379.009766386462, 5828.94171058284, 5988.970055149784, 6094.603850749687, 5038.976614031551, 5489.780408783604, 5888.941110588839, 5890.378781442217, 5896.169838477469, 5437.797691934773, 5792.420757924174, 5799.333076696234, 5799.420057994167, 5803.3616302207565, 5751.166080918159, 5887.7056147193325, 6033.79766385275, 6085.756569737161, 6092.482139018056, 4323.589259020388, 4451.041541721632, 4563.429571303587, 5041.596672266283, 5123.462036486116, 5365.256291705134, 5638.0, 5922.822315330547, 5935.5548333875995, 5942.851428714143, 5013.899722005613, 5736.2217712509255, 5742.8751361994655, 5743.942560574508, 5762.740676669476, 4970.303063604859, 5068.695878247169, 5324.307839980933, 5633.8591535211945, 5772.105323674838, 5062.797488100435, 5179.974100129475, 5601.6358936668985, 5608.971955140199, 5622.522085622768, 5100.183970564692, 5301.098813201842, 5517.613767036269, 5687.60186786921, 5706.2367009321715, 4596.448426188745, 5386.192071189196, 5400.540954018952, 5523.420040895809, 5596.300462442195], "value": 4355.744948915967, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.5346791924842, 783.7256960063978, 804.1355542791497, 913.1690161952622, 923.0815338737955, 13199.93400033001, 17391.652166956686, 17544.0350780707, 17934.64130717385, 18355.0, 13565.660858478519, 16248.75626865598, 16629.584260393465, 16817.327306907708, 16818.32726690934, 988.5996171550515, 1010.7978404319128, 1011.3881101933334, 1012.4886932099316, 1014.0467960117503, 968.8449848024318, 997.4763249294106, 1022.6829682798357, 1026.3431403901473, 1031.3966329697137, 1061.9681409557725, 1074.4198133008167, 1077.849101125843, 1078.7033565769436, 1080.1358912869673, 1073.6349641121978, 1075.93544387337, 1077.0629552289479, 1077.709018564987, 1079.8974097460728, 794.972175973844, 797.8204903896577, 798.4450806689354, 800.4276941986508, 801.1147681811573, 14728.852711472855, 14955.102693838404, 14955.626109347353, 16117.677646447122, 16168.272427740661, 11991.400429978466, 14991.925040374837, 15018.699626007528, 15209.771853422208, 15473.613159670986, 10691.893081069245, 12003.279803211835, 12399.318037507934, 12506.81239781404, 12536.623901282976, 3764.8682296119505, 3859.826307816155, 3873.225354928997, 3940.980295098535, 4042.514898212204, 117274.41362793217, 127201.0, 129783.0, 131100.0, 132650.3367483166, 11096.667099986851, 11129.332240065622, 11539.134564907665, 11807.645770626896, 12200.75598488043, 23640.29079127629, 24454.51090978206, 24536.0, 24786.50426991486, 24878.0, 8162.224588664068, 8173.427860049858, 8202.26179643823, 8267.421280510307, 8343.997440614208, 3885.378339465672, 4513.0, 4543.5002149763495, 4710.670253082251, 4751.786169622375, 3422.19578399076, 3478.060923550627, 3484.007057988461, 3501.649835016529, 3517.1558825881602, 562.4235158962097, 591.3997292747864, 593.6378808926552, 602.5059451249933, 613.3590398034065, 687.9105716256854, 713.9607321597362, 724.8296650287178, 727.5271073802071, 758.1167939350595, 10370.740731481774, 10698.572057117784, 10978.231523793258, 11035.779284414266, 11127.944360278309, 696.8362434827811, 710.1903829634222, 739.474972769329, 740.1710084705164, 747.7083937264471, 4837.733924634109, 5041.621878359138, 5113.565346945551, 5151.330327057459, 5174.896502069938, 92993.0, 105848.47075764726, 107465.92534074716, 108800.0, 109802.0, 83381.0, 88811.0, 94819.0, 95562.08875822445, 97708.0, 58437.4156258432, 63111.0, 75351.62324188344, 81719.59140204261, 84159.5792021036, 10304.55736196948, 10325.483725813829, 11268.436578170895, 11547.191696581158, 11563.537458501902, 49893.25160122528, 51255.0, 51633.483665162865, 52093.739531302104, 53318.0, 64353.0, 65974.67012664906, 67027.66486167538, 67543.0, 67692.0, 10818.51316690735, 13416.262105584286, 13581.524646637321, 13702.246376449391, 13851.37668804886, 12924.676883077998, 15237.3905043797, 15484.767728484307, 15627.687446251239, 15854.9207253963, 14298.714025719635, 14299.785503217669, 14527.491537796126, 15041.924790376415, 15130.470433534774, 14145.929270353583, 14244.572662820132, 14285.857141428869, 14313.856861431668, 14393.64015899611, 12312.199707019015, 13529.932350338186, 14247.501337453139, 14332.0, 14529.273536323353, 10273.486325683836, 10784.838227426439, 10884.0, 11157.10743140563, 11290.379029153475, 11229.831552526883, 11279.928172386339, 11659.650210493699, 11666.475008624462, 11681.824772628248], "value": 8007.421658518209, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1491.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 121.0, 120.0, 120.0, 132.0, 118.0, 119.0, 116.0, 118.0, 118.0], "value": 118.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 109.0, 109.0, 141.0, 109.0, 116.0, 112.0, 110.0, 124.0, 114.0], "value": 117.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 195.0, 223.0, 263.0, 195.0, 199.0, 192.0, 192.0, 193.0, 192.0], "value": 203.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 59.0, 61.0, 88.0, 59.0, 63.0, 63.0, 61.0, 72.0, 60.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 85.0, 72.0, 72.0, 70.0, 84.0, 85.0, 66.0, 77.0], "value": 76.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 90.0, 89.0, 89.0, 90.0, 85.0, 90.0, 85.0, 135.0, 119.0], "value": 96.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 96.0, 105.0, 111.0, 97.0, 104.0, 116.0, 135.0], "value": 105.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 111.0, 146.0, 140.0, 91.0, 89.0, 91.0, 90.0, 89.0, 84.0], "value": 102.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 66.0, 67.0, 68.0, 67.0, 81.0, 99.0, 104.0, 80.0], "value": 76.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 64.0, 65.0, 64.0, 63.0, 55.0, 55.0, 55.0, 56.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 85.0, 86.0, 84.0, 92.0, 83.0, 84.0, 83.0, 86.0, 86.0], "value": 85.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 166.0, 143.0, 133.0, 138.0, 134.0, 156.0, 145.0, 190.0, 175.0], "value": 153.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 170.0, 163.0, 166.0, 165.0, 165.0, 161.0, 170.0, 172.0], "value": 166.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 62.0, 63.0, 65.0, 66.0, 65.0, 64.0, 63.0, 64.0], "value": 64.1, "unit": "score"}]}]} 19:40:54 INFO - Return code: 0 19:40:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:40:54 ERROR - # TBPL SUCCESS # 19:40:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:40:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:40:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:40:54 INFO - 2017-04-19 19:40:54.971 screenresolution[1658:10590] starting screenresolution argv=screenresolution get 19:40:54 INFO - 2017-04-19 19:40:54.973 screenresolution[1658:10590] Display 0: 1600x1200x32@60 19:40:54 INFO - 2017-04-19 19:40:54.980 screenresolution[1659:10593] starting screenresolution argv=screenresolution list 19:40:54 INFO - Available Modes on Display 0 19:40:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:40:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:40:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:40:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:40:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:40:55 INFO - Intel Iris: 19:40:55 INFO - Chipset Model: Intel Iris 19:40:55 INFO - Type: GPU 19:40:55 INFO - Bus: Built-In 19:40:55 INFO - VRAM (Dynamic, Max): 1536 MB 19:40:55 INFO - Vendor: Intel (0x8086) 19:40:55 INFO - Device ID: 0x0a2e 19:40:55 INFO - Revision ID: 0x0009 19:40:55 INFO - Displays: 19:40:55 INFO - Display: 19:40:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:40:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:40:55 INFO - Display Serial Number: 1600x1200 60 19:40:55 INFO - Main Display: Yes 19:40:55 INFO - Mirror: Off 19:40:55 INFO - Online: Yes 19:40:55 INFO - Rotation: Supported 19:40:55 INFO - Return code: 0 19:40:55 INFO - Running post-action listener: _resource_record_post_action 19:40:55 INFO - [mozharness: 2017-04-20 02:40:55.215167Z] Finished run-tests step (success) 19:40:55 INFO - Running post-run listener: _resource_record_post_run 19:40:55 INFO - Total resource usage - Wall time: 1190s; CPU: 54.0%; Read bytes: 40392704; Write bytes: 425030656; Read time: 262; Write time: 1418 19:40:55 INFO - TinderboxPrint: CPU usage
54.4% 19:40:55 INFO - TinderboxPrint: I/O read bytes / time
40,392,704 / 262 19:40:55 INFO - TinderboxPrint: I/O write bytes / time
425,030,656 / 1,418 19:40:55 INFO - TinderboxPrint: CPU idle
2,169.5 (45.6%) 19:40:55 INFO - TinderboxPrint: CPU system
954.1 (20.0%) 19:40:55 INFO - TinderboxPrint: CPU user
1,638.0 (34.4%) 19:40:55 INFO - TinderboxPrint: Swap in / out
175,833,088 / 0 19:40:55 INFO - install - Wall time: 15s; CPU: 53.0%; Read bytes: 122735104; Write bytes: 123930112; Read time: 11276; Write time: 280 19:40:55 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 36337664; Write bytes: 299732480; Read time: 235; Write time: 1134 19:40:55 INFO - Running post-run listener: _upload_blobber_files 19:40:55 INFO - Blob upload gear active. 19:40:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:40:55 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 19:40:55 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'] 19:40:55 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 19:40:56 INFO - (blobuploader) - INFO - Open directory for files ... 19:40:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:40:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:40:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:40:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:40:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:40:57 INFO - (blobuploader) - INFO - Done attempting. 19:40:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:40:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:40:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:40:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:40:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:40:58 INFO - (blobuploader) - INFO - Done attempting. 19:40:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 19:40:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:40:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:40:59 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 19:40:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:40:59 INFO - (blobuploader) - INFO - Done attempting. 19:40:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:40:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:40:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:41:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:41:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:41:01 INFO - (blobuploader) - INFO - Done attempting. 19:41:01 INFO - (blobuploader) - INFO - Iteration through files over. 19:41:01 INFO - Return code: 0 19:41:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:41:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:41:01 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d10a85ecdbbf59317e049ae1869c8166ed2f7330341817c190dc2dba9ce4720c3e90c758b3350c0227060c699c5cb1067fc58fac717a931d316fb4e3bf68bd85", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/49735d4ba8d594e80502d660bbf34467296c312347291ca45d04270af873132f2620b5648a3422ff6e6afac3e6afbb165ab12db098f9584023472cd41fc7b961", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/539848dab206e77fe075a7381b40473004d5d7e46fee73884dcd78e4aa9a0f7d55aaab1fe11551e9487367a1d2897fae0e9235af7f1c2f57a8e47e0de8af5b6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/53d56ac437f60777d5433bbd2e19c0ccc13bc99d1a453f688b5bdd644001845235f3053fd558a0836c6d7cd67c7f6ece0370242667e1a1881b6a783e123160b3"} 19:41:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:41:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:41:01 INFO - Contents: 19:41:01 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d10a85ecdbbf59317e049ae1869c8166ed2f7330341817c190dc2dba9ce4720c3e90c758b3350c0227060c699c5cb1067fc58fac717a931d316fb4e3bf68bd85", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/49735d4ba8d594e80502d660bbf34467296c312347291ca45d04270af873132f2620b5648a3422ff6e6afac3e6afbb165ab12db098f9584023472cd41fc7b961", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/539848dab206e77fe075a7381b40473004d5d7e46fee73884dcd78e4aa9a0f7d55aaab1fe11551e9487367a1d2897fae0e9235af7f1c2f57a8e47e0de8af5b6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/53d56ac437f60777d5433bbd2e19c0ccc13bc99d1a453f688b5bdd644001845235f3053fd558a0836c6d7cd67c7f6ece0370242667e1a1881b6a783e123160b3"} 19:41:01 INFO - Running post-run listener: copy_logs_to_upload_dir 19:41:01 INFO - Copying logs to upload dir... 19:41:01 INFO - mkdir: /builds/slave/test/build/upload/logs 19:41:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.034301 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2017-04-19 19:41:01.842471) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-19 19:41:01.845691) ========= 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.VHq44xafGo/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.xGASsDO1Hi/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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/d10a85ecdbbf59317e049ae1869c8166ed2f7330341817c190dc2dba9ce4720c3e90c758b3350c0227060c699c5cb1067fc58fac717a931d316fb4e3bf68bd85", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/49735d4ba8d594e80502d660bbf34467296c312347291ca45d04270af873132f2620b5648a3422ff6e6afac3e6afbb165ab12db098f9584023472cd41fc7b961", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/539848dab206e77fe075a7381b40473004d5d7e46fee73884dcd78e4aa9a0f7d55aaab1fe11551e9487367a1d2897fae0e9235af7f1c2f57a8e47e0de8af5b6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/53d56ac437f60777d5433bbd2e19c0ccc13bc99d1a453f688b5bdd644001845235f3053fd558a0836c6d7cd67c7f6ece0370242667e1a1881b6a783e123160b3"} build_url:https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010896 build_url: 'https://queue.taskcluster.net/v1/task/LtjCt5WhQTGQsS4PV889Iw/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/d10a85ecdbbf59317e049ae1869c8166ed2f7330341817c190dc2dba9ce4720c3e90c758b3350c0227060c699c5cb1067fc58fac717a931d316fb4e3bf68bd85", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/49735d4ba8d594e80502d660bbf34467296c312347291ca45d04270af873132f2620b5648a3422ff6e6afac3e6afbb165ab12db098f9584023472cd41fc7b961", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/539848dab206e77fe075a7381b40473004d5d7e46fee73884dcd78e4aa9a0f7d55aaab1fe11551e9487367a1d2897fae0e9235af7f1c2f57a8e47e0de8af5b6f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/53d56ac437f60777d5433bbd2e19c0ccc13bc99d1a453f688b5bdd644001845235f3053fd558a0836c6d7cd67c7f6ece0370242667e1a1881b6a783e123160b3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-19 19:41:01.879486) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 19:41:01.879835) ========= 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.VHq44xafGo/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.xGASsDO1Hi/Listeners TMPDIR=/var/folders/k4/cmrx_0_d2gd2sqlxqp_js7l000000w/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.005038 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-19 19:41:01.928174) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-19 19:41:01.928512) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-19 19:41:01.928855) ========= ========= Total master_lag: 0.19 =========