builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0277 starttime: 1491427543.44 results: success (0) buildid: 20170405125420 builduid: 261490be90d14e41afac8b3bf8761ef4 revision: 730db8b60c1e4443af45f94b6411b81c889e0759 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 14:25:43.443653) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 14:25:43.444092) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 14:25:43.444388) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 14:25:43.471224) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 14:25:43.471597) ========= 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.odgy7hNxZH/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.7uUWNioBpS/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-05 14:25:43-- 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% 135M=0s 2017-04-05 14:25:43 (135 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.209636 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 14:25:43.706227) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 14:25:43.706561) ========= 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.odgy7hNxZH/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.7uUWNioBpS/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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.036690 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 14:25:43.765525) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-05 14:25:43.765887) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 730db8b60c1e4443af45f94b6411b81c889e0759 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 730db8b60c1e4443af45f94b6411b81c889e0759 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.odgy7hNxZH/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.7uUWNioBpS/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-05 14:25:43,873 truncating revision to first 12 chars 2017-04-05 14:25:43,874 Setting DEBUG logging. 2017-04-05 14:25:43,874 attempt 1/10 2017-04-05 14:25:43,874 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/730db8b60c1e?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-05 14:25:45,304 unpacking tar archive at: mozilla-central-730db8b60c1e/testing/mozharness/ program finished with exit code 0 elapsedTime=1.721378 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-05 14:25:45.510962) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 14:25:45.511308) ========= script_repo_revision: 730db8b60c1e4443af45f94b6411b81c889e0759 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 14:25:45.511744) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 14:25:45.512017) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 14:25:45.532292) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-04-05 14:25:45.532691) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.odgy7hNxZH/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.7uUWNioBpS/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 14:25:45 INFO - MultiFileLogger online at 20170405 14:25:45 in /builds/slave/test 14:25:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 14:25:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 14:25:45 INFO - {'append_to_log': False, 14:25:45 INFO - 'base_work_dir': '/builds/slave/test', 14:25:45 INFO - 'blob_upload_branch': 'Firefox', 14:25:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 14:25:45 INFO - 'branch': 'Firefox', 14:25:45 INFO - 'buildbot_json_path': 'buildprops.json', 14:25:45 INFO - 'config_files': ('talos/mac_config.py',), 14:25:45 INFO - 'default_actions': ('clobber', 14:25:45 INFO - 'read-buildbot-config', 14:25:45 INFO - 'download-and-extract', 14:25:45 INFO - 'populate-webroot', 14:25:45 INFO - 'create-virtualenv', 14:25:45 INFO - 'install', 14:25:45 INFO - 'run-tests'), 14:25:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 14:25:45 INFO - 'download_minidump_stackwalk': True, 14:25:45 INFO - 'download_symbols': 'ondemand', 14:25:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 14:25:45 INFO - 'tooltool.py': '/tools/tooltool.py', 14:25:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 14:25:45 INFO - '/tools/misc-python/virtualenv.py')}, 14:25:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 14:25:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 14:25:45 INFO - 'gecko_profile': False, 14:25:45 INFO - 'gecko_profile_interval': 0, 14:25:45 INFO - 'installer_path': 'installer.exe', 14:25:45 INFO - 'log_level': 'info', 14:25:45 INFO - 'log_name': 'talos', 14:25:45 INFO - 'log_to_console': True, 14:25:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 14:25:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 14:25:45 INFO - 'opt_config_files': (), 14:25:45 INFO - 'pip_index': False, 14:25:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:25:45 INFO - 'cmd': ('bash', 14:25:45 INFO - '-c', 14:25:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:25:45 INFO - 'enabled': True, 14:25:45 INFO - 'halt_on_failure': False, 14:25:45 INFO - 'name': 'check_screen_resolution'},), 14:25:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 14:25:45 INFO - 'cmd': ('bash', 14:25:45 INFO - '-c', 14:25:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 14:25:45 INFO - 'enabled': True, 14:25:45 INFO - 'halt_on_failure': False, 14:25:45 INFO - 'name': 'check_screen_resolution'},), 14:25:45 INFO - 'run_cmd_checks_enabled': True, 14:25:45 INFO - 'suite': 'dromaeojs-e10s', 14:25:45 INFO - 'system_bits': '32', 14:25:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 14:25:45 INFO - 'title': 't-yosemite-r7-0277', 14:25:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 14:25:45 INFO - 'use_talos_json': True, 14:25:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 14:25:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 14:25:45 INFO - 'work_dir': 'build'} 14:25:45 INFO - [mozharness: 2017-04-05 21:25:45.740762Z] Running clobber step. 14:25:45 INFO - Running pre-action listener: _resource_record_pre_action 14:25:45 INFO - Running main action method: clobber 14:25:45 INFO - rmtree: /builds/slave/test/build 14:25:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 14:25:48 INFO - Running post-action listener: _resource_record_post_action 14:25:48 INFO - [mozharness: 2017-04-05 21:25:48.310322Z] Finished clobber step (success) 14:25:48 INFO - [mozharness: 2017-04-05 21:25:48.310512Z] Running read-buildbot-config step. 14:25:48 INFO - Running pre-action listener: _resource_record_pre_action 14:25:48 INFO - Running main action method: read_buildbot_config 14:25:48 INFO - Using buildbot properties: 14:25:48 INFO - { 14:25:48 INFO - "project": "", 14:25:48 INFO - "product": "firefox", 14:25:48 INFO - "script_repo_revision": "production", 14:25:48 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 14:25:48 INFO - "repository": "", 14:25:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 14:25:48 INFO - "buildid": "20170405125420", 14:25:48 INFO - "pgo_build": "False", 14:25:48 INFO - "basedir": "/builds/slave/test", 14:25:48 INFO - "buildnumber": 36, 14:25:48 INFO - "slavename": "t-yosemite-r7-0277", 14:25:48 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 14:25:48 INFO - "platform": "yosemite_r7", 14:25:48 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 14:25:48 INFO - "branch": "mozilla-central", 14:25:48 INFO - "repo_path": "mozilla-central", 14:25:48 INFO - "revision": "730db8b60c1e4443af45f94b6411b81c889e0759", 14:25:48 INFO - "stage_platform": "macosx64", 14:25:48 INFO - "builduid": "261490be90d14e41afac8b3bf8761ef4", 14:25:48 INFO - "slavebuilddir": "test" 14:25:48 INFO - } 14:25:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/XfHkKcCZQqijvkwhlFv4Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 14:25:48 INFO - Running post-action listener: _resource_record_post_action 14:25:48 INFO - [mozharness: 2017-04-05 21:25:48.315825Z] Finished read-buildbot-config step (success) 14:25:48 INFO - [mozharness: 2017-04-05 21:25:48.316058Z] Running download-and-extract step. 14:25:48 INFO - Running pre-action listener: _resource_record_pre_action 14:25:48 INFO - Running main action method: download_and_extract 14:25:48 INFO - mkdir: /builds/slave/test/build/tests 14:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:25:48 INFO - trying https://queue.taskcluster.net/v1/task/XfHkKcCZQqijvkwhlFv4Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 14:25:48 INFO - Downloading https://queue.taskcluster.net/v1/task/XfHkKcCZQqijvkwhlFv4Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 14:25:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XfHkKcCZQqijvkwhlFv4Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 14:25:49 INFO - Downloaded 1325 bytes. 14:25:49 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 14:25:49 INFO - Using the following test package requirements: 14:25:49 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:25:49 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 14:25:49 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 14:25:49 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:25:49 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 14:25:49 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:25:49 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 14:25:49 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:25:49 INFO - u'jsshell-mac.zip'], 14:25:49 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:25:49 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 14:25:49 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 14:25:49 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:25:49 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 14:25:49 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:25:49 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 14:25:49 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:25:49 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 14:25:49 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 14:25:49 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 14:25:49 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 14:25:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XfHkKcCZQqijvkwhlFv4Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 14:25:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XfHkKcCZQqijvkwhlFv4Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:25:49 INFO - Fetch https://queue.taskcluster.net/v1/task/XfHkKcCZQqijvkwhlFv4Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 14:25:51 INFO - Expected file size: 52517711 14:25:51 INFO - Obtained file size: 52517711 14:26:07 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 14:26:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XfHkKcCZQqijvkwhlFv4Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 14:26:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XfHkKcCZQqijvkwhlFv4Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 14:26:07 INFO - Fetch https://queue.taskcluster.net/v1/task/XfHkKcCZQqijvkwhlFv4Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 14:26:09 INFO - Expected file size: 52517711 14:26:09 INFO - Obtained file size: 52517711 14:26:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/XfHkKcCZQqijvkwhlFv4Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 14:26:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/XfHkKcCZQqijvkwhlFv4Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 14:26:24 INFO - Fetch https://queue.taskcluster.net/v1/task/XfHkKcCZQqijvkwhlFv4Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 14:26:26 INFO - Expected file size: 14404152 14:26:26 INFO - Obtained file size: 14404152 14:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:26:26 INFO - trying https://queue.taskcluster.net/v1/task/XfHkKcCZQqijvkwhlFv4Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:26:26 INFO - Downloading https://queue.taskcluster.net/v1/task/XfHkKcCZQqijvkwhlFv4Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 14:26:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/XfHkKcCZQqijvkwhlFv4Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 14:26:28 INFO - Downloaded 70746414 bytes. 14:26:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/XfHkKcCZQqijvkwhlFv4Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:26:28 INFO - mkdir: /builds/slave/test/properties 14:26:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 14:26:28 INFO - Writing to file /builds/slave/test/properties/build_url 14:26:28 INFO - Contents: 14:26:28 INFO - build_url:https://queue.taskcluster.net/v1/task/XfHkKcCZQqijvkwhlFv4Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 14:26:29 INFO - Running post-action listener: _resource_record_post_action 14:26:29 INFO - Running post-action listener: set_extra_try_arguments 14:26:29 INFO - [mozharness: 2017-04-05 21:26:29.219175Z] Finished download-and-extract step (success) 14:26:29 INFO - [mozharness: 2017-04-05 21:26:29.219329Z] Running populate-webroot step. 14:26:29 INFO - Running pre-action listener: _resource_record_pre_action 14:26:29 INFO - Running main action method: populate_webroot 14:26:29 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 14:26:29 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 14:26:29 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 14:26:29 INFO - '--tppagecycles', 14:26:29 INFO - '7'], 14:26:29 INFO - 'tests': ['tsvgm']}}, 14:26:29 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 14:26:29 INFO - 'tests': ['tresize', 'tcanvasmark']}, 14:26:29 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 14:26:29 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 14:26:29 INFO - 'tests': ['dromaeo_css', 'kraken']}, 14:26:29 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 14:26:29 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 14:26:29 INFO - 'talos_options': ['--disable-e10s'], 14:26:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:26:29 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 14:26:29 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 14:26:29 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 14:26:29 INFO - 'talos_options': ['--disable-e10s'], 14:26:29 INFO - 'tests': ['damp', 'tps']}, 14:26:29 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 14:26:29 INFO - 'tests': ['damp', 'tps']}, 14:26:29 INFO - 'g3': {'talos_options': ['--disable-e10s'], 14:26:29 INFO - 'tests': ['dromaeo_dom']}, 14:26:29 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 14:26:29 INFO - 'g4': {'talos_options': ['--disable-e10s'], 14:26:29 INFO - 'tests': ['basic_compositor_video']}, 14:26:29 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 14:26:29 INFO - 'other': {'talos_options': ['--disable-e10s'], 14:26:29 INFO - 'tests': ['a11yr', 14:26:29 INFO - 'ts_paint', 14:26:29 INFO - 'tpaint', 14:26:29 INFO - 'sessionrestore', 14:26:29 INFO - 'sessionrestore_no_auto_restore', 14:26:29 INFO - 'tabpaint']}, 14:26:29 INFO - 'other-e10s': {'tests': ['a11yr', 14:26:29 INFO - 'ts_paint', 14:26:29 INFO - 'tpaint', 14:26:29 INFO - 'sessionrestore', 14:26:29 INFO - 'sessionrestore_no_auto_restore', 14:26:29 INFO - 'tabpaint']}, 14:26:29 INFO - 'other-e10s_l64': {'tests': ['a11yr', 14:26:29 INFO - 'ts_paint', 14:26:29 INFO - 'tpaint', 14:26:29 INFO - 'sessionrestore', 14:26:29 INFO - 'sessionrestore_no_auto_restore', 14:26:29 INFO - 'tabpaint']}, 14:26:29 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 14:26:29 INFO - 'ts_paint', 14:26:29 INFO - 'tpaint', 14:26:29 INFO - 'sessionrestore', 14:26:29 INFO - 'sessionrestore_no_auto_restore', 14:26:29 INFO - 'tabpaint']}, 14:26:29 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 14:26:29 INFO - 'tests': ['a11yr', 14:26:29 INFO - 'ts_paint', 14:26:29 INFO - 'tpaint', 14:26:29 INFO - 'sessionrestore', 14:26:29 INFO - 'sessionrestore_no_auto_restore', 14:26:29 INFO - 'tabpaint']}, 14:26:29 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 14:26:29 INFO - 'tests': ['a11yr', 14:26:29 INFO - 'ts_paint', 14:26:29 INFO - 'tpaint', 14:26:29 INFO - 'sessionrestore', 14:26:29 INFO - 'sessionrestore_no_auto_restore', 14:26:29 INFO - 'tabpaint']}, 14:26:29 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 14:26:29 INFO - 'tests': ['tsvgx', 14:26:29 INFO - 'tsvgr_opacity', 14:26:29 INFO - 'tart', 14:26:29 INFO - 'tscrollx', 14:26:29 INFO - 'cart', 14:26:29 INFO - 'tsvg_static']}, 14:26:29 INFO - 'svgr-e10s': {'tests': ['tsvgx', 14:26:29 INFO - 'tsvgr_opacity', 14:26:29 INFO - 'tart', 14:26:29 INFO - 'tscrollx', 14:26:29 INFO - 'cart', 14:26:29 INFO - 'tsvg_static']}, 14:26:29 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 14:26:29 INFO - 'talos_options': ['--disable-e10s'], 14:26:29 INFO - 'tests': ['tp5o']}, 14:26:29 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 14:26:29 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 14:26:29 INFO - 'talos_options': ['--disable-e10s', 14:26:29 INFO - '--xperf_path', 14:26:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:26:29 INFO - 'tests': ['tp5n']}, 14:26:29 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 14:26:29 INFO - 'talos_options': ['--xperf_path', 14:26:29 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 14:26:29 INFO - 'tests': ['tp5n']}}, 14:26:29 INFO - 'talos.zip': {'path': '', 14:26:29 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 14:26:29 INFO - Running post-action listener: _resource_record_post_action 14:26:29 INFO - [mozharness: 2017-04-05 21:26:29.237873Z] Finished populate-webroot step (success) 14:26:29 INFO - [mozharness: 2017-04-05 21:26:29.237981Z] Running create-virtualenv step. 14:26:29 INFO - Running pre-action listener: _resource_record_pre_action 14:26:29 INFO - Running main action method: create_virtualenv 14:26:29 INFO - Creating virtualenv /builds/slave/test/build/venv 14:26:29 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 14:26:29 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 14:26:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 14:26:29 INFO - Using real prefix '/tools/python27' 14:26:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 14:26:30 INFO - Installing distribute.............................................................................................................................................................................................done. 14:26:33 INFO - Installing pip.................done. 14:26:33 INFO - Return code: 0 14:26:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 14:26:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 14:26:33 INFO - Reading from file tmpfile_stdout 14:26:33 INFO - Output received: 14:26:33 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) 14:26:33 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 14:26:33 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')]} 14:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:33 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')]} 14:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:33 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 0x10f273b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f276768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe65859b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f051d30>, '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 0x10ef78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f046be8>, '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.odgy7hNxZH/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.7uUWNioBpS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 14:26:33 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 14:26:33 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 14:26:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.odgy7hNxZH/Render', 14:26:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:26:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:26:33 INFO - 'HOME': '/Users/cltbld', 14:26:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:26:33 INFO - 'LOGNAME': 'cltbld', 14:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:33 INFO - 'MOZ_NO_REMOTE': '1', 14:26:33 INFO - 'NO_EM_RESTART': '1', 14:26:33 INFO - 'PAGER': '/bin/cat', 14:26:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:33 INFO - 'PWD': '/builds/slave/test', 14:26:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:26:33 INFO - 'SHELL': '/bin/bash', 14:26:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7uUWNioBpS/Listeners', 14:26:33 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 14:26:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:26:33 INFO - 'USER': 'cltbld', 14:26:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:26:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:33 INFO - 'XPC_FLAGS': '0x0', 14:26:33 INFO - 'XPC_SERVICE_NAME': '0', 14:26:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:26:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:26:33 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 14:26:33 INFO - Cleaning up... 14:26:33 INFO - Return code: 0 14:26:33 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 14:26:33 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')]} 14:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:26:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:33 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')]} 14:26:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:26:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:33 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 0x10f273b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f276768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe65859b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f051d30>, '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 0x10ef78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f046be8>, '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.odgy7hNxZH/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.7uUWNioBpS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 14:26:33 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 14:26:33 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 14:26:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.odgy7hNxZH/Render', 14:26:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:26:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:26:33 INFO - 'HOME': '/Users/cltbld', 14:26:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:26:33 INFO - 'LOGNAME': 'cltbld', 14:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:33 INFO - 'MOZ_NO_REMOTE': '1', 14:26:33 INFO - 'NO_EM_RESTART': '1', 14:26:33 INFO - 'PAGER': '/bin/cat', 14:26:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:33 INFO - 'PWD': '/builds/slave/test', 14:26:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:26:33 INFO - 'SHELL': '/bin/bash', 14:26:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7uUWNioBpS/Listeners', 14:26:33 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 14:26:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:26:33 INFO - 'USER': 'cltbld', 14:26:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:26:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:33 INFO - 'XPC_FLAGS': '0x0', 14:26:33 INFO - 'XPC_SERVICE_NAME': '0', 14:26:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:26:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:26:33 INFO - Downloading/unpacking psutil>=3.1.1 14:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:26:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:26:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:26:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:26:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:26:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 14:26:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:26:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:26:37 INFO - Installing collected packages: psutil 14:26:37 INFO - Running setup.py install for psutil 14:26:37 INFO - building 'psutil._psutil_osx' extension 14:26:37 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 14:26:38 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 14:26:38 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 14:26:38 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 14:26:38 INFO - building 'psutil._psutil_posix' extension 14:26:38 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 14:26:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 14:26:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 14:26:38 INFO - ^ 14:26:38 INFO - 1 warning generated. 14:26:38 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 14:26:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 14:26:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 14:26:38 INFO - Successfully installed psutil 14:26:38 INFO - Cleaning up... 14:26:38 INFO - Return code: 0 14:26:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 14:26:38 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')]} 14:26:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:26:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26: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')]} 14:26:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:26:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f273b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f276768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe65859b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f051d30>, '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 0x10ef78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f046be8>, '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.odgy7hNxZH/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.7uUWNioBpS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 14:26:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 14:26:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 14:26:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.odgy7hNxZH/Render', 14:26:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:26:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:26:39 INFO - 'HOME': '/Users/cltbld', 14:26:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:26:39 INFO - 'LOGNAME': 'cltbld', 14:26:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:39 INFO - 'MOZ_NO_REMOTE': '1', 14:26:39 INFO - 'NO_EM_RESTART': '1', 14:26:39 INFO - 'PAGER': '/bin/cat', 14:26:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:26:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:39 INFO - 'PWD': '/builds/slave/test', 14:26:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:26:39 INFO - 'SHELL': '/bin/bash', 14:26:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7uUWNioBpS/Listeners', 14:26:39 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 14:26:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:26:39 INFO - 'USER': 'cltbld', 14:26:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:26:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:26:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:39 INFO - 'XPC_FLAGS': '0x0', 14:26:39 INFO - 'XPC_SERVICE_NAME': '0', 14:26:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:26:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:26:39 INFO - Downloading/unpacking mozsystemmonitor==0.3 14:26:39 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 14:26:39 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 14:26:39 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 14:26:39 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 14:26:39 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 14:26:39 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 14:26:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 14:26:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 14:26:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 14:26:42 INFO - Installing collected packages: mozsystemmonitor 14:26:42 INFO - Running setup.py install for mozsystemmonitor 14:26:43 INFO - Successfully installed mozsystemmonitor 14:26:43 INFO - Cleaning up... 14:26:43 INFO - Return code: 0 14:26:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 14:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:26:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 14:26:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:26:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:43 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 0x10f273b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f276768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe65859b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f051d30>, '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 0x10ef78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f046be8>, '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.odgy7hNxZH/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.7uUWNioBpS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 14:26:43 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 14:26:43 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 14:26:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.odgy7hNxZH/Render', 14:26:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:26:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:26:43 INFO - 'HOME': '/Users/cltbld', 14:26:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:26:43 INFO - 'LOGNAME': 'cltbld', 14:26:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:43 INFO - 'MOZ_NO_REMOTE': '1', 14:26:43 INFO - 'NO_EM_RESTART': '1', 14:26:43 INFO - 'PAGER': '/bin/cat', 14:26:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:26:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:43 INFO - 'PWD': '/builds/slave/test', 14:26:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:26:43 INFO - 'SHELL': '/bin/bash', 14:26:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7uUWNioBpS/Listeners', 14:26:43 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 14:26:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:26:43 INFO - 'USER': 'cltbld', 14:26:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:26:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:26:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:43 INFO - 'XPC_FLAGS': '0x0', 14:26:43 INFO - 'XPC_SERVICE_NAME': '0', 14:26:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:26:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:26:43 INFO - Downloading/unpacking jsonschema==2.5.1 14:26:43 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 14:26:43 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 14:26:43 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 14:26:43 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 14:26:43 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 14:26:43 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 14:26:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 14:26:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 14:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:26:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:26:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:26:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:26:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:26:46 INFO - Downloading functools32-3.2.3-2.tar.gz 14:26:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 14:26:46 INFO - warning: no files found matching '*.txt' 14:26:46 INFO - no previously-included directories found matching 'build' 14:26:46 INFO - no previously-included directories found matching 'dist' 14:26:46 INFO - no previously-included directories found matching '.git*' 14:26:46 INFO - Installing collected packages: jsonschema, functools32 14:26:46 INFO - Running setup.py install for functools32 14:26:46 INFO - warning: no files found matching '*.txt' 14:26:46 INFO - no previously-included directories found matching 'build' 14:26:46 INFO - no previously-included directories found matching 'dist' 14:26:46 INFO - no previously-included directories found matching '.git*' 14:26:46 INFO - Successfully installed jsonschema functools32 14:26:46 INFO - Cleaning up... 14:26:46 INFO - Return code: 0 14:26:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 14:26: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')]} 14:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:26:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26: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')]} 14:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:26:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26: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', '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 0x10f273b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f276768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe65859b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f051d30>, '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 0x10ef78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f046be8>, '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.odgy7hNxZH/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.7uUWNioBpS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 14:26: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 14:26: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 functools32==3.2.3-2 14:26:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.odgy7hNxZH/Render', 14:26:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:26:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:26:46 INFO - 'HOME': '/Users/cltbld', 14:26:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:26:46 INFO - 'LOGNAME': 'cltbld', 14:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:46 INFO - 'MOZ_NO_REMOTE': '1', 14:26:46 INFO - 'NO_EM_RESTART': '1', 14:26:46 INFO - 'PAGER': '/bin/cat', 14:26:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:46 INFO - 'PWD': '/builds/slave/test', 14:26:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:26:46 INFO - 'SHELL': '/bin/bash', 14:26:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7uUWNioBpS/Listeners', 14:26:46 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 14:26:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:26:46 INFO - 'USER': 'cltbld', 14:26:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:26:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:46 INFO - 'XPC_FLAGS': '0x0', 14:26:46 INFO - 'XPC_SERVICE_NAME': '0', 14:26:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:26:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:26:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 14:26:46 INFO - Cleaning up... 14:26:46 INFO - Return code: 0 14:26:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 14:26: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')]} 14:26:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:26:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26: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')]} 14:26:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:26:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26: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', '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 0x10f273b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f276768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe65859b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f051d30>, '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 0x10ef78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f046be8>, '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.odgy7hNxZH/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.7uUWNioBpS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 14:26: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 14:26: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 blobuploader==1.2.4 14:26:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.odgy7hNxZH/Render', 14:26:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:26:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:26:46 INFO - 'HOME': '/Users/cltbld', 14:26:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:26:46 INFO - 'LOGNAME': 'cltbld', 14:26:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:46 INFO - 'MOZ_NO_REMOTE': '1', 14:26:46 INFO - 'NO_EM_RESTART': '1', 14:26:46 INFO - 'PAGER': '/bin/cat', 14:26:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:26:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:46 INFO - 'PWD': '/builds/slave/test', 14:26:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:26:46 INFO - 'SHELL': '/bin/bash', 14:26:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7uUWNioBpS/Listeners', 14:26:46 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 14:26:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:26:46 INFO - 'USER': 'cltbld', 14:26:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:26:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:26:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:46 INFO - 'XPC_FLAGS': '0x0', 14:26:46 INFO - 'XPC_SERVICE_NAME': '0', 14:26:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:26:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:26:47 INFO - Downloading/unpacking blobuploader==1.2.4 14:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:26:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:26:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 14:26:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 14:26:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 14:26:49 INFO - Downloading blobuploader-1.2.4.tar.gz 14:26:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 14:26:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 14:26: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 14:26: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 14:26: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 14:26: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 14:26: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 14:26: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 14:26:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 14:26:50 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 14:26:50 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 14:26:50 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 14:26:50 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 14:26:50 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 14:26:50 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 14:26:50 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 14:26:51 INFO - Downloading docopt-0.6.1.tar.gz 14:26:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 14:26:51 INFO - Installing collected packages: blobuploader, requests, docopt 14:26:51 INFO - Running setup.py install for blobuploader 14:26:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 14:26:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 14:26:51 INFO - Running setup.py install for requests 14:26:51 INFO - Running setup.py install for docopt 14:26:52 INFO - Successfully installed blobuploader requests docopt 14:26:52 INFO - Cleaning up... 14:26:52 INFO - Return code: 0 14:26:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:26: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')]} 14:26:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:26:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26: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')]} 14:26:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:26:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:52 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 0x10f273b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f276768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe65859b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f051d30>, '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 0x10ef78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f046be8>, '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.odgy7hNxZH/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.7uUWNioBpS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 14:26:52 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 14:26:52 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 14:26:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.odgy7hNxZH/Render', 14:26:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:26:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:26:52 INFO - 'HOME': '/Users/cltbld', 14:26:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:26:52 INFO - 'LOGNAME': 'cltbld', 14:26:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:52 INFO - 'MOZ_NO_REMOTE': '1', 14:26:52 INFO - 'NO_EM_RESTART': '1', 14:26:52 INFO - 'PAGER': '/bin/cat', 14:26:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:26:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:52 INFO - 'PWD': '/builds/slave/test', 14:26:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:26:52 INFO - 'SHELL': '/bin/bash', 14:26:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7uUWNioBpS/Listeners', 14:26:52 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 14:26:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:26:52 INFO - 'USER': 'cltbld', 14:26:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:26:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:26:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:52 INFO - 'XPC_FLAGS': '0x0', 14:26:52 INFO - 'XPC_SERVICE_NAME': '0', 14:26:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:26:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:26:52 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-kJ8aX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:26:52 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-HMZpRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:26:52 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-QEDHD5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:26:52 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-qEUBWv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:26:52 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-XlIqUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:26:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:26:52 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-QHFkLQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:26:53 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-UF4dt0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:26:53 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-m1JZSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:26:53 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-slEgKq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:26:53 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-AUdC5P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:26:53 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-L6czwH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:26:53 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-Eoj4uf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:26:53 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-yMqxX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:26:53 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-Z5HFZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:26:53 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-jdB_bd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:26:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:26:53 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-BFdPKY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:26:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:26:54 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-2l_GT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:26:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 14:26:54 INFO - Running setup.py install for manifestparser 14:26:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 14:26:54 INFO - Running setup.py install for mozcrash 14:26:54 INFO - Running setup.py install for mozdebug 14:26:54 INFO - Running setup.py install for mozdevice 14:26:54 INFO - Installing dm script to /builds/slave/test/build/venv/bin 14:26:54 INFO - Running setup.py install for mozfile 14:26:54 INFO - Running setup.py install for mozhttpd 14:26:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 14:26:55 INFO - Running setup.py install for mozinfo 14:26:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 14:26:55 INFO - Running setup.py install for mozInstall 14:26:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 14:26:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 14:26:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 14:26:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 14:26:55 INFO - Running setup.py install for mozleak 14:26:55 INFO - Running setup.py install for mozlog 14:26:55 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 14:26:55 INFO - Running setup.py install for moznetwork 14:26:55 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 14:26:55 INFO - Running setup.py install for mozprocess 14:26:55 INFO - Running setup.py install for mozprofile 14:26:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 14:26:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 14:26:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 14:26:56 INFO - Running setup.py install for mozrunner 14:26:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 14:26:56 INFO - Running setup.py install for mozscreenshot 14:26:56 INFO - Running setup.py install for moztest 14:26:56 INFO - Running setup.py install for mozversion 14:26:56 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 14:26:56 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 14:26:56 INFO - Cleaning up... 14:26:56 INFO - Return code: 0 14:26:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:26:56 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')]} 14:26:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:26:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:56 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')]} 14:26:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:26:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:26:56 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 0x10f273b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f276768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe65859b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f051d30>, '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 0x10ef78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f046be8>, '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.odgy7hNxZH/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.7uUWNioBpS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 14:26:56 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 14:26:56 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 14:26:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.odgy7hNxZH/Render', 14:26:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:26:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:26:56 INFO - 'HOME': '/Users/cltbld', 14:26:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:26:56 INFO - 'LOGNAME': 'cltbld', 14:26:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:26:56 INFO - 'MOZ_NO_REMOTE': '1', 14:26:56 INFO - 'NO_EM_RESTART': '1', 14:26:56 INFO - 'PAGER': '/bin/cat', 14:26:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:26:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:26:56 INFO - 'PWD': '/builds/slave/test', 14:26:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:26:56 INFO - 'SHELL': '/bin/bash', 14:26:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7uUWNioBpS/Listeners', 14:26:56 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 14:26:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:26:56 INFO - 'USER': 'cltbld', 14:26:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:26:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:26:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:26:56 INFO - 'XPC_FLAGS': '0x0', 14:26:56 INFO - 'XPC_SERVICE_NAME': '0', 14:26:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:26:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 14:26:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-4PzTiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 14:26:57 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)) 14:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 14:26:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-PW3dIC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 14:26:57 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)) 14:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 14:26:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-BUCu2L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 14:26:57 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)) 14:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 14:26:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-jju71z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 14:26:57 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)) 14:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 14:26:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-Nomn6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 14:26:57 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)) 14:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 14:26:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-euZqNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 14:26:57 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)) 14:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 14:26:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-jr4xtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 14:26:57 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)) 14:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 14:26:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-wU4Rza-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 14:26:57 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)) 14:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 14:26:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-ykgDn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 14:26:57 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)) 14:26:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 14:26:57 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-opAZr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 14:26:58 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)) 14:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 14:26:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-UHVB9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 14:26:58 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)) 14:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 14:26:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-mbF8Q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 14:26:58 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)) 14:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 14:26:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-VNNQ0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 14:26:58 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)) 14:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 14:26:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-sZ6l0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 14:26:58 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)) 14:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 14:26:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-mpOswM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 14:26:58 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)) 14:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 14:26:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-qNIyD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 14:26:58 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)) 14:26:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 14:26:58 INFO - Running setup.py (path:/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/pip-WoC8Po-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 14:26:58 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)) 14:26:58 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)) 14:26:58 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)) 14:26:58 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)) 14:26:58 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)) 14:26:58 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)) 14:26:58 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 14:26:58 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 14:26:58 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 14:26:58 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 14:26:58 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 14:26:58 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 14:26:58 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 14:27:01 INFO - Downloading blessings-1.6.tar.gz 14:27:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 14:27:01 INFO - Installing collected packages: blessings 14:27:01 INFO - Running setup.py install for blessings 14:27:01 INFO - Successfully installed blessings 14:27:01 INFO - Cleaning up... 14:27:01 INFO - Return code: 0 14:27:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 14:27:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:27:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:27:02 INFO - Reading from file tmpfile_stdout 14:27:02 INFO - Current package versions: 14:27:02 INFO - blessings == 1.6 14:27:02 INFO - blobuploader == 1.2.4 14:27:02 INFO - docopt == 0.6.1 14:27:02 INFO - functools32 == 3.2.3-2 14:27:02 INFO - jsonschema == 2.5.1 14:27:02 INFO - manifestparser == 1.1 14:27:02 INFO - mozInstall == 1.12 14:27:02 INFO - mozcrash == 1.0 14:27:02 INFO - mozdebug == 0.1 14:27:02 INFO - mozdevice == 0.49 14:27:02 INFO - mozfile == 1.2 14:27:02 INFO - mozhttpd == 0.7 14:27:02 INFO - mozinfo == 0.9 14:27:02 INFO - mozleak == 0.1 14:27:02 INFO - mozlog == 3.4 14:27:02 INFO - moznetwork == 0.27 14:27:02 INFO - mozprocess == 0.25 14:27:02 INFO - mozprofile == 0.28 14:27:02 INFO - mozrunner == 6.13 14:27:02 INFO - mozscreenshot == 0.1 14:27:02 INFO - mozsystemmonitor == 0.3 14:27:02 INFO - moztest == 0.8 14:27:02 INFO - mozversion == 1.4 14:27:02 INFO - psutil == 3.1.1 14:27:02 INFO - requests == 1.2.3 14:27:02 INFO - wsgiref == 0.1.2 14:27:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 14:27:02 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')]} 14:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:02 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')]} 14:27:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:02 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 0x10f273b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f276768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe65859b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f051d30>, '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 0x10ef78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f046be8>, '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.odgy7hNxZH/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.7uUWNioBpS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 14:27:02 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 14:27:02 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 14:27:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.odgy7hNxZH/Render', 14:27:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:02 INFO - 'HOME': '/Users/cltbld', 14:27:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:02 INFO - 'LOGNAME': 'cltbld', 14:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:02 INFO - 'MOZ_NO_REMOTE': '1', 14:27:02 INFO - 'NO_EM_RESTART': '1', 14:27:02 INFO - 'PAGER': '/bin/cat', 14:27:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:02 INFO - 'PWD': '/builds/slave/test', 14:27:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:02 INFO - 'SHELL': '/bin/bash', 14:27:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7uUWNioBpS/Listeners', 14:27:02 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 14:27:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:02 INFO - 'USER': 'cltbld', 14:27:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:02 INFO - 'XPC_FLAGS': '0x0', 14:27:02 INFO - 'XPC_SERVICE_NAME': '0', 14:27:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:02 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)) 14:27:02 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)) 14:27:02 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)) 14:27:02 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)) 14:27:02 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)) 14:27:02 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)) 14:27:02 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)) 14:27:02 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)) 14:27:02 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)) 14:27:02 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)) 14:27:02 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)) 14:27:02 INFO - Cleaning up... 14:27:02 INFO - Return code: 0 14:27:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 14:27:02 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')]} 14:27:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 14:27:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:02 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')]} 14:27:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 14:27:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 14:27:02 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 0x10f273b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f276768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe65859b7d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f051d30>, '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 0x10ef78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f046be8>, '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.odgy7hNxZH/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.7uUWNioBpS/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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 14:27:02 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 14:27:02 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 14:27:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.odgy7hNxZH/Render', 14:27:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:02 INFO - 'HOME': '/Users/cltbld', 14:27:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:02 INFO - 'LOGNAME': 'cltbld', 14:27:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:02 INFO - 'MOZ_NO_REMOTE': '1', 14:27:02 INFO - 'NO_EM_RESTART': '1', 14:27:02 INFO - 'PAGER': '/bin/cat', 14:27:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:02 INFO - 'PWD': '/builds/slave/test', 14:27:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:02 INFO - 'SHELL': '/bin/bash', 14:27:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7uUWNioBpS/Listeners', 14:27:02 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 14:27:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:02 INFO - 'USER': 'cltbld', 14:27:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:02 INFO - 'XPC_FLAGS': '0x0', 14:27:02 INFO - 'XPC_SERVICE_NAME': '0', 14:27:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 14:27:02 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 14:27:02 INFO - Cleaning up... 14:27:02 INFO - Return code: 0 14:27:02 INFO - Running post-action listener: _resource_record_post_action 14:27:02 INFO - Running post-action listener: _start_resource_monitoring 14:27:02 INFO - Starting resource monitoring. 14:27:02 INFO - [mozharness: 2017-04-05 21:27:02.661321Z] Finished create-virtualenv step (success) 14:27:02 INFO - [mozharness: 2017-04-05 21:27:02.662281Z] Running install step. 14:27:02 INFO - Running pre-action listener: _resource_record_pre_action 14:27:02 INFO - Running main action method: install 14:27:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 14:27:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 14:27:02 INFO - Reading from file tmpfile_stdout 14:27:02 INFO - Detecting whether we're running mozinstall >=1.0... 14:27:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 14:27:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 14:27:03 INFO - Reading from file tmpfile_stdout 14:27:03 INFO - Output received: 14:27:03 INFO - Usage: mozinstall [options] installer 14:27:03 INFO - Options: 14:27:03 INFO - -h, --help show this help message and exit 14:27:03 INFO - -d DEST, --destination=DEST 14:27:03 INFO - Directory to install application into. [default: 14:27:03 INFO - "/builds/slave/test"] 14:27:03 INFO - --app=APP Application being installed. [default: firefox] 14:27:03 INFO - mkdir: /builds/slave/test/build/application 14:27:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 14:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 14:27:22 INFO - Reading from file tmpfile_stdout 14:27:22 INFO - Output received: 14:27:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 14:27:22 INFO - Running post-action listener: _resource_record_post_action 14:27:22 INFO - [mozharness: 2017-04-05 21:27:22.694644Z] Finished install step (success) 14:27:22 INFO - [mozharness: 2017-04-05 21:27:22.694782Z] Running run-tests step. 14:27:22 INFO - Running pre-action listener: _resource_record_pre_action 14:27:22 INFO - Running main action method: run_tests 14:27:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:27:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:27:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:27:22 INFO - 2017-04-05 14:27:22.709 screenresolution[1631:7391] starting screenresolution argv=screenresolution get 14:27:22 INFO - 2017-04-05 14:27:22.712 screenresolution[1631:7391] Display 0: 1600x1200x32@60 14:27:22 INFO - 2017-04-05 14:27:22.718 screenresolution[1632:7394] starting screenresolution argv=screenresolution list 14:27:22 INFO - Available Modes on Display 0 14:27:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:27:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:27:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:27:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:27:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:27:22 INFO - Intel Iris: 14:27:22 INFO - Chipset Model: Intel Iris 14:27:22 INFO - Type: GPU 14:27:22 INFO - Bus: Built-In 14:27:22 INFO - VRAM (Dynamic, Max): 1536 MB 14:27:22 INFO - Vendor: Intel (0x8086) 14:27:22 INFO - Device ID: 0x0a2e 14:27:22 INFO - Revision ID: 0x0009 14:27:22 INFO - Displays: 14:27:22 INFO - Display: 14:27:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:27:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:27:22 INFO - Display Serial Number: 1600x1200 60 14:27:22 INFO - Main Display: Yes 14:27:22 INFO - Mirror: Off 14:27:22 INFO - Online: Yes 14:27:22 INFO - Rotation: Supported 14:27:22 INFO - Return code: 0 14:27:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 14:27:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 14:27:22 INFO - Python 2.7.3 14:27:22 INFO - Return code: 0 14:27:22 INFO - grabbing minidump binary from tooltool 14:27:22 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')]} 14:27:22 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 0x10f051d30>, '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 0x10ef78db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f046be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 14:27:22 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 14:27:22 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 14:27:22 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 14:27:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 14:27:23 INFO - Return code: 0 14:27:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 14:27:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 14:27:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 14:27:23 INFO - ENV: RUST_BACKTRACE is now 1 14:27:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 14:27:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 14:27:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XfHkKcCZQqijvkwhlFv4Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0277', '--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 14:27:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/XfHkKcCZQqijvkwhlFv4Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0277 --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 14:27:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.odgy7hNxZH/Render', 14:27:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 14:27:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 14:27:23 INFO - 'HOME': '/Users/cltbld', 14:27:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 14:27:23 INFO - 'LOGNAME': 'cltbld', 14:27:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 14:27:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 14:27:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 14:27:23 INFO - 'MOZ_NO_REMOTE': '1', 14:27:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 14:27:23 INFO - 'NO_EM_RESTART': '1', 14:27:23 INFO - 'PAGER': '/bin/cat', 14:27:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 14:27:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 14:27:23 INFO - 'PWD': '/builds/slave/test', 14:27:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 14:27:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 14:27:23 INFO - 'RUST_BACKTRACE': '1', 14:27:23 INFO - 'SHELL': '/bin/bash', 14:27:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.7uUWNioBpS/Listeners', 14:27:23 INFO - 'TMPDIR': '/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/', 14:27:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 14:27:23 INFO - 'USER': 'cltbld', 14:27:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 14:27:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 14:27:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 14:27:23 INFO - 'XPC_FLAGS': '0x0', 14:27:23 INFO - 'XPC_SERVICE_NAME': '0', 14:27:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 14:27:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/XfHkKcCZQqijvkwhlFv4Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0277', '--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 14:27:23 INFO - mozversion application_buildid: 20170405125420 14:27:23 INFO - mozversion application_changeset: 730db8b60c1e4443af45f94b6411b81c889e0759 14:27:23 INFO - mozversion application_display_name: Nightly 14:27:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 14:27:23 INFO - mozversion application_name: Firefox 14:27:23 INFO - mozversion application_remotingname: firefox 14:27:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 14:27:23 INFO - mozversion application_vendor: Mozilla 14:27:23 INFO - mozversion application_version: 55.0a1 14:27:23 INFO - mozversion platform_buildid: 20170405125420 14:27:23 INFO - mozversion platform_changeset: 730db8b60c1e4443af45f94b6411b81c889e0759 14:27:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 14:27:23 INFO - mozversion platform_version: 55.0a1 14:27:23 INFO - using testdate: 1491427643 14:27:23 INFO - actual date: 1491427643 14:27:23 INFO - starting webserver on 'localhost:49240' 14:27:23 INFO - SUITE-START | Running 2 tests 14:27:23 INFO - TEST-START | dromaeo_css 14:27:23 INFO - operating with platform_type : mac_ 14:27:23 INFO - Initialising browser for dromaeo_css test... 14:27:23 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpcXJhSG/profile http://localhost:49240/getInfo.html) 14:27:26 INFO - PID 1642 | 2017-04-05 14:27:26.599 plugin-container[1644:7577] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e43, name = 'com.apple.tsm.portname' 14:27:26 INFO - PID 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:27:26 INFO - PID 1642 | 2017-04-05 14:27:26.602 plugin-container[1644:7577] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x911b, name = 'com.apple.CFPasteboardClient' 14:27:26 INFO - PID 1642 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:27:26 INFO - PID 1642 | 2017-04-05 14:27:26.602 plugin-container[1644:7577] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:27:26 INFO - PID 1642 | __metrics Screen width/height:1600/1200 14:27:26 INFO - PID 1642 | colorDepth:24 14:27:26 INFO - PID 1642 | Browser inner width/height: 1024/689 14:27:26 INFO - PID 1642 | __metrics 14:27:26 ERROR - PID 1642 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 14:27:27 INFO - TEST-INFO | 1642: exit 0 14:27:27 INFO - Browser initialized. 14:27:27 INFO - Running cycle 1/1 for dromaeo_css test... 14:27:27 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpcXJhSG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:27:30 INFO - PID 1645 | 2017-04-05 14:27:30.472 plugin-container[1646:7714] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x883f, name = 'com.apple.tsm.portname' 14:27:30 INFO - PID 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:27:30 INFO - PID 1645 | 2017-04-05 14:27:30.473 plugin-container[1646:7714] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8e0b, name = 'com.apple.CFPasteboardClient' 14:27:30 INFO - PID 1645 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:27:30 INFO - PID 1645 | 2017-04-05 14:27:30.473 plugin-container[1646:7714] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:27:40 INFO - PID 1645 | RSS: Main: 234889216 14:27:40 INFO - PID 1645 | 14:30:45 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 14:30:46 INFO - PID 1645 | RSS: Main: 251252736 14:30:46 INFO - PID 1645 | 14:32:28 INFO - PID 1645 | ************************* 14:32:28 INFO - PID 1645 | A coding exception was thrown and uncaught in a Task. 14:32:28 INFO - PID 1645 | 14:32:28 ERROR - PID 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:32:28 INFO - PID 1645 | Full stack: 14:32:28 INFO - PID 1645 | ************************* 14:32:28 INFO - PID 1645 | ************************* 14:32:28 INFO - PID 1645 | A coding exception was thrown and uncaught in a Task. 14:32:28 INFO - PID 1645 | 14:32:28 ERROR - PID 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:32:28 INFO - PID 1645 | Full stack: 14:32:28 INFO - PID 1645 | ************************* 14:32:28 INFO - PID 1645 | ************************* 14:32:28 INFO - PID 1645 | A coding exception was thrown and uncaught in a Task. 14:32:28 INFO - PID 1645 | 14:32:28 ERROR - PID 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:32:28 INFO - PID 1645 | Full stack: 14:32:28 INFO - PID 1645 | ************************* 14:32:28 INFO - PID 1645 | ************************* 14:32:28 INFO - PID 1645 | A coding exception was thrown and uncaught in a Task. 14:32:28 INFO - PID 1645 | 14:32:28 ERROR - PID 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:32:28 INFO - PID 1645 | Full stack: 14:32:28 INFO - PID 1645 | ************************* 14:33:48 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 14:33:49 INFO - PID 1645 | RSS: Main: 259248128 14:33:49 INFO - PID 1645 | 14:36:50 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 14:36:51 INFO - PID 1645 | RSS: Main: 272281600 14:36:51 INFO - PID 1645 | 14:39:53 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 14:39:53 INFO - PID 1645 | RSS: Main: 264560640 14:39:53 INFO - PID 1645 | 14:42:56 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 14:42:57 INFO - PID 1645 | RSS: Main: 274862080 14:42:57 INFO - PID 1645 | 14:45:59 INFO - PID 1645 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 14:46:00 INFO - PID 1645 | RSS: Main: 268722176 14:46:00 INFO - PID 1645 | 14:46:00 INFO - PID 1645 | __start_tp_report 14:46:00 INFO - PID 1645 | _x_x_mozilla_page_load 14:46:00 INFO - PID 1645 | _x_x_mozilla_page_load_details 14:46:00 INFO - PID 1645 | |i|pagename|runs| 14:46:00 INFO - PID 1645 | |0;dojo.html;3621.112827357297;3649.9452508212366;3673.5591728992517;3684.594694583597;3688.299223147602;6216.471599914002;6309.810705678831;6336.683165841712;6413.230412350513;6423.486121110312;6312.210973628296;6371.0443433485;6390.3929126733;6392.520560957923;6395;5027;5381.5425688816495;5499.642523235977;5566.55467562595;5773.884522309572;5635.943640563582;5645.802396916109;5689.573282003846;5706.828795136153;5724.370319264877;5456.645318054314;5534.391216966131;5583.888322233533;5602.943970560324;5617.101263797814;5521.613487055908;5531.806386776484;5537.750801213955;5538.335399752055;5558.305211848519;5344.91982620261;5527.226188333596;5543.25166102575;5550.056490396642;5633.915491267634;6064.151018857364;6226.564140510166;6243.500519958392;6262.248530176363;6266.561340706153;6837.760678376283;6857.245702972669;6858.3141685831515;6866.176058872918;6883.518153729241;6929.930700693029;6931;6953.130858642669;6953.33943275388;6969.756058537927;6257.843553911189;6268.811935641938;6326.557141000178;6342;6401.807945761635;6929.3070692931315;6976.337247961435;7045.295470453017;7048.436125109979;7072.469564782559;6411.711472983634;6504.934950650433;6508.837279068061;6555.770548030891;6741.966290168616;6881.552699074544;6888.862222755517;6905.929580914966;6906.689198986058;6931.722731090801;6478;6541.34586541342;6822.795316140524;6827.385535301847;6836.5214434989075;6666.966665166643;6808.4212841908;6848.3494068063455;6864.141982252218;6880.827979300458;5413.539849112791;5433.592480563973;5435.461389739612;5443.700596467153;5461.0716178249795;4712.340272361872;4727.314539391769;4821.63837712173;4843.24929635907;4847.321375007502;6175.228096487939;6322.33615470369;6384.968075159594;6401.487880969511;6404.23149222087;6854.657267136623;6883.414909732729;6886.552374095668;6891.345322194384;6898.689558969859;5210.739463026909;5381.273528073738;6342.587731797418;6387.968060159669;6415.743370265231;5920.881582368328;5964.254468191476;5968.582199246098;6035.486983606443;6123.693815309217;7209.531380460253;7226.458015648742;7231;7233.63831808418;7246.311600397954;6802.659867006729;6899.999500072562;6939;6946.235914049552;6959.234484206632;6854.554453960476;6909.067275917687;7126.572405655677;7163.31948464895;7171.99592057102;6735.966320168368;6802.455803535607;6808.659567021728;6823.454123669995;6827.726890924308;5452.727363631723;6689.933100668931;6819.693113809792;6852.6916288768125;6875.3812156906115;5247.55395791362;6444.806655800334;6485.805425837232;6603.438707709706;6754.324567543403;5632.7183640816975;6469.8706025880165;6706.128203333536;6713.12729345182;6719.395254427125;5520.861978450571;6300.936990630218;6399.488040956805;6458.773942911976;6525.086487891604;6715.227748808754;6738.831529211809;6746.224184218681;6748.898766518408;6754.6622668865375;6507.511936604679;6513;6528.053432252202;6554.311797261219;6562.737490500326 14:46:00 INFO - PID 1645 | |1;ext.html;656.9113169722087;753.600591686406;830.2030051150895;1267.9873201267985;1269.631806776035;39894.60105398945;40661.796691016505;40668.79665601672;40678.79660601693;41054.589454105415;40270.7986460068;40419.787406377785;40820.183596328054;40876.36494540215;40893.795531022304;8067.394945379106;8254.628541715638;8442.451240669368;8659;8663.480191188517;8697.086805885387;8701.825963480727;8789.165029322236;8795.164459376349;8802.911970880305;8761.430507017023;8779.429337093068;8809.163129502687;8811.73564793054;8817.118288171196;8706.869396959051;8765.211130998208;8774.210321071134;8783.604737786814;8792.208701216858;8634.093420190915;8685.305175585938;8696.782580435476;8709.346798990038;8722.38943273971;38955;39206.82379528619;39428.21143577141;39449;39529.80235098806;3512.2799826035603;3523.7709548879243;3558.5195998540125;3562.8574857005688;3565.4295312749837;31049.534256986164;31085.689143108506;31136.844315778275;31181;31322.37355252905;2543.338731929693;3104.1153271317567;3126.8592913318957;3132.7963682360573;3146.685331466858;298270;301332;301696;302267;303788.9999999978;41884.58115418807;48982.89747986522;49672;49881.50118498841;49979.25031124536;41246.79376603158;42877;51990.88054716729;52327.21509177365;52501.21248181281;14551.05418147817;14792;15003.774943375858;15004.249787510798;15042.02226855251;11996.64010079699;12011.33937633421;12020.45907934145;12062.87937120635;12070.396480175956;13887.444502219798;14094.718105638034;14128.646783830487;14144.646383840487;14220.71558568823;6009.549283803733;6031.457168854824;6035.517158627387;6044.879102417927;6045.6070355426755;945.5036106044245;967.4920666650065;976.1214906584131;999.4003597841237;1020.4234607446768;22690.20584279542;23790;24237.272881813573;24276.0289588418;24750.628740568907;1069.3476979042778;1073.259450978822;1113.3153110836777;1116.8938950799661;1122.927009744364;11873;12492.188007779465;12499.875001249871;12527;12586.307753073668;466561;469195;469699;470124;470441;54588;55935.321940341855;56973.715131424906;57313;57362.42637573571;1468.897177197586;1496.9550913472613;1504.368165370547;1508.7661412480863;1510.8564686354778;23928.20738312775;24455.38861528476;29440.705592943796;30084;30436.84781576078;40487;40637.390439142844;40802.387964179965;41090.79454602708;41176;444951;446576;446597;447454;448981;34637.57536972489;35036.824815875756;35239.295214096084;35328.11679708028;35441;43737.56262437335;44165.337519936584;44354.55645443504;45269.868253293935;45371.86570335768;25799.32304400208;28451.87029426803;29012.564811528267;30362.69637303687;30547.847260763552;30406.391872162876;30643.54034689437;30681.079567613007;30699.693003069682;30826.845865771425;35527.46708799319;36492.81753591215;36527.634723653486;36969.6303036977;37465.25069498649;30280.84859575688;30366.93715719939;31119.844400777853;31142;31749.682503175598;23073;23996.160134395213;24311;24419.918223714925;24464.51070978606 14:46:00 INFO - PID 1645 | |2;jquery.html;395.8832144517367;426.39451978190965;438.2265301742425;443.4014080990662;465.9813607455702;21808.563828723436;21815.454613634665;22476;22723.886380568096;22754.54490910181;22551.436214094654;23053.308400748003;23765.881170594123;23942.760572394272;24113.75886241137;4612.423447069116;6177.691115444232;6346.111544383767;6404.42360187583;6413.454856337217;6277.5291853110975;6364.713587888533;6378.330275321094;6396.328385519523;6405.7117429715545;6134.9386506134815;6223.751049957997;6288.025356069817;6290.591111577733;6343.46080583151;6094.8171554853425;6182.659953702545;6267.749290028393;6276.968615156918;6281.466075383598;5521.558275337963;5624.859378515529;5630.521405680522;5637.577181711388;5654.85862853432;27293.863530682218;27764.583531247048;27837.025704100462;27904.581431278548;28030.159095227176;2191.3316438486254;2225.810806081485;2233.966490502644;2234.5084081502046;2237.820974322067;15495.535133946;17484.562885927826;18211.18049687754;18442.07789610514;18468.815311846844;1867.318428773488;1953.4627977306213;2008.7288216090788;2030.979690203094;2116.8306535477127;111803;129907;143990.2800485991;144787.276063619;146544;10626.787464250827;12637.93681031589;12729.55446559366;12926.806097908539;13090.280034597998;16948.576285592713;16949.32202711878;16969.36974768913;16990.70625465571;17022;7197.604131772803;7778.455508114491;8821.206091451671;9158.542072896329;9310.906890931004;8705.869411958825;8715.34634902372;8719.825603488021;8871.866921996176;8914.28685705155;6679.599224046573;8009.517049714607;8138.593070346459;8151.347892168612;8164.510129392255;1874.5126267170633;2047.6518991771434;2072.637288474511;2147.194801949269;2151.4943988162768;954.6897258390911;958.496789185683;966.8114717629994;994.4679596415883;998.9950050249702;20300.695489567668;21406.25078122258;21472.033758480906;21551.67672484914;21595.892020539795;818.3167055508717;1003.19744204636;1030.1449796668746;1038.3925403638955;1040.3445829127602;10405.484349332639;11086.61196858106;11090.611828585961;11095.278806877526;11134.61028864002;699504;721027;723155;726273;731923;151111;153070;154720;155832;158470.41529584557;1203.8194270859267;1208.1301462946665;1234.2964510229262;1234.6851552854143;1240.9689757755948;12995.350232488527;14077.648058798612;16328.836711632732;18199.363022294157;18205.453836384928;60771.99999999823;61238.693806532465;61476.38523614706;61790.1462956112;62353.68823155855;82054.58972705338;83805;84126;84818.45544633671;85716.42805726705;8706.782330441789;8740.038595754335;9128.589213485277;9171.77070573241;9319.369110405516;13726.794098088338;13830.65423364424;14207.786883196553;14247.073940193854;14293.57119286423;9630.711078667651;11054.723631909266;11173.162012848907;11784.410779461165;12083.75832483363;11085.556577736801;11255.380954047607;11426.371549564854;11654.941725291319;11718.648440546796;11705;12065.758684826078;12270.509179632714;12300.507979680713;12460.252384856574;6689.9965005249605;8010.639521221676;8123.390745693979;8858.848349714495;9291.024442433447;11431.942840286078;11913.52345906154;12178.330191839534;12279.386030698608;12288.754224915272 14:46:00 INFO - PID 1645 | |3;mootools.html;1281.3016905786346;1408.162143524603;1465.098964137056;1465.5163795947344;1513.1526345246664;9270.629174833015;11148.442577871105;11436.485358158881;11588.42057897106;12247.448864801083;11844.34856082915;11884.584039558616;11891.345975971319;12030.759384812298;12039.939800300986;2480.5535003699374;2530.101813856082;2530.72162062173;2531.6835395575554;2532.1390727152766;2434.1845481763544;2481.553320402327;2484.142970675114;2487.253823852846;2493.763092506209;2407.2296865003204;2411.3007227903886;2435.3789783605157;2438.2807071913826;2448.5837407640743;2404.7354790972977;2405.5669979403788;2424.309071914505;2449.909790143387;2459.163884279336;2366.219147681261;2405.1341517053847;2423.551642946061;2429.307647320523;2497.612870005152;11630.011449026842;11694.47374868133;11718.003969662588;11747.94126029373;11756.353400562966;5594;6341.556091073627;6639.103720997652;6650.135482387259;6676.031975363594;3967.246223217608;4171.561985991488;4190.51809041961;4290.613844753987;4291.763952982585;1231.5320178332265;1244.104244943639;1252.8536389203869;1269.3399432295248;1286.1254347044007;14419.269687637447;14949.327280272306;16433.58916027097;16526.338946442127;16570.83429165705;5341.225522299244;5488.862778430492;5678.233438485834;5719.799807006735;5741.569382296345;12389.256644601353;12444.315562644142;12506.749865002648;12526.686832829253;12546.247225166519;5781.479666830005;6233.75064997395;6567.408933196035;6592.571482853599;6593.967030164915;5960.314563825129;6116.327204007555;6166.568340216231;6210.068489726577;6237.126802247689;3992.181602771425;4279.636230920407;4422.690411671152;4442.333649952533;4451.3545535897765;1216.993915030437;1280.6862318731785;1287.1118927939692;1299.2009913902882;1301.466398776497;651.7523341130341;761.3680645064583;775.3758224629115;796.4982061301343;800.1998001998002;6017.608855424383;6126.111713801474;6248.687565621701;6285.654289014148;6312.463440607508;554.9167624856303;563.104663584902;891;904.4437670832391;929.149827907457;4545.5908968193025;4546.272596384562;4628.83799067031;4722.716637001791;4787.3776409067295;14115.717685646436;14913.92543037278;15087.698246035237;15169.08985460876;15187.164705941279;14510.854891451161;14632.122072675673;14634.121952682874;14634.560963171121;14637.634059148393;10654.893451065545;10737.087347575387;10907.127429805596;10958.671239862817;10964.890351096386;6588.604683718992;7004.719811207495;7062.752803651848;7125.073740413713;7129.108861392326;13295.933520332337;13586.38861251266;13670.384832682752;13806.516771912935;13836.23900685472;11001.339919604528;11280.492377842853;11943.68619451877;13569.321533923461;13722.245276509888;9438.103380178873;9474.857877131986;9620.13418792284;9621.422714637145;9623.759406014906;10619.415932123808;10685.679429617125;10736.624218152327;10822.296550724177;10854.457277135954;9051.366404351895;9154.633814647339;9227.815443691223;9230.861537076815;9365.391249568756;7294.2341054190665;8783;8934.776630584287;8940.284777217677;9177.632894684404;8164.224398682116;8201.507909525448;8217.753467395987;8296.83406331858;8315.334773218248;5682.346530149086;5835.912461313169;5865.090910908816;6031.698415079316;6062.575619706578;5949.077892926603;6001.309849367204;6098.512119030378;6209.130721698875;6212.751489940351 14:46:00 INFO - PID 1645 | |4;prototype.html;353.4750894921042;366.31316281971306;366.919277758893;374.4888227569369;375.31317688629804;6269;6420.743170273196;6499.902501462476;6578.177727784027;6605.900911486326;5000.874978125548;6206.751729930808;6247.7813276535335;6257.405546473078;6264.968675156618;3688.3729765939856;4476.194285028701;4484.529124441936;4501.7974191161475;4515.887102822423;4419.911601767963;4424.225760491917;4474.753888536129;4498.02087081683;4510.233260345733;4225.7253278536955;4410.801513931865;4429.822807087713;4455.309427038798;4467.5755803198645;3648.28530590622;4365.88254696472;4441.423294730373;4460.799264033094;4501.437320334958;3125.359301343219;3681.742278040538;3816.3512202925567;3827.617238276178;3843.8654647087496;5555.2778138842095;5936.970315148396;6004.849878753066;6054.788082417094;6104.816855494342;4415.271480205763;4628.352030715702;4889.877753056202;5257.973710131425;5341.706206158659;5599.860003499904;5905.2323197984415;6048.276241271261;6129.233845769279;6614.7684831031165;3578.8389522471552;4281.229378711831;4282.079352939133;4287.356896465524;4299.1831552005015;5110.466859942003;6784.1858976922595;6940.577181677794;7002.579845209304;7070.186928503236;3679.5833604062095;4357.0196705740955;4373.169097871394;4384.7114664002;4423.911521769546;3965.405189221582;4243.130158317537;4429.889252768642;4449.777511124431;4482.4172857528965;4460.50934397216;5338.91991620126;5341.450979215984;5350.635587925132;5370.946290537123;5505.752241149078;6688;6708.2956289589865;6713.932860671331;6772.830679233059;1405.6977749783846;1498.5803974887049;1515.272669118829;1518.1574226304508;1518.6127537477873;957.7509847439716;964.5611246882652;972.231936769958;981.4405788700373;983.680303901235;6334.619922804646;6357.809265722036;6368.29948705642;6376.489880809524;6410.262819775692;5625.296837895263;6286.559940804192;6700.865982680319;6940.514164008471;7032.824179395556;6308.558400911984;6322.33615470369;6326.145970294044;6346.650934198571;6362.204724409449;3608.585012723518;3638.69071128957;3648.087978005499;3655.8903232903053;3667.8166091695844;5956;6910.896336554955;7110.288971102848;7216;7226.736225626905;6790.830229244309;7118.9644051779405;7140.678669459887;7164.641767911584;7170.139583250043;5682.289713785777;7002.264762199998;7078.54211732559;7195.604241766753;7280.599567023971;6203.8138855834395;6909.550879192836;6952.965235173791;6976.19773726028;6987.755428559976;6492.318306577741;6548.672566371758;6781.152355955505;6852.006459063308;6869.725210991504;6320.638759256099;6427.260865000585;6768.593884366954;7078.575285482888;7264.89102663471;3616.65641764032;3815.484909537288;4356.825726970886;4370.759608221579;4382.298832186835;6681.198256209286;6926.333361655698;6936.7225310989015;6962.1297337832775;6993.825154371181;6126;6338.746450141943;6526.347365263626;6734.595924244561;6740;6445.291017988111;6502.414782669583;6738.393544581011;6741.59550426976;6773.254941956479;5318.590573497949;5697.259356283656;6142.2629284484365;6500.869982600416;6581.506387021088;6024.006039003515;6670.599764014175;6756.425703815231;6760.222574404006;6803.632202060012;5809.680467574155;6210.4100110489435;6488.480921526172;6501.707423165874;6588.505862060269 14:46:00 INFO - PID 1645 | |5;yui.html;688.849621132708;819.6311659753112;822.0956947357907;847.8897743293371;854.8162145138793;15675.764863527042;16015.599610009742;16108;16947;17037.63698904088;15047;15360.61598460039;15484.99347542409;15646.452374166907;15708.84291157091;885.3802338363139;1019.2050200843317;1023.2274632652375;1024.1806554756201;1024.2983556263946;974.6880998080617;1011.1354791653141;1012.5291739341205;1017.8066167428202;1023.5803320638539;1054.0460882900986;1082.3668154129805;1082.5074591061089;1083.138904570864;1085.3704851186294;1043.363548235572;1074.8119079161115;1074.9462526873704;1075.1613741281813;1077.20286987629;779.4777499075633;785.8231897823001;806.5725165662209;807.8465091632571;808.0263282744279;16327.510174694778;16426.75359869603;16525.83474165255;16849.494515164566;16872.578185545335;14320.283985800668;14451.277436128257;14508.782368264485;14621.561353159315;14624.707505849823;13385.732285354336;13459.528916487876;13524.459021639123;13625.727485450236;13712.108712933627;3358.7648864579487;3360.2103505676146;3390.762646614738;3399.5070714746225;3399.8810041648426;116138.19309034514;116507.41746291298;120034;120152.79847201504;121186;11457.656270311903;11508.712282192844;11641.126915481373;11676.47455864488;11987.743777072452;21724.45688857791;25455.61816572753;25583.360415989748;25913.35216619562;25987.61018584723;7553.282438168365;7617.542947423172;7758.379329653614;7778.027746531684;7914.208579142155;4133.359329303963;4200.579942005775;4219;4233.470816147981;4248.235317642792;3356.47974563943;3667.7799332040163;4092.2838503262406;4198.979005105016;4282.693778397618;775.8370742144212;834.98330033399;906.1934877958622;910.235402262103;910.6858133943779;632.509804901196;635.4439865118022;649.8018104478085;660.1615947746432;672.468749687751;9706.805863882824;9965.950170249102;10209.097215340344;10389.480525973671;10506.474676266156;598.3717097048169;600.3126420248877;649.9025146228009;662.5031226580065;666.3403230801472;4566.49768525462;4821.710697358169;4828.686135401188;4872.599447897782;4877.097736918681;88455;88884.11115888887;94402.0559794407;96475.51762241144;98842.5057874706;88814;88857;89087.55456222677;90676.09323906676;91324;58686;76528.61735691174;81749.36501269942;82203;82237;9409.388389754644;10546.20903432261;10766.600341955496;10972;11165.776684466427;35450.82274588611;36506;38036.42945355877;39071.609283907936;39248.80375598218;35723;49842.50157498524;50082.74958625183;50408.747956259984;50758.984820304126;13389.799153012907;13440.46238150463;13637.24995125238;13798.93100534491;14116.788248176492;14179.574612761633;14297.556980483792;14301.713965720419;14332.211728355041;14689.04521206161;13086.411111500196;13240.271785051915;13430.865691342962;13818.930905345409;13994.440222391398;13633;13732.176069435865;13791.586252412444;14253.786193206903;14564.635884102981;13667.31663416845;13668;13702.588922331946;13825.032247742562;13974.301284935917;10030.348027378197;10062.39625622465;10254;10439.348159888928;10448.622876083684;9618.711438656852;10595.417252050904;10621.831598524002;11381.772364552828;11650.825237621273 14:46:00 INFO - PID 1645 | __end_tp_report 14:46:00 INFO - PID 1645 | __start_cc_report 14:46:00 INFO - PID 1645 | _x_x_mozilla_cycle_collect,427 14:46:00 INFO - PID 1645 | __end_cc_report 14:46:00 INFO - PID 1645 | __startTimestamp1491428760136__endTimestamp 14:46:00 INFO - PID 1645 | 14:46:00 INFO - PID 1645 | ------- Summary: start ------- 14:46:00 INFO - PID 1645 | Number of tests: 6 14:46:00 INFO - PID 1645 | 14:46:00 INFO - PID 1645 | [#0] dojo.html Cycles:165 Average:6261.51 Median:6444.81 stddev:764.43 (11.9%) stddev-sans-first:738.18 14:46:00 INFO - PID 1645 | Values: 3621.1 3649.9 3673.6 3684.6 3688.3 6216.5 6309.8 6336.7 6413.2 6423.5 6312.2 6371.0 6390.4 6392.5 6395.0 5027.0 5381.5 5499.6 5566.6 5773.9 5635.9 5645.8 5689.6 5706.8 5724.4 5456.6 5534.4 5583.9 5602.9 5617.1 5521.6 5531.8 5537.8 5538.3 5558.3 5344.9 5527.2 5543.3 5550.1 5633.9 6064.2 6226.6 6243.5 6262.2 6266.6 6837.8 6857.2 6858.3 6866.2 6883.5 6929.9 6931.0 6953.1 6953.3 6969.8 6257.8 6268.8 6326.6 6342.0 6401.8 6929.3 6976.3 7045.3 7048.4 7072.5 6411.7 6504.9 6508.8 6555.8 6742.0 6881.6 6888.9 6905.9 6906.7 6931.7 6478.0 6541.3 6822.8 6827.4 6836.5 6667.0 6808.4 6848.3 6864.1 6880.8 5413.5 5433.6 5435.5 5443.7 5461.1 4712.3 4727.3 4821.6 4843.2 4847.3 6175.2 6322.3 6385.0 6401.5 6404.2 6854.7 6883.4 6886.6 6891.3 6898.7 5210.7 5381.3 6342.6 6388.0 6415.7 5920.9 5964.3 5968.6 6035.5 6123.7 7209.5 7226.5 7231.0 7233.6 7246.3 6802.7 6900.0 6939.0 6946.2 6959.2 6854.6 6909.1 7126.6 7163.3 7172.0 6736.0 6802.5 6808.7 6823.5 6827.7 5452.7 6689.9 6819.7 6852.7 6875.4 5247.6 6444.8 6485.8 6603.4 6754.3 5632.7 6469.9 6706.1 6713.1 6719.4 5520.9 6300.9 6399.5 6458.8 6525.1 6715.2 6738.8 6746.2 6748.9 6754.7 6507.5 6513.0 6528.1 6554.3 6562.7 14:46:00 INFO - PID 1645 | 14:46:00 INFO - PID 1645 | [#1] ext.html Cycles:180 Average:54422.13 Median:36748.63 stddev:109578.85 (298.2%) stddev-sans-first:109811.89 14:46:00 INFO - PID 1645 | Values: 656.9 753.6 830.2 1268.0 1269.6 39894.6 40661.8 40668.8 40678.8 41054.6 40270.8 40419.8 40820.2 40876.4 40893.8 8067.4 8254.6 8442.5 8659.0 8663.5 8697.1 8701.8 8789.2 8795.2 8802.9 8761.4 8779.4 8809.2 8811.7 8817.1 8706.9 8765.2 8774.2 8783.6 8792.2 8634.1 8685.3 8696.8 8709.3 8722.4 38955.0 39206.8 39428.2 39449.0 39529.8 3512.3 3523.8 3558.5 3562.9 3565.4 31049.5 31085.7 31136.8 31181.0 31322.4 2543.3 3104.1 3126.9 3132.8 3146.7 298270.0 301332.0 301696.0 302267.0 303789.0 41884.6 48982.9 49672.0 49881.5 49979.3 41246.8 42877.0 51990.9 52327.2 52501.2 14551.1 14792.0 15003.8 15004.2 15042.0 11996.6 12011.3 12020.5 12062.9 12070.4 13887.4 14094.7 14128.6 14144.6 14220.7 6009.5 6031.5 6035.5 6044.9 6045.6 945.5 967.5 976.1 999.4 1020.4 22690.2 23790.0 24237.3 24276.0 24750.6 1069.3 1073.3 1113.3 1116.9 1122.9 11873.0 12492.2 12499.9 12527.0 12586.3 466561.0 469195.0 469699.0 470124.0 470441.0 54588.0 55935.3 56973.7 57313.0 57362.4 1468.9 1497.0 1504.4 1508.8 1510.9 23928.2 24455.4 29440.7 30084.0 30436.8 40487.0 40637.4 40802.4 41090.8 41176.0 444951.0 446576.0 446597.0 447454.0 448981.0 34637.6 35036.8 35239.3 35328.1 35441.0 43737.6 44165.3 44354.6 45269.9 45371.9 25799.3 28451.9 29012.6 30362.7 30547.8 30406.4 30643.5 30681.1 30699.7 30826.8 35527.5 36492.8 36527.6 36969.6 37465.3 30280.8 30366.9 31119.8 31142.0 31749.7 23073.0 23996.2 24311.0 24419.9 24464.5 14:46:00 INFO - PID 1645 | 14:46:00 INFO - PID 1645 | [#2] jquery.html Cycles:180 Average:40784.50 Median:22513.72 stddev:120194.20 (533.9%) stddev-sans-first:120493.12 14:46:00 INFO - PID 1645 | Values: 395.9 426.4 438.2 443.4 466.0 21808.6 21815.5 22476.0 22723.9 22754.5 22551.4 23053.3 23765.9 23942.8 24113.8 4612.4 6177.7 6346.1 6404.4 6413.5 6277.5 6364.7 6378.3 6396.3 6405.7 6134.9 6223.8 6288.0 6290.6 6343.5 6094.8 6182.7 6267.7 6277.0 6281.5 5521.6 5624.9 5630.5 5637.6 5654.9 27293.9 27764.6 27837.0 27904.6 28030.2 2191.3 2225.8 2234.0 2234.5 2237.8 15495.5 17484.6 18211.2 18442.1 18468.8 1867.3 1953.5 2008.7 2031.0 2116.8 111803.0 129907.0 143990.3 144787.3 146544.0 10626.8 12637.9 12729.6 12926.8 13090.3 16948.6 16949.3 16969.4 16990.7 17022.0 7197.6 7778.5 8821.2 9158.5 9310.9 8705.9 8715.3 8719.8 8871.9 8914.3 6679.6 8009.5 8138.6 8151.3 8164.5 1874.5 2047.7 2072.6 2147.2 2151.5 954.7 958.5 966.8 994.5 999.0 20300.7 21406.3 21472.0 21551.7 21595.9 818.3 1003.2 1030.1 1038.4 1040.3 10405.5 11086.6 11090.6 11095.3 11134.6 699504.0 721027.0 723155.0 726273.0 731923.0 151111.0 153070.0 154720.0 155832.0 158470.4 1203.8 1208.1 1234.3 1234.7 1241.0 12995.4 14077.6 16328.8 18199.4 18205.5 60772.0 61238.7 61476.4 61790.1 62353.7 82054.6 83805.0 84126.0 84818.5 85716.4 8706.8 8740.0 9128.6 9171.8 9319.4 13726.8 13830.7 14207.8 14247.1 14293.6 9630.7 11054.7 11173.2 11784.4 12083.8 11085.6 11255.4 11426.4 11654.9 11718.6 11705.0 12065.8 12270.5 12300.5 12460.3 6690.0 8010.6 8123.4 8858.8 9291.0 11431.9 11913.5 12178.3 12279.4 12288.8 14:46:00 INFO - PID 1645 | 14:46:00 INFO - PID 1645 | [#3] mootools.html Cycles:180 Average:7118.25 Median:2530.41 stddev:4472.82 (176.8%) stddev-sans-first:4463.86 14:46:00 INFO - PID 1645 | Values: 1281.3 1408.2 1465.1 1465.5 1513.2 9270.6 11148.4 11436.5 11588.4 12247.4 11844.3 11884.6 11891.3 12030.8 12039.9 2480.6 2530.1 2530.7 2531.7 2532.1 2434.2 2481.6 2484.1 2487.3 2493.8 2407.2 2411.3 2435.4 2438.3 2448.6 2404.7 2405.6 2424.3 2449.9 2459.2 2366.2 2405.1 2423.6 2429.3 2497.6 11630.0 11694.5 11718.0 11747.9 11756.4 5594.0 6341.6 6639.1 6650.1 6676.0 3967.2 4171.6 4190.5 4290.6 4291.8 1231.5 1244.1 1252.9 1269.3 1286.1 14419.3 14949.3 16433.6 16526.3 16570.8 5341.2 5488.9 5678.2 5719.8 5741.6 12389.3 12444.3 12506.7 12526.7 12546.2 5781.5 6233.8 6567.4 6592.6 6594.0 5960.3 6116.3 6166.6 6210.1 6237.1 3992.2 4279.6 4422.7 4442.3 4451.4 1217.0 1280.7 1287.1 1299.2 1301.5 651.8 761.4 775.4 796.5 800.2 6017.6 6126.1 6248.7 6285.7 6312.5 554.9 563.1 891.0 904.4 929.1 4545.6 4546.3 4628.8 4722.7 4787.4 14115.7 14913.9 15087.7 15169.1 15187.2 14510.9 14632.1 14634.1 14634.6 14637.6 10654.9 10737.1 10907.1 10958.7 10964.9 6588.6 7004.7 7062.8 7125.1 7129.1 13295.9 13586.4 13670.4 13806.5 13836.2 11001.3 11280.5 11943.7 13569.3 13722.2 9438.1 9474.9 9620.1 9621.4 9623.8 10619.4 10685.7 10736.6 10822.3 10854.5 9051.4 9154.6 9227.8 9230.9 9365.4 7294.2 8783.0 8934.8 8940.3 9177.6 8164.2 8201.5 8217.8 8296.8 8315.3 5682.3 5835.9 5865.1 6031.7 6062.6 5949.1 6001.3 6098.5 6209.1 6212.8 14:46:00 INFO - PID 1645 | 14:46:00 INFO - PID 1645 | [#4] prototype.html Cycles:180 Average:5315.13 Median:6173.04 stddev:1738.92 (28.2%) stddev-sans-first:1703.45 14:46:00 INFO - PID 1645 | Values: 353.5 366.3 366.9 374.5 375.3 6269.0 6420.7 6499.9 6578.2 6605.9 5000.9 6206.8 6247.8 6257.4 6265.0 3688.4 4476.2 4484.5 4501.8 4515.9 4419.9 4424.2 4474.8 4498.0 4510.2 4225.7 4410.8 4429.8 4455.3 4467.6 3648.3 4365.9 4441.4 4460.8 4501.4 3125.4 3681.7 3816.4 3827.6 3843.9 5555.3 5937.0 6004.8 6054.8 6104.8 4415.3 4628.4 4889.9 5258.0 5341.7 5599.9 5905.2 6048.3 6129.2 6614.8 3578.8 4281.2 4282.1 4287.4 4299.2 5110.5 6784.2 6940.6 7002.6 7070.2 3679.6 4357.0 4373.2 4384.7 4423.9 3965.4 4243.1 4429.9 4449.8 4482.4 4460.5 5338.9 5341.5 5350.6 5370.9 5505.8 6688.0 6708.3 6713.9 6772.8 1405.7 1498.6 1515.3 1518.2 1518.6 957.8 964.6 972.2 981.4 983.7 6334.6 6357.8 6368.3 6376.5 6410.3 5625.3 6286.6 6700.9 6940.5 7032.8 6308.6 6322.3 6326.1 6346.7 6362.2 3608.6 3638.7 3648.1 3655.9 3667.8 5956.0 6910.9 7110.3 7216.0 7226.7 6790.8 7119.0 7140.7 7164.6 7170.1 5682.3 7002.3 7078.5 7195.6 7280.6 6203.8 6909.6 6953.0 6976.2 6987.8 6492.3 6548.7 6781.2 6852.0 6869.7 6320.6 6427.3 6768.6 7078.6 7264.9 3616.7 3815.5 4356.8 4370.8 4382.3 6681.2 6926.3 6936.7 6962.1 6993.8 6126.0 6338.7 6526.3 6734.6 6740.0 6445.3 6502.4 6738.4 6741.6 6773.3 5318.6 5697.3 6142.3 6500.9 6581.5 6024.0 6670.6 6756.4 6760.2 6803.6 5809.7 6210.4 6488.5 6501.7 6588.5 14:46:00 INFO - PID 1645 | 14:46:00 INFO - PID 1645 | [#5] yui.html Cycles:180 Average:19980.82 Median:16861.04 stddev:28760.88 (170.6%) stddev-sans-first:28805.08 14:46:00 INFO - PID 1645 | Values: 688.8 819.6 822.1 847.9 854.8 15675.8 16015.6 16108.0 16947.0 17037.6 15047.0 15360.6 15485.0 15646.5 15708.8 885.4 1019.2 1023.2 1024.2 1024.3 974.7 1011.1 1012.5 1017.8 1023.6 1054.0 1082.4 1082.5 1083.1 1085.4 1043.4 1074.8 1074.9 1075.2 1077.2 779.5 785.8 806.6 807.8 808.0 16327.5 16426.8 16525.8 16849.5 16872.6 14320.3 14451.3 14508.8 14621.6 14624.7 13385.7 13459.5 13524.5 13625.7 13712.1 3358.8 3360.2 3390.8 3399.5 3399.9 116138.2 116507.4 120034.0 120152.8 121186.0 11457.7 11508.7 11641.1 11676.5 11987.7 21724.5 25455.6 25583.4 25913.4 25987.6 7553.3 7617.5 7758.4 7778.0 7914.2 4133.4 4200.6 4219.0 4233.5 4248.2 3356.5 3667.8 4092.3 4199.0 4282.7 775.8 835.0 906.2 910.2 910.7 632.5 635.4 649.8 660.2 672.5 9706.8 9966.0 10209.1 10389.5 10506.5 598.4 600.3 649.9 662.5 666.3 4566.5 4821.7 4828.7 4872.6 4877.1 88455.0 88884.1 94402.1 96475.5 98842.5 88814.0 88857.0 89087.6 90676.1 91324.0 58686.0 76528.6 81749.4 82203.0 82237.0 9409.4 10546.2 10766.6 10972.0 11165.8 35450.8 36506.0 38036.4 39071.6 39248.8 35723.0 49842.5 50082.7 50408.7 50759.0 13389.8 13440.5 13637.2 13798.9 14116.8 14179.6 14297.6 14301.7 14332.2 14689.0 13086.4 13240.3 13430.9 13818.9 13994.4 13633.0 13732.2 13791.6 14253.8 14564.6 13667.3 13668.0 13702.6 13825.0 13974.3 10030.3 10062.4 10254.0 10439.3 10448.6 9618.7 10595.4 10621.8 11381.8 11650.8 14:46:00 INFO - PID 1645 | -------- Summary: end -------- 14:46:00 INFO - PID 1645 | 14:46:00 INFO - TEST-INFO | 1645: exit 0 14:46:00 INFO - TEST-OK | dromaeo_css | took 1117497ms 14:46:00 INFO - TEST-START | kraken 14:46:00 INFO - operating with platform_type : mac_ 14:46:00 INFO - Initialising browser for kraken test... 14:46:00 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpwl1ASd/profile http://localhost:49240/getInfo.html) 14:46:03 INFO - PID 1659 | 2017-04-05 14:46:03.357 plugin-container[1660:10111] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x444b, name = 'com.apple.tsm.portname' 14:46:03 INFO - PID 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:46:03 INFO - PID 1659 | 2017-04-05 14:46:03.360 plugin-container[1660:10111] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x8f0b, name = 'com.apple.CFPasteboardClient' 14:46:03 INFO - PID 1659 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:46:03 INFO - PID 1659 | 2017-04-05 14:46:03.360 plugin-container[1660:10111] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:46:03 INFO - PID 1659 | __metrics Screen width/height:1600/1200 14:46:03 INFO - PID 1659 | colorDepth:24 14:46:03 INFO - PID 1659 | Browser inner width/height: 1024/689 14:46:03 INFO - PID 1659 | __metrics 14:46:03 ERROR - PID 1659 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3364: TypeError: this.tabs is undefined 14:46:04 INFO - TEST-INFO | 1659: exit 0 14:46:04 INFO - Browser initialized. 14:46:04 INFO - Running cycle 1/1 for kraken test... 14:46:04 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/T/tmpwl1ASd/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:46:07 INFO - PID 1661 | 2017-04-05 14:46:07.324 plugin-container[1662:10231] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4747, name = 'com.apple.tsm.portname' 14:46:07 INFO - PID 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:46:07 INFO - PID 1661 | 2017-04-05 14:46:07.324 plugin-container[1662:10231] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x893f, name = 'com.apple.CFPasteboardClient' 14:46:07 INFO - PID 1661 | See /usr/include/servers/bootstrap_defs.h for the error codes. 14:46:07 INFO - PID 1661 | 2017-04-05 14:46:07.324 plugin-container[1662:10231] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 14:46:17 INFO - PID 1661 | RSS: Main: 249253888 14:46:17 INFO - PID 1661 | 14:46:19 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 14:46:20 INFO - PID 1661 | RSS: Main: 258998272 14:46:20 INFO - PID 1661 | 14:46:23 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 14:46:24 INFO - PID 1661 | RSS: Main: 266252288 14:46:24 INFO - PID 1661 | 14:46:27 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 14:46:28 INFO - PID 1661 | RSS: Main: 262057984 14:46:28 INFO - PID 1661 | 14:46:30 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 14:46:31 INFO - PID 1661 | RSS: Main: 264187904 14:46:31 INFO - PID 1661 | 14:46:33 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:46:33 INFO - PID 1661 | RSS: Main: 264843264 14:46:33 INFO - PID 1661 | 14:46:36 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 14:46:37 INFO - PID 1661 | RSS: Main: 270204928 14:46:37 INFO - PID 1661 | 14:46:40 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 14:46:41 INFO - PID 1661 | RSS: Main: 270520320 14:46:41 INFO - PID 1661 | 14:46:44 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 14:46:45 INFO - PID 1661 | RSS: Main: 270364672 14:46:45 INFO - PID 1661 | 14:46:46 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:46:47 INFO - PID 1661 | RSS: Main: 270659584 14:46:47 INFO - PID 1661 | 14:46:49 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:46:50 INFO - PID 1661 | RSS: Main: 270131200 14:46:50 INFO - PID 1661 | 14:46:52 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:46:53 INFO - PID 1661 | RSS: Main: 270143488 14:46:53 INFO - PID 1661 | 14:46:56 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:46:57 INFO - PID 1661 | RSS: Main: 270983168 14:46:57 INFO - PID 1661 | 14:47:00 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:47:01 INFO - PID 1661 | RSS: Main: 268984320 14:47:01 INFO - PID 1661 | 14:47:03 INFO - PID 1661 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 14:47:03 INFO - PID 1661 | RSS: Main: 271720448 14:47:03 INFO - PID 1661 | 14:47:03 INFO - PID 1661 | __start_tp_report 14:47:03 INFO - PID 1661 | _x_x_mozilla_page_load 14:47:03 INFO - PID 1661 | _x_x_mozilla_page_load_details 14:47:03 INFO - PID 1661 | |i|pagename|runs| 14:47:03 INFO - PID 1661 | |0;ai-astar;146;182;142;124;120;122;124;123;120;121 14:47:03 INFO - PID 1661 | |1;audio-beat-detection;146;114;116;154;119;162;157;150;139;117 14:47:03 INFO - PID 1661 | |2;audio-dft;210;224;226;219;225;271;272;215;207;208 14:47:03 INFO - PID 1661 | |3;audio-fft;86;56;56;91;56;65;84;51;103;51 14:47:03 INFO - PID 1661 | |4;audio-oscillator;91;71;86;75;68;111;101;109;108;87 14:47:03 INFO - PID 1661 | |5;imaging-gaussian-blur;117;91;91;92;93;92;94;91;93;94 14:47:03 INFO - PID 1661 | |6;imaging-darkroom;100;100;112;166;98;116;164;140;102;100 14:47:03 INFO - PID 1661 | |7;imaging-desaturate;102;101;104;105;102;120;101;100;103;103 14:47:03 INFO - PID 1661 | |8;json-parse-financial;51;53;50;63;84;81;44;46;72;51 14:47:03 INFO - PID 1661 | |9;json-stringify-tinderbox;60;65;54;80;98;55;51;52;59;89 14:47:03 INFO - PID 1661 | |10;stanford-crypto-aes;86;87;87;94;88;122;120;118;90;93 14:47:03 INFO - PID 1661 | |11;stanford-crypto-ccm;150;155;149;182;172;182;190;143;185;147 14:47:03 INFO - PID 1661 | |12;stanford-crypto-pbkdf2;188;185;252;252;208;217;253;207;195;247 14:47:03 INFO - PID 1661 | |13;stanford-crypto-sha256-iterative;71;71;72;100;106;98;72;73;70;72 14:47:03 INFO - PID 1661 | __end_tp_report 14:47:03 INFO - PID 1661 | __start_cc_report 14:47:03 INFO - PID 1661 | _x_x_mozilla_cycle_collect,1037 14:47:03 INFO - PID 1661 | __end_cc_report 14:47:03 INFO - PID 1661 | __startTimestamp1491428823320__endTimestamp 14:47:03 INFO - PID 1661 | 14:47:03 INFO - PID 1661 | ------- Summary: start ------- 14:47:03 INFO - PID 1661 | Number of tests: 14 14:47:03 INFO - PID 1661 | 14:47:03 INFO - PID 1661 | [#0] ai-astar Cycles:10 Average:132.40 Median:124.00 stddev:19.76 (15.9%) stddev-sans-first:20.33 14:47:03 INFO - PID 1661 | Values: 146.0 182.0 142.0 124.0 120.0 122.0 124.0 123.0 120.0 121.0 14:47:03 INFO - PID 1661 | 14:47:03 INFO - PID 1661 | [#1] audio-beat-detection Cycles:10 Average:137.40 Median:148.00 stddev:19.03 (12.9%) stddev-sans-first:19.93 14:47:03 INFO - PID 1661 | Values: 146.0 114.0 116.0 154.0 119.0 162.0 157.0 150.0 139.0 117.0 14:47:03 INFO - PID 1661 | 14:47:03 INFO - PID 1661 | [#2] audio-dft Cycles:10 Average:227.70 Median:224.50 stddev:24.10 (10.7%) stddev-sans-first:24.70 14:47:03 INFO - PID 1661 | Values: 210.0 224.0 226.0 219.0 225.0 271.0 272.0 215.0 207.0 208.0 14:47:03 INFO - PID 1661 | 14:47:03 INFO - PID 1661 | [#3] audio-fft Cycles:10 Average:69.90 Median:60.50 stddev:19.20 (31.7%) stddev-sans-first:19.46 14:47:03 INFO - PID 1661 | Values: 86.0 56.0 56.0 91.0 56.0 65.0 84.0 51.0 103.0 51.0 14:47:03 INFO - PID 1661 | 14:47:03 INFO - PID 1661 | [#4] audio-oscillator Cycles:10 Average:90.70 Median:73.00 stddev:16.12 (22.1%) stddev-sans-first:17.10 14:47:03 INFO - PID 1661 | Values: 91.0 71.0 86.0 75.0 68.0 111.0 101.0 109.0 108.0 87.0 14:47:03 INFO - PID 1661 | 14:47:03 INFO - PID 1661 | [#5] imaging-gaussian-blur Cycles:10 Average:94.80 Median:92.50 stddev:7.89 (8.5%) stddev-sans-first:1.22 14:47:03 INFO - PID 1661 | Values: 117.0 91.0 91.0 92.0 93.0 92.0 94.0 91.0 93.0 94.0 14:47:03 INFO - PID 1661 | 14:47:03 INFO - PID 1661 | [#6] imaging-darkroom Cycles:10 Average:119.80 Median:128.00 stddev:26.96 (21.1%) stddev-sans-first:27.62 14:47:03 INFO - PID 1661 | Values: 100.0 100.0 112.0 166.0 98.0 116.0 164.0 140.0 102.0 100.0 14:47:03 INFO - PID 1661 | 14:47:03 INFO - PID 1661 | [#7] imaging-desaturate Cycles:10 Average:104.10 Median:103.00 stddev:5.78 (5.6%) stddev-sans-first:6.08 14:47:03 INFO - PID 1661 | Values: 102.0 101.0 104.0 105.0 102.0 120.0 101.0 100.0 103.0 103.0 14:47:03 INFO - PID 1661 | 14:47:03 INFO - PID 1661 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:58.00 stddev:14.65 (25.3%) stddev-sans-first:15.21 14:47:03 INFO - PID 1661 | Values: 51.0 53.0 50.0 63.0 84.0 81.0 44.0 46.0 72.0 51.0 14:47:03 INFO - PID 1661 | 14:47:03 INFO - PID 1661 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:62.50 stddev:16.73 (26.8%) stddev-sans-first:17.59 14:47:03 INFO - PID 1661 | Values: 60.0 65.0 54.0 80.0 98.0 55.0 51.0 52.0 59.0 89.0 14:47:03 INFO - PID 1661 | 14:47:03 INFO - PID 1661 | [#10] stanford-crypto-aes Cycles:10 Average:98.50 Median:87.50 stddev:15.09 (17.2%) stddev-sans-first:15.31 14:47:03 INFO - PID 1661 | Values: 86.0 87.0 87.0 94.0 88.0 122.0 120.0 118.0 90.0 93.0 14:47:03 INFO - PID 1661 | 14:47:03 INFO - PID 1661 | [#11] stanford-crypto-ccm Cycles:10 Average:165.50 Median:177.00 stddev:18.37 (10.4%) stddev-sans-first:18.61 14:47:03 INFO - PID 1661 | Values: 150.0 155.0 149.0 182.0 172.0 182.0 190.0 143.0 185.0 147.0 14:47:03 INFO - PID 1661 | 14:47:03 INFO - PID 1661 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:220.40 Median:232.00 stddev:28.01 (12.1%) stddev-sans-first:27.14 14:47:03 INFO - PID 1661 | Values: 188.0 185.0 252.0 252.0 208.0 217.0 253.0 207.0 195.0 247.0 14:47:03 INFO - PID 1661 | 14:47:03 INFO - PID 1661 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.50 Median:72.00 stddev:14.53 (20.2%) stddev-sans-first:15.00 14:47:03 INFO - PID 1661 | Values: 71.0 71.0 72.0 100.0 106.0 98.0 72.0 73.0 70.0 72.0 14:47:03 INFO - PID 1661 | -------- Summary: end -------- 14:47:03 INFO - PID 1661 | 14:47:04 INFO - TEST-INFO | 1661: exit 0 14:47:04 INFO - TEST-OK | kraken | took 63643ms 14:47:04 INFO - SUITE-END | took 1181s 14:47:04 INFO - Completed test suite (00:19:41) 14:47:04 INFO - javascript benchmark 14:47:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7866.972805646085, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3621.112827357297, 3649.9452508212366, 3673.5591728992517, 3684.594694583597, 3688.299223147602, 6216.471599914002, 6309.810705678831, 6336.683165841712, 6413.230412350513, 6423.486121110312, 6312.210973628296, 6371.0443433485, 6390.3929126733, 6392.520560957923, 6395.0, 5027.0, 5381.5425688816495, 5499.642523235977, 5566.55467562595, 5773.884522309572, 5635.943640563582, 5645.802396916109, 5689.573282003846, 5706.828795136153, 5724.370319264877, 5456.645318054314, 5534.391216966131, 5583.888322233533, 5602.943970560324, 5617.101263797814, 5521.613487055908, 5531.806386776484, 5537.750801213955, 5538.335399752055, 5558.305211848519, 5344.91982620261, 5527.226188333596, 5543.25166102575, 5550.056490396642, 5633.915491267634, 6064.151018857364, 6226.564140510166, 6243.500519958392, 6262.248530176363, 6266.561340706153, 6837.760678376283, 6857.245702972669, 6858.3141685831515, 6866.176058872918, 6883.518153729241, 6929.930700693029, 6931.0, 6953.130858642669, 6953.33943275388, 6969.756058537927, 6257.843553911189, 6268.811935641938, 6326.557141000178, 6342.0, 6401.807945761635, 6929.3070692931315, 6976.337247961435, 7045.295470453017, 7048.436125109979, 7072.469564782559, 6411.711472983634, 6504.934950650433, 6508.837279068061, 6555.770548030891, 6741.966290168616, 6881.552699074544, 6888.862222755517, 6905.929580914966, 6906.689198986058, 6931.722731090801, 6478.0, 6541.34586541342, 6822.795316140524, 6827.385535301847, 6836.5214434989075, 6666.966665166643, 6808.4212841908, 6848.3494068063455, 6864.141982252218, 6880.827979300458, 5413.539849112791, 5433.592480563973, 5435.461389739612, 5443.700596467153, 5461.0716178249795, 4712.340272361872, 4727.314539391769, 4821.63837712173, 4843.24929635907, 4847.321375007502, 6175.228096487939, 6322.33615470369, 6384.968075159594, 6401.487880969511, 6404.23149222087, 6854.657267136623, 6883.414909732729, 6886.552374095668, 6891.345322194384, 6898.689558969859, 5210.739463026909, 5381.273528073738, 6342.587731797418, 6387.968060159669, 6415.743370265231, 5920.881582368328, 5964.254468191476, 5968.582199246098, 6035.486983606443, 6123.693815309217, 7209.531380460253, 7226.458015648742, 7231.0, 7233.63831808418, 7246.311600397954, 6802.659867006729, 6899.999500072562, 6939.0, 6946.235914049552, 6959.234484206632, 6854.554453960476, 6909.067275917687, 7126.572405655677, 7163.31948464895, 7171.99592057102, 6735.966320168368, 6802.455803535607, 6808.659567021728, 6823.454123669995, 6827.726890924308, 5452.727363631723, 6689.933100668931, 6819.693113809792, 6852.6916288768125, 6875.3812156906115, 5247.55395791362, 6444.806655800334, 6485.805425837232, 6603.438707709706, 6754.324567543403, 5632.7183640816975, 6469.8706025880165, 6706.128203333536, 6713.12729345182, 6719.395254427125, 5520.861978450571, 6300.936990630218, 6399.488040956805, 6458.773942911976, 6525.086487891604, 6715.227748808754, 6738.831529211809, 6746.224184218681, 6748.898766518408, 6754.6622668865375, 6507.511936604679, 6513.0, 6528.053432252202, 6554.311797261219, 6562.737490500326], "value": 6211.190497701583, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.9113169722087, 753.600591686406, 830.2030051150895, 1267.9873201267985, 1269.631806776035, 39894.60105398945, 40661.796691016505, 40668.79665601672, 40678.79660601693, 41054.589454105415, 40270.7986460068, 40419.787406377785, 40820.183596328054, 40876.36494540215, 40893.795531022304, 8067.394945379106, 8254.628541715638, 8442.451240669368, 8659.0, 8663.480191188517, 8697.086805885387, 8701.825963480727, 8789.165029322236, 8795.164459376349, 8802.911970880305, 8761.430507017023, 8779.429337093068, 8809.163129502687, 8811.73564793054, 8817.118288171196, 8706.869396959051, 8765.211130998208, 8774.210321071134, 8783.604737786814, 8792.208701216858, 8634.093420190915, 8685.305175585938, 8696.782580435476, 8709.346798990038, 8722.38943273971, 38955.0, 39206.82379528619, 39428.21143577141, 39449.0, 39529.80235098806, 3512.2799826035603, 3523.7709548879243, 3558.5195998540125, 3562.8574857005688, 3565.4295312749837, 31049.534256986164, 31085.689143108506, 31136.844315778275, 31181.0, 31322.37355252905, 2543.338731929693, 3104.1153271317567, 3126.8592913318957, 3132.7963682360573, 3146.685331466858, 298270.0, 301332.0, 301696.0, 302267.0, 303788.9999999978, 41884.58115418807, 48982.89747986522, 49672.0, 49881.50118498841, 49979.25031124536, 41246.79376603158, 42877.0, 51990.88054716729, 52327.21509177365, 52501.21248181281, 14551.05418147817, 14792.0, 15003.774943375858, 15004.249787510798, 15042.02226855251, 11996.64010079699, 12011.33937633421, 12020.45907934145, 12062.87937120635, 12070.396480175956, 13887.444502219798, 14094.718105638034, 14128.646783830487, 14144.646383840487, 14220.71558568823, 6009.549283803733, 6031.457168854824, 6035.517158627387, 6044.879102417927, 6045.6070355426755, 945.5036106044245, 967.4920666650065, 976.1214906584131, 999.4003597841237, 1020.4234607446768, 22690.20584279542, 23790.0, 24237.272881813573, 24276.0289588418, 24750.628740568907, 1069.3476979042778, 1073.259450978822, 1113.3153110836777, 1116.8938950799661, 1122.927009744364, 11873.0, 12492.188007779465, 12499.875001249871, 12527.0, 12586.307753073668, 466561.0, 469195.0, 469699.0, 470124.0, 470441.0, 54588.0, 55935.321940341855, 56973.715131424906, 57313.0, 57362.42637573571, 1468.897177197586, 1496.9550913472613, 1504.368165370547, 1508.7661412480863, 1510.8564686354778, 23928.20738312775, 24455.38861528476, 29440.705592943796, 30084.0, 30436.84781576078, 40487.0, 40637.390439142844, 40802.387964179965, 41090.79454602708, 41176.0, 444951.0, 446576.0, 446597.0, 447454.0, 448981.0, 34637.57536972489, 35036.824815875756, 35239.295214096084, 35328.11679708028, 35441.0, 43737.56262437335, 44165.337519936584, 44354.55645443504, 45269.868253293935, 45371.86570335768, 25799.32304400208, 28451.87029426803, 29012.564811528267, 30362.69637303687, 30547.847260763552, 30406.391872162876, 30643.54034689437, 30681.079567613007, 30699.693003069682, 30826.845865771425, 35527.46708799319, 36492.81753591215, 36527.634723653486, 36969.6303036977, 37465.25069498649, 30280.84859575688, 30366.93715719939, 31119.844400777853, 31142.0, 31749.682503175598, 23073.0, 23996.160134395213, 24311.0, 24419.918223714925, 24464.51070978606], "value": 18266.61885136348, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [395.8832144517367, 426.39451978190965, 438.2265301742425, 443.4014080990662, 465.9813607455702, 21808.563828723436, 21815.454613634665, 22476.0, 22723.886380568096, 22754.54490910181, 22551.436214094654, 23053.308400748003, 23765.881170594123, 23942.760572394272, 24113.75886241137, 4612.423447069116, 6177.691115444232, 6346.111544383767, 6404.42360187583, 6413.454856337217, 6277.5291853110975, 6364.713587888533, 6378.330275321094, 6396.328385519523, 6405.7117429715545, 6134.9386506134815, 6223.751049957997, 6288.025356069817, 6290.591111577733, 6343.46080583151, 6094.8171554853425, 6182.659953702545, 6267.749290028393, 6276.968615156918, 6281.466075383598, 5521.558275337963, 5624.859378515529, 5630.521405680522, 5637.577181711388, 5654.85862853432, 27293.863530682218, 27764.583531247048, 27837.025704100462, 27904.581431278548, 28030.159095227176, 2191.3316438486254, 2225.810806081485, 2233.966490502644, 2234.5084081502046, 2237.820974322067, 15495.535133946, 17484.562885927826, 18211.18049687754, 18442.07789610514, 18468.815311846844, 1867.318428773488, 1953.4627977306213, 2008.7288216090788, 2030.979690203094, 2116.8306535477127, 111803.0, 129907.0, 143990.2800485991, 144787.276063619, 146544.0, 10626.787464250827, 12637.93681031589, 12729.55446559366, 12926.806097908539, 13090.280034597998, 16948.576285592713, 16949.32202711878, 16969.36974768913, 16990.70625465571, 17022.0, 7197.604131772803, 7778.455508114491, 8821.206091451671, 9158.542072896329, 9310.906890931004, 8705.869411958825, 8715.34634902372, 8719.825603488021, 8871.866921996176, 8914.28685705155, 6679.599224046573, 8009.517049714607, 8138.593070346459, 8151.347892168612, 8164.510129392255, 1874.5126267170633, 2047.6518991771434, 2072.637288474511, 2147.194801949269, 2151.4943988162768, 954.6897258390911, 958.496789185683, 966.8114717629994, 994.4679596415883, 998.9950050249702, 20300.695489567668, 21406.25078122258, 21472.033758480906, 21551.67672484914, 21595.892020539795, 818.3167055508717, 1003.19744204636, 1030.1449796668746, 1038.3925403638955, 1040.3445829127602, 10405.484349332639, 11086.61196858106, 11090.611828585961, 11095.278806877526, 11134.61028864002, 699504.0, 721027.0, 723155.0, 726273.0, 731923.0, 151111.0, 153070.0, 154720.0, 155832.0, 158470.41529584557, 1203.8194270859267, 1208.1301462946665, 1234.2964510229262, 1234.6851552854143, 1240.9689757755948, 12995.350232488527, 14077.648058798612, 16328.836711632732, 18199.363022294157, 18205.453836384928, 60771.99999999823, 61238.693806532465, 61476.38523614706, 61790.1462956112, 62353.68823155855, 82054.58972705338, 83805.0, 84126.0, 84818.45544633671, 85716.42805726705, 8706.782330441789, 8740.038595754335, 9128.589213485277, 9171.77070573241, 9319.369110405516, 13726.794098088338, 13830.65423364424, 14207.786883196553, 14247.073940193854, 14293.57119286423, 9630.711078667651, 11054.723631909266, 11173.162012848907, 11784.410779461165, 12083.75832483363, 11085.556577736801, 11255.380954047607, 11426.371549564854, 11654.941725291319, 11718.648440546796, 11705.0, 12065.758684826078, 12270.509179632714, 12300.507979680713, 12460.252384856574, 6689.9965005249605, 8010.639521221676, 8123.390745693979, 8858.848349714495, 9291.024442433447, 11431.942840286078, 11913.52345906154, 12178.330191839534, 12279.386030698608, 12288.754224915272], "value": 10550.797382974113, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1281.3016905786346, 1408.162143524603, 1465.098964137056, 1465.5163795947344, 1513.1526345246664, 9270.629174833015, 11148.442577871105, 11436.485358158881, 11588.42057897106, 12247.448864801083, 11844.34856082915, 11884.584039558616, 11891.345975971319, 12030.759384812298, 12039.939800300986, 2480.5535003699374, 2530.101813856082, 2530.72162062173, 2531.6835395575554, 2532.1390727152766, 2434.1845481763544, 2481.553320402327, 2484.142970675114, 2487.253823852846, 2493.763092506209, 2407.2296865003204, 2411.3007227903886, 2435.3789783605157, 2438.2807071913826, 2448.5837407640743, 2404.7354790972977, 2405.5669979403788, 2424.309071914505, 2449.909790143387, 2459.163884279336, 2366.219147681261, 2405.1341517053847, 2423.551642946061, 2429.307647320523, 2497.612870005152, 11630.011449026842, 11694.47374868133, 11718.003969662588, 11747.94126029373, 11756.353400562966, 5594.0, 6341.556091073627, 6639.103720997652, 6650.135482387259, 6676.031975363594, 3967.246223217608, 4171.561985991488, 4190.51809041961, 4290.613844753987, 4291.763952982585, 1231.5320178332265, 1244.104244943639, 1252.8536389203869, 1269.3399432295248, 1286.1254347044007, 14419.269687637447, 14949.327280272306, 16433.58916027097, 16526.338946442127, 16570.83429165705, 5341.225522299244, 5488.862778430492, 5678.233438485834, 5719.799807006735, 5741.569382296345, 12389.256644601353, 12444.315562644142, 12506.749865002648, 12526.686832829253, 12546.247225166519, 5781.479666830005, 6233.75064997395, 6567.408933196035, 6592.571482853599, 6593.967030164915, 5960.314563825129, 6116.327204007555, 6166.568340216231, 6210.068489726577, 6237.126802247689, 3992.181602771425, 4279.636230920407, 4422.690411671152, 4442.333649952533, 4451.3545535897765, 1216.993915030437, 1280.6862318731785, 1287.1118927939692, 1299.2009913902882, 1301.466398776497, 651.7523341130341, 761.3680645064583, 775.3758224629115, 796.4982061301343, 800.1998001998002, 6017.608855424383, 6126.111713801474, 6248.687565621701, 6285.654289014148, 6312.463440607508, 554.9167624856303, 563.104663584902, 891.0, 904.4437670832391, 929.149827907457, 4545.5908968193025, 4546.272596384562, 4628.83799067031, 4722.716637001791, 4787.3776409067295, 14115.717685646436, 14913.92543037278, 15087.698246035237, 15169.08985460876, 15187.164705941279, 14510.854891451161, 14632.122072675673, 14634.121952682874, 14634.560963171121, 14637.634059148393, 10654.893451065545, 10737.087347575387, 10907.127429805596, 10958.671239862817, 10964.890351096386, 6588.604683718992, 7004.719811207495, 7062.752803651848, 7125.073740413713, 7129.108861392326, 13295.933520332337, 13586.38861251266, 13670.384832682752, 13806.516771912935, 13836.23900685472, 11001.339919604528, 11280.492377842853, 11943.68619451877, 13569.321533923461, 13722.245276509888, 9438.103380178873, 9474.857877131986, 9620.13418792284, 9621.422714637145, 9623.759406014906, 10619.415932123808, 10685.679429617125, 10736.624218152327, 10822.296550724177, 10854.457277135954, 9051.366404351895, 9154.633814647339, 9227.815443691223, 9230.861537076815, 9365.391249568756, 7294.2341054190665, 8783.0, 8934.776630584287, 8940.284777217677, 9177.632894684404, 8164.224398682116, 8201.507909525448, 8217.753467395987, 8296.83406331858, 8315.334773218248, 5682.346530149086, 5835.912461313169, 5865.090910908816, 6031.698415079316, 6062.575619706578, 5949.077892926603, 6001.309849367204, 6098.512119030378, 6209.130721698875, 6212.751489940351], "value": 5359.117422810171, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.4750894921042, 366.31316281971306, 366.919277758893, 374.4888227569369, 375.31317688629804, 6269.0, 6420.743170273196, 6499.902501462476, 6578.177727784027, 6605.900911486326, 5000.874978125548, 6206.751729930808, 6247.7813276535335, 6257.405546473078, 6264.968675156618, 3688.3729765939856, 4476.194285028701, 4484.529124441936, 4501.7974191161475, 4515.887102822423, 4419.911601767963, 4424.225760491917, 4474.753888536129, 4498.02087081683, 4510.233260345733, 4225.7253278536955, 4410.801513931865, 4429.822807087713, 4455.309427038798, 4467.5755803198645, 3648.28530590622, 4365.88254696472, 4441.423294730373, 4460.799264033094, 4501.437320334958, 3125.359301343219, 3681.742278040538, 3816.3512202925567, 3827.617238276178, 3843.8654647087496, 5555.2778138842095, 5936.970315148396, 6004.849878753066, 6054.788082417094, 6104.816855494342, 4415.271480205763, 4628.352030715702, 4889.877753056202, 5257.973710131425, 5341.706206158659, 5599.860003499904, 5905.2323197984415, 6048.276241271261, 6129.233845769279, 6614.7684831031165, 3578.8389522471552, 4281.229378711831, 4282.079352939133, 4287.356896465524, 4299.1831552005015, 5110.466859942003, 6784.1858976922595, 6940.577181677794, 7002.579845209304, 7070.186928503236, 3679.5833604062095, 4357.0196705740955, 4373.169097871394, 4384.7114664002, 4423.911521769546, 3965.405189221582, 4243.130158317537, 4429.889252768642, 4449.777511124431, 4482.4172857528965, 4460.50934397216, 5338.91991620126, 5341.450979215984, 5350.635587925132, 5370.946290537123, 5505.752241149078, 6688.0, 6708.2956289589865, 6713.932860671331, 6772.830679233059, 1405.6977749783846, 1498.5803974887049, 1515.272669118829, 1518.1574226304508, 1518.6127537477873, 957.7509847439716, 964.5611246882652, 972.231936769958, 981.4405788700373, 983.680303901235, 6334.619922804646, 6357.809265722036, 6368.29948705642, 6376.489880809524, 6410.262819775692, 5625.296837895263, 6286.559940804192, 6700.865982680319, 6940.514164008471, 7032.824179395556, 6308.558400911984, 6322.33615470369, 6326.145970294044, 6346.650934198571, 6362.204724409449, 3608.585012723518, 3638.69071128957, 3648.087978005499, 3655.8903232903053, 3667.8166091695844, 5956.0, 6910.896336554955, 7110.288971102848, 7216.0, 7226.736225626905, 6790.830229244309, 7118.9644051779405, 7140.678669459887, 7164.641767911584, 7170.139583250043, 5682.289713785777, 7002.264762199998, 7078.54211732559, 7195.604241766753, 7280.599567023971, 6203.8138855834395, 6909.550879192836, 6952.965235173791, 6976.19773726028, 6987.755428559976, 6492.318306577741, 6548.672566371758, 6781.152355955505, 6852.006459063308, 6869.725210991504, 6320.638759256099, 6427.260865000585, 6768.593884366954, 7078.575285482888, 7264.89102663471, 3616.65641764032, 3815.484909537288, 4356.825726970886, 4370.759608221579, 4382.298832186835, 6681.198256209286, 6926.333361655698, 6936.7225310989015, 6962.1297337832775, 6993.825154371181, 6126.0, 6338.746450141943, 6526.347365263626, 6734.595924244561, 6740.0, 6445.291017988111, 6502.414782669583, 6738.393544581011, 6741.59550426976, 6773.254941956479, 5318.590573497949, 5697.259356283656, 6142.2629284484365, 6500.869982600416, 6581.506387021088, 6024.006039003515, 6670.599764014175, 6756.425703815231, 6760.222574404006, 6803.632202060012, 5809.680467574155, 6210.4100110489435, 6488.480921526172, 6501.707423165874, 6588.505862060269], "value": 4760.578489157699, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [688.849621132708, 819.6311659753112, 822.0956947357907, 847.8897743293371, 854.8162145138793, 15675.764863527042, 16015.599610009742, 16108.0, 16947.0, 17037.63698904088, 15047.0, 15360.61598460039, 15484.99347542409, 15646.452374166907, 15708.84291157091, 885.3802338363139, 1019.2050200843317, 1023.2274632652375, 1024.1806554756201, 1024.2983556263946, 974.6880998080617, 1011.1354791653141, 1012.5291739341205, 1017.8066167428202, 1023.5803320638539, 1054.0460882900986, 1082.3668154129805, 1082.5074591061089, 1083.138904570864, 1085.3704851186294, 1043.363548235572, 1074.8119079161115, 1074.9462526873704, 1075.1613741281813, 1077.20286987629, 779.4777499075633, 785.8231897823001, 806.5725165662209, 807.8465091632571, 808.0263282744279, 16327.510174694778, 16426.75359869603, 16525.83474165255, 16849.494515164566, 16872.578185545335, 14320.283985800668, 14451.277436128257, 14508.782368264485, 14621.561353159315, 14624.707505849823, 13385.732285354336, 13459.528916487876, 13524.459021639123, 13625.727485450236, 13712.108712933627, 3358.7648864579487, 3360.2103505676146, 3390.762646614738, 3399.5070714746225, 3399.8810041648426, 116138.19309034514, 116507.41746291298, 120034.0, 120152.79847201504, 121186.0, 11457.656270311903, 11508.712282192844, 11641.126915481373, 11676.47455864488, 11987.743777072452, 21724.45688857791, 25455.61816572753, 25583.360415989748, 25913.35216619562, 25987.61018584723, 7553.282438168365, 7617.542947423172, 7758.379329653614, 7778.027746531684, 7914.208579142155, 4133.359329303963, 4200.579942005775, 4219.0, 4233.470816147981, 4248.235317642792, 3356.47974563943, 3667.7799332040163, 4092.2838503262406, 4198.979005105016, 4282.693778397618, 775.8370742144212, 834.98330033399, 906.1934877958622, 910.235402262103, 910.6858133943779, 632.509804901196, 635.4439865118022, 649.8018104478085, 660.1615947746432, 672.468749687751, 9706.805863882824, 9965.950170249102, 10209.097215340344, 10389.480525973671, 10506.474676266156, 598.3717097048169, 600.3126420248877, 649.9025146228009, 662.5031226580065, 666.3403230801472, 4566.49768525462, 4821.710697358169, 4828.686135401188, 4872.599447897782, 4877.097736918681, 88455.0, 88884.11115888887, 94402.0559794407, 96475.51762241144, 98842.5057874706, 88814.0, 88857.0, 89087.55456222677, 90676.09323906676, 91324.0, 58686.0, 76528.61735691174, 81749.36501269942, 82203.0, 82237.0, 9409.388389754644, 10546.20903432261, 10766.600341955496, 10972.0, 11165.776684466427, 35450.82274588611, 36506.0, 38036.42945355877, 39071.609283907936, 39248.80375598218, 35723.0, 49842.50157498524, 50082.74958625183, 50408.747956259984, 50758.984820304126, 13389.799153012907, 13440.46238150463, 13637.24995125238, 13798.93100534491, 14116.788248176492, 14179.574612761633, 14297.556980483792, 14301.713965720419, 14332.211728355041, 14689.04521206161, 13086.411111500196, 13240.271785051915, 13430.865691342962, 13818.930905345409, 13994.440222391398, 13633.0, 13732.176069435865, 13791.586252412444, 14253.786193206903, 14564.635884102981, 13667.31663416845, 13668.0, 13702.588922331946, 13825.032247742562, 13974.301284935917, 10030.348027378197, 10062.39625622465, 10254.0, 10439.348159888928, 10448.622876083684, 9618.711438656852, 10595.417252050904, 10621.831598524002, 11381.772364552828, 11650.825237621273], "value": 7761.447929399197, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1667.5, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 182.0, 142.0, 124.0, 120.0, 122.0, 124.0, 123.0, 120.0, 121.0], "value": 132.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 114.0, 116.0, 154.0, 119.0, 162.0, 157.0, 150.0, 139.0, 117.0], "value": 137.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [210.0, 224.0, 226.0, 219.0, 225.0, 271.0, 272.0, 215.0, 207.0, 208.0], "value": 227.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 56.0, 56.0, 91.0, 56.0, 65.0, 84.0, 51.0, 103.0, 51.0], "value": 69.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 86.0, 75.0, 68.0, 111.0, 101.0, 109.0, 108.0, 87.0], "value": 90.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 91.0, 91.0, 92.0, 93.0, 92.0, 94.0, 91.0, 93.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 100.0, 112.0, 166.0, 98.0, 116.0, 164.0, 140.0, 102.0, 100.0], "value": 119.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 101.0, 104.0, 105.0, 102.0, 120.0, 101.0, 100.0, 103.0, 103.0], "value": 104.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 53.0, 50.0, 63.0, 84.0, 81.0, 44.0, 46.0, 72.0, 51.0], "value": 59.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 65.0, 54.0, 80.0, 98.0, 55.0, 51.0, 52.0, 59.0, 89.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 87.0, 94.0, 88.0, 122.0, 120.0, 118.0, 90.0, 93.0], "value": 98.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 155.0, 149.0, 182.0, 172.0, 182.0, 190.0, 143.0, 185.0, 147.0], "value": 165.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 185.0, 252.0, 252.0, 208.0, 217.0, 253.0, 207.0, 195.0, 247.0], "value": 220.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 71.0, 72.0, 100.0, 106.0, 98.0, 72.0, 73.0, 70.0, 72.0], "value": 80.5, "unit": "score"}]}]} 14:47:04 INFO - Return code: 0 14:47:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:47:04 ERROR - # TBPL SUCCESS # 14:47:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:47:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:47:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:47:04 INFO - 2017-04-05 14:47:04.658 screenresolution[1666:10623] starting screenresolution argv=screenresolution get 14:47:04 INFO - 2017-04-05 14:47:04.661 screenresolution[1666:10623] Display 0: 1600x1200x32@60 14:47:04 INFO - 2017-04-05 14:47:04.668 screenresolution[1667:10626] starting screenresolution argv=screenresolution list 14:47:04 INFO - Available Modes on Display 0 14:47:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:47:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:47:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:47:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:47:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:47:04 INFO - Intel Iris: 14:47:04 INFO - Chipset Model: Intel Iris 14:47:04 INFO - Type: GPU 14:47:04 INFO - Bus: Built-In 14:47:04 INFO - VRAM (Dynamic, Max): 1536 MB 14:47:04 INFO - Vendor: Intel (0x8086) 14:47:04 INFO - Device ID: 0x0a2e 14:47:04 INFO - Revision ID: 0x0009 14:47:04 INFO - Displays: 14:47:04 INFO - Display: 14:47:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:47:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:47:04 INFO - Display Serial Number: 1600x1200 60 14:47:04 INFO - Main Display: Yes 14:47:04 INFO - Mirror: Off 14:47:04 INFO - Online: Yes 14:47:04 INFO - Rotation: Supported 14:47:04 INFO - Return code: 0 14:47:04 INFO - Running post-action listener: _resource_record_post_action 14:47:04 INFO - [mozharness: 2017-04-05 21:47:04.914999Z] Finished run-tests step (success) 14:47:04 INFO - Running post-run listener: _resource_record_post_run 14:47:04 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 39197184; Write bytes: 518848512; Read time: 254; Write time: 1653 14:47:04 INFO - TinderboxPrint: CPU usage
54.4% 14:47:04 INFO - TinderboxPrint: I/O read bytes / time
39,197,184 / 254 14:47:04 INFO - TinderboxPrint: I/O write bytes / time
518,848,512 / 1,653 14:47:04 INFO - TinderboxPrint: CPU idle
2,192.3 (45.6%) 14:47:04 INFO - TinderboxPrint: CPU system
968.2 (20.1%) 14:47:04 INFO - TinderboxPrint: CPU user
1,645.3 (34.2%) 14:47:04 INFO - TinderboxPrint: Swap in / out
245,825,536 / 0 14:47:04 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208230912; Write bytes: 210434048; Read time: 15979; Write time: 484 14:47:05 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 35301888; Write bytes: 306821120; Read time: 228; Write time: 1162 14:47:05 INFO - Running post-run listener: _upload_blobber_files 14:47:05 INFO - Blob upload gear active. 14:47:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:47:05 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 14:47:05 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:47:05 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:47:05 INFO - (blobuploader) - INFO - Open directory for files ... 14:47:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 14:47:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:47:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:47:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 14:47:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:47:06 INFO - (blobuploader) - INFO - Done attempting. 14:47:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 14:47:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:47:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:47:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 14:47:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:47:07 INFO - (blobuploader) - INFO - Done attempting. 14:47:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:47:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:47:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:47:08 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:47:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:47:08 INFO - (blobuploader) - INFO - Done attempting. 14:47:08 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:47:08 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:47:08 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:47:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:47:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:47:10 INFO - (blobuploader) - INFO - Done attempting. 14:47:10 INFO - (blobuploader) - INFO - Iteration through files over. 14:47:10 INFO - Return code: 0 14:47:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:47:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:47:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21c4bb37cb0b1776e1b1c28be82157d12f9af3b40b61c1134ad09d06ddf24ca08b85825d0bcaa8d8061da823fcfd36a2b7804ccfb150869f836597ed962b32cf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ed79722317c21d56e1c8080550bbcf42ec3e0faaaedf892d1e2f08077871244c414bafd708010d15810b87596c0217a2f91e8074abcdc0329c6b130cf6f9ab4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d57c0a1068c269f5f2fbd94d742d17e9f716e18ea5ecee0622bb3addfcddb98878b11f13410e5191510207b84b5ba8e108fc8b3503c23e70b638000b981563db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db90db2331435be48f2544b307d00872ff37dd456edc04bb013822abca0494416cc22a9ef18f17376372e7c114ce0a378f475288003a4f4c597e9016ab252128"} 14:47:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:47:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:47:10 INFO - Contents: 14:47:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21c4bb37cb0b1776e1b1c28be82157d12f9af3b40b61c1134ad09d06ddf24ca08b85825d0bcaa8d8061da823fcfd36a2b7804ccfb150869f836597ed962b32cf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ed79722317c21d56e1c8080550bbcf42ec3e0faaaedf892d1e2f08077871244c414bafd708010d15810b87596c0217a2f91e8074abcdc0329c6b130cf6f9ab4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d57c0a1068c269f5f2fbd94d742d17e9f716e18ea5ecee0622bb3addfcddb98878b11f13410e5191510207b84b5ba8e108fc8b3503c23e70b638000b981563db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db90db2331435be48f2544b307d00872ff37dd456edc04bb013822abca0494416cc22a9ef18f17376372e7c114ce0a378f475288003a4f4c597e9016ab252128"} 14:47:10 INFO - Running post-run listener: copy_logs_to_upload_dir 14:47:10 INFO - Copying logs to upload dir... 14:47:10 INFO - mkdir: /builds/slave/test/build/upload/logs 14:47:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.060659 ========= master_lag: 0.10 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 25 secs) (at 2017-04-05 14:47:10.693775) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 14:47:10.696165) ========= 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.odgy7hNxZH/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.7uUWNioBpS/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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/Firefox/sha512/21c4bb37cb0b1776e1b1c28be82157d12f9af3b40b61c1134ad09d06ddf24ca08b85825d0bcaa8d8061da823fcfd36a2b7804ccfb150869f836597ed962b32cf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ed79722317c21d56e1c8080550bbcf42ec3e0faaaedf892d1e2f08077871244c414bafd708010d15810b87596c0217a2f91e8074abcdc0329c6b130cf6f9ab4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d57c0a1068c269f5f2fbd94d742d17e9f716e18ea5ecee0622bb3addfcddb98878b11f13410e5191510207b84b5ba8e108fc8b3503c23e70b638000b981563db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db90db2331435be48f2544b307d00872ff37dd456edc04bb013822abca0494416cc22a9ef18f17376372e7c114ce0a378f475288003a4f4c597e9016ab252128"} build_url:https://queue.taskcluster.net/v1/task/XfHkKcCZQqijvkwhlFv4Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011103 build_url: 'https://queue.taskcluster.net/v1/task/XfHkKcCZQqijvkwhlFv4Mw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/21c4bb37cb0b1776e1b1c28be82157d12f9af3b40b61c1134ad09d06ddf24ca08b85825d0bcaa8d8061da823fcfd36a2b7804ccfb150869f836597ed962b32cf", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2ed79722317c21d56e1c8080550bbcf42ec3e0faaaedf892d1e2f08077871244c414bafd708010d15810b87596c0217a2f91e8074abcdc0329c6b130cf6f9ab4", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d57c0a1068c269f5f2fbd94d742d17e9f716e18ea5ecee0622bb3addfcddb98878b11f13410e5191510207b84b5ba8e108fc8b3503c23e70b638000b981563db", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/db90db2331435be48f2544b307d00872ff37dd456edc04bb013822abca0494416cc22a9ef18f17376372e7c114ce0a378f475288003a4f4c597e9016ab252128"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 14:47:10.734596) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2017-04-05 14:47:10.734923) ========= 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.odgy7hNxZH/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.7uUWNioBpS/Listeners TMPDIR=/var/folders/2h/m728c6kn5w33qr6tk69wj79m00000w/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.005041 ========= master_lag: 3.39 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2017-04-05 14:47:14.134652) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 14:47:14.134993) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 14:47:14.140243) ========= ========= Total master_lag: 3.59 =========