builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0286 starttime: 1494282177.43 results: success (0) buildid: 20170508140042 builduid: 3d185743c5354e9ca1bdfe74d85acdbe revision: 798ee0e6f73eaed68e3f3968a20e9ae5c7a82718 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 15:22:57.430393) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-08 15:22:57.430837) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 15:22:57.431121) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-08 15:22:57.456730) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 15:22:57.457154) ========= 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.ybI4BNWnTe/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.osa7rCxI49/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-05-08 15:22:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 143M=0s 2017-05-08 15:22:57 (143 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.351179 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 15:22:57.832822) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 15:22:57.833154) ========= 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.ybI4BNWnTe/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.osa7rCxI49/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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.021340 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 15:22:57.881089) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-08 15:22:57.881469) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 798ee0e6f73eaed68e3f3968a20e9ae5c7a82718 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 798ee0e6f73eaed68e3f3968a20e9ae5c7a82718 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ybI4BNWnTe/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.osa7rCxI49/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-05-08 15:22:57,968 truncating revision to first 12 chars 2017-05-08 15:22:57,968 Setting DEBUG logging. 2017-05-08 15:22:57,968 attempt 1/10 2017-05-08 15:22:57,968 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/798ee0e6f73e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-08 15:22:59,155 unpacking tar archive at: mozilla-beta-798ee0e6f73e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.452174 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-08 15:22:59.358021) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 15:22:59.358426) ========= script_repo_revision: 798ee0e6f73eaed68e3f3968a20e9ae5c7a82718 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-08 15:22:59.358820) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 15:22:59.359086) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-08 15:22:59.385250) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-05-08 15:22:59.385637) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ybI4BNWnTe/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.osa7rCxI49/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 15:22:59 INFO - MultiFileLogger online at 20170508 15:22:59 in /builds/slave/test 15:22:59 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 15:22:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:22:59 INFO - {'append_to_log': False, 15:22:59 INFO - 'base_work_dir': '/builds/slave/test', 15:22:59 INFO - 'blob_upload_branch': 'Mozilla-Beta', 15:22:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:22:59 INFO - 'branch': 'Mozilla-Beta', 15:22:59 INFO - 'buildbot_json_path': 'buildprops.json', 15:22:59 INFO - 'config_files': ('talos/mac_config.py',), 15:22:59 INFO - 'default_actions': ('clobber', 15:22:59 INFO - 'read-buildbot-config', 15:22:59 INFO - 'download-and-extract', 15:22:59 INFO - 'populate-webroot', 15:22:59 INFO - 'create-virtualenv', 15:22:59 INFO - 'install', 15:22:59 INFO - 'run-tests'), 15:22:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:22:59 INFO - 'download_minidump_stackwalk': True, 15:22:59 INFO - 'download_symbols': 'ondemand', 15:22:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:22:59 INFO - 'tooltool.py': '/tools/tooltool.py', 15:22:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:22:59 INFO - '/tools/misc-python/virtualenv.py')}, 15:22:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:22:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:22:59 INFO - 'gecko_profile': False, 15:22:59 INFO - 'gecko_profile_interval': 0, 15:22:59 INFO - 'installer_path': 'installer.exe', 15:22:59 INFO - 'log_level': 'info', 15:22:59 INFO - 'log_name': 'talos', 15:22:59 INFO - 'log_to_console': True, 15:22:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 15:22:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 15:22:59 INFO - 'opt_config_files': (), 15:22:59 INFO - 'pip_index': False, 15:22:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:22:59 INFO - 'cmd': ('bash', 15:22:59 INFO - '-c', 15:22:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:22:59 INFO - 'enabled': True, 15:22:59 INFO - 'halt_on_failure': False, 15:22:59 INFO - 'name': 'check_screen_resolution'},), 15:22:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 15:22:59 INFO - 'cmd': ('bash', 15:22:59 INFO - '-c', 15:22:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 15:22:59 INFO - 'enabled': True, 15:22:59 INFO - 'halt_on_failure': False, 15:22:59 INFO - 'name': 'check_screen_resolution'},), 15:22:59 INFO - 'run_cmd_checks_enabled': True, 15:22:59 INFO - 'suite': 'dromaeojs-e10s', 15:22:59 INFO - 'system_bits': '32', 15:22:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:22:59 INFO - 'title': 't-yosemite-r7-0286', 15:22:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:22:59 INFO - 'use_talos_json': True, 15:22:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:22:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:22:59 INFO - 'work_dir': 'build'} 15:22:59 INFO - [mozharness: 2017-05-08 22:22:59.593560Z] Running clobber step. 15:22:59 INFO - Running pre-action listener: _resource_record_pre_action 15:22:59 INFO - Running main action method: clobber 15:22:59 INFO - rmtree: /builds/slave/test/build 15:22:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:23:01 INFO - Running post-action listener: _resource_record_post_action 15:23:01 INFO - [mozharness: 2017-05-08 22:23:01.753950Z] Finished clobber step (success) 15:23:01 INFO - [mozharness: 2017-05-08 22:23:01.754114Z] Running read-buildbot-config step. 15:23:01 INFO - Running pre-action listener: _resource_record_pre_action 15:23:01 INFO - Running main action method: read_buildbot_config 15:23:01 INFO - Using buildbot properties: 15:23:01 INFO - { 15:23:01 INFO - "project": "", 15:23:01 INFO - "product": "firefox", 15:23:01 INFO - "script_repo_revision": "production", 15:23:01 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 15:23:01 INFO - "repository": "", 15:23:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 15:23:01 INFO - "buildid": "20170508140042", 15:23:01 INFO - "pgo_build": "False", 15:23:01 INFO - "basedir": "/builds/slave/test", 15:23:01 INFO - "buildnumber": 27, 15:23:01 INFO - "slavename": "t-yosemite-r7-0286", 15:23:01 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 15:23:01 INFO - "platform": "yosemite_r7", 15:23:01 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 15:23:01 INFO - "branch": "mozilla-beta", 15:23:01 INFO - "repo_path": "releases/mozilla-beta", 15:23:01 INFO - "revision": "798ee0e6f73eaed68e3f3968a20e9ae5c7a82718", 15:23:01 INFO - "stage_platform": "macosx64", 15:23:01 INFO - "builduid": "3d185743c5354e9ca1bdfe74d85acdbe", 15:23:01 INFO - "slavebuilddir": "test" 15:23:01 INFO - } 15:23:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 15:23:01 INFO - Running post-action listener: _resource_record_post_action 15:23:01 INFO - [mozharness: 2017-05-08 22:23:01.757726Z] Finished read-buildbot-config step (success) 15:23:01 INFO - [mozharness: 2017-05-08 22:23:01.757848Z] Running download-and-extract step. 15:23:01 INFO - Running pre-action listener: _resource_record_pre_action 15:23:01 INFO - Running main action method: download_and_extract 15:23:01 INFO - mkdir: /builds/slave/test/build/tests 15:23:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:01 INFO - trying https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 15:23:01 INFO - Downloading https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 15:23:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 15:23:03 INFO - Downloaded 1287 bytes. 15:23:03 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 15:23:03 INFO - Using the following test package requirements: 15:23:03 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 15:23:03 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 15:23:03 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 15:23:03 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 15:23:03 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 15:23:03 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 15:23:03 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 15:23:03 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 15:23:03 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 15:23:03 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 15:23:03 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 15:23:03 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 15:23:03 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 15:23:03 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 15:23:03 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 15:23:03 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 15:23:03 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 15:23:03 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 15:23:03 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 15:23:03 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 15:23:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 15:23:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 15:23:03 INFO - Fetch https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 15:23:04 INFO - Expected file size: 51223527 15:23:04 INFO - Obtained file size: 51223527 15:23:20 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 15:23:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 15:23:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 15:23:20 INFO - Fetch https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 15:23:23 INFO - Expected file size: 51223527 15:23:23 INFO - Obtained file size: 51223527 15:23:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 15:23:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 15:23:38 INFO - Fetch https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 15:23:39 INFO - Expected file size: 14404449 15:23:39 INFO - Obtained file size: 14404449 15:23: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')]} 15:23:39 INFO - trying https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.dmg 15:23:39 INFO - Downloading https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 15:23:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 15:23:41 INFO - Downloaded 59569966 bytes. 15:23:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.dmg 15:23:41 INFO - mkdir: /builds/slave/test/properties 15:23:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:23:41 INFO - Writing to file /builds/slave/test/properties/build_url 15:23:41 INFO - Contents: 15:23:41 INFO - build_url:https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.dmg 15:23:41 INFO - Running post-action listener: _resource_record_post_action 15:23:41 INFO - Running post-action listener: set_extra_try_arguments 15:23:41 INFO - [mozharness: 2017-05-08 22:23:41.855296Z] Finished download-and-extract step (success) 15:23:41 INFO - [mozharness: 2017-05-08 22:23:41.855445Z] Running populate-webroot step. 15:23:41 INFO - Running pre-action listener: _resource_record_pre_action 15:23:41 INFO - Running main action method: populate_webroot 15:23:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:23:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:23:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:23:41 INFO - '--tppagecycles', 15:23:41 INFO - '7'], 15:23:41 INFO - 'tests': ['tsvgm']}}, 15:23:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:23:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:23:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:23:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:23:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:23:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:23:41 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 15:23:41 INFO - 'talos_options': ['--disable-e10s'], 15:23:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:23:41 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 15:23:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:23:41 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 15:23:41 INFO - 'talos_options': ['--disable-e10s'], 15:23:41 INFO - 'tests': ['damp', 'tps']}, 15:23:41 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 15:23:41 INFO - 'tests': ['damp', 'tps']}, 15:23:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:23:41 INFO - 'tests': ['dromaeo_dom']}, 15:23:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:23:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:23:41 INFO - 'tests': ['basic_compositor_video']}, 15:23:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:23:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:23:41 INFO - 'tests': ['a11yr', 15:23:41 INFO - 'ts_paint', 15:23:41 INFO - 'tpaint', 15:23:41 INFO - 'sessionrestore', 15:23:41 INFO - 'sessionrestore_no_auto_restore', 15:23:41 INFO - 'tabpaint']}, 15:23:41 INFO - 'other-e10s': {'tests': ['a11yr', 15:23:41 INFO - 'ts_paint', 15:23:41 INFO - 'tpaint', 15:23:41 INFO - 'sessionrestore', 15:23:41 INFO - 'sessionrestore_no_auto_restore', 15:23:41 INFO - 'tabpaint']}, 15:23:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:23:41 INFO - 'ts_paint', 15:23:41 INFO - 'tpaint', 15:23:41 INFO - 'sessionrestore', 15:23:41 INFO - 'sessionrestore_no_auto_restore', 15:23:41 INFO - 'tabpaint']}, 15:23:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:23:41 INFO - 'ts_paint', 15:23:41 INFO - 'tpaint', 15:23:41 INFO - 'sessionrestore', 15:23:41 INFO - 'sessionrestore_no_auto_restore', 15:23:41 INFO - 'tabpaint']}, 15:23:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:23:41 INFO - 'tests': ['a11yr', 15:23:41 INFO - 'ts_paint', 15:23:41 INFO - 'tpaint', 15:23:41 INFO - 'sessionrestore', 15:23:41 INFO - 'sessionrestore_no_auto_restore', 15:23:41 INFO - 'tabpaint']}, 15:23:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:23:41 INFO - 'tests': ['a11yr', 15:23:41 INFO - 'ts_paint', 15:23:41 INFO - 'tpaint', 15:23:41 INFO - 'sessionrestore', 15:23:41 INFO - 'sessionrestore_no_auto_restore', 15:23:41 INFO - 'tabpaint']}, 15:23:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:23:41 INFO - 'tests': ['tsvgx', 15:23:41 INFO - 'tsvgr_opacity', 15:23:41 INFO - 'tart', 15:23:41 INFO - 'tscrollx', 15:23:41 INFO - 'cart', 15:23:41 INFO - 'tsvg_static']}, 15:23:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:23:41 INFO - 'tsvgr_opacity', 15:23:41 INFO - 'tart', 15:23:41 INFO - 'tscrollx', 15:23:41 INFO - 'cart', 15:23:41 INFO - 'tsvg_static']}, 15:23:41 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 15:23:41 INFO - 'talos_options': ['--disable-e10s'], 15:23:41 INFO - 'tests': ['tp5o']}, 15:23:41 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 15:23:41 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 15:23:41 INFO - 'talos_options': ['--disable-e10s', 15:23:41 INFO - '--xperf_path', 15:23:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:23:41 INFO - 'tests': ['tp5n']}, 15:23:41 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 15:23:41 INFO - 'talos_options': ['--xperf_path', 15:23:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:23:41 INFO - 'tests': ['tp5n']}}, 15:23:41 INFO - 'talos.zip': {'path': '', 15:23:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:23:41 INFO - Running post-action listener: _resource_record_post_action 15:23:41 INFO - [mozharness: 2017-05-08 22:23:41.874648Z] Finished populate-webroot step (success) 15:23:41 INFO - [mozharness: 2017-05-08 22:23:41.874761Z] Running create-virtualenv step. 15:23:41 INFO - Running pre-action listener: _resource_record_pre_action 15:23:41 INFO - Running main action method: create_virtualenv 15:23:41 INFO - Creating virtualenv /builds/slave/test/build/venv 15:23:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 15:23:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:23:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:23:41 INFO - Using real prefix '/tools/python27' 15:23:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:23:42 INFO - Installing distribute.............................................................................................................................................................................................done. 15:23:45 INFO - Installing pip.................done. 15:23:45 INFO - Return code: 0 15:23:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 15:23:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 15:23:45 INFO - Reading from file tmpfile_stdout 15:23:45 INFO - Output received: 15:23:45 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 15:23:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109815b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109818768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94eb5cf1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095f3d30>, '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 0x10951adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095e8be8>, '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.ybI4BNWnTe/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.osa7rCxI49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 15:23:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:23:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:23:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ybI4BNWnTe/Render', 15:23:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:23:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:23:45 INFO - 'HOME': '/Users/cltbld', 15:23:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:23:45 INFO - 'LOGNAME': 'cltbld', 15:23:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:45 INFO - 'MOZ_NO_REMOTE': '1', 15:23:45 INFO - 'NO_EM_RESTART': '1', 15:23:45 INFO - 'PAGER': '/bin/cat', 15:23:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:23:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:45 INFO - 'PWD': '/builds/slave/test', 15:23:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:23:45 INFO - 'SHELL': '/bin/bash', 15:23:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.osa7rCxI49/Listeners', 15:23:45 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 15:23:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:23:45 INFO - 'USER': 'cltbld', 15:23:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:23:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:23:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:45 INFO - 'XPC_FLAGS': '0x0', 15:23:45 INFO - 'XPC_SERVICE_NAME': '0', 15:23:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:23:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:46 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 15:23:46 INFO - Cleaning up... 15:23:46 INFO - Return code: 0 15:23:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:46 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 0x109815b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109818768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94eb5cf1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095f3d30>, '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 0x10951adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095e8be8>, '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.ybI4BNWnTe/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.osa7rCxI49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 15:23:46 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 15:23:46 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 15:23:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ybI4BNWnTe/Render', 15:23:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:23:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:23:46 INFO - 'HOME': '/Users/cltbld', 15:23:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:23:46 INFO - 'LOGNAME': 'cltbld', 15:23:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:46 INFO - 'MOZ_NO_REMOTE': '1', 15:23:46 INFO - 'NO_EM_RESTART': '1', 15:23:46 INFO - 'PAGER': '/bin/cat', 15:23:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:23:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:46 INFO - 'PWD': '/builds/slave/test', 15:23:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:23:46 INFO - 'SHELL': '/bin/bash', 15:23:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.osa7rCxI49/Listeners', 15:23:46 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 15:23:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:23:46 INFO - 'USER': 'cltbld', 15:23:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:23:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:23:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:46 INFO - 'XPC_FLAGS': '0x0', 15:23:46 INFO - 'XPC_SERVICE_NAME': '0', 15:23:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:23:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:46 INFO - Downloading/unpacking psutil>=3.1.1 15:23: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 15:23: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 15:23: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 15:23: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 15:23: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 15:23: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 15:23:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:23:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:23:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:23:48 INFO - Installing collected packages: psutil 15:23:48 INFO - Running setup.py install for psutil 15:23:48 INFO - building 'psutil._psutil_osx' extension 15:23:48 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 15:23:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 15:23:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 15:23:49 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 15:23:49 INFO - building 'psutil._psutil_posix' extension 15:23:49 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 15:23:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 15:23:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 15:23:49 INFO - ^ 15:23:49 INFO - 1 warning generated. 15:23:49 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 15:23:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:23:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:23:49 INFO - Successfully installed psutil 15:23:49 INFO - Cleaning up... 15:23:49 INFO - Return code: 0 15:23:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:23: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')]} 15:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23: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')]} 15:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109815b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109818768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94eb5cf1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095f3d30>, '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 0x10951adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095e8be8>, '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.ybI4BNWnTe/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.osa7rCxI49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 15:23: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:23: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 mozsystemmonitor==0.3 15:23:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ybI4BNWnTe/Render', 15:23:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:23:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:23:49 INFO - 'HOME': '/Users/cltbld', 15:23:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:23:49 INFO - 'LOGNAME': 'cltbld', 15:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:49 INFO - 'MOZ_NO_REMOTE': '1', 15:23:49 INFO - 'NO_EM_RESTART': '1', 15:23:49 INFO - 'PAGER': '/bin/cat', 15:23:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:49 INFO - 'PWD': '/builds/slave/test', 15:23:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:23:49 INFO - 'SHELL': '/bin/bash', 15:23:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.osa7rCxI49/Listeners', 15:23:49 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 15:23:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:23:49 INFO - 'USER': 'cltbld', 15:23:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:23:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:49 INFO - 'XPC_FLAGS': '0x0', 15:23:49 INFO - 'XPC_SERVICE_NAME': '0', 15:23:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:23:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:23:49 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 15:23:49 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 15:23:49 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 15:23:49 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 15:23:49 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 15:23:49 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 15:23:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:23:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:23:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:23:51 INFO - Installing collected packages: mozsystemmonitor 15:23:51 INFO - Running setup.py install for mozsystemmonitor 15:23:51 INFO - Successfully installed mozsystemmonitor 15:23:51 INFO - Cleaning up... 15:23:51 INFO - Return code: 0 15:23:51 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:52 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')]} 15:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:52 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 0x109815b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109818768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94eb5cf1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095f3d30>, '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 0x10951adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095e8be8>, '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.ybI4BNWnTe/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.osa7rCxI49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 15:23:52 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 15:23:52 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 15:23:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ybI4BNWnTe/Render', 15:23:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:23:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:23:52 INFO - 'HOME': '/Users/cltbld', 15:23:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:23:52 INFO - 'LOGNAME': 'cltbld', 15:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:52 INFO - 'MOZ_NO_REMOTE': '1', 15:23:52 INFO - 'NO_EM_RESTART': '1', 15:23:52 INFO - 'PAGER': '/bin/cat', 15:23:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:52 INFO - 'PWD': '/builds/slave/test', 15:23:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:23:52 INFO - 'SHELL': '/bin/bash', 15:23:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.osa7rCxI49/Listeners', 15:23:52 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 15:23:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:23:52 INFO - 'USER': 'cltbld', 15:23:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:23:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:52 INFO - 'XPC_FLAGS': '0x0', 15:23:52 INFO - 'XPC_SERVICE_NAME': '0', 15:23:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:52 INFO - Downloading/unpacking jsonschema==2.5.1 15:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:23:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:23:53 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 15:23:53 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 15:23:53 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 15:23:53 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 15:23:53 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 15:23:53 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 15:23:54 INFO - Downloading functools32-3.2.3-2.tar.gz 15:23:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:23:54 INFO - warning: no files found matching '*.txt' 15:23:54 INFO - no previously-included directories found matching 'build' 15:23:54 INFO - no previously-included directories found matching 'dist' 15:23:54 INFO - no previously-included directories found matching '.git*' 15:23:54 INFO - Installing collected packages: jsonschema, functools32 15:23:54 INFO - Running setup.py install for functools32 15:23:54 INFO - warning: no files found matching '*.txt' 15:23:54 INFO - no previously-included directories found matching 'build' 15:23:54 INFO - no previously-included directories found matching 'dist' 15:23:54 INFO - no previously-included directories found matching '.git*' 15:23:54 INFO - Successfully installed jsonschema functools32 15:23:54 INFO - Cleaning up... 15:23:54 INFO - Return code: 0 15:23:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109815b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109818768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94eb5cf1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095f3d30>, '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 0x10951adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095e8be8>, '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.ybI4BNWnTe/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.osa7rCxI49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 15:23:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:23:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ybI4BNWnTe/Render', 15:23:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:23:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:23:54 INFO - 'HOME': '/Users/cltbld', 15:23:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:23:54 INFO - 'LOGNAME': 'cltbld', 15:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:54 INFO - 'MOZ_NO_REMOTE': '1', 15:23:54 INFO - 'NO_EM_RESTART': '1', 15:23:54 INFO - 'PAGER': '/bin/cat', 15:23:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:54 INFO - 'PWD': '/builds/slave/test', 15:23:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:23:54 INFO - 'SHELL': '/bin/bash', 15:23:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.osa7rCxI49/Listeners', 15:23:54 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 15:23:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:23:54 INFO - 'USER': 'cltbld', 15:23:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:23:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:54 INFO - 'XPC_FLAGS': '0x0', 15:23:54 INFO - 'XPC_SERVICE_NAME': '0', 15:23:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:23:54 INFO - Cleaning up... 15:23:54 INFO - Return code: 0 15:23:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109815b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109818768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94eb5cf1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095f3d30>, '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 0x10951adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095e8be8>, '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.ybI4BNWnTe/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.osa7rCxI49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 15:23:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:23:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:23:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ybI4BNWnTe/Render', 15:23:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:23:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:23:54 INFO - 'HOME': '/Users/cltbld', 15:23:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:23:54 INFO - 'LOGNAME': 'cltbld', 15:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:54 INFO - 'MOZ_NO_REMOTE': '1', 15:23:54 INFO - 'NO_EM_RESTART': '1', 15:23:54 INFO - 'PAGER': '/bin/cat', 15:23:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:54 INFO - 'PWD': '/builds/slave/test', 15:23:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:23:54 INFO - 'SHELL': '/bin/bash', 15:23:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.osa7rCxI49/Listeners', 15:23:54 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 15:23:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:23:54 INFO - 'USER': 'cltbld', 15:23:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:23:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:54 INFO - 'XPC_FLAGS': '0x0', 15:23:54 INFO - 'XPC_SERVICE_NAME': '0', 15:23:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:23:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:55 INFO - Downloading/unpacking blobuploader==1.2.4 15:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:56 INFO - Downloading blobuploader-1.2.4.tar.gz 15:23:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:23:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:23:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:23:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:23:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:23:57 INFO - Downloading docopt-0.6.1.tar.gz 15:23:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:23:57 INFO - Installing collected packages: blobuploader, requests, docopt 15:23:57 INFO - Running setup.py install for blobuploader 15:23:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:23:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:23:57 INFO - Running setup.py install for requests 15:23:58 INFO - Running setup.py install for docopt 15:23:58 INFO - Successfully installed blobuploader requests docopt 15:23:58 INFO - Cleaning up... 15:23:58 INFO - Return code: 0 15:23:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:23:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:23:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:23:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:23:58 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 0x109815b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109818768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94eb5cf1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095f3d30>, '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 0x10951adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095e8be8>, '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.ybI4BNWnTe/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.osa7rCxI49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 15:23:58 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 15:23:58 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 15:23:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ybI4BNWnTe/Render', 15:23:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:23:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:23:58 INFO - 'HOME': '/Users/cltbld', 15:23:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:23:58 INFO - 'LOGNAME': 'cltbld', 15:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:23:58 INFO - 'MOZ_NO_REMOTE': '1', 15:23:58 INFO - 'NO_EM_RESTART': '1', 15:23:58 INFO - 'PAGER': '/bin/cat', 15:23:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:23:58 INFO - 'PWD': '/builds/slave/test', 15:23:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:23:58 INFO - 'SHELL': '/bin/bash', 15:23:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.osa7rCxI49/Listeners', 15:23:58 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 15:23:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:23:58 INFO - 'USER': 'cltbld', 15:23:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:23:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:23:58 INFO - 'XPC_FLAGS': '0x0', 15:23:58 INFO - 'XPC_SERVICE_NAME': '0', 15:23:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:23:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:23:58 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-2UI6hH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:23:58 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-TrjgjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:23:58 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-1D_fmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:23:58 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-66uqXL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:23:59 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-lSHha5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:23:59 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ngEeL5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:23:59 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-gYklg2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:23:59 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-6r74Rm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:23:59 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-dfHoaT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:23:59 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-FD1W5n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:23:59 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-JEOWfx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:23:59 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-fgRiLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:23:59 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-n0FprK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:23:59 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-TE17s5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:00 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-fBXinh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:24:00 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ZZg41k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:24:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:24:00 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-GaxLzs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:24:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:24:00 INFO - Running setup.py install for manifestparser 15:24:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:24:00 INFO - Running setup.py install for mozcrash 15:24:00 INFO - Running setup.py install for mozdebug 15:24:00 INFO - Running setup.py install for mozdevice 15:24:01 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:24:01 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:24:01 INFO - Running setup.py install for mozfile 15:24:01 INFO - Running setup.py install for mozhttpd 15:24:01 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:24:01 INFO - Running setup.py install for mozinfo 15:24:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:24:01 INFO - Running setup.py install for mozInstall 15:24:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:24:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:24:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:24:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:24:01 INFO - Running setup.py install for mozleak 15:24:01 INFO - Running setup.py install for mozlog 15:24:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:24:01 INFO - Running setup.py install for moznetwork 15:24:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:24:02 INFO - Running setup.py install for mozprocess 15:24:02 INFO - Running setup.py install for mozprofile 15:24:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:24:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:24:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:24:02 INFO - Running setup.py install for mozrunner 15:24:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:24:02 INFO - Running setup.py install for mozscreenshot 15:24:02 INFO - Running setup.py install for moztest 15:24:02 INFO - Running setup.py install for mozversion 15:24:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:24:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:24:02 INFO - Cleaning up... 15:24:03 INFO - Return code: 0 15:24:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:03 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 0x109815b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109818768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94eb5cf1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095f3d30>, '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 0x10951adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095e8be8>, '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.ybI4BNWnTe/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.osa7rCxI49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 15:24:03 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 15:24:03 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 15:24:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ybI4BNWnTe/Render', 15:24:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:24:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:24:03 INFO - 'HOME': '/Users/cltbld', 15:24:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:24:03 INFO - 'LOGNAME': 'cltbld', 15:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:03 INFO - 'MOZ_NO_REMOTE': '1', 15:24:03 INFO - 'NO_EM_RESTART': '1', 15:24:03 INFO - 'PAGER': '/bin/cat', 15:24:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:03 INFO - 'PWD': '/builds/slave/test', 15:24:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:24:03 INFO - 'SHELL': '/bin/bash', 15:24:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.osa7rCxI49/Listeners', 15:24:03 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 15:24:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:24:03 INFO - 'USER': 'cltbld', 15:24:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:24:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:03 INFO - 'XPC_FLAGS': '0x0', 15:24:03 INFO - 'XPC_SERVICE_NAME': '0', 15:24:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:24:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-ypPfoJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:24:03 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)) 15:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:24:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-CgyHT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:24:03 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)) 15:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:24:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-9suG9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:24:03 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)) 15:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:24:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-EenS7x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:24:03 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)) 15:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:24:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-mFsz62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:24:03 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)) 15:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:24:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-0htNaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:24:03 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)) 15:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:24:03 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-Dp1TEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:24:04 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)) 15:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:24:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-IuUJrt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:24:04 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)) 15:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:24:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-C3q22M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:24:04 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)) 15:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:24:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-fdlBVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:24:04 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)) 15:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:24:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-cxpZB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:24:04 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)) 15:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:24:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-CUVwxw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:24:04 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)) 15:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:24:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-5BIXDF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:24:04 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)) 15:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:24:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-AP8G2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:24:04 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)) 15:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-YASasN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:24:04 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)) 15:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:24:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-Qr4RlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:24:04 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)) 15:24:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:24:04 INFO - Running setup.py (path:/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/pip-9twQnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:24:05 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)) 15:24:05 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)) 15:24:05 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)) 15:24:05 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)) 15:24:05 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)) 15:24:05 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)) 15:24:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:24:05 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 15:24:05 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 15:24:05 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 15:24:05 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 15:24:05 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 15:24:05 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 15:24:06 INFO - Downloading blessings-1.6.tar.gz 15:24:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:24:06 INFO - Installing collected packages: blessings 15:24:06 INFO - Running setup.py install for blessings 15:24:06 INFO - Successfully installed blessings 15:24:06 INFO - Cleaning up... 15:24:06 INFO - Return code: 0 15:24:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:24:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:24:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:24:07 INFO - Reading from file tmpfile_stdout 15:24:07 INFO - Current package versions: 15:24:07 INFO - blessings == 1.6 15:24:07 INFO - blobuploader == 1.2.4 15:24:07 INFO - docopt == 0.6.1 15:24:07 INFO - functools32 == 3.2.3-2 15:24:07 INFO - jsonschema == 2.5.1 15:24:07 INFO - manifestparser == 1.1 15:24:07 INFO - mozInstall == 1.12 15:24:07 INFO - mozcrash == 1.0 15:24:07 INFO - mozdebug == 0.1 15:24:07 INFO - mozdevice == 0.49 15:24:07 INFO - mozfile == 1.2 15:24:07 INFO - mozhttpd == 0.7 15:24:07 INFO - mozinfo == 0.9 15:24:07 INFO - mozleak == 0.1 15:24:07 INFO - mozlog == 3.4 15:24:07 INFO - moznetwork == 0.27 15:24:07 INFO - mozprocess == 0.25 15:24:07 INFO - mozprofile == 0.28 15:24:07 INFO - mozrunner == 6.13 15:24:07 INFO - mozscreenshot == 0.1 15:24:07 INFO - mozsystemmonitor == 0.3 15:24:07 INFO - moztest == 0.8 15:24:07 INFO - mozversion == 1.4 15:24:07 INFO - psutil == 3.1.1 15:24:07 INFO - requests == 1.2.3 15:24:07 INFO - wsgiref == 0.1.2 15:24:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:24:07 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')]} 15:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:07 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')]} 15:24:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:07 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 0x109815b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109818768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94eb5cf1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095f3d30>, '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 0x10951adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095e8be8>, '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.ybI4BNWnTe/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.osa7rCxI49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 15:24:07 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 15:24:07 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 15:24:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ybI4BNWnTe/Render', 15:24:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:24:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:24:07 INFO - 'HOME': '/Users/cltbld', 15:24:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:24:07 INFO - 'LOGNAME': 'cltbld', 15:24:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:07 INFO - 'MOZ_NO_REMOTE': '1', 15:24:07 INFO - 'NO_EM_RESTART': '1', 15:24:07 INFO - 'PAGER': '/bin/cat', 15:24:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:24:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:07 INFO - 'PWD': '/builds/slave/test', 15:24:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:24:07 INFO - 'SHELL': '/bin/bash', 15:24:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.osa7rCxI49/Listeners', 15:24:07 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 15:24:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:24:07 INFO - 'USER': 'cltbld', 15:24:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:24:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:24:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:07 INFO - 'XPC_FLAGS': '0x0', 15:24:07 INFO - 'XPC_SERVICE_NAME': '0', 15:24:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:24:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:07 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)) 15:24:07 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)) 15:24:07 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)) 15:24:07 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)) 15:24:07 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)) 15:24:07 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)) 15:24:07 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)) 15:24:07 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)) 15:24:07 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)) 15:24:07 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)) 15:24:07 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)) 15:24:07 INFO - Cleaning up... 15:24:07 INFO - Return code: 0 15:24:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:24:07 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')]} 15:24:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:24:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:07 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')]} 15:24:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:24:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:24:07 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 0x109815b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109818768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f94eb5cf1e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1095f3d30>, '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 0x10951adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095e8be8>, '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.ybI4BNWnTe/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.osa7rCxI49/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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 15:24:07 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 15:24:07 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 15:24:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ybI4BNWnTe/Render', 15:24:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:24:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:24:07 INFO - 'HOME': '/Users/cltbld', 15:24:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:24:07 INFO - 'LOGNAME': 'cltbld', 15:24:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:07 INFO - 'MOZ_NO_REMOTE': '1', 15:24:07 INFO - 'NO_EM_RESTART': '1', 15:24:07 INFO - 'PAGER': '/bin/cat', 15:24:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:24:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:07 INFO - 'PWD': '/builds/slave/test', 15:24:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:24:07 INFO - 'SHELL': '/bin/bash', 15:24:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.osa7rCxI49/Listeners', 15:24:07 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 15:24:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:24:07 INFO - 'USER': 'cltbld', 15:24:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:24:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:24:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:07 INFO - 'XPC_FLAGS': '0x0', 15:24:07 INFO - 'XPC_SERVICE_NAME': '0', 15:24:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:24:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:24:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:24:07 INFO - Cleaning up... 15:24:07 INFO - Return code: 0 15:24:07 INFO - Running post-action listener: _resource_record_post_action 15:24:07 INFO - Running post-action listener: _start_resource_monitoring 15:24:07 INFO - Starting resource monitoring. 15:24:07 INFO - [mozharness: 2017-05-08 22:24:07.650976Z] Finished create-virtualenv step (success) 15:24:07 INFO - [mozharness: 2017-05-08 22:24:07.652021Z] Running install step. 15:24:07 INFO - Running pre-action listener: _resource_record_pre_action 15:24:07 INFO - Running main action method: install 15:24:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:24:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:24:07 INFO - Reading from file tmpfile_stdout 15:24:07 INFO - Detecting whether we're running mozinstall >=1.0... 15:24:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:24:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:24:08 INFO - Reading from file tmpfile_stdout 15:24:08 INFO - Output received: 15:24:08 INFO - Usage: mozinstall [options] installer 15:24:08 INFO - Options: 15:24:08 INFO - -h, --help show this help message and exit 15:24:08 INFO - -d DEST, --destination=DEST 15:24:08 INFO - Directory to install application into. [default: 15:24:08 INFO - "/builds/slave/test"] 15:24:08 INFO - --app=APP Application being installed. [default: firefox] 15:24:08 INFO - mkdir: /builds/slave/test/build/application 15:24:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 15:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 15:24:22 INFO - Reading from file tmpfile_stdout 15:24:22 INFO - Output received: 15:24:22 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 15:24:22 INFO - Running post-action listener: _resource_record_post_action 15:24:22 INFO - [mozharness: 2017-05-08 22:24:22.754350Z] Finished install step (success) 15:24:22 INFO - [mozharness: 2017-05-08 22:24:22.754489Z] Running run-tests step. 15:24:22 INFO - Running pre-action listener: _resource_record_pre_action 15:24:22 INFO - Running main action method: run_tests 15:24:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:24:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:24:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:24:22 INFO - 2017-05-08 15:24:22.769 screenresolution[1986:15155] starting screenresolution argv=screenresolution get 15:24:22 INFO - 2017-05-08 15:24:22.771 screenresolution[1986:15155] Display 0: 1600x1200x32@60 15:24:22 INFO - 2017-05-08 15:24:22.777 screenresolution[1987:15157] starting screenresolution argv=screenresolution list 15:24:22 INFO - Available Modes on Display 0 15:24:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:24:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:24:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:24:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:24:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:24:23 INFO - Intel Iris: 15:24:23 INFO - Chipset Model: Intel Iris 15:24:23 INFO - Type: GPU 15:24:23 INFO - Bus: Built-In 15:24:23 INFO - VRAM (Dynamic, Max): 1536 MB 15:24:23 INFO - Vendor: Intel (0x8086) 15:24:23 INFO - Device ID: 0x0a2e 15:24:23 INFO - Revision ID: 0x0009 15:24:23 INFO - Displays: 15:24:23 INFO - Display: 15:24:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:24:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:24:23 INFO - Display Serial Number: 1600x1200 60 15:24:23 INFO - Main Display: Yes 15:24:23 INFO - Mirror: Off 15:24:23 INFO - Online: Yes 15:24:23 INFO - Rotation: Supported 15:24:23 INFO - Return code: 0 15:24:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:24:23 INFO - Python 2.7.3 15:24:23 INFO - Return code: 0 15:24:23 INFO - grabbing minidump binary from tooltool 15:24:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:24:23 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 0x1095f3d30>, '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 0x10951adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1095e8be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:24:23 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 15:24:23 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 15:24:23 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 15:24:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:24:23 INFO - Return code: 0 15:24:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 15:24:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:24:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:24:23 INFO - ENV: RUST_BACKTRACE is now 1 15:24:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 15:24:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:24:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0286', '--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 15:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0286 --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 15:24:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ybI4BNWnTe/Render', 15:24:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 15:24:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 15:24:23 INFO - 'HOME': '/Users/cltbld', 15:24:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 15:24:23 INFO - 'LOGNAME': 'cltbld', 15:24:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:24:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 15:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:24:23 INFO - 'MOZ_NO_REMOTE': '1', 15:24:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:24:23 INFO - 'NO_EM_RESTART': '1', 15:24:23 INFO - 'PAGER': '/bin/cat', 15:24:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 15:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:24:23 INFO - 'PWD': '/builds/slave/test', 15:24:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:24:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 15:24:23 INFO - 'RUST_BACKTRACE': '1', 15:24:23 INFO - 'SHELL': '/bin/bash', 15:24:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.osa7rCxI49/Listeners', 15:24:23 INFO - 'TMPDIR': '/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/', 15:24:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 15:24:23 INFO - 'USER': 'cltbld', 15:24:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 15:24:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 15:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:24:23 INFO - 'XPC_FLAGS': '0x0', 15:24:23 INFO - 'XPC_SERVICE_NAME': '0', 15:24:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 15:24:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0286', '--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 15:24:23 INFO - mozversion application_buildid: 20170508140042 15:24:23 INFO - mozversion application_changeset: 798ee0e6f73eaed68e3f3968a20e9ae5c7a82718 15:24:23 INFO - mozversion application_display_name: Firefox 15:24:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:24:23 INFO - mozversion application_name: Firefox 15:24:23 INFO - mozversion application_remotingname: firefox 15:24:23 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 15:24:23 INFO - mozversion application_vendor: Mozilla 15:24:23 INFO - mozversion application_version: 54.0 15:24:23 INFO - mozversion platform_buildid: 20170508140042 15:24:23 INFO - mozversion platform_changeset: 798ee0e6f73eaed68e3f3968a20e9ae5c7a82718 15:24:23 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 15:24:23 INFO - mozversion platform_version: 54.0 15:24:23 INFO - using testdate: 1494282263 15:24:23 INFO - actual date: 1494282263 15:24:23 INFO - starting webserver on 'localhost:49660' 15:24:23 INFO - SUITE-START | Running 2 tests 15:24:23 INFO - TEST-START | dromaeo_css 15:24:23 INFO - operating with platform_type : mac_ 15:24:23 INFO - Initialising browser for dromaeo_css test... 15:24:23 INFO - TEST-INFO | started process 1997 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmp9DPhtK/profile http://localhost:49660/getInfo.html) 15:24:26 INFO - PROCESS | 1997 | 2017-05-08 15:24:26.200 plugin-container[2000:15317] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4d4b, name = 'com.apple.tsm.portname' 15:24:26 INFO - PROCESS | 1997 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:24:26 INFO - PROCESS | 1997 | 2017-05-08 15:24:26.201 plugin-container[2000:15317] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4b27, name = 'com.apple.CFPasteboardClient' 15:24:26 INFO - PROCESS | 1997 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:24:26 INFO - PROCESS | 1997 | 2017-05-08 15:24:26.201 plugin-container[2000:15317] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:24:26 INFO - PROCESS | 1997 | __metrics Screen width/height:1600/1200 15:24:26 INFO - PROCESS | 1997 | colorDepth:24 15:24:26 INFO - PROCESS | 1997 | Browser inner width/height: 1024/689 15:24:26 INFO - PROCESS | 1997 | __metrics 15:24:26 ERROR - PROCESS | 1997 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 15:24:26 INFO - TEST-INFO | 1997: exit 0 15:24:26 INFO - Browser initialized. 15:24:26 INFO - Running cycle 1/1 for dromaeo_css test... 15:24:26 INFO - TEST-INFO | started process 2001 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmp9DPhtK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:24:29 INFO - PROCESS | 2001 | 2017-05-08 15:24:29.124 plugin-container[2002:15446] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x833f, name = 'com.apple.tsm.portname' 15:24:29 INFO - PROCESS | 2001 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:24:29 INFO - PROCESS | 2001 | 2017-05-08 15:24:29.125 plugin-container[2002:15446] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x880f, name = 'com.apple.CFPasteboardClient' 15:24:29 INFO - PROCESS | 2001 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:24:29 INFO - PROCESS | 2001 | 2017-05-08 15:24:29.125 plugin-container[2002:15446] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:24:38 INFO - PROCESS | 2001 | RSS: Main: 174583808 15:24:38 INFO - PROCESS | 2001 | 15:27:41 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:49660/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49660/tests/dromaeo/cssquery-ext.html) 15:27:43 INFO - PROCESS | 2001 | RSS: Main: 193257472 15:27:43 INFO - PROCESS | 2001 | 15:30:45 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:49660/tests/dromaeo/cssquery-ext.html (next: http://localhost:49660/tests/dromaeo/cssquery-jquery.html) 15:30:46 INFO - PROCESS | 2001 | RSS: Main: 203653120 15:30:46 INFO - PROCESS | 2001 | 15:33:48 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:49660/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49660/tests/dromaeo/cssquery-mootools.html) 15:33:49 INFO - PROCESS | 2001 | RSS: Main: 205352960 15:33:49 INFO - PROCESS | 2001 | 15:36:50 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:49660/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49660/tests/dromaeo/cssquery-prototype.html) 15:36:51 INFO - PROCESS | 2001 | RSS: Main: 208482304 15:36:51 INFO - PROCESS | 2001 | 15:39:54 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:49660/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49660/tests/dromaeo/cssquery-yui.html) 15:39:55 INFO - PROCESS | 2001 | RSS: Main: 210923520 15:39:55 INFO - PROCESS | 2001 | 15:42:57 INFO - PROCESS | 2001 | Cycle 1(1): loaded http://localhost:49660/tests/dromaeo/cssquery-yui.html (next: http://localhost:49660/tests/dromaeo/cssquery-dojo.html) 15:42:57 INFO - PROCESS | 2001 | RSS: Main: 209096704 15:42:57 INFO - PROCESS | 2001 | 15:42:57 INFO - PROCESS | 2001 | __start_tp_report 15:42:57 INFO - PROCESS | 2001 | _x_x_mozilla_page_load 15:42:57 INFO - PROCESS | 2001 | _x_x_mozilla_page_load_details 15:42:57 INFO - PROCESS | 2001 | |i|pagename|runs| 15:42:57 INFO - PROCESS | 2001 | |0;dojo.html;3226.822524761138;3432.794032358057;3510.140015696155;3654.104744337638;3670.3576874047053;6182.969085154574;6206.534509911752;6210.596311239767;6214.098955651428;6255.030470277115;6128.203333566641;6187.814365569029;6200.627962322253;6206.534509911752;6214;4841.7821198045995;5546;5601.29983752031;5623.4938855503;5689.6586204827845;5670.06443936752;5672.68800215988;5672.938925211287;5679.432056794308;5736.512396446307;5460.645058071233;5478.808241711541;5623.690697011662;5666.46168613981;5671.688057156875;5034.270030845543;5655.26481557399;5689.374168841445;5732.799352022701;5757.712114394263;5336.092864213054;5574.944250557483;5582.804601838916;5656.462636049569;5664.093745000821;5477.424870388591;6081.969590152065;6127.509799216052;6221.502279817604;6223.190985171944;6504.8699026019685;6545.639989800559;6641.601503909733;6650.767223147167;6651.567648102858;6746.089277947463;6746.59520428771;6748.055272261888;6750.561213521155;6759.053732477457;6125.815438131368;6354.80935571929;6363.172787537683;6367.267764207176;6374.490040796772;6361.809145725636;6644.169478815148;6758.932410675929;6843.418309443654;6851.417629501549;6558.213014438298;6560.704768285439;6563.1796025496815;6573.441257493167;6587.80236592903;5359;6651.33486651331;6723.63020033893;6732.629705366252;6763.830904227335;6324.3043265240785;6386.457151142112;6476.870462590816;6515.315891831384;6571.441427478718;6344.143540621957;6593.208814942238;6648.966755166193;6654.23476300222;6663.800945687912;5271.65734227274;5300.09898317287;5305.389880163753;5315.574754019669;5382.515573598395;4740.7392593407;4786.521347865186;4814.133455977958;4817.759112044384;4821.252705830602;6228.844278893064;6382.010788327817;6385.074164246158;6401.615903045832;6407.871842563122;5495.725213739297;6544.574602650812;6650.168728908887;6749.966250168816;6800.421964133104;6348.650824204621;6377.330380310001;6379.393957574023;6387.041943708388;6400.423961843457;5960.433758792908;5971.552133589998;5973.970130149321;5980;5997.970010149921;5481.506664400223;6624.834379140464;6729.495287853529;6784.626845523544;6959.930400695928;5719.370869204467;6556;6670.83322916931;6675.866482670416;6792.93207067923;6946.479014073863;6960.79117626472;6974.407175389946;6991.196012458632;6995.4753393494675;5314;6317.968410158103;6369.681515924278;6500.414962653384;6600.537962342782;6752.291009443938;6772.796816095525;6788.76239331621;6791.966040169767;6825.2833452486775;6297.370262973666;6566.540342176193;6575.868482630225;6578.407943284936;6592.43964263043;6292.968535157478;6313.05304204373;6416.230052393743;6589.835254118685;6612.23959244693;6316.842078948063;6352.174217351715;6382.96808515973;6419;6430.807075787734;6513.902291465726;6548;6559.048937904073;6561.081448597105;6566.343365663395;6189.412005859436;6252.781152659635;6291.716872740829;6330.208723909512;6355.586886852339 15:42:57 INFO - PROCESS | 2001 | |1;ext.html;753.4386881773078;778.1051790440993;851.1105894340413;984.9852252216214;992.136840948375;40800.183996320055;41701;42968.140637187236;43018.13963720728;43062;41513.37729934054;42120;42211.36682949751;42322.57677423225;42407.15185696284;8312.70905518307;8476.02525709545;11227.214095013353;11510.827337589943;11775.94112029443;11540.422978851024;11556;11629.534818607246;11652.359120248382;11666.41667916605;11608.24546404481;11641.767164656743;11655.883441165606;11665.766684666301;11675.708107297301;11544.076473882069;11576.884231157706;11577;11615.477303521362;11620.360880151587;11279.548818047268;11346.48940797666;11373.772524549462;11389.088872890232;11395.316281023164;36313.45529817055;36410.8179459101;36463;36486;36559.63440365589;3892.649661530476;3907.9405283048904;3930.862419815321;3946.2699400610977;3966.940495892564;22328.665070023962;26784.330391740168;26805.597916031275;27029;28388;3177.4757165067967;3248.3990461764647;3310.0731795097413;3330.333933213343;3405.2338223899674;322662;324494;367945;400096;403594;37357;47301.5269847304;47693.284600731015;47993.5200647996;48017.75991120092;49220.753896230286;49369;49384.75307623511;49385;49409.752951235736;14873.553793386216;15010.924945375204;15012.249387530579;15022.774658379914;15051.849481505045;12742.299173545543;12863.742725145445;12902.935485322701;12917.935410322889;12926.482940682456;12471.93764031174;12491.375431228402;12506.937465312616;12600.243985360725;12612.990960723304;4797.800549862534;5226.216067589816;5375.16684913839;5700.486956173964;5704.714764261853;1105.1987309200765;1168.3165348271357;1171.7696418760268;1198.1253684810138;1207.4850180576998;23814.880925595262;28396.148115556567;28629.427411451656;28805.27986800305;28958.407287598962;1038.2057725839588;1260.3131293445094;1271.1419791640606;1282.140965553063;1322.5172811923578;11519.596814111634;15053.548393548212;15142.697146057017;15146.318415671321;15392.769108463383;495083;495963;496166.0383396192;496354;497184;50225;50624.74687626612;50709;50719.985600287786;50776.74611626918;1434.5839706485003;1440.1934916446824;1478.4825311141014;1487.8660920517204;1488.7692407676827;23160.884195578914;25506.48987020212;27633.585496217976;27713;28550.42899142047;44405.88985275394;44811.77594112008;45071;45116.54883451255;45158.32262516131;422801;489116;489255;491604;491632.54183728853;26182.738172618792;26669.59995600029;30765;31006.534901976036;31038.534421983237;41293;41397.586024139375;41668.166636666494;41841;42406.151876962904;23190.76809231886;28702.56946145768;29031.56452653254;29665.703342966295;30153;29412.705872941;29421.411571768873;29675.258118547208;30008.84995575008;30114.945976890704;33781.66218337884;35198;35258.29483410369;35901.82049089738;36504.90485285446;26175.607365889147;27145.185644430698;30116;30418.174909505502;30929.536056959612;21340.679889801977;24900.750992490568;25097.8705958236;25126.874365628053;25151.49697006013 15:42:57 INFO - PROCESS | 2001 | |2;jquery.html;390.9550401703804;422.09881902138926;424.04378127322883;436.7532344225513;463.20097831241094;20677.483062923435;22274.109035638576;22752.772472275272;22952.88523557384;23073.653895191586;22926.885365573147;23571;24093.277201683934;24448.87775561124;24457.510849782993;6666.866662666744;6792.490563207754;6915.239323674417;7048.083749112634;7066.434685225196;6774.153230846145;6846.623435711034;6896.827579310508;6905.516613837033;6913.89629155563;6640.468762498988;6895.448364130857;6967.198772141192;7009.75465858695;7011.474139439562;6529.706163222666;6801.557898736591;6861.931380686179;6865.244823069484;6866.622335771531;6765.458763298924;6770.221424536192;6775.390214880685;6782.948642960349;6790.660466976681;22252.10991560352;27644.86177569099;27762.305942351402;28126.578101328498;28200;2893.7829662775166;3025.6066711327608;3029.621297337833;3030.2424393901524;3058.694130586946;13345.666358341023;16274;16613.83386166147;16963.3214671413;17513.12434378276;2099.5276062885882;2171.4354267890462;2176.075168053571;2179.346196141167;2194.5172062146303;164616.3538364613;167842;171956;174487;176043.11978440153;17215.139243037796;20749.170033198803;20929.790702093087;21393.358199253737;21561.353159405244;33263.33473330568;33572.66427335695;33677;33683.66316336854;33723.49414758781;10879.619213327496;10991.725206869733;11278.379689117013;11315.207935444605;11330.37682927447;7467.626618669045;7643;9354.625814967325;9362.297827662953;9485.952570237105;9883.308168428284;9922.851157232648;9960.501974901226;9972.950135249423;10027.498625068718;3719.1445967427644;4275.5724427557;4280.957190428118;4320.978395108004;4372.737635741865;1060.2366296266675;1075.4783929794044;1078.654830454247;1083.7615724540588;1113.1595645287755;22651.660225096635;22954.42613934665;22972.310830675106;23047;23084;1088.9074428673493;1102.3165637304921;1137.7724455108846;1139.2367114033618;1142.5943789954613;11120;11831.704207394883;11970.341631210367;12039.879601204051;12046.939765301293;749647;757634;760508;764219;772967;122981;135381;146606;150482.24758876135;155519;1281.551456990046;1286.2154086007529;1313.1136482874022;1315.1780137414116;1319.287584704249;18720.362656698846;19683.31108411199;20696.068676909275;20948.58102837904;21273.255436059662;52356.47643523516;52749.7362513185;53661.195082074584;65246.02130967945;65638.68722625425;69028.65485672539;93445;95247.66633167806;96128.51935740277;96360.51819740856;9890.703278901645;10924.781504370027;12544.372781361079;13384.263865487103;13722.794158087836;13610.727785444433;14143.929280353532;14219.928900355431;14544.709105818036;14608.634784130481;10625.840612390975;11226.596675415572;11906.40467976615;12177.269363838199;12495.750084998432;10166.796664066826;11052;11107.333559986104;11165;11299.491522881655;10065.24510661718;12081.745550061105;12277.079219058427;12361.567345142877;12452.750944980868;13265.469381224642;13275.601731948056;13521.59435216945;13572.592822215349;13696.65758356049;11890.881091189323;12002.819957700467;12159.81760273579;12183.269003859798;12299.69250768738 15:42:57 INFO - PROCESS | 2001 | |3;mootools.html;1604.8796340274482;1640.9507714768554;1655.510040963133;1658.2537857963912;1674.0457938974785;11002.174836887236;11443.656690299284;11694.239874408167;11727;11813.822792658095;11549.711257218574;11774.411279436037;11781.410929453536;11784.17510774244;11801.291922484636;2408.9518209635753;2430.538197742423;2440.9023639054417;2446.8531888086773;2447.1801946347996;2352.517733864562;2399.9760002400017;2450.9509809803794;2453.7914277286454;2455.607102863542;2029.3911826452006;2361.586722323595;2422.903083876643;2423.8545687258734;2425.5876500994873;2325.720913490392;2379.7144342678903;2393.6050551658955;2395.101836811196;2402.111218849037;2380.4286971126976;2382.702162229721;2393.994522300638;2394.1979436888664;2402.1112188490197;10127.442990635513;11281.32312061279;11468.082553395709;11472.31166130035;11493.367864767435;5572.634704497384;5738.024535828878;5907.497862681677;5911.497522710575;5942.702864856783;3296.868125274986;3505.7896526208256;3637.418013117915;3670.467782171597;3690.132818787583;1165.3299352872132;1238.120934136755;1275.222114510148;1304.778187708092;1322.4644019172251;14170.92914535431;14407.495737649237;15240.237988100662;15826.366945322288;15874.841251587568;4591.357209990604;4706.1999460091865;4706.411698537683;4721.763911804396;4754.881127971828;12251.387430628432;12281.385930703429;12285.815712764315;12296.815547766791;12334.444949977273;5756;5785.681787501728;5794.217780599565;5796.362400135981;5810.273715785527;5115.8721031973755;5226.869328266824;5341.839744807662;5342.171963345688;5359.892802144013;3780.546334439885;3909.706771992112;3924.2151569686175;3967.9603203968168;3972.483577134954;999.1656966432964;1009.258195226508;1016.9542370593193;1017.3234798858676;1020.5713600287897;966.2318456826839;969.99030009699;995.1044060345602;1005.9547320370455;1008.495752123938;5833.854153646193;6763.951587503945;6804.455643548505;6906.827329316808;7018.719251229996;976.5800705696477;1020.8723909511311;1026.8870424253325;1029.6807989523272;1084.34939036579;4270.316749320094;4292.699511034198;4303.505096913832;4325.1565944641125;4416.984093658477;12384.009279257638;13549.306336707912;13717.931410343084;14249.002569820013;14324.427022919175;10920.836187457195;12411.813822792665;13544.86455135436;14213.431462741375;14223.786643200361;10260.43567603774;10483.580656773644;10546.156307495383;10564.10205132557;10569.894301057046;6925.757598484029;6932.61870597122;7168.211496735251;7175.569465832067;7301.744438944612;12189.268643881396;12827.358632068173;12900;12953.481860725842;13043.673908152372;11586.71033224176;11877.930986211282;12336.198147120409;13120.409581568661;13128.081034327506;10179.796404072025;10531.684049478528;10840.295380800222;10841.18691098155;10889.401082940514;8946.463212207029;10479.68560943173;10505.737356566147;10608.204384671026;10684.519196636014;8837.690680826141;8916.06381329951;8967.058458861986;9023.77440563965;9323.72028839136;8884.555772211494;9015.233705135137;9085.273178145864;9116.772080698036;9188.448693078437;8291.253787158943;8297.95851020741;8359.540225287425;8397.118302578141;8401.62192701342;6051.304100028553;6055.212822333245;6073.817785466266;6207.844803879939;6251.906221406592;6140.723667435065;6200.782972595937;6372.044193371032;6417.839554011187;6454.322296158835 15:42:57 INFO - PROCESS | 2001 | |4;prototype.html;340.7359296545178;388.1770646229993;391.4246058294308;400.20359484625584;404.62369995903805;4298;4835.323054772331;4857.6599638025355;5410.188471729242;5527.226188333637;4568.657350698702;5283.894322113555;5311.052365936904;5360.812371566996;5385.734352427176;4073;4220.620144187023;4310.612044915957;4322.697411181219;4457;3758.8762349272574;3807.562130355017;3932.4691166692414;4496.55034496551;4502.131615379613;4153.376993450991;4460.933086003713;4516.9774151129195;4520.208963431386;4524.751138687371;3792.715546334036;4018.799060046986;4398.406215160944;4503.234450143484;4504.279315309551;3886.145048089416;4061.3704875744306;4089.364254298275;4101.323281658522;4105.835766569334;5280.702894240979;5281.36623605166;5293.947060529384;5304.867378315573;5343.812966546191;4600.2869555218995;5016.473270306602;5163.690178589259;5169.2504586835075;5227.954409118153;5445.264889239981;5615.578831587647;5717.1995920570735;5722.97138514309;5743.712814359265;4270.210011147917;4361.849791793587;4390.517043125254;4582.404287442644;4637.675362724611;5158.716270605115;5616.1014237721765;5903.704814759245;5950.2264705587995;6202.6815653625545;4758.762061896891;4762.261849413347;4768.189407800683;4829.420469543607;4843.370361853007;4134.359174327984;4209.642180414638;4831.371921650163;4897.755112244374;4917.582005529499;4303.376010478526;4866.902661946812;5123.004056835674;5158.845234642967;5190.143626301618;4949.455559888409;5139.922901156486;5397.487238712316;5572.606848287928;5645.689487078168;1494.6412860913304;1591.8885678002428;1629.1691237468976;1631.2007116512823;1638.8197298297177;1051.3849398102043;1065.63235683689;1094.895984881435;1142.7088687182313;1240.4789988204795;5030.622703297267;5320.095583750772;5492.697901615449;5542.362628297717;5545.694986775766;4757.714537127784;5622.409646987089;5697.4587414195585;5719.656820590778;6044.576879618472;4952.801887924515;5255.921161182585;5404.29744133268;5471.972640136773;5574.470425309589;2680.490706765708;3097.7212050915527;3115.345777386729;3125.968430417957;3152.8108313500807;5412.972935135299;5790.478856902815;5964.7912323068485;6247.437730604177;6296.370362963667;5450.91823622646;5781.768729250867;6184.81445556634;6214.937850621526;6234.101142968541;5289.418164001957;5401.378841433207;5975.551833612496;6223.284322302902;6261.7182226799;5217.321748172713;5487.588430867621;5964.956132676851;6032.426919442646;6062.848428789315;5247.501487358695;5409.891802164014;5567.969925563783;5713.685747283939;5988.28140623128;5858.794942177004;6090;6223.813285601439;6238.594491358047;6261.685046140179;4414.9558504414545;4541;4667.346571480063;4689.226277664147;4706.235011990326;5057.949420505748;5323.547498462674;5658.9151162733415;5886.823395298148;6003.339632640319;5196.53231209193;5572.804951826666;5582.49757521825;5761.596688231783;5839.5036421904615;4822.7829747662145;5015;5393.9730301348245;5667.036603777286;5865.3254875688135;4690.648201384978;4725.40932383452;5469.179623056573;5586.217929489793;5722.656640601577;4769.998300356964;5197.896042079213;5846.912296315644;5919.822405327847;5955.434233747787;5412.83761487156;5618.438156184349;5674.56688703345;5684.687342196219;5778.873119741778 15:42:57 INFO - PROCESS | 2001 | |5;yui.html;821.7041864928625;830.2901019628218;892.5091199840082;900.9009009009012;917.1928702741588;16424.83575164248;17275.48173554792;17448.953062816225;17468.388606398777;17487.125643717827;15957.760633590506;16051.518454446385;16089.517314480556;16126.032438053726;16201.91899040503;971.8882328532238;990.0891180114312;1002.2433063037433;1008.2841182760249;1019.9898001020006;1022.2282176956387;1023.3859684189501;1024.1550720655453;1024.2471783239314;1024.2881197567694;1044.0290529807276;1055.757175849555;1059.4120263253892;1060.363781730963;1064.2603390643505;1052.6736711619421;1054.1882750282316;1054.2936232724094;1055.3456856748787;1056.4559251985233;768.8231706707488;773.1804287455259;778.2023425988351;778.8286576953061;781.581853708269;17289.214538680317;17338.739918901225;18123.54691132719;18475.722864157047;18638;14979.251037448194;15000.399984000736;15028.549143525712;15060.397584096623;15336.309866056054;11970.700732481671;12278.386080696018;12287.631371058882;12435.689107772378;12594.307313097775;3845.057960799594;3845.807709614508;3866.1008958038715;3923;3999.7400168988925;111678;113053.43473282582;115987.42006289914;117950;118059.4097029518;9663.613455461844;11469.483873225725;11523.711907202387;11634.6509604712;12035.037197024218;24280.878595606908;24550.386240344134;24615.753842461345;24686;24793.380165496008;8225.8354832903;8239.546824924566;8265.46274492156;8268.421210515206;8392.202740739742;4628.861134165981;4635.976820115878;4681.976590117028;4686.976565117153;4775.856724298276;2717.3478365192213;3535.3636345458062;3569.1255642367787;3574.5353104096303;3583.5878873929832;594.3640304873744;614.1126072824725;614.6158650843223;647.1489990662265;652.8694261147789;692.875282449164;705.6295444891371;714.3285311806885;732.5751064382646;753.5215138387164;10061.698149055394;10618.415987120783;10789.62236321725;10925.07136893357;11024.559017639205;550.422056840316;606.3693758491208;612.0849330251214;618.7153909201818;621.8123384335896;5100.4899510049445;5244.868878277997;5322.201669749491;5329.467053294717;5351.25082488452;86455;95897.04102958881;98968;100662;102887;81832.59083704662;84073.73889391664;87093;88754.55622721974;89171;79052.60473697595;79419;79433;81407.18592813997;81896.77154842683;9512.95243523778;10909.563617455213;11281.663064157938;11616.88383116158;11654;51701.48298516967;52105.739471302404;52766;53986;53993;67358;68372.63254734778;68750.3124968744;70824;75858.24141758733;13322;13452.305417193551;13499.257540835348;13699.726005480034;13797.724045519235;12920.547780828001;13480.662983425493;15417.229138543253;15932.36270549165;16022.519324420286;12850.485980560672;13496;14361.353739081558;14664.560063198121;15218.619534511727;14085.436582536993;14283.571492855232;14433.494827680981;14480.85519144795;14604.780928285873;13694.904407647165;14126.152430854181;14285.143370966214;14328;14366.209858457885;9858.457784821616;9909.355891867006;10330.48347582633;10441.843372349269;10448.843267351147;11326.433678315887;11444.103914879488;11454.885451145381;11462.770744584896;11583.884161158618 15:42:57 INFO - PROCESS | 2001 | __end_tp_report 15:42:57 INFO - PROCESS | 2001 | __start_cc_report 15:42:57 INFO - PROCESS | 2001 | _x_x_mozilla_cycle_collect,386 15:42:57 INFO - PROCESS | 2001 | __end_cc_report 15:42:57 INFO - PROCESS | 2001 | __startTimestamp1494283377865__endTimestamp 15:42:57 INFO - PROCESS | 2001 | 15:42:57 INFO - PROCESS | 2001 | ------- Summary: start ------- 15:42:57 INFO - PROCESS | 2001 | Number of tests: 6 15:42:57 INFO - PROCESS | 2001 | 15:42:57 INFO - PROCESS | 2001 | [#0] dojo.html Cycles:165 Average:6140.45 Median:6361.81 stddev:704.72 (11.1%) stddev-sans-first:668.79 15:42:57 INFO - PROCESS | 2001 | Values: 3226.8 3432.8 3510.1 3654.1 3670.4 6183.0 6206.5 6210.6 6214.1 6255.0 6128.2 6187.8 6200.6 6206.5 6214.0 4841.8 5546.0 5601.3 5623.5 5689.7 5670.1 5672.7 5672.9 5679.4 5736.5 5460.6 5478.8 5623.7 5666.5 5671.7 5034.3 5655.3 5689.4 5732.8 5757.7 5336.1 5574.9 5582.8 5656.5 5664.1 5477.4 6082.0 6127.5 6221.5 6223.2 6504.9 6545.6 6641.6 6650.8 6651.6 6746.1 6746.6 6748.1 6750.6 6759.1 6125.8 6354.8 6363.2 6367.3 6374.5 6361.8 6644.2 6758.9 6843.4 6851.4 6558.2 6560.7 6563.2 6573.4 6587.8 5359.0 6651.3 6723.6 6732.6 6763.8 6324.3 6386.5 6476.9 6515.3 6571.4 6344.1 6593.2 6649.0 6654.2 6663.8 5271.7 5300.1 5305.4 5315.6 5382.5 4740.7 4786.5 4814.1 4817.8 4821.3 6228.8 6382.0 6385.1 6401.6 6407.9 5495.7 6544.6 6650.2 6750.0 6800.4 6348.7 6377.3 6379.4 6387.0 6400.4 5960.4 5971.6 5974.0 5980.0 5998.0 5481.5 6624.8 6729.5 6784.6 6959.9 5719.4 6556.0 6670.8 6675.9 6792.9 6946.5 6960.8 6974.4 6991.2 6995.5 5314.0 6318.0 6369.7 6500.4 6600.5 6752.3 6772.8 6788.8 6792.0 6825.3 6297.4 6566.5 6575.9 6578.4 6592.4 6293.0 6313.1 6416.2 6589.8 6612.2 6316.8 6352.2 6383.0 6419.0 6430.8 6513.9 6548.0 6559.0 6561.1 6566.3 6189.4 6252.8 6291.7 6330.2 6355.6 15:42:57 INFO - PROCESS | 2001 | 15:42:57 INFO - PROCESS | 2001 | [#1] ext.html Cycles:180 Average:57630.36 Median:30115.47 stddev:119695.46 (397.5%) stddev-sans-first:119955.06 15:42:57 INFO - PROCESS | 2001 | Values: 753.4 778.1 851.1 985.0 992.1 40800.2 41701.0 42968.1 43018.1 43062.0 41513.4 42120.0 42211.4 42322.6 42407.2 8312.7 8476.0 11227.2 11510.8 11775.9 11540.4 11556.0 11629.5 11652.4 11666.4 11608.2 11641.8 11655.9 11665.8 11675.7 11544.1 11576.9 11577.0 11615.5 11620.4 11279.5 11346.5 11373.8 11389.1 11395.3 36313.5 36410.8 36463.0 36486.0 36559.6 3892.6 3907.9 3930.9 3946.3 3966.9 22328.7 26784.3 26805.6 27029.0 28388.0 3177.5 3248.4 3310.1 3330.3 3405.2 322662.0 324494.0 367945.0 400096.0 403594.0 37357.0 47301.5 47693.3 47993.5 48017.8 49220.8 49369.0 49384.8 49385.0 49409.8 14873.6 15010.9 15012.2 15022.8 15051.8 12742.3 12863.7 12902.9 12917.9 12926.5 12471.9 12491.4 12506.9 12600.2 12613.0 4797.8 5226.2 5375.2 5700.5 5704.7 1105.2 1168.3 1171.8 1198.1 1207.5 23814.9 28396.1 28629.4 28805.3 28958.4 1038.2 1260.3 1271.1 1282.1 1322.5 11519.6 15053.5 15142.7 15146.3 15392.8 495083.0 495963.0 496166.0 496354.0 497184.0 50225.0 50624.7 50709.0 50720.0 50776.7 1434.6 1440.2 1478.5 1487.9 1488.8 23160.9 25506.5 27633.6 27713.0 28550.4 44405.9 44811.8 45071.0 45116.5 45158.3 422801.0 489116.0 489255.0 491604.0 491632.5 26182.7 26669.6 30765.0 31006.5 31038.5 41293.0 41397.6 41668.2 41841.0 42406.2 23190.8 28702.6 29031.6 29665.7 30153.0 29412.7 29421.4 29675.3 30008.8 30114.9 33781.7 35198.0 35258.3 35901.8 36504.9 26175.6 27145.2 30116.0 30418.2 30929.5 21340.7 24900.8 25097.9 25126.9 25151.5 15:42:57 INFO - PROCESS | 2001 | 15:42:57 INFO - PROCESS | 2001 | [#2] jquery.html Cycles:180 Average:43999.71 Median:12223.31 stddev:126957.03 (1038.6%) stddev-sans-first:127270.95 15:42:57 INFO - PROCESS | 2001 | Values: 391.0 422.1 424.0 436.8 463.2 20677.5 22274.1 22752.8 22952.9 23073.7 22926.9 23571.0 24093.3 24448.9 24457.5 6666.9 6792.5 6915.2 7048.1 7066.4 6774.2 6846.6 6896.8 6905.5 6913.9 6640.5 6895.4 6967.2 7009.8 7011.5 6529.7 6801.6 6861.9 6865.2 6866.6 6765.5 6770.2 6775.4 6782.9 6790.7 22252.1 27644.9 27762.3 28126.6 28200.0 2893.8 3025.6 3029.6 3030.2 3058.7 13345.7 16274.0 16613.8 16963.3 17513.1 2099.5 2171.4 2176.1 2179.3 2194.5 164616.4 167842.0 171956.0 174487.0 176043.1 17215.1 20749.2 20929.8 21393.4 21561.4 33263.3 33572.7 33677.0 33683.7 33723.5 10879.6 10991.7 11278.4 11315.2 11330.4 7467.6 7643.0 9354.6 9362.3 9486.0 9883.3 9922.9 9960.5 9973.0 10027.5 3719.1 4275.6 4281.0 4321.0 4372.7 1060.2 1075.5 1078.7 1083.8 1113.2 22651.7 22954.4 22972.3 23047.0 23084.0 1088.9 1102.3 1137.8 1139.2 1142.6 11120.0 11831.7 11970.3 12039.9 12046.9 749647.0 757634.0 760508.0 764219.0 772967.0 122981.0 135381.0 146606.0 150482.2 155519.0 1281.6 1286.2 1313.1 1315.2 1319.3 18720.4 19683.3 20696.1 20948.6 21273.3 52356.5 52749.7 53661.2 65246.0 65638.7 69028.7 93445.0 95247.7 96128.5 96360.5 9890.7 10924.8 12544.4 13384.3 13722.8 13610.7 14143.9 14219.9 14544.7 14608.6 10625.8 11226.6 11906.4 12177.3 12495.8 10166.8 11052.0 11107.3 11165.0 11299.5 10065.2 12081.7 12277.1 12361.6 12452.8 13265.5 13275.6 13521.6 13572.6 13696.7 11890.9 12002.8 12159.8 12183.3 12299.7 15:42:57 INFO - PROCESS | 2001 | 15:42:57 INFO - PROCESS | 2001 | [#3] mootools.html Cycles:180 Average:6917.31 Median:2401.04 stddev:4307.82 (179.4%) stddev-sans-first:4301.41 15:42:57 INFO - PROCESS | 2001 | Values: 1604.9 1641.0 1655.5 1658.3 1674.0 11002.2 11443.7 11694.2 11727.0 11813.8 11549.7 11774.4 11781.4 11784.2 11801.3 2409.0 2430.5 2440.9 2446.9 2447.2 2352.5 2400.0 2451.0 2453.8 2455.6 2029.4 2361.6 2422.9 2423.9 2425.6 2325.7 2379.7 2393.6 2395.1 2402.1 2380.4 2382.7 2394.0 2394.2 2402.1 10127.4 11281.3 11468.1 11472.3 11493.4 5572.6 5738.0 5907.5 5911.5 5942.7 3296.9 3505.8 3637.4 3670.5 3690.1 1165.3 1238.1 1275.2 1304.8 1322.5 14170.9 14407.5 15240.2 15826.4 15874.8 4591.4 4706.2 4706.4 4721.8 4754.9 12251.4 12281.4 12285.8 12296.8 12334.4 5756.0 5785.7 5794.2 5796.4 5810.3 5115.9 5226.9 5341.8 5342.2 5359.9 3780.5 3909.7 3924.2 3968.0 3972.5 999.2 1009.3 1017.0 1017.3 1020.6 966.2 970.0 995.1 1006.0 1008.5 5833.9 6764.0 6804.5 6906.8 7018.7 976.6 1020.9 1026.9 1029.7 1084.3 4270.3 4292.7 4303.5 4325.2 4417.0 12384.0 13549.3 13717.9 14249.0 14324.4 10920.8 12411.8 13544.9 14213.4 14223.8 10260.4 10483.6 10546.2 10564.1 10569.9 6925.8 6932.6 7168.2 7175.6 7301.7 12189.3 12827.4 12900.0 12953.5 13043.7 11586.7 11877.9 12336.2 13120.4 13128.1 10179.8 10531.7 10840.3 10841.2 10889.4 8946.5 10479.7 10505.7 10608.2 10684.5 8837.7 8916.1 8967.1 9023.8 9323.7 8884.6 9015.2 9085.3 9116.8 9188.4 8291.3 8298.0 8359.5 8397.1 8401.6 6051.3 6055.2 6073.8 6207.8 6251.9 6140.7 6200.8 6372.0 6417.8 6454.3 15:42:57 INFO - PROCESS | 2001 | 15:42:57 INFO - PROCESS | 2001 | [#4] prototype.html Cycles:180 Average:4786.59 Median:5197.21 stddev:1345.14 (25.9%) stddev-sans-first:1306.87 15:42:57 INFO - PROCESS | 2001 | Values: 340.7 388.2 391.4 400.2 404.6 4298.0 4835.3 4857.7 5410.2 5527.2 4568.7 5283.9 5311.1 5360.8 5385.7 4073.0 4220.6 4310.6 4322.7 4457.0 3758.9 3807.6 3932.5 4496.6 4502.1 4153.4 4460.9 4517.0 4520.2 4524.8 3792.7 4018.8 4398.4 4503.2 4504.3 3886.1 4061.4 4089.4 4101.3 4105.8 5280.7 5281.4 5293.9 5304.9 5343.8 4600.3 5016.5 5163.7 5169.3 5228.0 5445.3 5615.6 5717.2 5723.0 5743.7 4270.2 4361.8 4390.5 4582.4 4637.7 5158.7 5616.1 5903.7 5950.2 6202.7 4758.8 4762.3 4768.2 4829.4 4843.4 4134.4 4209.6 4831.4 4897.8 4917.6 4303.4 4866.9 5123.0 5158.8 5190.1 4949.5 5139.9 5397.5 5572.6 5645.7 1494.6 1591.9 1629.2 1631.2 1638.8 1051.4 1065.6 1094.9 1142.7 1240.5 5030.6 5320.1 5492.7 5542.4 5545.7 4757.7 5622.4 5697.5 5719.7 6044.6 4952.8 5255.9 5404.3 5472.0 5574.5 2680.5 3097.7 3115.3 3126.0 3152.8 5413.0 5790.5 5964.8 6247.4 6296.4 5450.9 5781.8 6184.8 6214.9 6234.1 5289.4 5401.4 5975.6 6223.3 6261.7 5217.3 5487.6 5965.0 6032.4 6062.8 5247.5 5409.9 5568.0 5713.7 5988.3 5858.8 6090.0 6223.8 6238.6 6261.7 4415.0 4541.0 4667.3 4689.2 4706.2 5057.9 5323.5 5658.9 5886.8 6003.3 5196.5 5572.8 5582.5 5761.6 5839.5 4822.8 5015.0 5394.0 5667.0 5865.3 4690.6 4725.4 5469.2 5586.2 5722.7 4770.0 5197.9 5846.9 5919.8 5955.4 5412.8 5618.4 5674.6 5684.7 5778.9 15:42:57 INFO - PROCESS | 2001 | 15:42:57 INFO - PROCESS | 2001 | [#5] yui.html Cycles:180 Average:21221.10 Median:17458.67 stddev:29793.33 (170.7%) stddev-sans-first:29837.53 15:42:57 INFO - PROCESS | 2001 | Values: 821.7 830.3 892.5 900.9 917.2 16424.8 17275.5 17449.0 17468.4 17487.1 15957.8 16051.5 16089.5 16126.0 16201.9 971.9 990.1 1002.2 1008.3 1020.0 1022.2 1023.4 1024.2 1024.2 1024.3 1044.0 1055.8 1059.4 1060.4 1064.3 1052.7 1054.2 1054.3 1055.3 1056.5 768.8 773.2 778.2 778.8 781.6 17289.2 17338.7 18123.5 18475.7 18638.0 14979.3 15000.4 15028.5 15060.4 15336.3 11970.7 12278.4 12287.6 12435.7 12594.3 3845.1 3845.8 3866.1 3923.0 3999.7 111678.0 113053.4 115987.4 117950.0 118059.4 9663.6 11469.5 11523.7 11634.7 12035.0 24280.9 24550.4 24615.8 24686.0 24793.4 8225.8 8239.5 8265.5 8268.4 8392.2 4628.9 4636.0 4682.0 4687.0 4775.9 2717.3 3535.4 3569.1 3574.5 3583.6 594.4 614.1 614.6 647.1 652.9 692.9 705.6 714.3 732.6 753.5 10061.7 10618.4 10789.6 10925.1 11024.6 550.4 606.4 612.1 618.7 621.8 5100.5 5244.9 5322.2 5329.5 5351.3 86455.0 95897.0 98968.0 100662.0 102887.0 81832.6 84073.7 87093.0 88754.6 89171.0 79052.6 79419.0 79433.0 81407.2 81896.8 9513.0 10909.6 11281.7 11616.9 11654.0 51701.5 52105.7 52766.0 53986.0 53993.0 67358.0 68372.6 68750.3 70824.0 75858.2 13322.0 13452.3 13499.3 13699.7 13797.7 12920.5 13480.7 15417.2 15932.4 16022.5 12850.5 13496.0 14361.4 14664.6 15218.6 14085.4 14283.6 14433.5 14480.9 14604.8 13694.9 14126.2 14285.1 14328.0 14366.2 9858.5 9909.4 10330.5 10441.8 10448.8 11326.4 11444.1 11454.9 11462.8 11583.9 15:42:57 INFO - PROCESS | 2001 | -------- Summary: end -------- 15:42:57 INFO - PROCESS | 2001 | 15:42:58 INFO - TEST-INFO | 2001: exit 0 15:42:58 INFO - TEST-OK | dromaeo_css | took 1115098ms 15:42:58 INFO - TEST-START | kraken 15:42:58 INFO - operating with platform_type : mac_ 15:42:58 INFO - Initialising browser for kraken test... 15:42:58 INFO - TEST-INFO | started process 2007 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmpakOHKe/profile http://localhost:49660/getInfo.html) 15:43:00 INFO - PROCESS | 2007 | 2017-05-08 15:43:00.983 plugin-container[2009:17731] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8543, name = 'com.apple.tsm.portname' 15:43:00 INFO - PROCESS | 2007 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:43:00 INFO - PROCESS | 2007 | 2017-05-08 15:43:00.984 plugin-container[2009:17731] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8713, name = 'com.apple.CFPasteboardClient' 15:43:00 INFO - PROCESS | 2007 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:43:00 INFO - PROCESS | 2007 | 2017-05-08 15:43:00.984 plugin-container[2009:17731] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:43:01 INFO - PROCESS | 2007 | __metrics Screen width/height:1600/1200 15:43:01 INFO - PROCESS | 2007 | colorDepth:24 15:43:01 INFO - PROCESS | 2007 | Browser inner width/height: 1024/689 15:43:01 INFO - PROCESS | 2007 | __metrics 15:43:01 ERROR - PROCESS | 2007 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3371: TypeError: this.tabs is undefined 15:43:01 INFO - TEST-INFO | 2007: exit 0 15:43:01 INFO - Browser initialized. 15:43:01 INFO - Running cycle 1/1 for kraken test... 15:43:01 INFO - TEST-INFO | started process 2010 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/tmpakOHKe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:43:03 INFO - PROCESS | 2010 | 2017-05-08 15:43:03.922 plugin-container[2011:17859] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8443, name = 'com.apple.tsm.portname' 15:43:03 INFO - PROCESS | 2010 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:43:03 INFO - PROCESS | 2010 | 2017-05-08 15:43:03.923 plugin-container[2011:17859] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4607, name = 'com.apple.CFPasteboardClient' 15:43:03 INFO - PROCESS | 2010 | See /usr/include/servers/bootstrap_defs.h for the error codes. 15:43:03 INFO - PROCESS | 2010 | 2017-05-08 15:43:03.923 plugin-container[2011:17859] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 15:43:13 INFO - PROCESS | 2010 | RSS: Main: 174465024 15:43:13 INFO - PROCESS | 2010 | 15:43:16 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49660/tests/kraken/driver.html?testName=audio-beat-detection) 15:43:17 INFO - PROCESS | 2010 | RSS: Main: 188010496 15:43:17 INFO - PROCESS | 2010 | 15:43:20 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49660/tests/kraken/driver.html?testName=audio-dft) 15:43:20 INFO - PROCESS | 2010 | RSS: Main: 195911680 15:43:20 INFO - PROCESS | 2010 | 15:43:24 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49660/tests/kraken/driver.html?testName=audio-fft) 15:43:24 INFO - PROCESS | 2010 | RSS: Main: 199725056 15:43:24 INFO - PROCESS | 2010 | 15:43:26 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49660/tests/kraken/driver.html?testName=audio-oscillator) 15:43:27 INFO - PROCESS | 2010 | RSS: Main: 200015872 15:43:27 INFO - PROCESS | 2010 | 15:43:29 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49660/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:43:29 INFO - PROCESS | 2010 | RSS: Main: 201433088 15:43:29 INFO - PROCESS | 2010 | 15:43:32 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49660/tests/kraken/driver.html?testName=imaging-darkroom) 15:43:33 INFO - PROCESS | 2010 | RSS: Main: 205746176 15:43:33 INFO - PROCESS | 2010 | 15:43:36 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49660/tests/kraken/driver.html?testName=imaging-desaturate) 15:43:37 INFO - PROCESS | 2010 | RSS: Main: 206041088 15:43:37 INFO - PROCESS | 2010 | 15:43:40 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49660/tests/kraken/driver.html?testName=json-parse-financial) 15:43:40 INFO - PROCESS | 2010 | RSS: Main: 205606912 15:43:40 INFO - PROCESS | 2010 | 15:43:42 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49660/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:43:42 INFO - PROCESS | 2010 | RSS: Main: 204836864 15:43:42 INFO - PROCESS | 2010 | 15:43:44 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49660/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:43:45 INFO - PROCESS | 2010 | RSS: Main: 204926976 15:43:45 INFO - PROCESS | 2010 | 15:43:47 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49660/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:43:48 INFO - PROCESS | 2010 | RSS: Main: 204890112 15:43:48 INFO - PROCESS | 2010 | 15:43:51 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49660/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:43:52 INFO - PROCESS | 2010 | RSS: Main: 205492224 15:43:52 INFO - PROCESS | 2010 | 15:43:55 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49660/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:43:55 INFO - PROCESS | 2010 | RSS: Main: 205316096 15:43:55 INFO - PROCESS | 2010 | 15:43:57 INFO - PROCESS | 2010 | Cycle 1(1): loaded http://localhost:49660/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49660/tests/kraken/driver.html?testName=ai-astar) 15:43:57 INFO - PROCESS | 2010 | RSS: Main: 207347712 15:43:57 INFO - PROCESS | 2010 | 15:43:57 INFO - PROCESS | 2010 | __start_tp_report 15:43:57 INFO - PROCESS | 2010 | _x_x_mozilla_page_load 15:43:57 INFO - PROCESS | 2010 | _x_x_mozilla_page_load_details 15:43:57 INFO - PROCESS | 2010 | |i|pagename|runs| 15:43:57 INFO - PROCESS | 2010 | |0;ai-astar;106;118;119;144;157;116;117;118;118;98 15:43:57 INFO - PROCESS | 2010 | |1;audio-beat-detection;138;110;109;146;110;111;111;112;129;109 15:43:57 INFO - PROCESS | 2010 | |2;audio-dft;202;193;201;202;193;199;196;199;203;192 15:43:57 INFO - PROCESS | 2010 | |3;audio-fft;82;58;60;89;64;60;60;58;83;93 15:43:57 INFO - PROCESS | 2010 | |4;audio-oscillator;88;71;84;71;73;68;79;71;71;81 15:43:57 INFO - PROCESS | 2010 | |5;imaging-gaussian-blur;88;89;88;100;113;88;134;94;81;138 15:43:57 INFO - PROCESS | 2010 | |6;imaging-darkroom;153;108;95;95;95;96;97;113;150;111 15:43:57 INFO - PROCESS | 2010 | |7;imaging-desaturate;91;94;91;91;93;90;92;92;90;93 15:43:57 INFO - PROCESS | 2010 | |8;json-parse-financial;65;65;63;65;68;69;68;68;69;68 15:43:57 INFO - PROCESS | 2010 | |9;json-stringify-tinderbox;60;61;67;62;66;64;59;57;56;58 15:43:57 INFO - PROCESS | 2010 | |10;stanford-crypto-aes;82;99;72;91;101;104;81;76;98;68 15:43:57 INFO - PROCESS | 2010 | |11;stanford-crypto-ccm;151;134;135;155;150;148;163;151;205;181 15:43:57 INFO - PROCESS | 2010 | |12;stanford-crypto-pbkdf2;168;172;168;210;223;181;185;210;164;165 15:43:57 INFO - PROCESS | 2010 | |13;stanford-crypto-sha256-iterative;62;66;64;65;64;66;64;63;64;66 15:43:57 INFO - PROCESS | 2010 | __end_tp_report 15:43:57 INFO - PROCESS | 2010 | __start_cc_report 15:43:57 INFO - PROCESS | 2010 | _x_x_mozilla_cycle_collect,975 15:43:57 INFO - PROCESS | 2010 | __end_cc_report 15:43:57 INFO - PROCESS | 2010 | __startTimestamp1494283437554__endTimestamp 15:43:57 INFO - PROCESS | 2010 | 15:43:57 INFO - PROCESS | 2010 | ------- Summary: start ------- 15:43:57 INFO - PROCESS | 2010 | Number of tests: 14 15:43:57 INFO - PROCESS | 2010 | 15:43:57 INFO - PROCESS | 2010 | [#0] ai-astar Cycles:10 Average:121.10 Median:118.50 stddev:17.16 (14.5%) stddev-sans-first:17.31 15:43:57 INFO - PROCESS | 2010 | Values: 106.0 118.0 119.0 144.0 157.0 116.0 117.0 118.0 118.0 98.0 15:43:57 INFO - PROCESS | 2010 | 15:43:57 INFO - PROCESS | 2010 | [#1] audio-beat-detection Cycles:10 Average:118.50 Median:111.50 stddev:13.85 (12.4%) stddev-sans-first:12.77 15:43:57 INFO - PROCESS | 2010 | Values: 138.0 110.0 109.0 146.0 110.0 111.0 111.0 112.0 129.0 109.0 15:43:57 INFO - PROCESS | 2010 | 15:43:57 INFO - PROCESS | 2010 | [#2] audio-dft Cycles:10 Average:198.00 Median:200.00 stddev:4.19 (2.1%) stddev-sans-first:4.19 15:43:57 INFO - PROCESS | 2010 | Values: 202.0 193.0 201.0 202.0 193.0 199.0 196.0 199.0 203.0 192.0 15:43:57 INFO - PROCESS | 2010 | 15:43:57 INFO - PROCESS | 2010 | [#3] audio-fft Cycles:10 Average:70.70 Median:73.00 stddev:14.23 (19.5%) stddev-sans-first:14.49 15:43:57 INFO - PROCESS | 2010 | Values: 82.0 58.0 60.0 89.0 64.0 60.0 60.0 58.0 83.0 93.0 15:43:57 INFO - PROCESS | 2010 | 15:43:57 INFO - PROCESS | 2010 | [#4] audio-oscillator Cycles:10 Average:75.70 Median:76.00 stddev:6.78 (8.9%) stddev-sans-first:5.55 15:43:57 INFO - PROCESS | 2010 | Values: 88.0 71.0 84.0 71.0 73.0 68.0 79.0 71.0 71.0 81.0 15:43:57 INFO - PROCESS | 2010 | 15:43:57 INFO - PROCESS | 2010 | [#5] imaging-gaussian-blur Cycles:10 Average:101.30 Median:88.00 stddev:20.28 (23.0%) stddev-sans-first:20.93 15:43:57 INFO - PROCESS | 2010 | Values: 88.0 89.0 88.0 100.0 113.0 88.0 134.0 94.0 81.0 138.0 15:43:57 INFO - PROCESS | 2010 | 15:43:57 INFO - PROCESS | 2010 | [#6] imaging-darkroom Cycles:10 Average:111.30 Median:95.00 stddev:22.33 (23.5%) stddev-sans-first:17.87 15:43:57 INFO - PROCESS | 2010 | Values: 153.0 108.0 95.0 95.0 95.0 96.0 97.0 113.0 150.0 111.0 15:43:57 INFO - PROCESS | 2010 | 15:43:57 INFO - PROCESS | 2010 | [#7] imaging-desaturate Cycles:10 Average:91.70 Median:92.00 stddev:1.34 (1.5%) stddev-sans-first:1.39 15:43:57 INFO - PROCESS | 2010 | Values: 91.0 94.0 91.0 91.0 93.0 90.0 92.0 92.0 90.0 93.0 15:43:57 INFO - PROCESS | 2010 | 15:43:57 INFO - PROCESS | 2010 | [#8] json-parse-financial Cycles:10 Average:66.80 Median:68.00 stddev:2.10 (3.1%) stddev-sans-first:2.12 15:43:57 INFO - PROCESS | 2010 | Values: 65.0 65.0 63.0 65.0 68.0 69.0 68.0 68.0 69.0 68.0 15:43:57 INFO - PROCESS | 2010 | 15:43:57 INFO - PROCESS | 2010 | [#9] json-stringify-tinderbox Cycles:10 Average:61.00 Median:61.50 stddev:3.74 (6.1%) stddev-sans-first:3.95 15:43:57 INFO - PROCESS | 2010 | Values: 60.0 61.0 67.0 62.0 66.0 64.0 59.0 57.0 56.0 58.0 15:43:57 INFO - PROCESS | 2010 | 15:43:57 INFO - PROCESS | 2010 | [#10] stanford-crypto-aes Cycles:10 Average:87.20 Median:81.50 stddev:13.05 (16.0%) stddev-sans-first:13.71 15:43:57 INFO - PROCESS | 2010 | Values: 82.0 99.0 72.0 91.0 101.0 104.0 81.0 76.0 98.0 68.0 15:43:57 INFO - PROCESS | 2010 | 15:43:57 INFO - PROCESS | 2010 | [#11] stanford-crypto-ccm Cycles:10 Average:157.30 Median:153.00 stddev:21.43 (14.0%) stddev-sans-first:22.61 15:43:57 INFO - PROCESS | 2010 | Values: 151.0 134.0 135.0 155.0 150.0 148.0 163.0 151.0 205.0 181.0 15:43:57 INFO - PROCESS | 2010 | 15:43:57 INFO - PROCESS | 2010 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.60 Median:183.00 stddev:21.85 (11.9%) stddev-sans-first:22.33 15:43:57 INFO - PROCESS | 2010 | Values: 168.0 172.0 168.0 210.0 223.0 181.0 185.0 210.0 164.0 165.0 15:43:57 INFO - PROCESS | 2010 | 15:43:57 INFO - PROCESS | 2010 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.40 Median:64.50 stddev:1.35 (2.1%) stddev-sans-first:1.12 15:43:57 INFO - PROCESS | 2010 | Values: 62.0 66.0 64.0 65.0 64.0 66.0 64.0 63.0 64.0 66.0 15:43:57 INFO - PROCESS | 2010 | -------- Summary: end -------- 15:43:57 INFO - PROCESS | 2010 | 15:43:58 INFO - TEST-INFO | 2010: exit 0 15:43:58 INFO - TEST-OK | kraken | took 59955ms 15:43:58 INFO - SUITE-END | took 1175s 15:43:58 INFO - Completed test suite (00:19:35) 15:43:58 INFO - javascript benchmark 15:43:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7988.117642131994, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3226.822524761138, 3432.794032358057, 3510.140015696155, 3654.104744337638, 3670.3576874047053, 6182.969085154574, 6206.534509911752, 6210.596311239767, 6214.098955651428, 6255.030470277115, 6128.203333566641, 6187.814365569029, 6200.627962322253, 6206.534509911752, 6214.0, 4841.7821198045995, 5546.0, 5601.29983752031, 5623.4938855503, 5689.6586204827845, 5670.06443936752, 5672.68800215988, 5672.938925211287, 5679.432056794308, 5736.512396446307, 5460.645058071233, 5478.808241711541, 5623.690697011662, 5666.46168613981, 5671.688057156875, 5034.270030845543, 5655.26481557399, 5689.374168841445, 5732.799352022701, 5757.712114394263, 5336.092864213054, 5574.944250557483, 5582.804601838916, 5656.462636049569, 5664.093745000821, 5477.424870388591, 6081.969590152065, 6127.509799216052, 6221.502279817604, 6223.190985171944, 6504.8699026019685, 6545.639989800559, 6641.601503909733, 6650.767223147167, 6651.567648102858, 6746.089277947463, 6746.59520428771, 6748.055272261888, 6750.561213521155, 6759.053732477457, 6125.815438131368, 6354.80935571929, 6363.172787537683, 6367.267764207176, 6374.490040796772, 6361.809145725636, 6644.169478815148, 6758.932410675929, 6843.418309443654, 6851.417629501549, 6558.213014438298, 6560.704768285439, 6563.1796025496815, 6573.441257493167, 6587.80236592903, 5359.0, 6651.33486651331, 6723.63020033893, 6732.629705366252, 6763.830904227335, 6324.3043265240785, 6386.457151142112, 6476.870462590816, 6515.315891831384, 6571.441427478718, 6344.143540621957, 6593.208814942238, 6648.966755166193, 6654.23476300222, 6663.800945687912, 5271.65734227274, 5300.09898317287, 5305.389880163753, 5315.574754019669, 5382.515573598395, 4740.7392593407, 4786.521347865186, 4814.133455977958, 4817.759112044384, 4821.252705830602, 6228.844278893064, 6382.010788327817, 6385.074164246158, 6401.615903045832, 6407.871842563122, 5495.725213739297, 6544.574602650812, 6650.168728908887, 6749.966250168816, 6800.421964133104, 6348.650824204621, 6377.330380310001, 6379.393957574023, 6387.041943708388, 6400.423961843457, 5960.433758792908, 5971.552133589998, 5973.970130149321, 5980.0, 5997.970010149921, 5481.506664400223, 6624.834379140464, 6729.495287853529, 6784.626845523544, 6959.930400695928, 5719.370869204467, 6556.0, 6670.83322916931, 6675.866482670416, 6792.93207067923, 6946.479014073863, 6960.79117626472, 6974.407175389946, 6991.196012458632, 6995.4753393494675, 5314.0, 6317.968410158103, 6369.681515924278, 6500.414962653384, 6600.537962342782, 6752.291009443938, 6772.796816095525, 6788.76239331621, 6791.966040169767, 6825.2833452486775, 6297.370262973666, 6566.540342176193, 6575.868482630225, 6578.407943284936, 6592.43964263043, 6292.968535157478, 6313.05304204373, 6416.230052393743, 6589.835254118685, 6612.23959244693, 6316.842078948063, 6352.174217351715, 6382.96808515973, 6419.0, 6430.807075787734, 6513.902291465726, 6548.0, 6559.048937904073, 6561.081448597105, 6566.343365663395, 6189.412005859436, 6252.781152659635, 6291.716872740829, 6330.208723909512, 6355.586886852339], "value": 6096.205581820819, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.4386881773078, 778.1051790440993, 851.1105894340413, 984.9852252216214, 992.136840948375, 40800.183996320055, 41701.0, 42968.140637187236, 43018.13963720728, 43062.0, 41513.37729934054, 42120.0, 42211.36682949751, 42322.57677423225, 42407.15185696284, 8312.70905518307, 8476.02525709545, 11227.214095013353, 11510.827337589943, 11775.94112029443, 11540.422978851024, 11556.0, 11629.534818607246, 11652.359120248382, 11666.41667916605, 11608.24546404481, 11641.767164656743, 11655.883441165606, 11665.766684666301, 11675.708107297301, 11544.076473882069, 11576.884231157706, 11577.0, 11615.477303521362, 11620.360880151587, 11279.548818047268, 11346.48940797666, 11373.772524549462, 11389.088872890232, 11395.316281023164, 36313.45529817055, 36410.8179459101, 36463.0, 36486.0, 36559.63440365589, 3892.649661530476, 3907.9405283048904, 3930.862419815321, 3946.2699400610977, 3966.940495892564, 22328.665070023962, 26784.330391740168, 26805.597916031275, 27029.0, 28388.0, 3177.4757165067967, 3248.3990461764647, 3310.0731795097413, 3330.333933213343, 3405.2338223899674, 322662.0, 324494.0, 367945.0, 400096.0, 403594.0, 37357.0, 47301.5269847304, 47693.284600731015, 47993.5200647996, 48017.75991120092, 49220.753896230286, 49369.0, 49384.75307623511, 49385.0, 49409.752951235736, 14873.553793386216, 15010.924945375204, 15012.249387530579, 15022.774658379914, 15051.849481505045, 12742.299173545543, 12863.742725145445, 12902.935485322701, 12917.935410322889, 12926.482940682456, 12471.93764031174, 12491.375431228402, 12506.937465312616, 12600.243985360725, 12612.990960723304, 4797.800549862534, 5226.216067589816, 5375.16684913839, 5700.486956173964, 5704.714764261853, 1105.1987309200765, 1168.3165348271357, 1171.7696418760268, 1198.1253684810138, 1207.4850180576998, 23814.880925595262, 28396.148115556567, 28629.427411451656, 28805.27986800305, 28958.407287598962, 1038.2057725839588, 1260.3131293445094, 1271.1419791640606, 1282.140965553063, 1322.5172811923578, 11519.596814111634, 15053.548393548212, 15142.697146057017, 15146.318415671321, 15392.769108463383, 495083.0, 495963.0, 496166.0383396192, 496354.0, 497184.0, 50225.0, 50624.74687626612, 50709.0, 50719.985600287786, 50776.74611626918, 1434.5839706485003, 1440.1934916446824, 1478.4825311141014, 1487.8660920517204, 1488.7692407676827, 23160.884195578914, 25506.48987020212, 27633.585496217976, 27713.0, 28550.42899142047, 44405.88985275394, 44811.77594112008, 45071.0, 45116.54883451255, 45158.32262516131, 422801.0, 489116.0, 489255.0, 491604.0, 491632.54183728853, 26182.738172618792, 26669.59995600029, 30765.0, 31006.534901976036, 31038.534421983237, 41293.0, 41397.586024139375, 41668.166636666494, 41841.0, 42406.151876962904, 23190.76809231886, 28702.56946145768, 29031.56452653254, 29665.703342966295, 30153.0, 29412.705872941, 29421.411571768873, 29675.258118547208, 30008.84995575008, 30114.945976890704, 33781.66218337884, 35198.0, 35258.29483410369, 35901.82049089738, 36504.90485285446, 26175.607365889147, 27145.185644430698, 30116.0, 30418.174909505502, 30929.536056959612, 21340.679889801977, 24900.750992490568, 25097.8705958236, 25126.874365628053, 25151.49697006013], "value": 19030.624680306486, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.9550401703804, 422.09881902138926, 424.04378127322883, 436.7532344225513, 463.20097831241094, 20677.483062923435, 22274.109035638576, 22752.772472275272, 22952.88523557384, 23073.653895191586, 22926.885365573147, 23571.0, 24093.277201683934, 24448.87775561124, 24457.510849782993, 6666.866662666744, 6792.490563207754, 6915.239323674417, 7048.083749112634, 7066.434685225196, 6774.153230846145, 6846.623435711034, 6896.827579310508, 6905.516613837033, 6913.89629155563, 6640.468762498988, 6895.448364130857, 6967.198772141192, 7009.75465858695, 7011.474139439562, 6529.706163222666, 6801.557898736591, 6861.931380686179, 6865.244823069484, 6866.622335771531, 6765.458763298924, 6770.221424536192, 6775.390214880685, 6782.948642960349, 6790.660466976681, 22252.10991560352, 27644.86177569099, 27762.305942351402, 28126.578101328498, 28200.0, 2893.7829662775166, 3025.6066711327608, 3029.621297337833, 3030.2424393901524, 3058.694130586946, 13345.666358341023, 16274.0, 16613.83386166147, 16963.3214671413, 17513.12434378276, 2099.5276062885882, 2171.4354267890462, 2176.075168053571, 2179.346196141167, 2194.5172062146303, 164616.3538364613, 167842.0, 171956.0, 174487.0, 176043.11978440153, 17215.139243037796, 20749.170033198803, 20929.790702093087, 21393.358199253737, 21561.353159405244, 33263.33473330568, 33572.66427335695, 33677.0, 33683.66316336854, 33723.49414758781, 10879.619213327496, 10991.725206869733, 11278.379689117013, 11315.207935444605, 11330.37682927447, 7467.626618669045, 7643.0, 9354.625814967325, 9362.297827662953, 9485.952570237105, 9883.308168428284, 9922.851157232648, 9960.501974901226, 9972.950135249423, 10027.498625068718, 3719.1445967427644, 4275.5724427557, 4280.957190428118, 4320.978395108004, 4372.737635741865, 1060.2366296266675, 1075.4783929794044, 1078.654830454247, 1083.7615724540588, 1113.1595645287755, 22651.660225096635, 22954.42613934665, 22972.310830675106, 23047.0, 23084.0, 1088.9074428673493, 1102.3165637304921, 1137.7724455108846, 1139.2367114033618, 1142.5943789954613, 11120.0, 11831.704207394883, 11970.341631210367, 12039.879601204051, 12046.939765301293, 749647.0, 757634.0, 760508.0, 764219.0, 772967.0, 122981.0, 135381.0, 146606.0, 150482.24758876135, 155519.0, 1281.551456990046, 1286.2154086007529, 1313.1136482874022, 1315.1780137414116, 1319.287584704249, 18720.362656698846, 19683.31108411199, 20696.068676909275, 20948.58102837904, 21273.255436059662, 52356.47643523516, 52749.7362513185, 53661.195082074584, 65246.02130967945, 65638.68722625425, 69028.65485672539, 93445.0, 95247.66633167806, 96128.51935740277, 96360.51819740856, 9890.703278901645, 10924.781504370027, 12544.372781361079, 13384.263865487103, 13722.794158087836, 13610.727785444433, 14143.929280353532, 14219.928900355431, 14544.709105818036, 14608.634784130481, 10625.840612390975, 11226.596675415572, 11906.40467976615, 12177.269363838199, 12495.750084998432, 10166.796664066826, 11052.0, 11107.333559986104, 11165.0, 11299.491522881655, 10065.24510661718, 12081.745550061105, 12277.079219058427, 12361.567345142877, 12452.750944980868, 13265.469381224642, 13275.601731948056, 13521.59435216945, 13572.592822215349, 13696.65758356049, 11890.881091189323, 12002.819957700467, 12159.81760273579, 12183.269003859798, 12299.69250768738], "value": 12100.283688836555, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1604.8796340274482, 1640.9507714768554, 1655.510040963133, 1658.2537857963912, 1674.0457938974785, 11002.174836887236, 11443.656690299284, 11694.239874408167, 11727.0, 11813.822792658095, 11549.711257218574, 11774.411279436037, 11781.410929453536, 11784.17510774244, 11801.291922484636, 2408.9518209635753, 2430.538197742423, 2440.9023639054417, 2446.8531888086773, 2447.1801946347996, 2352.517733864562, 2399.9760002400017, 2450.9509809803794, 2453.7914277286454, 2455.607102863542, 2029.3911826452006, 2361.586722323595, 2422.903083876643, 2423.8545687258734, 2425.5876500994873, 2325.720913490392, 2379.7144342678903, 2393.6050551658955, 2395.101836811196, 2402.111218849037, 2380.4286971126976, 2382.702162229721, 2393.994522300638, 2394.1979436888664, 2402.1112188490197, 10127.442990635513, 11281.32312061279, 11468.082553395709, 11472.31166130035, 11493.367864767435, 5572.634704497384, 5738.024535828878, 5907.497862681677, 5911.497522710575, 5942.702864856783, 3296.868125274986, 3505.7896526208256, 3637.418013117915, 3670.467782171597, 3690.132818787583, 1165.3299352872132, 1238.120934136755, 1275.222114510148, 1304.778187708092, 1322.4644019172251, 14170.92914535431, 14407.495737649237, 15240.237988100662, 15826.366945322288, 15874.841251587568, 4591.357209990604, 4706.1999460091865, 4706.411698537683, 4721.763911804396, 4754.881127971828, 12251.387430628432, 12281.385930703429, 12285.815712764315, 12296.815547766791, 12334.444949977273, 5756.0, 5785.681787501728, 5794.217780599565, 5796.362400135981, 5810.273715785527, 5115.8721031973755, 5226.869328266824, 5341.839744807662, 5342.171963345688, 5359.892802144013, 3780.546334439885, 3909.706771992112, 3924.2151569686175, 3967.9603203968168, 3972.483577134954, 999.1656966432964, 1009.258195226508, 1016.9542370593193, 1017.3234798858676, 1020.5713600287897, 966.2318456826839, 969.99030009699, 995.1044060345602, 1005.9547320370455, 1008.495752123938, 5833.854153646193, 6763.951587503945, 6804.455643548505, 6906.827329316808, 7018.719251229996, 976.5800705696477, 1020.8723909511311, 1026.8870424253325, 1029.6807989523272, 1084.34939036579, 4270.316749320094, 4292.699511034198, 4303.505096913832, 4325.1565944641125, 4416.984093658477, 12384.009279257638, 13549.306336707912, 13717.931410343084, 14249.002569820013, 14324.427022919175, 10920.836187457195, 12411.813822792665, 13544.86455135436, 14213.431462741375, 14223.786643200361, 10260.43567603774, 10483.580656773644, 10546.156307495383, 10564.10205132557, 10569.894301057046, 6925.757598484029, 6932.61870597122, 7168.211496735251, 7175.569465832067, 7301.744438944612, 12189.268643881396, 12827.358632068173, 12900.0, 12953.481860725842, 13043.673908152372, 11586.71033224176, 11877.930986211282, 12336.198147120409, 13120.409581568661, 13128.081034327506, 10179.796404072025, 10531.684049478528, 10840.295380800222, 10841.18691098155, 10889.401082940514, 8946.463212207029, 10479.68560943173, 10505.737356566147, 10608.204384671026, 10684.519196636014, 8837.690680826141, 8916.06381329951, 8967.058458861986, 9023.77440563965, 9323.72028839136, 8884.555772211494, 9015.233705135137, 9085.273178145864, 9116.772080698036, 9188.448693078437, 8291.253787158943, 8297.95851020741, 8359.540225287425, 8397.118302578141, 8401.62192701342, 6051.304100028553, 6055.212822333245, 6073.817785466266, 6207.844803879939, 6251.906221406592, 6140.723667435065, 6200.782972595937, 6372.044193371032, 6417.839554011187, 6454.322296158835], "value": 5268.424317392541, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [340.7359296545178, 388.1770646229993, 391.4246058294308, 400.20359484625584, 404.62369995903805, 4298.0, 4835.323054772331, 4857.6599638025355, 5410.188471729242, 5527.226188333637, 4568.657350698702, 5283.894322113555, 5311.052365936904, 5360.812371566996, 5385.734352427176, 4073.0, 4220.620144187023, 4310.612044915957, 4322.697411181219, 4457.0, 3758.8762349272574, 3807.562130355017, 3932.4691166692414, 4496.55034496551, 4502.131615379613, 4153.376993450991, 4460.933086003713, 4516.9774151129195, 4520.208963431386, 4524.751138687371, 3792.715546334036, 4018.799060046986, 4398.406215160944, 4503.234450143484, 4504.279315309551, 3886.145048089416, 4061.3704875744306, 4089.364254298275, 4101.323281658522, 4105.835766569334, 5280.702894240979, 5281.36623605166, 5293.947060529384, 5304.867378315573, 5343.812966546191, 4600.2869555218995, 5016.473270306602, 5163.690178589259, 5169.2504586835075, 5227.954409118153, 5445.264889239981, 5615.578831587647, 5717.1995920570735, 5722.97138514309, 5743.712814359265, 4270.210011147917, 4361.849791793587, 4390.517043125254, 4582.404287442644, 4637.675362724611, 5158.716270605115, 5616.1014237721765, 5903.704814759245, 5950.2264705587995, 6202.6815653625545, 4758.762061896891, 4762.261849413347, 4768.189407800683, 4829.420469543607, 4843.370361853007, 4134.359174327984, 4209.642180414638, 4831.371921650163, 4897.755112244374, 4917.582005529499, 4303.376010478526, 4866.902661946812, 5123.004056835674, 5158.845234642967, 5190.143626301618, 4949.455559888409, 5139.922901156486, 5397.487238712316, 5572.606848287928, 5645.689487078168, 1494.6412860913304, 1591.8885678002428, 1629.1691237468976, 1631.2007116512823, 1638.8197298297177, 1051.3849398102043, 1065.63235683689, 1094.895984881435, 1142.7088687182313, 1240.4789988204795, 5030.622703297267, 5320.095583750772, 5492.697901615449, 5542.362628297717, 5545.694986775766, 4757.714537127784, 5622.409646987089, 5697.4587414195585, 5719.656820590778, 6044.576879618472, 4952.801887924515, 5255.921161182585, 5404.29744133268, 5471.972640136773, 5574.470425309589, 2680.490706765708, 3097.7212050915527, 3115.345777386729, 3125.968430417957, 3152.8108313500807, 5412.972935135299, 5790.478856902815, 5964.7912323068485, 6247.437730604177, 6296.370362963667, 5450.91823622646, 5781.768729250867, 6184.81445556634, 6214.937850621526, 6234.101142968541, 5289.418164001957, 5401.378841433207, 5975.551833612496, 6223.284322302902, 6261.7182226799, 5217.321748172713, 5487.588430867621, 5964.956132676851, 6032.426919442646, 6062.848428789315, 5247.501487358695, 5409.891802164014, 5567.969925563783, 5713.685747283939, 5988.28140623128, 5858.794942177004, 6090.0, 6223.813285601439, 6238.594491358047, 6261.685046140179, 4414.9558504414545, 4541.0, 4667.346571480063, 4689.226277664147, 4706.235011990326, 5057.949420505748, 5323.547498462674, 5658.9151162733415, 5886.823395298148, 6003.339632640319, 5196.53231209193, 5572.804951826666, 5582.49757521825, 5761.596688231783, 5839.5036421904615, 4822.7829747662145, 5015.0, 5393.9730301348245, 5667.036603777286, 5865.3254875688135, 4690.648201384978, 4725.40932383452, 5469.179623056573, 5586.217929489793, 5722.656640601577, 4769.998300356964, 5197.896042079213, 5846.912296315644, 5919.822405327847, 5955.434233747787, 5412.83761487156, 5618.438156184349, 5674.56688703345, 5684.687342196219, 5778.873119741778], "value": 4388.6733730088, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [821.7041864928625, 830.2901019628218, 892.5091199840082, 900.9009009009012, 917.1928702741588, 16424.83575164248, 17275.48173554792, 17448.953062816225, 17468.388606398777, 17487.125643717827, 15957.760633590506, 16051.518454446385, 16089.517314480556, 16126.032438053726, 16201.91899040503, 971.8882328532238, 990.0891180114312, 1002.2433063037433, 1008.2841182760249, 1019.9898001020006, 1022.2282176956387, 1023.3859684189501, 1024.1550720655453, 1024.2471783239314, 1024.2881197567694, 1044.0290529807276, 1055.757175849555, 1059.4120263253892, 1060.363781730963, 1064.2603390643505, 1052.6736711619421, 1054.1882750282316, 1054.2936232724094, 1055.3456856748787, 1056.4559251985233, 768.8231706707488, 773.1804287455259, 778.2023425988351, 778.8286576953061, 781.581853708269, 17289.214538680317, 17338.739918901225, 18123.54691132719, 18475.722864157047, 18638.0, 14979.251037448194, 15000.399984000736, 15028.549143525712, 15060.397584096623, 15336.309866056054, 11970.700732481671, 12278.386080696018, 12287.631371058882, 12435.689107772378, 12594.307313097775, 3845.057960799594, 3845.807709614508, 3866.1008958038715, 3923.0, 3999.7400168988925, 111678.0, 113053.43473282582, 115987.42006289914, 117950.0, 118059.4097029518, 9663.613455461844, 11469.483873225725, 11523.711907202387, 11634.6509604712, 12035.037197024218, 24280.878595606908, 24550.386240344134, 24615.753842461345, 24686.0, 24793.380165496008, 8225.8354832903, 8239.546824924566, 8265.46274492156, 8268.421210515206, 8392.202740739742, 4628.861134165981, 4635.976820115878, 4681.976590117028, 4686.976565117153, 4775.856724298276, 2717.3478365192213, 3535.3636345458062, 3569.1255642367787, 3574.5353104096303, 3583.5878873929832, 594.3640304873744, 614.1126072824725, 614.6158650843223, 647.1489990662265, 652.8694261147789, 692.875282449164, 705.6295444891371, 714.3285311806885, 732.5751064382646, 753.5215138387164, 10061.698149055394, 10618.415987120783, 10789.62236321725, 10925.07136893357, 11024.559017639205, 550.422056840316, 606.3693758491208, 612.0849330251214, 618.7153909201818, 621.8123384335896, 5100.4899510049445, 5244.868878277997, 5322.201669749491, 5329.467053294717, 5351.25082488452, 86455.0, 95897.04102958881, 98968.0, 100662.0, 102887.0, 81832.59083704662, 84073.73889391664, 87093.0, 88754.55622721974, 89171.0, 79052.60473697595, 79419.0, 79433.0, 81407.18592813997, 81896.77154842683, 9512.95243523778, 10909.563617455213, 11281.663064157938, 11616.88383116158, 11654.0, 51701.48298516967, 52105.739471302404, 52766.0, 53986.0, 53993.0, 67358.0, 68372.63254734778, 68750.3124968744, 70824.0, 75858.24141758733, 13322.0, 13452.305417193551, 13499.257540835348, 13699.726005480034, 13797.724045519235, 12920.547780828001, 13480.662983425493, 15417.229138543253, 15932.36270549165, 16022.519324420286, 12850.485980560672, 13496.0, 14361.353739081558, 14664.560063198121, 15218.619534511727, 14085.436582536993, 14283.571492855232, 14433.494827680981, 14480.85519144795, 14604.780928285873, 13694.904407647165, 14126.152430854181, 14285.143370966214, 14328.0, 14366.209858457885, 9858.457784821616, 9909.355891867006, 10330.48347582633, 10441.843372349269, 10448.843267351147, 11326.433678315887, 11444.103914879488, 11454.885451145381, 11462.770744584896, 11583.884161158618], "value": 8003.963850124799, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1509.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 118.0, 119.0, 144.0, 157.0, 116.0, 117.0, 118.0, 118.0, 98.0], "value": 121.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 110.0, 109.0, 146.0, 110.0, 111.0, 111.0, 112.0, 129.0, 109.0], "value": 118.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [202.0, 193.0, 201.0, 202.0, 193.0, 199.0, 196.0, 199.0, 203.0, 192.0], "value": 198.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 58.0, 60.0, 89.0, 64.0, 60.0, 60.0, 58.0, 83.0, 93.0], "value": 70.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 84.0, 71.0, 73.0, 68.0, 79.0, 71.0, 71.0, 81.0], "value": 75.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 88.0, 100.0, 113.0, 88.0, 134.0, 94.0, 81.0, 138.0], "value": 101.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 108.0, 95.0, 95.0, 95.0, 96.0, 97.0, 113.0, 150.0, 111.0], "value": 111.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 94.0, 91.0, 91.0, 93.0, 90.0, 92.0, 92.0, 90.0, 93.0], "value": 91.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 63.0, 65.0, 68.0, 69.0, 68.0, 68.0, 69.0, 68.0], "value": 66.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 61.0, 67.0, 62.0, 66.0, 64.0, 59.0, 57.0, 56.0, 58.0], "value": 61.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 99.0, 72.0, 91.0, 101.0, 104.0, 81.0, 76.0, 98.0, 68.0], "value": 87.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 134.0, 135.0, 155.0, 150.0, 148.0, 163.0, 151.0, 205.0, 181.0], "value": 157.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 172.0, 168.0, 210.0, 223.0, 181.0, 185.0, 210.0, 164.0, 165.0], "value": 184.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 66.0, 64.0, 65.0, 64.0, 66.0, 64.0, 63.0, 64.0, 66.0], "value": 64.4, "unit": "score"}]}]} 15:43:58 INFO - Return code: 0 15:43:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:43:58 ERROR - # TBPL SUCCESS # 15:43:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 15:43:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 15:43:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 15:43:58 INFO - 2017-05-08 15:43:58.893 screenresolution[2015:18241] starting screenresolution argv=screenresolution get 15:43:58 INFO - 2017-05-08 15:43:58.896 screenresolution[2015:18241] Display 0: 1600x1200x32@60 15:43:58 INFO - 2017-05-08 15:43:58.902 screenresolution[2016:18244] starting screenresolution argv=screenresolution list 15:43:58 INFO - Available Modes on Display 0 15:43:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 15:43:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 15:43:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 15:43:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 15:43:59 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 15:43:59 INFO - Intel Iris: 15:43:59 INFO - Chipset Model: Intel Iris 15:43:59 INFO - Type: GPU 15:43:59 INFO - Bus: Built-In 15:43:59 INFO - VRAM (Dynamic, Max): 1536 MB 15:43:59 INFO - Vendor: Intel (0x8086) 15:43:59 INFO - Device ID: 0x0a2e 15:43:59 INFO - Revision ID: 0x0009 15:43:59 INFO - Displays: 15:43:59 INFO - Display: 15:43:59 INFO - Resolution: 1600 x 1200 @ 60 Hz 15:43:59 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 15:43:59 INFO - Display Serial Number: 1600x1200 60 15:43:59 INFO - Main Display: Yes 15:43:59 INFO - Mirror: Off 15:43:59 INFO - Online: Yes 15:43:59 INFO - Rotation: Supported 15:43:59 INFO - Return code: 0 15:43:59 INFO - Running post-action listener: _resource_record_post_action 15:43:59 INFO - [mozharness: 2017-05-08 22:43:59.136273Z] Finished run-tests step (success) 15:43:59 INFO - Running post-run listener: _resource_record_post_run 15:43:59 INFO - Total resource usage - Wall time: 1191s; CPU: 54.0%; Read bytes: 1474560; Write bytes: 429126144; Read time: 16; Write time: 1430 15:43:59 INFO - TinderboxPrint: CPU usage
54.4% 15:43:59 INFO - TinderboxPrint: I/O read bytes / time
1,474,560 / 16 15:43:59 INFO - TinderboxPrint: I/O write bytes / time
429,126,144 / 1,430 15:43:59 INFO - TinderboxPrint: CPU idle
2,171.6 (45.6%) 15:43:59 INFO - TinderboxPrint: CPU system
951.9 (20.0%) 15:43:59 INFO - TinderboxPrint: CPU user
1,642.2 (34.5%) 15:43:59 INFO - TinderboxPrint: Swap in / out
123,686,912 / 0 15:43:59 INFO - install - Wall time: 15s; CPU: 54.0%; Read bytes: 122831360; Write bytes: 122847232; Read time: 11138; Write time: 274 15:43:59 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 1355776; Write bytes: 299751936; Read time: 14; Write time: 1125 15:43:59 INFO - Running post-run listener: _upload_blobber_files 15:43:59 INFO - Blob upload gear active. 15:43:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:43:59 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 15:43:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:43:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:44:00 INFO - (blobuploader) - INFO - Open directory for files ... 15:44:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 15:44:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 15:44:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:00 INFO - (blobuploader) - INFO - Done attempting. 15:44:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 15:44:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 15:44:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:02 INFO - (blobuploader) - INFO - Done attempting. 15:44:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 15:44:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:03 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 15:44:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:03 INFO - (blobuploader) - INFO - Done attempting. 15:44:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:44:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:44:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:44:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:44:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:44:05 INFO - (blobuploader) - INFO - Done attempting. 15:44:05 INFO - (blobuploader) - INFO - Iteration through files over. 15:44:05 INFO - Return code: 0 15:44:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:44:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:44:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8828cb4e5e3c7e60edc7833fb5cf20612e9f0ce4e12b4d4f456a72fa7deb03e58a257d4c33cc7941e5555c4cd6a1a7c06fb2a0c97feb593628929ba662e8f9d9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25e6c906ec4cd442c069729fc54ca2e3fe1a0acd7cd6fb821eb35d1b955492689e4e42ae1fca25327e13b72041d1d6f2cf60a597b3861f816f7656cf42002010", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9c5637b3e83177aebcc3792c8d50c1184609fa3baefdd26f1844853e1892b03c7bb27a3e48edb5293193db1644df4022d8b00385c4d48f2c905ba5036b3e6249", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3a723816514f2869f721f85dffbe8660d300dbebd260f45d007599fb7c470661883832bdd69d44f14ef8d7537288f3bfa08f8ad41b2ad4a3b9cf11cd7d5153cf"} 15:44:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:44:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:44:05 INFO - Contents: 15:44:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8828cb4e5e3c7e60edc7833fb5cf20612e9f0ce4e12b4d4f456a72fa7deb03e58a257d4c33cc7941e5555c4cd6a1a7c06fb2a0c97feb593628929ba662e8f9d9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25e6c906ec4cd442c069729fc54ca2e3fe1a0acd7cd6fb821eb35d1b955492689e4e42ae1fca25327e13b72041d1d6f2cf60a597b3861f816f7656cf42002010", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9c5637b3e83177aebcc3792c8d50c1184609fa3baefdd26f1844853e1892b03c7bb27a3e48edb5293193db1644df4022d8b00385c4d48f2c905ba5036b3e6249", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3a723816514f2869f721f85dffbe8660d300dbebd260f45d007599fb7c470661883832bdd69d44f14ef8d7537288f3bfa08f8ad41b2ad4a3b9cf11cd7d5153cf"} 15:44:05 INFO - Running post-run listener: copy_logs_to_upload_dir 15:44:05 INFO - Copying logs to upload dir... 15:44:05 INFO - mkdir: /builds/slave/test/build/upload/logs 15:44:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.996039 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2017-05-08 15:44:05.421898) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 15:44:05.425642) ========= 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.ybI4BNWnTe/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.osa7rCxI49/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8828cb4e5e3c7e60edc7833fb5cf20612e9f0ce4e12b4d4f456a72fa7deb03e58a257d4c33cc7941e5555c4cd6a1a7c06fb2a0c97feb593628929ba662e8f9d9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25e6c906ec4cd442c069729fc54ca2e3fe1a0acd7cd6fb821eb35d1b955492689e4e42ae1fca25327e13b72041d1d6f2cf60a597b3861f816f7656cf42002010", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9c5637b3e83177aebcc3792c8d50c1184609fa3baefdd26f1844853e1892b03c7bb27a3e48edb5293193db1644df4022d8b00385c4d48f2c905ba5036b3e6249", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3a723816514f2869f721f85dffbe8660d300dbebd260f45d007599fb7c470661883832bdd69d44f14ef8d7537288f3bfa08f8ad41b2ad4a3b9cf11cd7d5153cf"} build_url:https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011156 build_url: 'https://queue.taskcluster.net/v1/task/fJLPSi1bR7mvL2pi6heiug/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/8828cb4e5e3c7e60edc7833fb5cf20612e9f0ce4e12b4d4f456a72fa7deb03e58a257d4c33cc7941e5555c4cd6a1a7c06fb2a0c97feb593628929ba662e8f9d9", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/25e6c906ec4cd442c069729fc54ca2e3fe1a0acd7cd6fb821eb35d1b955492689e4e42ae1fca25327e13b72041d1d6f2cf60a597b3861f816f7656cf42002010", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9c5637b3e83177aebcc3792c8d50c1184609fa3baefdd26f1844853e1892b03c7bb27a3e48edb5293193db1644df4022d8b00385c4d48f2c905ba5036b3e6249", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/3a723816514f2869f721f85dffbe8660d300dbebd260f45d007599fb7c470661883832bdd69d44f14ef8d7537288f3bfa08f8ad41b2ad4a3b9cf11cd7d5153cf"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-08 15:44:05.460139) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 15:44:05.460481) ========= 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.ybI4BNWnTe/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.osa7rCxI49/Listeners TMPDIR=/var/folders/kt/md9tf2_d52xdhxcqh4xzhxzc00000w/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.005257 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-08 15:44:05.508907) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 15:44:05.509214) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-08 15:44:05.509569) ========= ========= Total master_lag: 0.18 =========