builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0163 starttime: 1489623812.53 results: success (0) buildid: 20170315161236 builduid: 5b959a9f19404aed912838f06e3f54a4 revision: e00635bc10f072b7ab93640a6094b3d92e8ab740 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 17:23:32.533919) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-15 17:23:32.534377) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 17:23:32.534663) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-15 17:23:32.559819) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 17:23:32.560209) ========= 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.0JKR6Blrrz/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.d2VYYEbgyL/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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-03-15 17:23:32-- 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% 8.20M=0.001s 2017-03-15 17:23:32 (8.20 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116396 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 17:23:32.700490) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 17:23:32.700893) ========= 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.0JKR6Blrrz/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.d2VYYEbgyL/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.021049 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 17:23:32.749725) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-15 17:23:32.750087) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e00635bc10f072b7ab93640a6094b3d92e8ab740 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e00635bc10f072b7ab93640a6094b3d92e8ab740 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0JKR6Blrrz/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.d2VYYEbgyL/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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-03-15 17:23:32,834 truncating revision to first 12 chars 2017-03-15 17:23:32,834 Setting DEBUG logging. 2017-03-15 17:23:32,834 attempt 1/10 2017-03-15 17:23:32,834 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e00635bc10f0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-15 17:23:34,106 unpacking tar archive at: mozilla-aurora-e00635bc10f0/testing/mozharness/ program finished with exit code 0 elapsedTime=1.538908 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-15 17:23:34.312557) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 17:23:34.312893) ========= script_repo_revision: e00635bc10f072b7ab93640a6094b3d92e8ab740 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-15 17:23:34.313281) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 17:23:34.313549) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-15 17:23:34.333369) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-03-15 17:23:34.333719) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.0JKR6Blrrz/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.d2VYYEbgyL/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 17:23:34 INFO - MultiFileLogger online at 20170315 17:23:34 in /builds/slave/test 17:23:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 17:23:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:23:34 INFO - {'append_to_log': False, 17:23:34 INFO - 'base_work_dir': '/builds/slave/test', 17:23:34 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 17:23:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:23:34 INFO - 'branch': 'Mozilla-Aurora', 17:23:34 INFO - 'buildbot_json_path': 'buildprops.json', 17:23:34 INFO - 'config_files': ('talos/mac_config.py',), 17:23:34 INFO - 'default_actions': ('clobber', 17:23:34 INFO - 'read-buildbot-config', 17:23:34 INFO - 'download-and-extract', 17:23:34 INFO - 'populate-webroot', 17:23:34 INFO - 'create-virtualenv', 17:23:34 INFO - 'install', 17:23:34 INFO - 'run-tests'), 17:23:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:23:34 INFO - 'download_minidump_stackwalk': True, 17:23:34 INFO - 'download_symbols': 'ondemand', 17:23:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:23:34 INFO - 'tooltool.py': '/tools/tooltool.py', 17:23:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:23:34 INFO - '/tools/misc-python/virtualenv.py')}, 17:23:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:23:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:23:34 INFO - 'gecko_profile': False, 17:23:34 INFO - 'gecko_profile_interval': 0, 17:23:34 INFO - 'installer_path': 'installer.exe', 17:23:34 INFO - 'log_level': 'info', 17:23:34 INFO - 'log_name': 'talos', 17:23:34 INFO - 'log_to_console': True, 17:23:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:23:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:23:34 INFO - 'opt_config_files': (), 17:23:34 INFO - 'pip_index': False, 17:23:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:23:34 INFO - 'cmd': ('bash', 17:23:34 INFO - '-c', 17:23:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:23:34 INFO - 'enabled': True, 17:23:34 INFO - 'halt_on_failure': False, 17:23:34 INFO - 'name': 'check_screen_resolution'},), 17:23:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:23:34 INFO - 'cmd': ('bash', 17:23:34 INFO - '-c', 17:23:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:23:34 INFO - 'enabled': True, 17:23:34 INFO - 'halt_on_failure': False, 17:23:34 INFO - 'name': 'check_screen_resolution'},), 17:23:34 INFO - 'run_cmd_checks_enabled': True, 17:23:34 INFO - 'suite': 'dromaeojs-e10s', 17:23:34 INFO - 'system_bits': '32', 17:23:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:23:34 INFO - 'title': 't-yosemite-r7-0163', 17:23:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:23:34 INFO - 'use_talos_json': True, 17:23:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:23:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:23:34 INFO - 'work_dir': 'build'} 17:23:34 INFO - [mozharness: 2017-03-16 00:23:34.543964Z] Running clobber step. 17:23:34 INFO - Running pre-action listener: _resource_record_pre_action 17:23:34 INFO - Running main action method: clobber 17:23:34 INFO - rmtree: /builds/slave/test/build 17:23:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:23:36 INFO - Running post-action listener: _resource_record_post_action 17:23:36 INFO - [mozharness: 2017-03-16 00:23:36.358330Z] Finished clobber step (success) 17:23:36 INFO - [mozharness: 2017-03-16 00:23:36.358531Z] Running read-buildbot-config step. 17:23:36 INFO - Running pre-action listener: _resource_record_pre_action 17:23:36 INFO - Running main action method: read_buildbot_config 17:23:36 INFO - Using buildbot properties: 17:23:36 INFO - { 17:23:36 INFO - "project": "", 17:23:36 INFO - "product": "firefox", 17:23:36 INFO - "script_repo_revision": "production", 17:23:36 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 17:23:36 INFO - "repository": "", 17:23:36 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 17:23:36 INFO - "buildid": "20170315161236", 17:23:36 INFO - "pgo_build": "False", 17:23:36 INFO - "basedir": "/builds/slave/test", 17:23:36 INFO - "buildnumber": 23, 17:23:36 INFO - "slavename": "t-yosemite-r7-0163", 17:23:36 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 17:23:36 INFO - "platform": "yosemite_r7", 17:23:36 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 17:23:36 INFO - "branch": "mozilla-aurora", 17:23:36 INFO - "repo_path": "releases/mozilla-aurora", 17:23:36 INFO - "revision": "e00635bc10f072b7ab93640a6094b3d92e8ab740", 17:23:36 INFO - "stage_platform": "macosx64", 17:23:36 INFO - "builduid": "5b959a9f19404aed912838f06e3f54a4", 17:23:36 INFO - "slavebuilddir": "test" 17:23:36 INFO - } 17:23:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/AvL1bm5CSrO1B75BiIZUCA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 17:23:36 INFO - Running post-action listener: _resource_record_post_action 17:23:36 INFO - [mozharness: 2017-03-16 00:23:36.364057Z] Finished read-buildbot-config step (success) 17:23:36 INFO - [mozharness: 2017-03-16 00:23:36.364271Z] Running download-and-extract step. 17:23:36 INFO - Running pre-action listener: _resource_record_pre_action 17:23:36 INFO - Running main action method: download_and_extract 17:23:36 INFO - mkdir: /builds/slave/test/build/tests 17:23:36 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')]} 17:23:36 INFO - trying https://queue.taskcluster.net/v1/task/AvL1bm5CSrO1B75BiIZUCA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 17:23:36 INFO - Downloading https://queue.taskcluster.net/v1/task/AvL1bm5CSrO1B75BiIZUCA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 17:23:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AvL1bm5CSrO1B75BiIZUCA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 17:23:37 INFO - Downloaded 1199 bytes. 17:23:37 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 17:23:37 INFO - Using the following test package requirements: 17:23:37 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 17:23:37 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 17:23:37 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 17:23:37 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 17:23:37 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 17:23:37 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 17:23:37 INFO - u'jsshell-mac.zip'], 17:23:37 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 17:23:37 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 17:23:37 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 17:23:37 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 17:23:37 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 17:23:37 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 17:23:37 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 17:23:37 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 17:23:37 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 17:23:37 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 17:23:37 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 17:23:37 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 17:23:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AvL1bm5CSrO1B75BiIZUCA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 17:23:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AvL1bm5CSrO1B75BiIZUCA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 17:23:37 INFO - Fetch https://queue.taskcluster.net/v1/task/AvL1bm5CSrO1B75BiIZUCA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 17:23:39 INFO - Expected file size: 51783930 17:23:39 INFO - Obtained file size: 51783930 17:23:55 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 17:23:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AvL1bm5CSrO1B75BiIZUCA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 17:23:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AvL1bm5CSrO1B75BiIZUCA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 17:23:55 INFO - Fetch https://queue.taskcluster.net/v1/task/AvL1bm5CSrO1B75BiIZUCA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 17:23:57 INFO - Expected file size: 51783930 17:23:57 INFO - Obtained file size: 51783930 17:24:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AvL1bm5CSrO1B75BiIZUCA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 17:24:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AvL1bm5CSrO1B75BiIZUCA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 17:24:12 INFO - Fetch https://queue.taskcluster.net/v1/task/AvL1bm5CSrO1B75BiIZUCA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 17:24:13 INFO - Expected file size: 14404424 17:24:13 INFO - Obtained file size: 14404424 17:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:14 INFO - trying https://queue.taskcluster.net/v1/task/AvL1bm5CSrO1B75BiIZUCA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 17:24:14 INFO - Downloading https://queue.taskcluster.net/v1/task/AvL1bm5CSrO1B75BiIZUCA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 17:24:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AvL1bm5CSrO1B75BiIZUCA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 17:24:16 INFO - Downloaded 74624156 bytes. 17:24:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AvL1bm5CSrO1B75BiIZUCA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 17:24:16 INFO - mkdir: /builds/slave/test/properties 17:24:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:24:16 INFO - Writing to file /builds/slave/test/properties/build_url 17:24:16 INFO - Contents: 17:24:16 INFO - build_url:https://queue.taskcluster.net/v1/task/AvL1bm5CSrO1B75BiIZUCA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 17:24:17 INFO - Running post-action listener: _resource_record_post_action 17:24:17 INFO - Running post-action listener: set_extra_try_arguments 17:24:17 INFO - [mozharness: 2017-03-16 00:24:17.076626Z] Finished download-and-extract step (success) 17:24:17 INFO - [mozharness: 2017-03-16 00:24:17.076750Z] Running populate-webroot step. 17:24:17 INFO - Running pre-action listener: _resource_record_pre_action 17:24:17 INFO - Running main action method: populate_webroot 17:24:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:24:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:24:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:24:17 INFO - '--tppagecycles', 17:24:17 INFO - '7'], 17:24:17 INFO - 'tests': ['tsvgm']}}, 17:24:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:24:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:24:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:24:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:24:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:24:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:24:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:24:17 INFO - 'talos_options': ['--disable-e10s'], 17:24:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:24:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:24:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:24:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:24:17 INFO - 'talos_options': ['--disable-e10s'], 17:24:17 INFO - 'tests': ['damp', 'tps']}, 17:24:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:24:17 INFO - 'tests': ['damp', 'tps']}, 17:24:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:24:17 INFO - 'tests': ['dromaeo_dom']}, 17:24:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:24:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:24:17 INFO - 'tests': ['basic_compositor_video']}, 17:24:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:24:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:24:17 INFO - 'tests': ['a11yr', 17:24:17 INFO - 'ts_paint', 17:24:17 INFO - 'tpaint', 17:24:17 INFO - 'sessionrestore', 17:24:17 INFO - 'sessionrestore_no_auto_restore', 17:24:17 INFO - 'tabpaint']}, 17:24:17 INFO - 'other-e10s': {'tests': ['a11yr', 17:24:17 INFO - 'ts_paint', 17:24:17 INFO - 'tpaint', 17:24:17 INFO - 'sessionrestore', 17:24:17 INFO - 'sessionrestore_no_auto_restore', 17:24:17 INFO - 'tabpaint']}, 17:24:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:24:17 INFO - 'ts_paint', 17:24:17 INFO - 'tpaint', 17:24:17 INFO - 'sessionrestore', 17:24:17 INFO - 'sessionrestore_no_auto_restore', 17:24:17 INFO - 'tabpaint']}, 17:24:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:24:17 INFO - 'ts_paint', 17:24:17 INFO - 'tpaint', 17:24:17 INFO - 'sessionrestore', 17:24:17 INFO - 'sessionrestore_no_auto_restore', 17:24:17 INFO - 'tabpaint']}, 17:24:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:24:17 INFO - 'tests': ['a11yr', 17:24:17 INFO - 'ts_paint', 17:24:17 INFO - 'tpaint', 17:24:17 INFO - 'sessionrestore', 17:24:17 INFO - 'sessionrestore_no_auto_restore', 17:24:17 INFO - 'tabpaint']}, 17:24:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:24:17 INFO - 'tests': ['a11yr', 17:24:17 INFO - 'ts_paint', 17:24:17 INFO - 'tpaint', 17:24:17 INFO - 'sessionrestore', 17:24:17 INFO - 'sessionrestore_no_auto_restore', 17:24:17 INFO - 'tabpaint']}, 17:24:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:24:17 INFO - 'tests': ['tsvgx', 17:24:17 INFO - 'tsvgr_opacity', 17:24:17 INFO - 'tart', 17:24:17 INFO - 'tscrollx', 17:24:17 INFO - 'cart', 17:24:17 INFO - 'tsvg_static']}, 17:24:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:24:17 INFO - 'tsvgr_opacity', 17:24:17 INFO - 'tart', 17:24:17 INFO - 'tscrollx', 17:24:17 INFO - 'cart', 17:24:17 INFO - 'tsvg_static']}, 17:24:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:24:17 INFO - 'talos_options': ['--disable-e10s'], 17:24:17 INFO - 'tests': ['tp5o']}, 17:24:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:24:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:24:17 INFO - 'talos_options': ['--disable-e10s', 17:24:17 INFO - '--xperf_path', 17:24:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:24:17 INFO - 'tests': ['tp5n']}, 17:24:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:24:17 INFO - 'talos_options': ['--xperf_path', 17:24:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:24:17 INFO - 'tests': ['tp5n']}}, 17:24:17 INFO - 'talos.zip': {'path': '', 17:24:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:24:17 INFO - Running post-action listener: _resource_record_post_action 17:24:17 INFO - [mozharness: 2017-03-16 00:24:17.095305Z] Finished populate-webroot step (success) 17:24:17 INFO - [mozharness: 2017-03-16 00:24:17.095419Z] Running create-virtualenv step. 17:24:17 INFO - Running pre-action listener: _resource_record_pre_action 17:24:17 INFO - Running main action method: create_virtualenv 17:24:17 INFO - Creating virtualenv /builds/slave/test/build/venv 17:24:17 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 17:24:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:24:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:24:17 INFO - Using real prefix '/tools/python27' 17:24:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:24:17 INFO - Installing distribute.............................................................................................................................................................................................done. 17:24:20 INFO - Installing pip.................done. 17:24:20 INFO - Return code: 0 17:24:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:24:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:24:21 INFO - Reading from file tmpfile_stdout 17:24:21 INFO - Output received: 17:24:21 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) 17:24:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c09fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a3591030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be7dd30>, '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 0x10bda4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be72be8>, '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.0JKR6Blrrz/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.d2VYYEbgyL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 17:24:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 17:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 17:24:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0JKR6Blrrz/Render', 17:24:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:21 INFO - 'HOME': '/Users/cltbld', 17:24:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:21 INFO - 'LOGNAME': 'cltbld', 17:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:21 INFO - 'MOZ_NO_REMOTE': '1', 17:24:21 INFO - 'NO_EM_RESTART': '1', 17:24:21 INFO - 'PAGER': '/bin/cat', 17:24:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:21 INFO - 'PWD': '/builds/slave/test', 17:24:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:21 INFO - 'SHELL': '/bin/bash', 17:24:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d2VYYEbgyL/Listeners', 17:24:21 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 17:24:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:21 INFO - 'USER': 'cltbld', 17:24:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:21 INFO - 'XPC_FLAGS': '0x0', 17:24:21 INFO - 'XPC_SERVICE_NAME': '0', 17:24:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:21 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 17:24:21 INFO - Cleaning up... 17:24:21 INFO - Return code: 0 17:24:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c09fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a3591030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be7dd30>, '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 0x10bda4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be72be8>, '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.0JKR6Blrrz/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.d2VYYEbgyL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 17:24:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 17:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 17:24:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0JKR6Blrrz/Render', 17:24:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:21 INFO - 'HOME': '/Users/cltbld', 17:24:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:21 INFO - 'LOGNAME': 'cltbld', 17:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:21 INFO - 'MOZ_NO_REMOTE': '1', 17:24:21 INFO - 'NO_EM_RESTART': '1', 17:24:21 INFO - 'PAGER': '/bin/cat', 17:24:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:21 INFO - 'PWD': '/builds/slave/test', 17:24:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:21 INFO - 'SHELL': '/bin/bash', 17:24:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d2VYYEbgyL/Listeners', 17:24:21 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 17:24:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:21 INFO - 'USER': 'cltbld', 17:24:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:21 INFO - 'XPC_FLAGS': '0x0', 17:24:21 INFO - 'XPC_SERVICE_NAME': '0', 17:24:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:21 INFO - Downloading/unpacking psutil>=3.1.1 17:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:24:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:24:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:24:25 INFO - Installing collected packages: psutil 17:24:25 INFO - Running setup.py install for psutil 17:24:25 INFO - building 'psutil._psutil_osx' extension 17:24:25 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 17:24:25 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 17:24:25 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 17:24:25 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 17:24:25 INFO - building 'psutil._psutil_posix' extension 17:24:25 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 17:24:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:24:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:24:25 INFO - ^ 17:24:25 INFO - 1 warning generated. 17:24:25 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 17:24:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:24:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:24:25 INFO - Successfully installed psutil 17:24:25 INFO - Cleaning up... 17:24:26 INFO - Return code: 0 17:24:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c09fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a3591030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be7dd30>, '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 0x10bda4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be72be8>, '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.0JKR6Blrrz/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.d2VYYEbgyL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 17:24:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 17:24:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 17:24:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0JKR6Blrrz/Render', 17:24:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:26 INFO - 'HOME': '/Users/cltbld', 17:24:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:26 INFO - 'LOGNAME': 'cltbld', 17:24:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:26 INFO - 'MOZ_NO_REMOTE': '1', 17:24:26 INFO - 'NO_EM_RESTART': '1', 17:24:26 INFO - 'PAGER': '/bin/cat', 17:24:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:26 INFO - 'PWD': '/builds/slave/test', 17:24:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:26 INFO - 'SHELL': '/bin/bash', 17:24:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d2VYYEbgyL/Listeners', 17:24:26 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 17:24:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:26 INFO - 'USER': 'cltbld', 17:24:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:26 INFO - 'XPC_FLAGS': '0x0', 17:24:26 INFO - 'XPC_SERVICE_NAME': '0', 17:24:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:24:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:24:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:24:29 INFO - Installing collected packages: mozsystemmonitor 17:24:29 INFO - Running setup.py install for mozsystemmonitor 17:24:29 INFO - Successfully installed mozsystemmonitor 17:24:29 INFO - Cleaning up... 17:24:29 INFO - Return code: 0 17:24:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:24:29 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')]} 17:24:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:29 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')]} 17:24:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10c09fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a3591030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be7dd30>, '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 0x10bda4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be72be8>, '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.0JKR6Blrrz/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.d2VYYEbgyL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 17:24:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 17:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 17:24:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0JKR6Blrrz/Render', 17:24:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:30 INFO - 'HOME': '/Users/cltbld', 17:24:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:30 INFO - 'LOGNAME': 'cltbld', 17:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:30 INFO - 'MOZ_NO_REMOTE': '1', 17:24:30 INFO - 'NO_EM_RESTART': '1', 17:24:30 INFO - 'PAGER': '/bin/cat', 17:24:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:30 INFO - 'PWD': '/builds/slave/test', 17:24:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:30 INFO - 'SHELL': '/bin/bash', 17:24:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d2VYYEbgyL/Listeners', 17:24:30 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 17:24:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:30 INFO - 'USER': 'cltbld', 17:24:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:30 INFO - 'XPC_FLAGS': '0x0', 17:24:30 INFO - 'XPC_SERVICE_NAME': '0', 17:24:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:30 INFO - Downloading/unpacking jsonschema==2.5.1 17:24:30 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 17:24:30 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 17:24:30 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 17:24:30 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 17:24:30 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 17:24:30 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 17:24:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:24:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:24:33 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 17:24:33 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 17:24:33 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 17:24:33 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 17:24:33 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 17:24:33 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 17:24:33 INFO - Downloading functools32-3.2.3-2.tar.gz 17:24:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:24:34 INFO - warning: no files found matching '*.txt' 17:24:34 INFO - no previously-included directories found matching 'build' 17:24:34 INFO - no previously-included directories found matching 'dist' 17:24:34 INFO - no previously-included directories found matching '.git*' 17:24:34 INFO - Installing collected packages: jsonschema, functools32 17:24:34 INFO - Running setup.py install for functools32 17:24:34 INFO - warning: no files found matching '*.txt' 17:24:34 INFO - no previously-included directories found matching 'build' 17:24:34 INFO - no previously-included directories found matching 'dist' 17:24:34 INFO - no previously-included directories found matching '.git*' 17:24:34 INFO - Successfully installed jsonschema functools32 17:24:34 INFO - Cleaning up... 17:24:34 INFO - Return code: 0 17:24:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:34 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 0x10c09fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a3591030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be7dd30>, '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 0x10bda4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be72be8>, '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.0JKR6Blrrz/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.d2VYYEbgyL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 17:24:34 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 17:24:34 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 17:24:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0JKR6Blrrz/Render', 17:24:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:34 INFO - 'HOME': '/Users/cltbld', 17:24:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:34 INFO - 'LOGNAME': 'cltbld', 17:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:34 INFO - 'MOZ_NO_REMOTE': '1', 17:24:34 INFO - 'NO_EM_RESTART': '1', 17:24:34 INFO - 'PAGER': '/bin/cat', 17:24:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:34 INFO - 'PWD': '/builds/slave/test', 17:24:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:34 INFO - 'SHELL': '/bin/bash', 17:24:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d2VYYEbgyL/Listeners', 17:24:34 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 17:24:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:34 INFO - 'USER': 'cltbld', 17:24:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:34 INFO - 'XPC_FLAGS': '0x0', 17:24:34 INFO - 'XPC_SERVICE_NAME': '0', 17:24:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:24:34 INFO - Cleaning up... 17:24:34 INFO - Return code: 0 17:24:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:34 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 0x10c09fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a3591030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be7dd30>, '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 0x10bda4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be72be8>, '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.0JKR6Blrrz/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.d2VYYEbgyL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 17:24:34 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 17:24:34 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 17:24:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0JKR6Blrrz/Render', 17:24:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:34 INFO - 'HOME': '/Users/cltbld', 17:24:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:34 INFO - 'LOGNAME': 'cltbld', 17:24:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:34 INFO - 'MOZ_NO_REMOTE': '1', 17:24:34 INFO - 'NO_EM_RESTART': '1', 17:24:34 INFO - 'PAGER': '/bin/cat', 17:24:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:34 INFO - 'PWD': '/builds/slave/test', 17:24:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:34 INFO - 'SHELL': '/bin/bash', 17:24:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d2VYYEbgyL/Listeners', 17:24:34 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 17:24:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:34 INFO - 'USER': 'cltbld', 17:24:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:34 INFO - 'XPC_FLAGS': '0x0', 17:24:34 INFO - 'XPC_SERVICE_NAME': '0', 17:24:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:34 INFO - Downloading/unpacking blobuploader==1.2.4 17:24:34 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 17:24:34 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 17:24:34 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 17:24:34 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 17:24:34 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 17:24:34 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 17:24:37 INFO - Downloading blobuploader-1.2.4.tar.gz 17:24:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:24:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:24:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:24:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:24:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:24:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:24:38 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 17:24:38 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 17:24:38 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 17:24:38 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 17:24:38 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 17:24:38 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 17:24:38 INFO - Downloading docopt-0.6.1.tar.gz 17:24:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:24:38 INFO - Installing collected packages: blobuploader, requests, docopt 17:24:38 INFO - Running setup.py install for blobuploader 17:24:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:24:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:24:38 INFO - Running setup.py install for requests 17:24:39 INFO - Running setup.py install for docopt 17:24:39 INFO - Successfully installed blobuploader requests docopt 17:24:39 INFO - Cleaning up... 17:24:39 INFO - Return code: 0 17:24:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:39 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 0x10c09fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a3591030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be7dd30>, '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 0x10bda4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be72be8>, '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.0JKR6Blrrz/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.d2VYYEbgyL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 17:24:39 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 17:24:39 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 17:24:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0JKR6Blrrz/Render', 17:24:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:39 INFO - 'HOME': '/Users/cltbld', 17:24:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:39 INFO - 'LOGNAME': 'cltbld', 17:24:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:39 INFO - 'MOZ_NO_REMOTE': '1', 17:24:39 INFO - 'NO_EM_RESTART': '1', 17:24:39 INFO - 'PAGER': '/bin/cat', 17:24:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:39 INFO - 'PWD': '/builds/slave/test', 17:24:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:39 INFO - 'SHELL': '/bin/bash', 17:24:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d2VYYEbgyL/Listeners', 17:24:39 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 17:24:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:39 INFO - 'USER': 'cltbld', 17:24:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:39 INFO - 'XPC_FLAGS': '0x0', 17:24:39 INFO - 'XPC_SERVICE_NAME': '0', 17:24:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:24:39 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-djpm2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:24:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-j5UxeF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:24:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-ZVRVuA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:24:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-gP5s8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:24:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-oVhOb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:24:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-6r8o3Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:24:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-NsJ1it-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:24:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-4dHMF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:24:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-32CBd6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:24:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-sRghnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:24:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:24:40 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-BiGvCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:24:41 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Wfroqu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:24:41 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-cnWQus-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:24:41 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-vBFFLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:41 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-x1vEf1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:24:41 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-YM8Jml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:24:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:24:41 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Jp64MV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:24:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:24:41 INFO - Running setup.py install for manifestparser 17:24:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:24:41 INFO - Running setup.py install for mozcrash 17:24:41 INFO - Running setup.py install for mozdebug 17:24:42 INFO - Running setup.py install for mozdevice 17:24:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:24:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:24:42 INFO - Running setup.py install for mozfile 17:24:42 INFO - Running setup.py install for mozhttpd 17:24:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:24:42 INFO - Running setup.py install for mozinfo 17:24:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:24:42 INFO - Running setup.py install for mozInstall 17:24:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:24:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:24:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:24:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:24:42 INFO - Running setup.py install for mozleak 17:24:42 INFO - Running setup.py install for mozlog 17:24:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:24:43 INFO - Running setup.py install for moznetwork 17:24:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:24:43 INFO - Running setup.py install for mozprocess 17:24:43 INFO - Running setup.py install for mozprofile 17:24:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:24:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:24:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:24:43 INFO - Running setup.py install for mozrunner 17:24:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:24:43 INFO - Running setup.py install for mozscreenshot 17:24:43 INFO - Running setup.py install for moztest 17:24:44 INFO - Running setup.py install for mozversion 17:24:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:24:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:24:44 INFO - Cleaning up... 17:24:44 INFO - Return code: 0 17:24:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:24:44 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')]} 17:24:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:44 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')]} 17:24:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:44 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 0x10c09fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a3591030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be7dd30>, '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 0x10bda4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be72be8>, '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.0JKR6Blrrz/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.d2VYYEbgyL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 17:24:44 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 17:24:44 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 17:24:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0JKR6Blrrz/Render', 17:24:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:44 INFO - 'HOME': '/Users/cltbld', 17:24:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:44 INFO - 'LOGNAME': 'cltbld', 17:24:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:44 INFO - 'MOZ_NO_REMOTE': '1', 17:24:44 INFO - 'NO_EM_RESTART': '1', 17:24:44 INFO - 'PAGER': '/bin/cat', 17:24:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:44 INFO - 'PWD': '/builds/slave/test', 17:24:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:44 INFO - 'SHELL': '/bin/bash', 17:24:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d2VYYEbgyL/Listeners', 17:24:44 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 17:24:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:44 INFO - 'USER': 'cltbld', 17:24:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:44 INFO - 'XPC_FLAGS': '0x0', 17:24:44 INFO - 'XPC_SERVICE_NAME': '0', 17:24:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:24:44 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-Io7d_o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:24:44 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)) 17:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:24:44 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-MnuC10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:24:44 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)) 17:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:24:44 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-5DS_wW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:24:44 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)) 17:24:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:24:44 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-y7ckf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:24:45 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)) 17:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:24:45 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-9CT8IM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:24:45 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)) 17:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:24:45 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-jFhN1Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:24:45 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)) 17:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:24:45 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-6k8hZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:24:45 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)) 17:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:24:45 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-AoA5XF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:24:45 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)) 17:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:24:45 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-z3iX93-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:24:45 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)) 17:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:24:45 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-bY9alF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:24:45 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)) 17:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:24:45 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-EuXTMM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:24:45 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)) 17:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:24:45 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-J4yTAf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:24:45 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)) 17:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:24:45 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-pTIyhE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:24:45 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)) 17:24:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:24:45 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-DkC8lb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:24:46 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)) 17:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:46 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-OIvfLn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:24:46 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)) 17:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:24:46 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-aB4yxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:24:46 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)) 17:24:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:24:46 INFO - Running setup.py (path:/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/pip-fC9MEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:24:46 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)) 17:24:46 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)) 17:24:46 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)) 17:24:46 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)) 17:24:46 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)) 17:24:46 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)) 17:24:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:24:46 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 17:24:46 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 17:24:46 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 17:24:46 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 17:24:46 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 17:24:46 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 17:24:49 INFO - Downloading blessings-1.6.tar.gz 17:24:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:24:49 INFO - Installing collected packages: blessings 17:24:49 INFO - Running setup.py install for blessings 17:24:49 INFO - Successfully installed blessings 17:24:49 INFO - Cleaning up... 17:24:49 INFO - Return code: 0 17:24:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:24:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:24:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:24:49 INFO - Reading from file tmpfile_stdout 17:24:49 INFO - Current package versions: 17:24:49 INFO - blessings == 1.6 17:24:49 INFO - blobuploader == 1.2.4 17:24:49 INFO - docopt == 0.6.1 17:24:49 INFO - functools32 == 3.2.3-2 17:24:49 INFO - jsonschema == 2.5.1 17:24:49 INFO - manifestparser == 1.1 17:24:49 INFO - mozInstall == 1.12 17:24:49 INFO - mozcrash == 1.0 17:24:49 INFO - mozdebug == 0.1 17:24:49 INFO - mozdevice == 0.49 17:24:49 INFO - mozfile == 1.2 17:24:49 INFO - mozhttpd == 0.7 17:24:49 INFO - mozinfo == 0.9 17:24:49 INFO - mozleak == 0.1 17:24:49 INFO - mozlog == 3.4 17:24:49 INFO - moznetwork == 0.27 17:24:49 INFO - mozprocess == 0.25 17:24:49 INFO - mozprofile == 0.28 17:24:49 INFO - mozrunner == 6.13 17:24:49 INFO - mozscreenshot == 0.1 17:24:49 INFO - mozsystemmonitor == 0.3 17:24:49 INFO - moztest == 0.8 17:24:49 INFO - mozversion == 1.4 17:24:49 INFO - psutil == 3.1.1 17:24:49 INFO - requests == 1.2.3 17:24:49 INFO - wsgiref == 0.1.2 17:24:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:49 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 0x10c09fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a3591030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be7dd30>, '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 0x10bda4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be72be8>, '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.0JKR6Blrrz/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.d2VYYEbgyL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 17:24:49 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 17:24:49 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 17:24:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0JKR6Blrrz/Render', 17:24:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:49 INFO - 'HOME': '/Users/cltbld', 17:24:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:49 INFO - 'LOGNAME': 'cltbld', 17:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:49 INFO - 'MOZ_NO_REMOTE': '1', 17:24:49 INFO - 'NO_EM_RESTART': '1', 17:24:49 INFO - 'PAGER': '/bin/cat', 17:24:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:49 INFO - 'PWD': '/builds/slave/test', 17:24:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:49 INFO - 'SHELL': '/bin/bash', 17:24:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d2VYYEbgyL/Listeners', 17:24:49 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 17:24:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:49 INFO - 'USER': 'cltbld', 17:24:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:49 INFO - 'XPC_FLAGS': '0x0', 17:24:49 INFO - 'XPC_SERVICE_NAME': '0', 17:24:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:49 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)) 17:24:49 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)) 17:24:49 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)) 17:24:49 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)) 17:24:49 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)) 17:24:49 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)) 17:24:49 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)) 17:24:49 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)) 17:24:49 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)) 17:24:49 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)) 17:24:49 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)) 17:24:49 INFO - Cleaning up... 17:24:49 INFO - Return code: 0 17:24:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:24:49 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 0x10c09fb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c0a2768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6a3591030>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10be7dd30>, '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 0x10bda4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be72be8>, '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.0JKR6Blrrz/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.d2VYYEbgyL/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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 17:24:49 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 17:24:49 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 17:24:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0JKR6Blrrz/Render', 17:24:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:24:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:24:49 INFO - 'HOME': '/Users/cltbld', 17:24:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:24:49 INFO - 'LOGNAME': 'cltbld', 17:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:24:49 INFO - 'MOZ_NO_REMOTE': '1', 17:24:49 INFO - 'NO_EM_RESTART': '1', 17:24:49 INFO - 'PAGER': '/bin/cat', 17:24:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:24:49 INFO - 'PWD': '/builds/slave/test', 17:24:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:24:49 INFO - 'SHELL': '/bin/bash', 17:24:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d2VYYEbgyL/Listeners', 17:24:49 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 17:24:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:24:49 INFO - 'USER': 'cltbld', 17:24:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:24:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:24:49 INFO - 'XPC_FLAGS': '0x0', 17:24:49 INFO - 'XPC_SERVICE_NAME': '0', 17:24:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:24:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:24:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:24:50 INFO - Cleaning up... 17:24:50 INFO - Return code: 0 17:24:50 INFO - Running post-action listener: _resource_record_post_action 17:24:50 INFO - Running post-action listener: _start_resource_monitoring 17:24:50 INFO - Starting resource monitoring. 17:24:50 INFO - [mozharness: 2017-03-16 00:24:50.242629Z] Finished create-virtualenv step (success) 17:24:50 INFO - [mozharness: 2017-03-16 00:24:50.243635Z] Running install step. 17:24:50 INFO - Running pre-action listener: _resource_record_pre_action 17:24:50 INFO - Running main action method: install 17:24:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:24:50 INFO - Reading from file tmpfile_stdout 17:24:50 INFO - Detecting whether we're running mozinstall >=1.0... 17:24:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:24:50 INFO - Reading from file tmpfile_stdout 17:24:50 INFO - Output received: 17:24:50 INFO - Usage: mozinstall [options] installer 17:24:50 INFO - Options: 17:24:50 INFO - -h, --help show this help message and exit 17:24:50 INFO - -d DEST, --destination=DEST 17:24:50 INFO - Directory to install application into. [default: 17:24:50 INFO - "/builds/slave/test"] 17:24:50 INFO - --app=APP Application being installed. [default: firefox] 17:24:50 INFO - mkdir: /builds/slave/test/build/application 17:24:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:24:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 17:25:10 INFO - Reading from file tmpfile_stdout 17:25:10 INFO - Output received: 17:25:10 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 17:25:10 INFO - Running post-action listener: _resource_record_post_action 17:25:10 INFO - [mozharness: 2017-03-16 00:25:10.546219Z] Finished install step (success) 17:25:10 INFO - [mozharness: 2017-03-16 00:25:10.546354Z] Running run-tests step. 17:25:10 INFO - Running pre-action listener: _resource_record_pre_action 17:25:10 INFO - Running main action method: run_tests 17:25:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:25:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:25:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:25:10 INFO - 2017-03-15 17:25:10.561 screenresolution[1905:20877] starting screenresolution argv=screenresolution get 17:25:10 INFO - 2017-03-15 17:25:10.564 screenresolution[1905:20877] Display 0: 1600x1200x32@60 17:25:10 INFO - 2017-03-15 17:25:10.569 screenresolution[1906:20880] starting screenresolution argv=screenresolution list 17:25:10 INFO - Available Modes on Display 0 17:25:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:25:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:25:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:25:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:25:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:25:10 INFO - Intel Iris: 17:25:10 INFO - Chipset Model: Intel Iris 17:25:10 INFO - Type: GPU 17:25:10 INFO - Bus: Built-In 17:25:10 INFO - VRAM (Dynamic, Max): 1536 MB 17:25:10 INFO - Vendor: Intel (0x8086) 17:25:10 INFO - Device ID: 0x0a2e 17:25:10 INFO - Revision ID: 0x0009 17:25:10 INFO - Displays: 17:25:10 INFO - Display: 17:25:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:25:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:25:10 INFO - Display Serial Number: 1600x1200 60 17:25:10 INFO - Main Display: Yes 17:25:10 INFO - Mirror: Off 17:25:10 INFO - Online: Yes 17:25:10 INFO - Rotation: Supported 17:25:10 INFO - Return code: 0 17:25:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:25:10 INFO - Python 2.7.3 17:25:10 INFO - Return code: 0 17:25:10 INFO - grabbing minidump binary from tooltool 17:25:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:25:10 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 0x10be7dd30>, '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 0x10bda4db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10be72be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:25:10 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 17:25:10 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 17:25:10 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 17:25:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:25:10 INFO - Return code: 0 17:25:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:25:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:25:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:25:10 INFO - ENV: RUST_BACKTRACE is now 1 17:25:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:25:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:25:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AvL1bm5CSrO1B75BiIZUCA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--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 17:25:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AvL1bm5CSrO1B75BiIZUCA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0163 --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 17:25:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.0JKR6Blrrz/Render', 17:25:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:25:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:25:10 INFO - 'HOME': '/Users/cltbld', 17:25:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:25:10 INFO - 'LOGNAME': 'cltbld', 17:25:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:25:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:25:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:10 INFO - 'MOZ_NO_REMOTE': '1', 17:25:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:25:10 INFO - 'NO_EM_RESTART': '1', 17:25:10 INFO - 'PAGER': '/bin/cat', 17:25:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:25:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:10 INFO - 'PWD': '/builds/slave/test', 17:25:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:25:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:25:10 INFO - 'RUST_BACKTRACE': '1', 17:25:10 INFO - 'SHELL': '/bin/bash', 17:25:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.d2VYYEbgyL/Listeners', 17:25:10 INFO - 'TMPDIR': '/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/', 17:25:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:25:10 INFO - 'USER': 'cltbld', 17:25:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:25:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:25:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:10 INFO - 'XPC_FLAGS': '0x0', 17:25:10 INFO - 'XPC_SERVICE_NAME': '0', 17:25:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:25:10 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AvL1bm5CSrO1B75BiIZUCA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0163', '--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 17:25:11 INFO - mozversion application_buildid: 20170315161236 17:25:11 INFO - mozversion application_changeset: e00635bc10f072b7ab93640a6094b3d92e8ab740 17:25:11 INFO - mozversion application_display_name: FirefoxDeveloperEdition 17:25:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:25:11 INFO - mozversion application_name: Firefox 17:25:11 INFO - mozversion application_remotingname: firefox-dev 17:25:11 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:25:11 INFO - mozversion application_vendor: Mozilla 17:25:11 INFO - mozversion application_version: 54.0a2 17:25:11 INFO - mozversion platform_buildid: 20170315161236 17:25:11 INFO - mozversion platform_changeset: e00635bc10f072b7ab93640a6094b3d92e8ab740 17:25:11 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 17:25:11 INFO - mozversion platform_version: 54.0a2 17:25:11 INFO - using testdate: 1489623911 17:25:11 INFO - actual date: 1489623911 17:25:11 INFO - starting webserver on 'localhost:56460' 17:25:11 INFO - SUITE-START | Running 2 tests 17:25:11 INFO - TEST-START | dromaeo_css 17:25:11 INFO - operating with platform_type : mac_ 17:25:11 INFO - Initialising browser for dromaeo_css test... 17:25:11 INFO - TEST-INFO | started process 1916 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpLYRC99/profile http://localhost:56460/getInfo.html) 17:25:14 INFO - PROCESS | 1916 | 2017-03-15 17:25:14.106 plugin-container[1918:21053] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x903b, name = 'com.apple.tsm.portname' 17:25:14 INFO - PROCESS | 1916 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:25:14 INFO - PROCESS | 1916 | 2017-03-15 17:25:14.109 plugin-container[1918:21053] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x940b, name = 'com.apple.CFPasteboardClient' 17:25:14 INFO - PROCESS | 1916 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:25:14 INFO - PROCESS | 1916 | 2017-03-15 17:25:14.109 plugin-container[1918:21053] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:25:14 INFO - PROCESS | 1916 | __metrics Screen width/height:1600/1200 17:25:14 INFO - PROCESS | 1916 | colorDepth:24 17:25:14 INFO - PROCESS | 1916 | Browser inner width/height: 1024/689 17:25:14 INFO - PROCESS | 1916 | __metrics 17:25:14 ERROR - PROCESS | 1916 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 17:25:15 INFO - TEST-INFO | 1916: exit 0 17:25:15 INFO - Browser initialized. 17:25:15 INFO - Running cycle 1/1 for dromaeo_css test... 17:25:15 INFO - TEST-INFO | started process 1919 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmpLYRC99/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:25:17 INFO - PROCESS | 1919 | 2017-03-15 17:25:17.367 plugin-container[1920:21189] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8937, name = 'com.apple.tsm.portname' 17:25:17 INFO - PROCESS | 1919 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:25:17 INFO - PROCESS | 1919 | 2017-03-15 17:25:17.368 plugin-container[1920:21189] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4707, name = 'com.apple.CFPasteboardClient' 17:25:17 INFO - PROCESS | 1919 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:25:17 INFO - PROCESS | 1919 | 2017-03-15 17:25:17.368 plugin-container[1920:21189] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:25:27 INFO - PROCESS | 1919 | RSS: Main: 220114944 17:25:27 INFO - PROCESS | 1919 | 17:28:31 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:56460/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56460/tests/dromaeo/cssquery-ext.html) 17:28:32 INFO - PROCESS | 1919 | RSS: Main: 241471488 17:28:32 INFO - PROCESS | 1919 | 17:30:15 INFO - PROCESS | 1919 | ************************* 17:30:15 INFO - PROCESS | 1919 | A coding exception was thrown and uncaught in a Task. 17:30:15 INFO - PROCESS | 1919 | 17:30:15 ERROR - PROCESS | 1919 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:30:15 INFO - PROCESS | 1919 | Full stack: 17:30:15 INFO - PROCESS | 1919 | ************************* 17:31:34 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:56460/tests/dromaeo/cssquery-ext.html (next: http://localhost:56460/tests/dromaeo/cssquery-jquery.html) 17:31:35 INFO - PROCESS | 1919 | RSS: Main: 251035648 17:31:35 INFO - PROCESS | 1919 | 17:34:37 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:56460/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56460/tests/dromaeo/cssquery-mootools.html) 17:34:37 INFO - PROCESS | 1919 | RSS: Main: 257921024 17:34:37 INFO - PROCESS | 1919 | 17:37:39 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:56460/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56460/tests/dromaeo/cssquery-prototype.html) 17:37:40 INFO - PROCESS | 1919 | RSS: Main: 255021056 17:37:40 INFO - PROCESS | 1919 | 17:40:43 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:56460/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56460/tests/dromaeo/cssquery-yui.html) 17:40:44 INFO - PROCESS | 1919 | RSS: Main: 260067328 17:40:44 INFO - PROCESS | 1919 | 17:43:46 INFO - PROCESS | 1919 | Cycle 1(1): loaded http://localhost:56460/tests/dromaeo/cssquery-yui.html (next: http://localhost:56460/tests/dromaeo/cssquery-dojo.html) 17:43:47 INFO - PROCESS | 1919 | RSS: Main: 256327680 17:43:47 INFO - PROCESS | 1919 | 17:43:47 INFO - PROCESS | 1919 | __start_tp_report 17:43:47 INFO - PROCESS | 1919 | _x_x_mozilla_page_load 17:43:47 INFO - PROCESS | 1919 | _x_x_mozilla_page_load_details 17:43:47 INFO - PROCESS | 1919 | |i|pagename|runs| 17:43:47 INFO - PROCESS | 1919 | |0;dojo.html;3390.694837464629;3399.1672040350104;3409.6590340965904;3411.573553305837;3416.4192087345155;4883.316335713003;5827.358990511046;5845.824625261243;5955.761769529214;5959.791407300745;5092.974535127329;5922.822315330536;5974.074018527124;6000.459958603725;6029.6382217067;5370.812021579255;5388.892222155555;5395.7032363220005;5415.593830462712;5447.400785913546;5436.91844622329;5443.727813609324;5448.046591846411;5472.72636368182;5530.668159910419;5202.739863006854;5258.737063146847;5442.374126975409;5449.3188351456065;5461.1535212042;4765.66561362819;5163.974180129076;5370.382406023318;5385.515303622654;5389.541888939445;5224;5372.623916325859;5378.731063446812;5395.649282796606;5430.13117901134;5651.265335506399;5972.880542389172;5973.790917317917;6000.159977603139;6040.48655864252;6182.567220294582;6186.10301506279;6237.376262373772;6281.277653069909;6296;6342.714577843962;6387.329330420332;6389.936100638981;6409.327020662857;6416.348147593005;6075;6089.269287685506;6106.877862442726;6110.511159107261;6131.2335958004805;6144.955357589131;6151;6318.842028949313;6353.714082866282;6486.935130648633;6238.438540531374;6276.964300890393;6292.559520833589;6306.49548036156;6311.526635502356;6322.114903913456;6334.936650633527;6335.746570137235;6343.302236753953;6345.555811093179;6126.548209435026;6133.73253493014;6198.411150940653;6218.694074244459;6237.688115594202;6165.815025549151;6283.02613094971;6294.622322660655;6297.653629050446;6300.117983482316;4212.641925436311;5033.0688822567945;5080.847574572768;5109.259157422153;5109.718965456861;4531.660125490602;4553.590176884097;4562.406887104655;4578.2903649934315;4580.65645076614;5127.846164615067;5896.823095307148;5977.850553736192;6037.154798328237;6042.6978651067275;6332.873342533216;6361.173047503888;6377.3303803100935;6412.647304398303;6434.420902118832;5636.605437619327;5978.4021597839865;5990.940090599125;6008.24896887889;6016.067509536029;5525.11598144303;5526.696031718214;5573.777048918079;5618.2415373924;5622.044252477089;6546.803595892131;6550.377714117151;6551.5413921026975;6568.146141001639;6583.0454584086;6326.715297811517;6340.731853629385;6342.143810585697;6348.555601107878;6367.363263673596;5469.234307196916;6121;6429.067785171031;6434.4852411806005;6499.5775274607;5610.298712660918;6027.668478233564;6284.402981716729;6288.434040936338;6305.5901366411035;6148.44663980244;6300.936990630035;6304.905426418516;6309.716062777278;6329.588576742497;6082.300535438481;6143.723532440961;6164.660943648142;6221.160143380766;6261.62430254168;5105.2597373381395;5142.280080788618;6153.446189842935;6195.721192546256;6241.375862413723;6010.2186715726675;6159.568830182024;6220.253569571681;6221.626702397871;6223.471004964629;6069.696515174135;6131.478824299985;6141.140240366263;6199.628022318675;6206.503479721521;6165.106059621419;6176;6188.597741146811;6192.102145189013;6195.938040619536 17:43:47 INFO - PROCESS | 1919 | |1;ext.html;747.9715391336912;801.430984001359;826.8718348655957;855.1790281329927;966.4684423567037;36544;37498;38780.41829372555;38819;38843.640472583465;37573.248535029285;37804.73171609698;37824;37895;37899.24201515968;7059.6823142958565;7959.920400795976;10432;10724;10767;10527.894721052806;10726.356418614909;10734.30227035244;10740.516676749527;10753.354798712064;10717.517711702953;10724.463776811168;10758.408287544182;10763.408012559306;10768.78462430751;10693.83959240612;10704.30422022566;10712.78574428507;10744.355338679627;10753.193510486706;10360.94819525905;10411.843822342671;10420.843687344695;10437.269391142623;10456.32033917793;32720;32829;33012.834935825405;33052.83473582641;33080.66919330824;3128.8435578220997;3714.368557345231;3732.675581458957;3742.401215805458;3926.0577461409343;22437.663435048486;23791.286261412013;23958.520829583485;25037.12370067057;25720.228393148234;3057.617797775278;3097.0708787363924;3100.268425796599;3118.1425108095227;3139.073973177918;319602;324316;324466;325575;385633;40974.590254097675;41348.37977430341;41389;41389.793051034554;41393.79303103525;44433;44544.10911781746;44565;44571.108577828265;45093.54906450894;12681.619551413472;12761.29812860283;12773.169743966613;12778.808317875239;12797;9015.909840901639;9397.483138427315;10645.361278323326;11005.229633925708;11044.226904116795;11646.650600481998;11678.70803229926;11688.94155529217;11691.707707307216;11755.412229388496;5590.636608620427;5617.859553511195;5629.183768353566;5690.658560486384;5722.399148089474;911.2983003087586;1037.6523864505475;1039.7556574205055;1041.4011943132577;1057.1120258982337;18818.811811881707;26132.34669133249;26309;26395.208143755717;26428.73571264301;885.6059053721033;1127.1658972360558;1163.3543383422282;1165.7493638867516;1174.4362705901215;13182.802257966137;13516.93241533786;13789.310534473236;13838.723225535434;13866;397097;402244.9887750542;404396;404817;405682;52291;52682.20976685353;52711.73644131832;52721.7363913178;52785.47214527882;1425.9144451332954;1460.5910345103175;1462.4004158295047;1463.7584798508126;1469.162577330911;24825.50348992974;24905.377365566004;25635.615465767656;25793.484130317665;25953.480930381666;39457.605423945395;39482.60517394789;39485;39516.40725389179;39547.2090558193;382028;382440;382735;383119;383696;26098.86950565235;26962;27018.784154713478;30353.544696829125;30408.695913041473;42084.57915420929;43076;43682.88736776602;43829.123417530835;45242.32136518021;31690.04929852108;34744;35992.100197495274;36551.45172822463;36741.26517469689;32444;35275;35618.46572301469;36309;36511.72208972673;34971.30057398787;35413;35847.82076089603;35950;36258.36837342273;30625;31943;31945.68054319427;31987;32018.839905800323;24022.67875266877;24307.878460607582;24449.755502444747;24619.753802462463;24749.752502475465 17:43:47 INFO - PROCESS | 1919 | |2;jquery.html;355.92881423715255;389.30703348040487;409.7582426368442;410.69198101423933;453.97503137327453;19814;21227.363179104632;21311;21628.134874604995;21836.45408864779;17696.38062667807;18105.642076844222;19123.330683426084;22378.776212237914;22545.774542254574;6103.877922441548;6437.034444833289;6526.4778817694705;6560.671966401685;6567.85062614043;6093.451589356957;6307.873842523147;6363.0773537836985;6393;6496.772612958547;6525.412712855842;6554.9344506555035;6559.475241980654;6564.868702625945;6574.04676321933;6495.545311828174;7089.89365159523;7411.073615797998;7541.962290188569;7567.356774674159;6220.377962203788;7078.929210707878;7314.5976971266555;7350.4854660173805;7381.9630901845685;25607.871960640263;25645.845936932696;26342.73657263422;26377.604335934975;26749.930002799865;3208.1658768720067;3222.419964406406;3310.8013519188926;3311.806426351702;3404.5063465797566;14604.853951460456;15419.922900385427;15688;16283.918580407022;16536.917315413466;1970.5172232803054;2037.7860324665844;2040.877547347164;2042.5506388594486;2042.7548694156649;151584;168088;174602.1269893655;174880;175169;20751.68872466914;21174;21232.575348492945;21269.68095478569;21533.89233053825;32158.678413216036;32286.83856580749;32710.67289327124;32718.83640581782;32812.67187328096;8302.750917472486;9976.900230997742;10112.342697724771;10271.332363396356;10431.426271555138;6688.866222675617;8378.371622128365;8399.95800020996;8550.957245213858;8551;9718.222542196607;9718.562664680107;9778.31551791382;9866.556004979793;9911.851322230172;3363.8654453821573;3371.364888029304;4032.516098068251;4098.631123198927;4117.444145040381;1025.661531694554;1038.787048655024;1049.2078480746986;1054.9419781911915;1061.5170097605571;17195.828041719673;17315.393961211295;19064.474842012605;20670.48323791887;20719.27482538104;920.30516959695;923.422860712055;1010.8584798128268;1033.0495943731785;1045.3571053801857;9395.859062114074;10238.12975897057;11132.777344453227;12073.698157546132;12471.75056498865;668567;782205;785705;788092.05953971;801484;99278;141133.29433352768;144152;144334;171088;1226.3316492511424;1242.2670624331506;1294.6892745741143;1323.9007074469453;1389.5831250624772;18787.436376908714;20211.292604758764;20227.494312641713;20272.493187669836;20419.59160816805;61371.69314153579;66007.66996164988;66601;67351.66324168348;68739.62520749457;74295.25704743099;78288.65134045988;81365.9658508542;86579.56710216409;94336.52831736072;10187.541560629938;11472.369019703663;11751.471183796579;11761.414726745998;11988.46051927648;11200.887991119984;13174.80237796453;13297.933510332387;13412.463501459832;13593.320333983063;11404.429778511207;11427.714307142389;11482.36846973391;11515.481803318704;11648.708782280512;9314.627414903329;9496.76542049529;10592.788144236918;11090.168237382068;11186.888131118585;11553.595624153115;11595.420228988685;11637.825432618349;11969.820452693042;12040.879591204326;9202.677906273248;11679.124065694938;11901.642950711492;11908.880911191123;11915.702107447036;9989.900100998897;10279.53742081623;11247.943760281147;11324.716882078013;11443.656690299304 17:43:47 INFO - PROCESS | 1919 | |3;mootools.html;1461.9342129604167;1540.5917431880546;1544.2896267716849;1588.44332554097;1600.887937844351;10603.469826508672;10850.511726972285;11216.270942388759;11257.6622701319;11258.099352051837;10994.615188468406;11182.105431565476;11204.831927521094;11238.550457981692;11277.605283815048;2373.5964885969343;2404.615261558151;2414.2998530426244;2415.5168966206743;2431.1369463840347;2347.0377145370317;2376.7742064503846;2396.3290278721897;2400.6879105716234;2409.590369637166;2322.6980492535945;2363.72817126031;2367.230650038736;2373.596488596943;2378.3816207785926;2331.1258278145697;2332.230363979891;2334.9416264593438;2338.088145623208;2347.1080989224156;2125.2667829598763;2251.808596269319;2335.2760644200353;2360.055977608953;2391.7249516305674;10983.835242471368;11144.944275278653;11148.108151347873;11158.218924675195;11160.386178760245;5671.177679236529;5813.651180929158;5845.707714614252;5852;5909.379515150933;3512.982435087834;3611.205534782344;3651.6348365163535;3668.413053911388;3682.0794801299676;1110.5946329589642;1157.2073129906041;1199.2384835629439;1225.185251807556;1229.4959066782576;12239.571614993432;12793.168444051107;13449.932750336284;15204;15475;4319.395284660087;4320.071184695305;4566;4724.976375118171;4734.455537613149;11766.117541184445;11791.115666324888;11817.704557386134;11823.231489953125;11845.763084738257;5662.490375866192;5691.117876729114;5702;5718.4567466091485;5757.337906140764;5030.572401345853;5191.714455704972;5268.394134674561;5270.736463176902;5279.656822306538;3281.605317739951;3857.1707082977296;3942.6254505821903;3967.722259441869;4059.4519739834745;1032.2774058159318;1035.5857656937135;1039.1894322428366;1044.9602645367906;1046.1682962045193;923.5013092929877;923.7505873414141;950.8193443245762;964.252704154272;1004.5630150884389;6378.904316435257;6464.967675161594;6604.174478190226;6663.800085997428;6777.695003724844;973.2068364283086;996.9501524923725;1053.5996321397972;1058.513083981362;1069.9304545204536;3446.5691788526433;4107.199096176277;4156.2726522858375;4237.449131612932;4389.297712366006;12824.615261542169;13532.391042403115;13844.861551384558;13875.444982200801;14003.579892603238;13583;13595.184288942695;13597.796033059512;13606;13696.383662735201;9989.700308990596;10247.487625618689;10252.333598316085;10254.692359229235;10340.224483163793;5759.280089988752;5803.883922321615;6650.168728908887;6685.76599819004;6975;12063.457144428347;12210.633680989584;12361.876381236072;12373.75252494963;12405.937970310091;10439.791204176026;12281.631551053126;12377.62867113988;12759;12793.61619151427;9152.95423522878;9411.717648470556;9470.526473676151;9523.666671666459;9534.809303814023;10303.896961030294;10351.430671312848;10368.637097701545;10427.530761115617;10492.055714985689;7716.459847810824;9134.040925702706;9158.313126515404;9245.815083698422;9350.345475816628;8949.776255593662;9000.414973026733;9038.774030649287;9094.27245820346;9105.317101217302;7742.032245969254;7801.765947021599;7871.33093687043;7890.171531989058;7933.246341597539;5862.091375836752;5873.2658417697785;5897.970510147422;6038.9396106038375;6124.877502449837;5171.798481273716;5899.203607512931;5978.940210597838;6082.2093127893095;6235.469985051322 17:43:47 INFO - PROCESS | 1919 | |4;prototype.html;333.81973734183543;365.3150343106675;371.331603114394;382.9540455145381;386.3046516270713;4357.668647273706;4771.26045462953;5053.343065401493;5325.707086110262;5359.785608575652;4755.9774648450575;4786.83246086387;4831.541003604661;5117.498688909419;5190.688558686482;3621.7283703722196;3859.4017927221325;3983.9800800996027;4342.849144976583;4360.694751367406;3437.175077981279;3699.3537875645347;3895.2404281165186;4386.517483076859;4404.977975110136;4203.822929579723;4319.071399649075;4320.805563749639;4332.24185767491;4341.701715301844;3541.858325666983;4253.1706317268145;4352.630026447756;4398.778616798496;4404.537523560012;3390.7117894978956;3491.0050635568996;4037.394390841368;4043.028374145001;4044.777537235451;5022.623303252234;5038.244263360489;5050.39395272566;5056.393232812086;5071.18860982241;4965.088440950224;5035.748212589392;5050.84847454577;5069.898602027939;5074.644774865761;4679.789409476582;5420.915816836648;5674.3190817101795;5694.97828270962;5722.570807189436;3836.5204349456317;3997.760134391946;4351.238533256667;4465.303184789792;4480.72299394671;5006.5744411725045;5245.711485868275;5411.998780225632;5611.915821262725;6001.48987336077;4033.415154802537;4207.347861081537;4441.689081764245;4500.887477813016;4562.520935301812;3863.6522712955407;4191.161767646483;4326.048269380732;4634.652401069933;4636.629069674418;4043.433919251307;4219.683523735671;4673.883152921137;4761.024174967419;4975.950240497621;4992.825251116194;5199.766010529535;5616.943830561724;5619.831405057855;5634.605577609528;1364.5428781358355;1418.7233489469454;1534.3325653340833;1590.9443169489011;1593.5060131359317;1004.7287232447198;1022.8465730140539;1079.6976846482996;1122.9213955023233;1148.5463242019523;5246;5247.685138891678;5260.237265596467;5274.868128296746;5302.973485132549;5124.821291103067;5713.143028545752;5791.88416231673;5841.591088623755;5886.175935369051;4596.862094137181;4897.8285759998225;5006.07387633289;5172.948270517247;5245.485524698462;2540.9455076143195;2771.3810449125785;2957.896473623413;2999.3203805868347;3043.239190202449;5213.817516386908;5681;5845.006348920694;5916.160243083258;5919.496842768327;4903.621743454421;5665.9716701417055;5707.229524014288;5747.798827041033;5782.566307526952;5432.5231851615;6052.485538729257;6062.969685151635;6110.800111959691;6159.6612186330185;5054.321209758834;5259.868503287448;5279.6040296978645;5555.22226888244;5845.795397161079;5202.817901373433;5492.60591526769;5540.86147846291;5725.366331487396;5781.624194427349;5483.040467918018;5836.708164591669;5972.372900845348;6037.547183961133;6059.757609695739;4034.936155125299;4336.002719374625;4459.420275364182;4607.525591810589;4649.86050418488;4989.850304490871;5178.456262092426;5309.929127640146;5718.168826885913;5857.326407463026;5642.379338272869;5670.8015219467125;5674.77300907959;5697.601167918372;5741.5406767459335;4435.489918659267;5526.640768350045;5691.605556638485;5693.047049067172;5834.7082645866685;5067.087924173684;5131.948680513147;5223;5468.91796623059;5514.724263786875;4527.592516673515;5264.447233040476;5580.5535557156145;5593.356763972032;5704.543636508986;4542.957317377774;4753.453352864465;4776.47458779527;5252.9737351313;5372.811951581833 17:43:47 INFO - PROCESS | 1919 | |5;yui.html;718.75562308815;719.8416348403349;796.968121275149;797.8949155419743;833.2459124492335;14003.369848356822;14438.566842994727;14876.702465950688;16031.679366412665;16104.35582576697;14877.479288224915;14912;15005.62485937852;15036.699266014673;15083.62290942727;862.594580547145;894.5348418822208;900.2392977933636;919.7838507950627;928.1414691410453;922.6862866625346;926.0646746785761;926.6339795780663;926.763675262807;927.717046300878;931.1154403316876;964.2430691906854;976.7216343342113;977.8826540815112;983.4443539400216;954.5799848066863;961.2790407194605;967.5259123029736;967.67099186277;972.1882228339346;699.6047233313162;701.1621112770241;702.2100137345486;702.301210295759;702.585474570001;13317.26755028473;14109.64725881851;14233.146011239358;14761.483348082766;16743.995360278423;13899.79150312746;13993.650158746012;14240.501582444565;14260.786088208684;14264.144151350849;10999.395033273247;11504.367259800707;11805.881941180563;11865.347405892673;11960.521579136825;4448.154850578412;4482.282834746425;4497.257952437843;4631.560001799824;4659.5573420525;70268;83222;100622.99999999927;100997;101907.49046254721;10495.422751748574;10599.682009539727;10705.9464702676;10746.94626526878;10815.242932994772;16910.492685219462;20506.79493205049;20742.688859667116;20775.37673869786;20909.05909234088;7269.418446524265;7406.8888966665545;7498.700051997859;7506.36638548465;7539.472236943361;3812.790296533717;3902.004988727856;3903.4925459690626;3934.350832112669;3935.5670876203594;3371.3088816792497;3411.2154204533094;3435.3129374125274;3437.8796742113905;3442.9655703443145;632.8670979094442;635.3995474276857;637.1632384514189;643.1189270699172;653.4804830160034;536.6753114365753;546.9753861076262;550.6558400999376;551.48987186852;558.5168828962999;9304.767380815398;9816.263780216512;9878.308518403786;9901.455419951972;10024.649137280161;593.3562085137588;598.7156100852061;644.8162273751958;652.420011519133;654.1234745441132;4781.163296423181;4831.100395217646;4851.417829860439;4899.877503062381;5077.441481437039;97841;98603.50698246463;99890;100116.49941750245;101795;53862;54141.72929135408;75902.8614570782;89105;90483.54758226167;75555.62222188854;77026;77304.61347693337;77847.22152778514;78361;9137.40606860552;10017.899821001696;10852;10969.890301096886;11123.555057797921;34008.829955850066;34999;38513.03717407087;43619;48153.07387704593;57240.42759572351;57590;57661.711691441276;58232.12651810311;58525.70737146287;12689.482421001376;12749.765922266612;12951.481940722266;12979.28613926243;13279.734405311647;14906.701865962837;15001.849981500045;15068.924655376653;15080.396784128512;15291.388344466097;13749.381277842722;13883.65290867696;14102.929485352508;14279.785803212751;14337.856621433652;11565.942170289094;11664.591739289084;13440.193588384729;13972.650683732989;14364.353604087632;12065.73309802458;13243.735125297633;13568;13821.86178138246;14482.637934051732;10502.894971050191;11130;11338.829917551408;11477.139214559109;11755.941220293844;10220.59117635316;10751.354918704903;11317.207795454238;11709.063274937815;11731.354775487089 17:43:47 INFO - PROCESS | 1919 | __end_tp_report 17:43:47 INFO - PROCESS | 1919 | __start_cc_report 17:43:47 INFO - PROCESS | 1919 | _x_x_mozilla_cycle_collect,411 17:43:47 INFO - PROCESS | 1919 | __end_cc_report 17:43:47 INFO - PROCESS | 1919 | __startTimestamp1489625027219__endTimestamp 17:43:47 INFO - PROCESS | 1919 | 17:43:47 INFO - PROCESS | 1919 | ------- Summary: start ------- 17:43:47 INFO - PROCESS | 1919 | Number of tests: 6 17:43:47 INFO - PROCESS | 1919 | 17:43:47 INFO - PROCESS | 1919 | [#0] dojo.html Cycles:165 Average:5843.10 Median:6121.00 stddev:659.90 (10.8%) stddev-sans-first:633.26 17:43:47 INFO - PROCESS | 1919 | Values: 3390.7 3399.2 3409.7 3411.6 3416.4 4883.3 5827.4 5845.8 5955.8 5959.8 5093.0 5922.8 5974.1 6000.5 6029.6 5370.8 5388.9 5395.7 5415.6 5447.4 5436.9 5443.7 5448.0 5472.7 5530.7 5202.7 5258.7 5442.4 5449.3 5461.2 4765.7 5164.0 5370.4 5385.5 5389.5 5224.0 5372.6 5378.7 5395.6 5430.1 5651.3 5972.9 5973.8 6000.2 6040.5 6182.6 6186.1 6237.4 6281.3 6296.0 6342.7 6387.3 6389.9 6409.3 6416.3 6075.0 6089.3 6106.9 6110.5 6131.2 6145.0 6151.0 6318.8 6353.7 6486.9 6238.4 6277.0 6292.6 6306.5 6311.5 6322.1 6334.9 6335.7 6343.3 6345.6 6126.5 6133.7 6198.4 6218.7 6237.7 6165.8 6283.0 6294.6 6297.7 6300.1 4212.6 5033.1 5080.8 5109.3 5109.7 4531.7 4553.6 4562.4 4578.3 4580.7 5127.8 5896.8 5977.9 6037.2 6042.7 6332.9 6361.2 6377.3 6412.6 6434.4 5636.6 5978.4 5990.9 6008.2 6016.1 5525.1 5526.7 5573.8 5618.2 5622.0 6546.8 6550.4 6551.5 6568.1 6583.0 6326.7 6340.7 6342.1 6348.6 6367.4 5469.2 6121.0 6429.1 6434.5 6499.6 5610.3 6027.7 6284.4 6288.4 6305.6 6148.4 6300.9 6304.9 6309.7 6329.6 6082.3 6143.7 6164.7 6221.2 6261.6 5105.3 5142.3 6153.4 6195.7 6241.4 6010.2 6159.6 6220.3 6221.6 6223.5 6069.7 6131.5 6141.1 6199.6 6206.5 6165.1 6176.0 6188.6 6192.1 6195.9 17:43:47 INFO - PROCESS | 1919 | 17:43:47 INFO - PROCESS | 1919 | [#1] ext.html Cycles:180 Average:50943.29 Median:32002.92 stddev:99154.73 (309.8%) stddev-sans-first:99361.27 17:43:47 INFO - PROCESS | 1919 | Values: 748.0 801.4 826.9 855.2 966.5 36544.0 37498.0 38780.4 38819.0 38843.6 37573.2 37804.7 37824.0 37895.0 37899.2 7059.7 7959.9 10432.0 10724.0 10767.0 10527.9 10726.4 10734.3 10740.5 10753.4 10717.5 10724.5 10758.4 10763.4 10768.8 10693.8 10704.3 10712.8 10744.4 10753.2 10360.9 10411.8 10420.8 10437.3 10456.3 32720.0 32829.0 33012.8 33052.8 33080.7 3128.8 3714.4 3732.7 3742.4 3926.1 22437.7 23791.3 23958.5 25037.1 25720.2 3057.6 3097.1 3100.3 3118.1 3139.1 319602.0 324316.0 324466.0 325575.0 385633.0 40974.6 41348.4 41389.0 41389.8 41393.8 44433.0 44544.1 44565.0 44571.1 45093.5 12681.6 12761.3 12773.2 12778.8 12797.0 9015.9 9397.5 10645.4 11005.2 11044.2 11646.7 11678.7 11688.9 11691.7 11755.4 5590.6 5617.9 5629.2 5690.7 5722.4 911.3 1037.7 1039.8 1041.4 1057.1 18818.8 26132.3 26309.0 26395.2 26428.7 885.6 1127.2 1163.4 1165.7 1174.4 13182.8 13516.9 13789.3 13838.7 13866.0 397097.0 402245.0 404396.0 404817.0 405682.0 52291.0 52682.2 52711.7 52721.7 52785.5 1425.9 1460.6 1462.4 1463.8 1469.2 24825.5 24905.4 25635.6 25793.5 25953.5 39457.6 39482.6 39485.0 39516.4 39547.2 382028.0 382440.0 382735.0 383119.0 383696.0 26098.9 26962.0 27018.8 30353.5 30408.7 42084.6 43076.0 43682.9 43829.1 45242.3 31690.0 34744.0 35992.1 36551.5 36741.3 32444.0 35275.0 35618.5 36309.0 36511.7 34971.3 35413.0 35847.8 35950.0 36258.4 30625.0 31943.0 31945.7 31987.0 32018.8 24022.7 24307.9 24449.8 24619.8 24749.8 17:43:47 INFO - PROCESS | 1919 | 17:43:47 INFO - PROCESS | 1919 | [#2] jquery.html Cycles:180 Average:43448.53 Median:21581.01 stddev:127897.91 (592.6%) stddev-sans-first:128215.77 17:43:47 INFO - PROCESS | 1919 | Values: 355.9 389.3 409.8 410.7 454.0 19814.0 21227.4 21311.0 21628.1 21836.5 17696.4 18105.6 19123.3 22378.8 22545.8 6103.9 6437.0 6526.5 6560.7 6567.9 6093.5 6307.9 6363.1 6393.0 6496.8 6525.4 6554.9 6559.5 6564.9 6574.0 6495.5 7089.9 7411.1 7542.0 7567.4 6220.4 7078.9 7314.6 7350.5 7382.0 25607.9 25645.8 26342.7 26377.6 26749.9 3208.2 3222.4 3310.8 3311.8 3404.5 14604.9 15419.9 15688.0 16283.9 16536.9 1970.5 2037.8 2040.9 2042.6 2042.8 151584.0 168088.0 174602.1 174880.0 175169.0 20751.7 21174.0 21232.6 21269.7 21533.9 32158.7 32286.8 32710.7 32718.8 32812.7 8302.8 9976.9 10112.3 10271.3 10431.4 6688.9 8378.4 8400.0 8551.0 8551.0 9718.2 9718.6 9778.3 9866.6 9911.9 3363.9 3371.4 4032.5 4098.6 4117.4 1025.7 1038.8 1049.2 1054.9 1061.5 17195.8 17315.4 19064.5 20670.5 20719.3 920.3 923.4 1010.9 1033.0 1045.4 9395.9 10238.1 11132.8 12073.7 12471.8 668567.0 782205.0 785705.0 788092.1 801484.0 99278.0 141133.3 144152.0 144334.0 171088.0 1226.3 1242.3 1294.7 1323.9 1389.6 18787.4 20211.3 20227.5 20272.5 20419.6 61371.7 66007.7 66601.0 67351.7 68739.6 74295.3 78288.7 81366.0 86579.6 94336.5 10187.5 11472.4 11751.5 11761.4 11988.5 11200.9 13174.8 13297.9 13412.5 13593.3 11404.4 11427.7 11482.4 11515.5 11648.7 9314.6 9496.8 10592.8 11090.2 11186.9 11553.6 11595.4 11637.8 11969.8 12040.9 9202.7 11679.1 11901.6 11908.9 11915.7 9989.9 10279.5 11247.9 11324.7 11443.7 17:43:47 INFO - PROCESS | 1919 | 17:43:47 INFO - PROCESS | 1919 | [#3] mootools.html Cycles:180 Average:6709.96 Median:2394.03 stddev:4174.19 (174.4%) stddev-sans-first:4167.27 17:43:47 INFO - PROCESS | 1919 | Values: 1461.9 1540.6 1544.3 1588.4 1600.9 10603.5 10850.5 11216.3 11257.7 11258.1 10994.6 11182.1 11204.8 11238.6 11277.6 2373.6 2404.6 2414.3 2415.5 2431.1 2347.0 2376.8 2396.3 2400.7 2409.6 2322.7 2363.7 2367.2 2373.6 2378.4 2331.1 2332.2 2334.9 2338.1 2347.1 2125.3 2251.8 2335.3 2360.1 2391.7 10983.8 11144.9 11148.1 11158.2 11160.4 5671.2 5813.7 5845.7 5852.0 5909.4 3513.0 3611.2 3651.6 3668.4 3682.1 1110.6 1157.2 1199.2 1225.2 1229.5 12239.6 12793.2 13449.9 15204.0 15475.0 4319.4 4320.1 4566.0 4725.0 4734.5 11766.1 11791.1 11817.7 11823.2 11845.8 5662.5 5691.1 5702.0 5718.5 5757.3 5030.6 5191.7 5268.4 5270.7 5279.7 3281.6 3857.2 3942.6 3967.7 4059.5 1032.3 1035.6 1039.2 1045.0 1046.2 923.5 923.8 950.8 964.3 1004.6 6378.9 6465.0 6604.2 6663.8 6777.7 973.2 997.0 1053.6 1058.5 1069.9 3446.6 4107.2 4156.3 4237.4 4389.3 12824.6 13532.4 13844.9 13875.4 14003.6 13583.0 13595.2 13597.8 13606.0 13696.4 9989.7 10247.5 10252.3 10254.7 10340.2 5759.3 5803.9 6650.2 6685.8 6975.0 12063.5 12210.6 12361.9 12373.8 12405.9 10439.8 12281.6 12377.6 12759.0 12793.6 9153.0 9411.7 9470.5 9523.7 9534.8 10303.9 10351.4 10368.6 10427.5 10492.1 7716.5 9134.0 9158.3 9245.8 9350.3 8949.8 9000.4 9038.8 9094.3 9105.3 7742.0 7801.8 7871.3 7890.2 7933.2 5862.1 5873.3 5898.0 6038.9 6124.9 5171.8 5899.2 5978.9 6082.2 6235.5 17:43:47 INFO - PROCESS | 1919 | 17:43:47 INFO - PROCESS | 1919 | [#4] prototype.html Cycles:180 Average:4620.48 Median:5037.00 stddev:1324.29 (26.3%) stddev-sans-first:1288.33 17:43:47 INFO - PROCESS | 1919 | Values: 333.8 365.3 371.3 383.0 386.3 4357.7 4771.3 5053.3 5325.7 5359.8 4756.0 4786.8 4831.5 5117.5 5190.7 3621.7 3859.4 3984.0 4342.8 4360.7 3437.2 3699.4 3895.2 4386.5 4405.0 4203.8 4319.1 4320.8 4332.2 4341.7 3541.9 4253.2 4352.6 4398.8 4404.5 3390.7 3491.0 4037.4 4043.0 4044.8 5022.6 5038.2 5050.4 5056.4 5071.2 4965.1 5035.7 5050.8 5069.9 5074.6 4679.8 5420.9 5674.3 5695.0 5722.6 3836.5 3997.8 4351.2 4465.3 4480.7 5006.6 5245.7 5412.0 5611.9 6001.5 4033.4 4207.3 4441.7 4500.9 4562.5 3863.7 4191.2 4326.0 4634.7 4636.6 4043.4 4219.7 4673.9 4761.0 4976.0 4992.8 5199.8 5616.9 5619.8 5634.6 1364.5 1418.7 1534.3 1590.9 1593.5 1004.7 1022.8 1079.7 1122.9 1148.5 5246.0 5247.7 5260.2 5274.9 5303.0 5124.8 5713.1 5791.9 5841.6 5886.2 4596.9 4897.8 5006.1 5172.9 5245.5 2540.9 2771.4 2957.9 2999.3 3043.2 5213.8 5681.0 5845.0 5916.2 5919.5 4903.6 5666.0 5707.2 5747.8 5782.6 5432.5 6052.5 6063.0 6110.8 6159.7 5054.3 5259.9 5279.6 5555.2 5845.8 5202.8 5492.6 5540.9 5725.4 5781.6 5483.0 5836.7 5972.4 6037.5 6059.8 4034.9 4336.0 4459.4 4607.5 4649.9 4989.9 5178.5 5309.9 5718.2 5857.3 5642.4 5670.8 5674.8 5697.6 5741.5 4435.5 5526.6 5691.6 5693.0 5834.7 5067.1 5131.9 5223.0 5468.9 5514.7 4527.6 5264.4 5580.6 5593.4 5704.5 4543.0 4753.5 4776.5 5253.0 5372.8 17:43:47 INFO - PROCESS | 1919 | 17:43:47 INFO - PROCESS | 1919 | [#5] yui.html Cycles:180 Average:18948.11 Median:3918.92 stddev:26449.30 (674.9%) stddev-sans-first:26488.08 17:43:47 INFO - PROCESS | 1919 | Values: 718.8 719.8 797.0 797.9 833.2 14003.4 14438.6 14876.7 16031.7 16104.4 14877.5 14912.0 15005.6 15036.7 15083.6 862.6 894.5 900.2 919.8 928.1 922.7 926.1 926.6 926.8 927.7 931.1 964.2 976.7 977.9 983.4 954.6 961.3 967.5 967.7 972.2 699.6 701.2 702.2 702.3 702.6 13317.3 14109.6 14233.1 14761.5 16744.0 13899.8 13993.7 14240.5 14260.8 14264.1 10999.4 11504.4 11805.9 11865.3 11960.5 4448.2 4482.3 4497.3 4631.6 4659.6 70268.0 83222.0 100623.0 100997.0 101907.5 10495.4 10599.7 10705.9 10746.9 10815.2 16910.5 20506.8 20742.7 20775.4 20909.1 7269.4 7406.9 7498.7 7506.4 7539.5 3812.8 3902.0 3903.5 3934.4 3935.6 3371.3 3411.2 3435.3 3437.9 3443.0 632.9 635.4 637.2 643.1 653.5 536.7 547.0 550.7 551.5 558.5 9304.8 9816.3 9878.3 9901.5 10024.6 593.4 598.7 644.8 652.4 654.1 4781.2 4831.1 4851.4 4899.9 5077.4 97841.0 98603.5 99890.0 100116.5 101795.0 53862.0 54141.7 75902.9 89105.0 90483.5 75555.6 77026.0 77304.6 77847.2 78361.0 9137.4 10017.9 10852.0 10969.9 11123.6 34008.8 34999.0 38513.0 43619.0 48153.1 57240.4 57590.0 57661.7 58232.1 58525.7 12689.5 12749.8 12951.5 12979.3 13279.7 14906.7 15001.8 15068.9 15080.4 15291.4 13749.4 13883.7 14102.9 14279.8 14337.9 11565.9 11664.6 13440.2 13972.7 14364.4 12065.7 13243.7 13568.0 13821.9 14482.6 10502.9 11130.0 11338.8 11477.1 11755.9 10220.6 10751.4 11317.2 11709.1 11731.4 17:43:47 INFO - PROCESS | 1919 | -------- Summary: end -------- 17:43:47 INFO - PROCESS | 1919 | 17:43:47 INFO - TEST-INFO | 1919: exit 0 17:43:47 INFO - TEST-OK | dromaeo_css | took 1116723ms 17:43:47 INFO - TEST-START | kraken 17:43:47 INFO - operating with platform_type : mac_ 17:43:47 INFO - Initialising browser for kraken test... 17:43:47 INFO - TEST-INFO | started process 1926 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmprZVoem/profile http://localhost:56460/getInfo.html) 17:43:50 INFO - PROCESS | 1926 | 2017-03-15 17:43:50.585 plugin-container[1927:23342] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.tsm.portname' 17:43:50 INFO - PROCESS | 1926 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:43:50 INFO - PROCESS | 1926 | 2017-03-15 17:43:50.588 plugin-container[1927:23342] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x471b, name = 'com.apple.CFPasteboardClient' 17:43:50 INFO - PROCESS | 1926 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:43:50 INFO - PROCESS | 1926 | 2017-03-15 17:43:50.588 plugin-container[1927:23342] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:43:50 INFO - PROCESS | 1926 | __metrics Screen width/height:1600/1200 17:43:50 INFO - PROCESS | 1926 | colorDepth:24 17:43:50 INFO - PROCESS | 1926 | Browser inner width/height: 1024/689 17:43:50 INFO - PROCESS | 1926 | __metrics 17:43:50 ERROR - PROCESS | 1926 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3353: TypeError: this.tabs is undefined 17:43:51 INFO - TEST-INFO | 1926: exit 0 17:43:51 INFO - Browser initialized. 17:43:51 INFO - Running cycle 1/1 for kraken test... 17:43:51 INFO - TEST-INFO | started process 1928 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/tmprZVoem/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:43:54 INFO - PROCESS | 1928 | 2017-03-15 17:43:54.017 plugin-container[1929:23470] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 17:43:54 INFO - PROCESS | 1928 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:43:54 INFO - PROCESS | 1928 | 2017-03-15 17:43:54.018 plugin-container[1929:23470] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 17:43:54 INFO - PROCESS | 1928 | See /usr/include/servers/bootstrap_defs.h for the error codes. 17:43:54 INFO - PROCESS | 1928 | 2017-03-15 17:43:54.018 plugin-container[1929:23470] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 17:44:03 INFO - PROCESS | 1928 | RSS: Main: 220401664 17:44:03 INFO - PROCESS | 1928 | 17:44:06 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56460/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56460/tests/kraken/driver.html?testName=audio-beat-detection) 17:44:07 INFO - PROCESS | 1928 | RSS: Main: 235053056 17:44:07 INFO - PROCESS | 1928 | 17:44:10 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56460/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56460/tests/kraken/driver.html?testName=audio-dft) 17:44:11 INFO - PROCESS | 1928 | RSS: Main: 243273728 17:44:11 INFO - PROCESS | 1928 | 17:44:14 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56460/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56460/tests/kraken/driver.html?testName=audio-fft) 17:44:15 INFO - PROCESS | 1928 | RSS: Main: 246931456 17:44:15 INFO - PROCESS | 1928 | 17:44:17 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56460/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56460/tests/kraken/driver.html?testName=audio-oscillator) 17:44:17 INFO - PROCESS | 1928 | RSS: Main: 247279616 17:44:17 INFO - PROCESS | 1928 | 17:44:19 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56460/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56460/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:44:20 INFO - PROCESS | 1928 | RSS: Main: 247255040 17:44:20 INFO - PROCESS | 1928 | 17:44:23 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56460/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56460/tests/kraken/driver.html?testName=imaging-darkroom) 17:44:24 INFO - PROCESS | 1928 | RSS: Main: 251203584 17:44:24 INFO - PROCESS | 1928 | 17:44:27 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56460/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56460/tests/kraken/driver.html?testName=imaging-desaturate) 17:44:28 INFO - PROCESS | 1928 | RSS: Main: 248053760 17:44:28 INFO - PROCESS | 1928 | 17:44:31 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56460/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56460/tests/kraken/driver.html?testName=json-parse-financial) 17:44:32 INFO - PROCESS | 1928 | RSS: Main: 249597952 17:44:32 INFO - PROCESS | 1928 | 17:44:33 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56460/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56460/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:44:34 INFO - PROCESS | 1928 | RSS: Main: 250638336 17:44:34 INFO - PROCESS | 1928 | 17:44:36 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56460/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56460/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:44:36 INFO - PROCESS | 1928 | RSS: Main: 250695680 17:44:36 INFO - PROCESS | 1928 | 17:44:39 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56460/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56460/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:44:39 INFO - PROCESS | 1928 | RSS: Main: 250937344 17:44:39 INFO - PROCESS | 1928 | 17:44:42 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56460/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56460/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:44:43 INFO - PROCESS | 1928 | RSS: Main: 251400192 17:44:43 INFO - PROCESS | 1928 | 17:44:46 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56460/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56460/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:44:46 INFO - PROCESS | 1928 | RSS: Main: 251109376 17:44:46 INFO - PROCESS | 1928 | 17:44:48 INFO - PROCESS | 1928 | Cycle 1(1): loaded http://localhost:56460/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56460/tests/kraken/driver.html?testName=ai-astar) 17:44:48 INFO - PROCESS | 1928 | RSS: Main: 253124608 17:44:48 INFO - PROCESS | 1928 | 17:44:48 INFO - PROCESS | 1928 | __start_tp_report 17:44:48 INFO - PROCESS | 1928 | _x_x_mozilla_page_load 17:44:48 INFO - PROCESS | 1928 | _x_x_mozilla_page_load_details 17:44:48 INFO - PROCESS | 1928 | |i|pagename|runs| 17:44:48 INFO - PROCESS | 1928 | |0;ai-astar;158;177;141;125;171;119;119;120;119;118 17:44:48 INFO - PROCESS | 1928 | |1;audio-beat-detection;133;111;112;149;110;114;113;113;145;143 17:44:48 INFO - PROCESS | 1928 | |2;audio-dft;193;228;278;236;197;201;197;192;198;194 17:44:48 INFO - PROCESS | 1928 | |3;audio-fft;86;72;60;93;61;62;61;61;75;59 17:44:48 INFO - PROCESS | 1928 | |4;audio-oscillator;95;68;86;73;72;73;80;73;71;83 17:44:48 INFO - PROCESS | 1928 | |5;imaging-gaussian-blur;107;115;136;98;138;91;125;138;119;138 17:44:48 INFO - PROCESS | 1928 | |6;imaging-darkroom;109;162;139;96;95;100;140;154;108;155 17:44:48 INFO - PROCESS | 1928 | |7;imaging-desaturate;92;95;92;92;90;91;97;129;92;113 17:44:48 INFO - PROCESS | 1928 | |8;json-parse-financial;67;66;66;69;69;69;69;70;69;70 17:44:48 INFO - PROCESS | 1928 | |9;json-stringify-tinderbox;57;69;65;65;64;60;59;59;57;50 17:44:48 INFO - PROCESS | 1928 | |10;stanford-crypto-aes;90;103;107;87;87;89;93;85;82;86 17:44:48 INFO - PROCESS | 1928 | |11;stanford-crypto-ccm;139;141;138;138;139;138;140;146;175;141 17:44:48 INFO - PROCESS | 1928 | |12;stanford-crypto-pbkdf2;170;169;168;166;168;166;152;211;225;197 17:44:48 INFO - PROCESS | 1928 | |13;stanford-crypto-sha256-iterative;66;67;64;65;67;68;65;66;64;66 17:44:48 INFO - PROCESS | 1928 | __end_tp_report 17:44:48 INFO - PROCESS | 1928 | __start_cc_report 17:44:48 INFO - PROCESS | 1928 | _x_x_mozilla_cycle_collect,1020 17:44:48 INFO - PROCESS | 1928 | __end_cc_report 17:44:48 INFO - PROCESS | 1928 | __startTimestamp1489625088855__endTimestamp 17:44:48 INFO - PROCESS | 1928 | 17:44:48 INFO - PROCESS | 1928 | ------- Summary: start ------- 17:44:48 INFO - PROCESS | 1928 | Number of tests: 14 17:44:48 INFO - PROCESS | 1928 | 17:44:48 INFO - PROCESS | 1928 | [#0] ai-astar Cycles:10 Average:136.70 Median:133.00 stddev:23.52 (17.7%) stddev-sans-first:23.65 17:44:48 INFO - PROCESS | 1928 | Values: 158.0 177.0 141.0 125.0 171.0 119.0 119.0 120.0 119.0 118.0 17:44:48 INFO - PROCESS | 1928 | 17:44:48 INFO - PROCESS | 1928 | [#1] audio-beat-detection Cycles:10 Average:124.30 Median:123.50 stddev:16.19 (13.1%) stddev-sans-first:16.86 17:44:48 INFO - PROCESS | 1928 | Values: 133.0 111.0 112.0 149.0 110.0 114.0 113.0 113.0 145.0 143.0 17:44:48 INFO - PROCESS | 1928 | 17:44:48 INFO - PROCESS | 1928 | [#2] audio-dft Cycles:10 Average:211.40 Median:199.50 stddev:27.96 (14.0%) stddev-sans-first:28.85 17:44:48 INFO - PROCESS | 1928 | Values: 193.0 228.0 278.0 236.0 197.0 201.0 197.0 192.0 198.0 194.0 17:44:48 INFO - PROCESS | 1928 | 17:44:48 INFO - PROCESS | 1928 | [#3] audio-fft Cycles:10 Average:69.00 Median:67.00 stddev:12.17 (18.2%) stddev-sans-first:11.24 17:44:48 INFO - PROCESS | 1928 | Values: 86.0 72.0 60.0 93.0 61.0 62.0 61.0 61.0 75.0 59.0 17:44:48 INFO - PROCESS | 1928 | 17:44:48 INFO - PROCESS | 1928 | [#4] audio-oscillator Cycles:10 Average:77.40 Median:76.50 stddev:8.42 (11.0%) stddev-sans-first:6.06 17:44:48 INFO - PROCESS | 1928 | Values: 95.0 68.0 86.0 73.0 72.0 73.0 80.0 73.0 71.0 83.0 17:44:48 INFO - PROCESS | 1928 | 17:44:48 INFO - PROCESS | 1928 | [#5] imaging-gaussian-blur Cycles:10 Average:120.50 Median:138.00 stddev:17.55 (12.7%) stddev-sans-first:17.92 17:44:48 INFO - PROCESS | 1928 | Values: 107.0 115.0 136.0 98.0 138.0 91.0 125.0 138.0 119.0 138.0 17:44:48 INFO - PROCESS | 1928 | 17:44:48 INFO - PROCESS | 1928 | [#6] imaging-darkroom Cycles:10 Average:125.80 Median:154.50 stddev:26.74 (17.3%) stddev-sans-first:27.66 17:44:48 INFO - PROCESS | 1928 | Values: 109.0 162.0 139.0 96.0 95.0 100.0 140.0 154.0 108.0 155.0 17:44:48 INFO - PROCESS | 1928 | 17:44:48 INFO - PROCESS | 1928 | [#7] imaging-desaturate Cycles:10 Average:98.30 Median:92.00 stddev:12.70 (13.8%) stddev-sans-first:13.27 17:44:48 INFO - PROCESS | 1928 | Values: 92.0 95.0 92.0 92.0 90.0 91.0 97.0 129.0 92.0 113.0 17:44:48 INFO - PROCESS | 1928 | 17:44:48 INFO - PROCESS | 1928 | [#8] json-parse-financial Cycles:10 Average:68.40 Median:69.00 stddev:1.51 (2.2%) stddev-sans-first:1.51 17:44:48 INFO - PROCESS | 1928 | Values: 67.0 66.0 66.0 69.0 69.0 69.0 69.0 70.0 69.0 70.0 17:44:48 INFO - PROCESS | 1928 | 17:44:48 INFO - PROCESS | 1928 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:62.00 stddev:5.42 (8.7%) stddev-sans-first:5.60 17:44:48 INFO - PROCESS | 1928 | Values: 57.0 69.0 65.0 65.0 64.0 60.0 59.0 59.0 57.0 50.0 17:44:48 INFO - PROCESS | 1928 | 17:44:48 INFO - PROCESS | 1928 | [#10] stanford-crypto-aes Cycles:10 Average:90.90 Median:87.00 stddev:8.05 (9.3%) stddev-sans-first:8.53 17:44:48 INFO - PROCESS | 1928 | Values: 90.0 103.0 107.0 87.0 87.0 89.0 93.0 85.0 82.0 86.0 17:44:48 INFO - PROCESS | 1928 | 17:44:48 INFO - PROCESS | 1928 | [#11] stanford-crypto-ccm Cycles:10 Average:143.50 Median:140.50 stddev:11.33 (8.1%) stddev-sans-first:11.90 17:44:48 INFO - PROCESS | 1928 | Values: 139.0 141.0 138.0 138.0 139.0 138.0 140.0 146.0 175.0 141.0 17:44:48 INFO - PROCESS | 1928 | 17:44:48 INFO - PROCESS | 1928 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.20 Median:169.50 stddev:23.46 (13.8%) stddev-sans-first:24.65 17:44:48 INFO - PROCESS | 1928 | Values: 170.0 169.0 168.0 166.0 168.0 166.0 152.0 211.0 225.0 197.0 17:44:48 INFO - PROCESS | 1928 | 17:44:48 INFO - PROCESS | 1928 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.80 Median:66.00 stddev:1.32 (2.0%) stddev-sans-first:1.39 17:44:48 INFO - PROCESS | 1928 | Values: 66.0 67.0 64.0 65.0 67.0 68.0 65.0 66.0 64.0 66.0 17:44:48 INFO - PROCESS | 1928 | -------- Summary: end -------- 17:44:48 INFO - PROCESS | 1928 | 17:44:49 INFO - TEST-INFO | 1928: exit 0 17:44:49 INFO - TEST-OK | kraken | took 61884ms 17:44:49 INFO - SUITE-END | took 1178s 17:44:50 INFO - Completed test suite (00:19:38) 17:44:50 INFO - javascript benchmark 17:44:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7595.56991427837, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3390.694837464629, 3399.1672040350104, 3409.6590340965904, 3411.573553305837, 3416.4192087345155, 4883.316335713003, 5827.358990511046, 5845.824625261243, 5955.761769529214, 5959.791407300745, 5092.974535127329, 5922.822315330536, 5974.074018527124, 6000.459958603725, 6029.6382217067, 5370.812021579255, 5388.892222155555, 5395.7032363220005, 5415.593830462712, 5447.400785913546, 5436.91844622329, 5443.727813609324, 5448.046591846411, 5472.72636368182, 5530.668159910419, 5202.739863006854, 5258.737063146847, 5442.374126975409, 5449.3188351456065, 5461.1535212042, 4765.66561362819, 5163.974180129076, 5370.382406023318, 5385.515303622654, 5389.541888939445, 5224.0, 5372.623916325859, 5378.731063446812, 5395.649282796606, 5430.13117901134, 5651.265335506399, 5972.880542389172, 5973.790917317917, 6000.159977603139, 6040.48655864252, 6182.567220294582, 6186.10301506279, 6237.376262373772, 6281.277653069909, 6296.0, 6342.714577843962, 6387.329330420332, 6389.936100638981, 6409.327020662857, 6416.348147593005, 6075.0, 6089.269287685506, 6106.877862442726, 6110.511159107261, 6131.2335958004805, 6144.955357589131, 6151.0, 6318.842028949313, 6353.714082866282, 6486.935130648633, 6238.438540531374, 6276.964300890393, 6292.559520833589, 6306.49548036156, 6311.526635502356, 6322.114903913456, 6334.936650633527, 6335.746570137235, 6343.302236753953, 6345.555811093179, 6126.548209435026, 6133.73253493014, 6198.411150940653, 6218.694074244459, 6237.688115594202, 6165.815025549151, 6283.02613094971, 6294.622322660655, 6297.653629050446, 6300.117983482316, 4212.641925436311, 5033.0688822567945, 5080.847574572768, 5109.259157422153, 5109.718965456861, 4531.660125490602, 4553.590176884097, 4562.406887104655, 4578.2903649934315, 4580.65645076614, 5127.846164615067, 5896.823095307148, 5977.850553736192, 6037.154798328237, 6042.6978651067275, 6332.873342533216, 6361.173047503888, 6377.3303803100935, 6412.647304398303, 6434.420902118832, 5636.605437619327, 5978.4021597839865, 5990.940090599125, 6008.24896887889, 6016.067509536029, 5525.11598144303, 5526.696031718214, 5573.777048918079, 5618.2415373924, 5622.044252477089, 6546.803595892131, 6550.377714117151, 6551.5413921026975, 6568.146141001639, 6583.0454584086, 6326.715297811517, 6340.731853629385, 6342.143810585697, 6348.555601107878, 6367.363263673596, 5469.234307196916, 6121.0, 6429.067785171031, 6434.4852411806005, 6499.5775274607, 5610.298712660918, 6027.668478233564, 6284.402981716729, 6288.434040936338, 6305.5901366411035, 6148.44663980244, 6300.936990630035, 6304.905426418516, 6309.716062777278, 6329.588576742497, 6082.300535438481, 6143.723532440961, 6164.660943648142, 6221.160143380766, 6261.62430254168, 5105.2597373381395, 5142.280080788618, 6153.446189842935, 6195.721192546256, 6241.375862413723, 6010.2186715726675, 6159.568830182024, 6220.253569571681, 6221.626702397871, 6223.471004964629, 6069.696515174135, 6131.478824299985, 6141.140240366263, 6199.628022318675, 6206.503479721521, 6165.106059621419, 6176.0, 6188.597741146811, 6192.102145189013, 6195.938040619536], "value": 5802.222950557818, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.9715391336912, 801.430984001359, 826.8718348655957, 855.1790281329927, 966.4684423567037, 36544.0, 37498.0, 38780.41829372555, 38819.0, 38843.640472583465, 37573.248535029285, 37804.73171609698, 37824.0, 37895.0, 37899.24201515968, 7059.6823142958565, 7959.920400795976, 10432.0, 10724.0, 10767.0, 10527.894721052806, 10726.356418614909, 10734.30227035244, 10740.516676749527, 10753.354798712064, 10717.517711702953, 10724.463776811168, 10758.408287544182, 10763.408012559306, 10768.78462430751, 10693.83959240612, 10704.30422022566, 10712.78574428507, 10744.355338679627, 10753.193510486706, 10360.94819525905, 10411.843822342671, 10420.843687344695, 10437.269391142623, 10456.32033917793, 32720.0, 32829.0, 33012.834935825405, 33052.83473582641, 33080.66919330824, 3128.8435578220997, 3714.368557345231, 3732.675581458957, 3742.401215805458, 3926.0577461409343, 22437.663435048486, 23791.286261412013, 23958.520829583485, 25037.12370067057, 25720.228393148234, 3057.617797775278, 3097.0708787363924, 3100.268425796599, 3118.1425108095227, 3139.073973177918, 319602.0, 324316.0, 324466.0, 325575.0, 385633.0, 40974.590254097675, 41348.37977430341, 41389.0, 41389.793051034554, 41393.79303103525, 44433.0, 44544.10911781746, 44565.0, 44571.108577828265, 45093.54906450894, 12681.619551413472, 12761.29812860283, 12773.169743966613, 12778.808317875239, 12797.0, 9015.909840901639, 9397.483138427315, 10645.361278323326, 11005.229633925708, 11044.226904116795, 11646.650600481998, 11678.70803229926, 11688.94155529217, 11691.707707307216, 11755.412229388496, 5590.636608620427, 5617.859553511195, 5629.183768353566, 5690.658560486384, 5722.399148089474, 911.2983003087586, 1037.6523864505475, 1039.7556574205055, 1041.4011943132577, 1057.1120258982337, 18818.811811881707, 26132.34669133249, 26309.0, 26395.208143755717, 26428.73571264301, 885.6059053721033, 1127.1658972360558, 1163.3543383422282, 1165.7493638867516, 1174.4362705901215, 13182.802257966137, 13516.93241533786, 13789.310534473236, 13838.723225535434, 13866.0, 397097.0, 402244.9887750542, 404396.0, 404817.0, 405682.0, 52291.0, 52682.20976685353, 52711.73644131832, 52721.7363913178, 52785.47214527882, 1425.9144451332954, 1460.5910345103175, 1462.4004158295047, 1463.7584798508126, 1469.162577330911, 24825.50348992974, 24905.377365566004, 25635.615465767656, 25793.484130317665, 25953.480930381666, 39457.605423945395, 39482.60517394789, 39485.0, 39516.40725389179, 39547.2090558193, 382028.0, 382440.0, 382735.0, 383119.0, 383696.0, 26098.86950565235, 26962.0, 27018.784154713478, 30353.544696829125, 30408.695913041473, 42084.57915420929, 43076.0, 43682.88736776602, 43829.123417530835, 45242.32136518021, 31690.04929852108, 34744.0, 35992.100197495274, 36551.45172822463, 36741.26517469689, 32444.0, 35275.0, 35618.46572301469, 36309.0, 36511.72208972673, 34971.30057398787, 35413.0, 35847.82076089603, 35950.0, 36258.36837342273, 30625.0, 31943.0, 31945.68054319427, 31987.0, 32018.839905800323, 24022.67875266877, 24307.878460607582, 24449.755502444747, 24619.753802462463, 24749.752502475465], "value": 17925.811694592576, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [355.92881423715255, 389.30703348040487, 409.7582426368442, 410.69198101423933, 453.97503137327453, 19814.0, 21227.363179104632, 21311.0, 21628.134874604995, 21836.45408864779, 17696.38062667807, 18105.642076844222, 19123.330683426084, 22378.776212237914, 22545.774542254574, 6103.877922441548, 6437.034444833289, 6526.4778817694705, 6560.671966401685, 6567.85062614043, 6093.451589356957, 6307.873842523147, 6363.0773537836985, 6393.0, 6496.772612958547, 6525.412712855842, 6554.9344506555035, 6559.475241980654, 6564.868702625945, 6574.04676321933, 6495.545311828174, 7089.89365159523, 7411.073615797998, 7541.962290188569, 7567.356774674159, 6220.377962203788, 7078.929210707878, 7314.5976971266555, 7350.4854660173805, 7381.9630901845685, 25607.871960640263, 25645.845936932696, 26342.73657263422, 26377.604335934975, 26749.930002799865, 3208.1658768720067, 3222.419964406406, 3310.8013519188926, 3311.806426351702, 3404.5063465797566, 14604.853951460456, 15419.922900385427, 15688.0, 16283.918580407022, 16536.917315413466, 1970.5172232803054, 2037.7860324665844, 2040.877547347164, 2042.5506388594486, 2042.7548694156649, 151584.0, 168088.0, 174602.1269893655, 174880.0, 175169.0, 20751.68872466914, 21174.0, 21232.575348492945, 21269.68095478569, 21533.89233053825, 32158.678413216036, 32286.83856580749, 32710.67289327124, 32718.83640581782, 32812.67187328096, 8302.750917472486, 9976.900230997742, 10112.342697724771, 10271.332363396356, 10431.426271555138, 6688.866222675617, 8378.371622128365, 8399.95800020996, 8550.957245213858, 8551.0, 9718.222542196607, 9718.562664680107, 9778.31551791382, 9866.556004979793, 9911.851322230172, 3363.8654453821573, 3371.364888029304, 4032.516098068251, 4098.631123198927, 4117.444145040381, 1025.661531694554, 1038.787048655024, 1049.2078480746986, 1054.9419781911915, 1061.5170097605571, 17195.828041719673, 17315.393961211295, 19064.474842012605, 20670.48323791887, 20719.27482538104, 920.30516959695, 923.422860712055, 1010.8584798128268, 1033.0495943731785, 1045.3571053801857, 9395.859062114074, 10238.12975897057, 11132.777344453227, 12073.698157546132, 12471.75056498865, 668567.0, 782205.0, 785705.0, 788092.05953971, 801484.0, 99278.0, 141133.29433352768, 144152.0, 144334.0, 171088.0, 1226.3316492511424, 1242.2670624331506, 1294.6892745741143, 1323.9007074469453, 1389.5831250624772, 18787.436376908714, 20211.292604758764, 20227.494312641713, 20272.493187669836, 20419.59160816805, 61371.69314153579, 66007.66996164988, 66601.0, 67351.66324168348, 68739.62520749457, 74295.25704743099, 78288.65134045988, 81365.9658508542, 86579.56710216409, 94336.52831736072, 10187.541560629938, 11472.369019703663, 11751.471183796579, 11761.414726745998, 11988.46051927648, 11200.887991119984, 13174.80237796453, 13297.933510332387, 13412.463501459832, 13593.320333983063, 11404.429778511207, 11427.714307142389, 11482.36846973391, 11515.481803318704, 11648.708782280512, 9314.627414903329, 9496.76542049529, 10592.788144236918, 11090.168237382068, 11186.888131118585, 11553.595624153115, 11595.420228988685, 11637.825432618349, 11969.820452693042, 12040.879591204326, 9202.677906273248, 11679.124065694938, 11901.642950711492, 11908.880911191123, 11915.702107447036, 9989.900100998897, 10279.53742081623, 11247.943760281147, 11324.716882078013, 11443.656690299304], "value": 11560.886405041312, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1461.9342129604167, 1540.5917431880546, 1544.2896267716849, 1588.44332554097, 1600.887937844351, 10603.469826508672, 10850.511726972285, 11216.270942388759, 11257.6622701319, 11258.099352051837, 10994.615188468406, 11182.105431565476, 11204.831927521094, 11238.550457981692, 11277.605283815048, 2373.5964885969343, 2404.615261558151, 2414.2998530426244, 2415.5168966206743, 2431.1369463840347, 2347.0377145370317, 2376.7742064503846, 2396.3290278721897, 2400.6879105716234, 2409.590369637166, 2322.6980492535945, 2363.72817126031, 2367.230650038736, 2373.596488596943, 2378.3816207785926, 2331.1258278145697, 2332.230363979891, 2334.9416264593438, 2338.088145623208, 2347.1080989224156, 2125.2667829598763, 2251.808596269319, 2335.2760644200353, 2360.055977608953, 2391.7249516305674, 10983.835242471368, 11144.944275278653, 11148.108151347873, 11158.218924675195, 11160.386178760245, 5671.177679236529, 5813.651180929158, 5845.707714614252, 5852.0, 5909.379515150933, 3512.982435087834, 3611.205534782344, 3651.6348365163535, 3668.413053911388, 3682.0794801299676, 1110.5946329589642, 1157.2073129906041, 1199.2384835629439, 1225.185251807556, 1229.4959066782576, 12239.571614993432, 12793.168444051107, 13449.932750336284, 15204.0, 15475.0, 4319.395284660087, 4320.071184695305, 4566.0, 4724.976375118171, 4734.455537613149, 11766.117541184445, 11791.115666324888, 11817.704557386134, 11823.231489953125, 11845.763084738257, 5662.490375866192, 5691.117876729114, 5702.0, 5718.4567466091485, 5757.337906140764, 5030.572401345853, 5191.714455704972, 5268.394134674561, 5270.736463176902, 5279.656822306538, 3281.605317739951, 3857.1707082977296, 3942.6254505821903, 3967.722259441869, 4059.4519739834745, 1032.2774058159318, 1035.5857656937135, 1039.1894322428366, 1044.9602645367906, 1046.1682962045193, 923.5013092929877, 923.7505873414141, 950.8193443245762, 964.252704154272, 1004.5630150884389, 6378.904316435257, 6464.967675161594, 6604.174478190226, 6663.800085997428, 6777.695003724844, 973.2068364283086, 996.9501524923725, 1053.5996321397972, 1058.513083981362, 1069.9304545204536, 3446.5691788526433, 4107.199096176277, 4156.2726522858375, 4237.449131612932, 4389.297712366006, 12824.615261542169, 13532.391042403115, 13844.861551384558, 13875.444982200801, 14003.579892603238, 13583.0, 13595.184288942695, 13597.796033059512, 13606.0, 13696.383662735201, 9989.700308990596, 10247.487625618689, 10252.333598316085, 10254.692359229235, 10340.224483163793, 5759.280089988752, 5803.883922321615, 6650.168728908887, 6685.76599819004, 6975.0, 12063.457144428347, 12210.633680989584, 12361.876381236072, 12373.75252494963, 12405.937970310091, 10439.791204176026, 12281.631551053126, 12377.62867113988, 12759.0, 12793.61619151427, 9152.95423522878, 9411.717648470556, 9470.526473676151, 9523.666671666459, 9534.809303814023, 10303.896961030294, 10351.430671312848, 10368.637097701545, 10427.530761115617, 10492.055714985689, 7716.459847810824, 9134.040925702706, 9158.313126515404, 9245.815083698422, 9350.345475816628, 8949.776255593662, 9000.414973026733, 9038.774030649287, 9094.27245820346, 9105.317101217302, 7742.032245969254, 7801.765947021599, 7871.33093687043, 7890.171531989058, 7933.246341597539, 5862.091375836752, 5873.2658417697785, 5897.970510147422, 6038.9396106038375, 6124.877502449837, 5171.798481273716, 5899.203607512931, 5978.940210597838, 6082.2093127893095, 6235.469985051322], "value": 5121.92173906972, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.81973734183543, 365.3150343106675, 371.331603114394, 382.9540455145381, 386.3046516270713, 4357.668647273706, 4771.26045462953, 5053.343065401493, 5325.707086110262, 5359.785608575652, 4755.9774648450575, 4786.83246086387, 4831.541003604661, 5117.498688909419, 5190.688558686482, 3621.7283703722196, 3859.4017927221325, 3983.9800800996027, 4342.849144976583, 4360.694751367406, 3437.175077981279, 3699.3537875645347, 3895.2404281165186, 4386.517483076859, 4404.977975110136, 4203.822929579723, 4319.071399649075, 4320.805563749639, 4332.24185767491, 4341.701715301844, 3541.858325666983, 4253.1706317268145, 4352.630026447756, 4398.778616798496, 4404.537523560012, 3390.7117894978956, 3491.0050635568996, 4037.394390841368, 4043.028374145001, 4044.777537235451, 5022.623303252234, 5038.244263360489, 5050.39395272566, 5056.393232812086, 5071.18860982241, 4965.088440950224, 5035.748212589392, 5050.84847454577, 5069.898602027939, 5074.644774865761, 4679.789409476582, 5420.915816836648, 5674.3190817101795, 5694.97828270962, 5722.570807189436, 3836.5204349456317, 3997.760134391946, 4351.238533256667, 4465.303184789792, 4480.72299394671, 5006.5744411725045, 5245.711485868275, 5411.998780225632, 5611.915821262725, 6001.48987336077, 4033.415154802537, 4207.347861081537, 4441.689081764245, 4500.887477813016, 4562.520935301812, 3863.6522712955407, 4191.161767646483, 4326.048269380732, 4634.652401069933, 4636.629069674418, 4043.433919251307, 4219.683523735671, 4673.883152921137, 4761.024174967419, 4975.950240497621, 4992.825251116194, 5199.766010529535, 5616.943830561724, 5619.831405057855, 5634.605577609528, 1364.5428781358355, 1418.7233489469454, 1534.3325653340833, 1590.9443169489011, 1593.5060131359317, 1004.7287232447198, 1022.8465730140539, 1079.6976846482996, 1122.9213955023233, 1148.5463242019523, 5246.0, 5247.685138891678, 5260.237265596467, 5274.868128296746, 5302.973485132549, 5124.821291103067, 5713.143028545752, 5791.88416231673, 5841.591088623755, 5886.175935369051, 4596.862094137181, 4897.8285759998225, 5006.07387633289, 5172.948270517247, 5245.485524698462, 2540.9455076143195, 2771.3810449125785, 2957.896473623413, 2999.3203805868347, 3043.239190202449, 5213.817516386908, 5681.0, 5845.006348920694, 5916.160243083258, 5919.496842768327, 4903.621743454421, 5665.9716701417055, 5707.229524014288, 5747.798827041033, 5782.566307526952, 5432.5231851615, 6052.485538729257, 6062.969685151635, 6110.800111959691, 6159.6612186330185, 5054.321209758834, 5259.868503287448, 5279.6040296978645, 5555.22226888244, 5845.795397161079, 5202.817901373433, 5492.60591526769, 5540.86147846291, 5725.366331487396, 5781.624194427349, 5483.040467918018, 5836.708164591669, 5972.372900845348, 6037.547183961133, 6059.757609695739, 4034.936155125299, 4336.002719374625, 4459.420275364182, 4607.525591810589, 4649.86050418488, 4989.850304490871, 5178.456262092426, 5309.929127640146, 5718.168826885913, 5857.326407463026, 5642.379338272869, 5670.8015219467125, 5674.77300907959, 5697.601167918372, 5741.5406767459335, 4435.489918659267, 5526.640768350045, 5691.605556638485, 5693.047049067172, 5834.7082645866685, 5067.087924173684, 5131.948680513147, 5223.0, 5468.91796623059, 5514.724263786875, 4527.592516673515, 5264.447233040476, 5580.5535557156145, 5593.356763972032, 5704.543636508986, 4542.957317377774, 4753.453352864465, 4776.47458779527, 5252.9737351313, 5372.811951581833], "value": 4227.354274194168, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.75562308815, 719.8416348403349, 796.968121275149, 797.8949155419743, 833.2459124492335, 14003.369848356822, 14438.566842994727, 14876.702465950688, 16031.679366412665, 16104.35582576697, 14877.479288224915, 14912.0, 15005.62485937852, 15036.699266014673, 15083.62290942727, 862.594580547145, 894.5348418822208, 900.2392977933636, 919.7838507950627, 928.1414691410453, 922.6862866625346, 926.0646746785761, 926.6339795780663, 926.763675262807, 927.717046300878, 931.1154403316876, 964.2430691906854, 976.7216343342113, 977.8826540815112, 983.4443539400216, 954.5799848066863, 961.2790407194605, 967.5259123029736, 967.67099186277, 972.1882228339346, 699.6047233313162, 701.1621112770241, 702.2100137345486, 702.301210295759, 702.585474570001, 13317.26755028473, 14109.64725881851, 14233.146011239358, 14761.483348082766, 16743.995360278423, 13899.79150312746, 13993.650158746012, 14240.501582444565, 14260.786088208684, 14264.144151350849, 10999.395033273247, 11504.367259800707, 11805.881941180563, 11865.347405892673, 11960.521579136825, 4448.154850578412, 4482.282834746425, 4497.257952437843, 4631.560001799824, 4659.5573420525, 70268.0, 83222.0, 100622.99999999927, 100997.0, 101907.49046254721, 10495.422751748574, 10599.682009539727, 10705.9464702676, 10746.94626526878, 10815.242932994772, 16910.492685219462, 20506.79493205049, 20742.688859667116, 20775.37673869786, 20909.05909234088, 7269.418446524265, 7406.8888966665545, 7498.700051997859, 7506.36638548465, 7539.472236943361, 3812.790296533717, 3902.004988727856, 3903.4925459690626, 3934.350832112669, 3935.5670876203594, 3371.3088816792497, 3411.2154204533094, 3435.3129374125274, 3437.8796742113905, 3442.9655703443145, 632.8670979094442, 635.3995474276857, 637.1632384514189, 643.1189270699172, 653.4804830160034, 536.6753114365753, 546.9753861076262, 550.6558400999376, 551.48987186852, 558.5168828962999, 9304.767380815398, 9816.263780216512, 9878.308518403786, 9901.455419951972, 10024.649137280161, 593.3562085137588, 598.7156100852061, 644.8162273751958, 652.420011519133, 654.1234745441132, 4781.163296423181, 4831.100395217646, 4851.417829860439, 4899.877503062381, 5077.441481437039, 97841.0, 98603.50698246463, 99890.0, 100116.49941750245, 101795.0, 53862.0, 54141.72929135408, 75902.8614570782, 89105.0, 90483.54758226167, 75555.62222188854, 77026.0, 77304.61347693337, 77847.22152778514, 78361.0, 9137.40606860552, 10017.899821001696, 10852.0, 10969.890301096886, 11123.555057797921, 34008.829955850066, 34999.0, 38513.03717407087, 43619.0, 48153.07387704593, 57240.42759572351, 57590.0, 57661.711691441276, 58232.12651810311, 58525.70737146287, 12689.482421001376, 12749.765922266612, 12951.481940722266, 12979.28613926243, 13279.734405311647, 14906.701865962837, 15001.849981500045, 15068.924655376653, 15080.396784128512, 15291.388344466097, 13749.381277842722, 13883.65290867696, 14102.929485352508, 14279.785803212751, 14337.856621433652, 11565.942170289094, 11664.591739289084, 13440.193588384729, 13972.650683732989, 14364.353604087632, 12065.73309802458, 13243.735125297633, 13568.0, 13821.86178138246, 14482.637934051732, 10502.894971050191, 11130.0, 11338.829917551408, 11477.139214559109, 11755.941220293844, 10220.59117635316, 10751.354918704903, 11317.207795454238, 11709.063274937815, 11731.354775487089], "value": 7374.901960094149, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1571.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 177.0, 141.0, 125.0, 171.0, 119.0, 119.0, 120.0, 119.0, 118.0], "value": 136.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 111.0, 112.0, 149.0, 110.0, 114.0, 113.0, 113.0, 145.0, 143.0], "value": 124.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 228.0, 278.0, 236.0, 197.0, 201.0, 197.0, 192.0, 198.0, 194.0], "value": 211.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 72.0, 60.0, 93.0, 61.0, 62.0, 61.0, 61.0, 75.0, 59.0], "value": 69.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 68.0, 86.0, 73.0, 72.0, 73.0, 80.0, 73.0, 71.0, 83.0], "value": 77.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 115.0, 136.0, 98.0, 138.0, 91.0, 125.0, 138.0, 119.0, 138.0], "value": 120.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 162.0, 139.0, 96.0, 95.0, 100.0, 140.0, 154.0, 108.0, 155.0], "value": 125.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 95.0, 92.0, 92.0, 90.0, 91.0, 97.0, 129.0, 92.0, 113.0], "value": 98.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 66.0, 69.0, 69.0, 69.0, 69.0, 70.0, 69.0, 70.0], "value": 68.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 69.0, 65.0, 65.0, 64.0, 60.0, 59.0, 59.0, 57.0, 50.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 103.0, 107.0, 87.0, 87.0, 89.0, 93.0, 85.0, 82.0, 86.0], "value": 90.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 141.0, 138.0, 138.0, 139.0, 138.0, 140.0, 146.0, 175.0, 141.0], "value": 143.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 169.0, 168.0, 166.0, 168.0, 166.0, 152.0, 211.0, 225.0, 197.0], "value": 179.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 64.0, 65.0, 67.0, 68.0, 65.0, 66.0, 64.0, 66.0], "value": 65.8, "unit": "score"}]}]} 17:44:50 INFO - Return code: 0 17:44:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:44:50 ERROR - # TBPL SUCCESS # 17:44:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:44:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:44:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:44:50 INFO - 2017-03-15 17:44:50.166 screenresolution[1933:23862] starting screenresolution argv=screenresolution get 17:44:50 INFO - 2017-03-15 17:44:50.168 screenresolution[1933:23862] Display 0: 1600x1200x32@60 17:44:50 INFO - 2017-03-15 17:44:50.175 screenresolution[1934:23865] starting screenresolution argv=screenresolution list 17:44:50 INFO - Available Modes on Display 0 17:44:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:44:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:44:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:44:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:44:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:44:50 INFO - Intel Iris: 17:44:50 INFO - Chipset Model: Intel Iris 17:44:50 INFO - Type: GPU 17:44:50 INFO - Bus: Built-In 17:44:50 INFO - VRAM (Dynamic, Max): 1536 MB 17:44:50 INFO - Vendor: Intel (0x8086) 17:44:50 INFO - Device ID: 0x0a2e 17:44:50 INFO - Revision ID: 0x0009 17:44:50 INFO - Displays: 17:44:50 INFO - Display: 17:44:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:44:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:44:50 INFO - Display Serial Number: 1600x1200 60 17:44:50 INFO - Main Display: Yes 17:44:50 INFO - Mirror: Off 17:44:50 INFO - Online: Yes 17:44:50 INFO - Rotation: Supported 17:44:50 INFO - Return code: 0 17:44:50 INFO - Running post-action listener: _resource_record_post_action 17:44:50 INFO - [mozharness: 2017-03-16 00:44:50.414651Z] Finished run-tests step (success) 17:44:50 INFO - Running post-run listener: _resource_record_post_run 17:44:50 INFO - Total resource usage - Wall time: 1199s; CPU: 54.0%; Read bytes: 1504768; Write bytes: 511003136; Read time: 20; Write time: 1613 17:44:50 INFO - TinderboxPrint: CPU usage
54.4% 17:44:50 INFO - TinderboxPrint: I/O read bytes / time
1,504,768 / 20 17:44:50 INFO - TinderboxPrint: I/O write bytes / time
511,003,136 / 1,613 17:44:50 INFO - TinderboxPrint: CPU idle
2,186.3 (45.6%) 17:44:50 INFO - TinderboxPrint: CPU system
965.0 (20.1%) 17:44:50 INFO - TinderboxPrint: CPU user
1,646.4 (34.3%) 17:44:50 INFO - TinderboxPrint: Swap in / out
210,464,768 / 0 17:44:50 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 206006784; Write bytes: 201107456; Read time: 15743; Write time: 455 17:44:50 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 1463808; Write bytes: 298856960; Read time: 19; Write time: 1119 17:44:50 INFO - Running post-run listener: _upload_blobber_files 17:44:50 INFO - Blob upload gear active. 17:44:50 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:44:50 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 17:44:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:44:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:44:51 INFO - (blobuploader) - INFO - Open directory for files ... 17:44:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 17:44:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:44:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:44:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 17:44:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:44:52 INFO - (blobuploader) - INFO - Done attempting. 17:44:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 17:44:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:44:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:44:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 17:44:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:44:53 INFO - (blobuploader) - INFO - Done attempting. 17:44:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:44:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:44:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:44:54 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:44:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:44:54 INFO - (blobuploader) - INFO - Done attempting. 17:44:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:44:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:44:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:44:56 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:44:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:44:56 INFO - (blobuploader) - INFO - Done attempting. 17:44:56 INFO - (blobuploader) - INFO - Iteration through files over. 17:44:56 INFO - Return code: 0 17:44:56 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:44:56 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:44:56 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/697a8fb5ce08cd6379b730d1c44777e12684a810757a097922c22fe1f307b9d9ea71a2afb4251e473c9273f98b0559a6b1659f36752920f34fa1fb609196e9f8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a6343832e0ab079bad0623fe09dba44b019226cb090f499ae8a80d429680353835ca4a3376fd31ed93838acf096462432b3a060c4e1246be67a48e519a6aa841", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c3254063ec0e8fa0c53963b1d80ec086cc2b1eb63514ee81e7d3c55a227d22b2757620253f7ef9c061049d3a785a39f68bae5945bb12d2dc298ca63798f2204", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/10c66cfa6bd34fec222cc72edf88504dab824958e32634dd823ec20671d165b9856c06a6e036e3f0f50f9bb8c6764a5966c0e424c35d7b40deb48549e61114bb"} 17:44:56 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:44:56 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:44:56 INFO - Contents: 17:44:56 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/697a8fb5ce08cd6379b730d1c44777e12684a810757a097922c22fe1f307b9d9ea71a2afb4251e473c9273f98b0559a6b1659f36752920f34fa1fb609196e9f8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a6343832e0ab079bad0623fe09dba44b019226cb090f499ae8a80d429680353835ca4a3376fd31ed93838acf096462432b3a060c4e1246be67a48e519a6aa841", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c3254063ec0e8fa0c53963b1d80ec086cc2b1eb63514ee81e7d3c55a227d22b2757620253f7ef9c061049d3a785a39f68bae5945bb12d2dc298ca63798f2204", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/10c66cfa6bd34fec222cc72edf88504dab824958e32634dd823ec20671d165b9856c06a6e036e3f0f50f9bb8c6764a5966c0e424c35d7b40deb48549e61114bb"} 17:44:56 INFO - Running post-run listener: copy_logs_to_upload_dir 17:44:56 INFO - Copying logs to upload dir... 17:44:56 INFO - mkdir: /builds/slave/test/build/upload/logs 17:44:56 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.859989 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-03-15 17:44:56.232086) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 17:44:56.235221) ========= 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.0JKR6Blrrz/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.d2VYYEbgyL/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/697a8fb5ce08cd6379b730d1c44777e12684a810757a097922c22fe1f307b9d9ea71a2afb4251e473c9273f98b0559a6b1659f36752920f34fa1fb609196e9f8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a6343832e0ab079bad0623fe09dba44b019226cb090f499ae8a80d429680353835ca4a3376fd31ed93838acf096462432b3a060c4e1246be67a48e519a6aa841", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c3254063ec0e8fa0c53963b1d80ec086cc2b1eb63514ee81e7d3c55a227d22b2757620253f7ef9c061049d3a785a39f68bae5945bb12d2dc298ca63798f2204", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/10c66cfa6bd34fec222cc72edf88504dab824958e32634dd823ec20671d165b9856c06a6e036e3f0f50f9bb8c6764a5966c0e424c35d7b40deb48549e61114bb"} build_url:https://queue.taskcluster.net/v1/task/AvL1bm5CSrO1B75BiIZUCA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011009 build_url: 'https://queue.taskcluster.net/v1/task/AvL1bm5CSrO1B75BiIZUCA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/697a8fb5ce08cd6379b730d1c44777e12684a810757a097922c22fe1f307b9d9ea71a2afb4251e473c9273f98b0559a6b1659f36752920f34fa1fb609196e9f8", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/a6343832e0ab079bad0623fe09dba44b019226cb090f499ae8a80d429680353835ca4a3376fd31ed93838acf096462432b3a060c4e1246be67a48e519a6aa841", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/2c3254063ec0e8fa0c53963b1d80ec086cc2b1eb63514ee81e7d3c55a227d22b2757620253f7ef9c061049d3a785a39f68bae5945bb12d2dc298ca63798f2204", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/10c66cfa6bd34fec222cc72edf88504dab824958e32634dd823ec20671d165b9856c06a6e036e3f0f50f9bb8c6764a5966c0e424c35d7b40deb48549e61114bb"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-15 17:44:56.269944) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 17:44:56.270248) ========= 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.0JKR6Blrrz/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.d2VYYEbgyL/Listeners TMPDIR=/var/folders/bj/hz090k0x51d88nc483dscv7m00000w/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.004643 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-15 17:44:56.319274) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 17:44:56.319552) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-15 17:44:56.319882) ========= ========= Total master_lag: 0.18 =========