builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0308 starttime: 1493050771.75 results: success (0) buildid: 20170424075425 builduid: 82c461abe19e4c15b6b3f4432b9987a2 revision: 62a2d3693579fc77b1c510984ae471a860d03302 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 09:19:31.752441) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-24 09:19:31.753032) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 09:19:31.753374) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-24 09:19:31.781785) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 09:19:31.782197) ========= 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.AbU0xuG7Q5/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.AgrjoJPR53/Listeners TMPDIR=/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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-24 09:19:31-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.4M=0.001s 2017-04-24 09:19:31 (18.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.132351 ========= master_lag: 0.39 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 09:19:32.308089) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 09:19:32.308464) ========= 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.AbU0xuG7Q5/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.AgrjoJPR53/Listeners TMPDIR=/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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.027828 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 09:19:32.360215) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-24 09:19:32.360591) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 62a2d3693579fc77b1c510984ae471a860d03302 --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 62a2d3693579fc77b1c510984ae471a860d03302 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.AbU0xuG7Q5/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.AgrjoJPR53/Listeners TMPDIR=/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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-24 09:19:32,422 truncating revision to first 12 chars 2017-04-24 09:19:32,422 Setting DEBUG logging. 2017-04-24 09:19:32,423 attempt 1/10 2017-04-24 09:19:32,423 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/62a2d3693579?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-24 09:19:33,962 unpacking tar archive at: mozilla-central-62a2d3693579/testing/mozharness/ program finished with exit code 0 elapsedTime=2.170228 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-24 09:19:34.559174) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 09:19:34.559583) ========= script_repo_revision: 62a2d3693579fc77b1c510984ae471a860d03302 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-24 09:19:34.559986) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 09:19:34.560300) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-24 09:19:34.581386) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-04-24 09:19:34.581796) ========= /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.AbU0xuG7Q5/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.AgrjoJPR53/Listeners TMPDIR=/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 09:19:34 INFO - MultiFileLogger online at 20170424 09:19:34 in /builds/slave/test 09:19:34 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 09:19:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:19:34 INFO - {'append_to_log': False, 09:19:34 INFO - 'base_work_dir': '/builds/slave/test', 09:19:34 INFO - 'blob_upload_branch': 'Firefox', 09:19:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:19:34 INFO - 'branch': 'Firefox', 09:19:34 INFO - 'buildbot_json_path': 'buildprops.json', 09:19:34 INFO - 'config_files': ('talos/mac_config.py',), 09:19:34 INFO - 'default_actions': ('clobber', 09:19:34 INFO - 'read-buildbot-config', 09:19:34 INFO - 'download-and-extract', 09:19:34 INFO - 'populate-webroot', 09:19:34 INFO - 'create-virtualenv', 09:19:34 INFO - 'install', 09:19:34 INFO - 'run-tests'), 09:19:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:19:34 INFO - 'download_minidump_stackwalk': True, 09:19:34 INFO - 'download_symbols': 'ondemand', 09:19:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:19:34 INFO - 'tooltool.py': '/tools/tooltool.py', 09:19:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:19:34 INFO - '/tools/misc-python/virtualenv.py')}, 09:19:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:19:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:19:34 INFO - 'gecko_profile': False, 09:19:34 INFO - 'gecko_profile_interval': 0, 09:19:34 INFO - 'installer_path': 'installer.exe', 09:19:34 INFO - 'log_level': 'info', 09:19:34 INFO - 'log_name': 'talos', 09:19:34 INFO - 'log_to_console': True, 09:19:34 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:19:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:19:34 INFO - 'opt_config_files': (), 09:19:34 INFO - 'pip_index': False, 09:19:34 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:19:34 INFO - 'cmd': ('bash', 09:19:34 INFO - '-c', 09:19:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:19:34 INFO - 'enabled': True, 09:19:34 INFO - 'halt_on_failure': False, 09:19:34 INFO - 'name': 'check_screen_resolution'},), 09:19:34 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:19:34 INFO - 'cmd': ('bash', 09:19:34 INFO - '-c', 09:19:34 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:19:34 INFO - 'enabled': True, 09:19:34 INFO - 'halt_on_failure': False, 09:19:34 INFO - 'name': 'check_screen_resolution'},), 09:19:34 INFO - 'run_cmd_checks_enabled': True, 09:19:34 INFO - 'suite': 'dromaeojs-e10s', 09:19:34 INFO - 'system_bits': '32', 09:19:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:19:34 INFO - 'title': 't-yosemite-r7-0308', 09:19:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:19:34 INFO - 'use_talos_json': True, 09:19:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:19:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:19:34 INFO - 'work_dir': 'build'} 09:19:34 INFO - [mozharness: 2017-04-24 16:19:34.752325Z] Running clobber step. 09:19:34 INFO - Running pre-action listener: _resource_record_pre_action 09:19:34 INFO - Running main action method: clobber 09:19:34 INFO - rmtree: /builds/slave/test/build 09:19:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:19:37 INFO - Running post-action listener: _resource_record_post_action 09:19:37 INFO - [mozharness: 2017-04-24 16:19:37.084487Z] Finished clobber step (success) 09:19:37 INFO - [mozharness: 2017-04-24 16:19:37.084564Z] Running read-buildbot-config step. 09:19:37 INFO - Running pre-action listener: _resource_record_pre_action 09:19:37 INFO - Running main action method: read_buildbot_config 09:19:37 INFO - Using buildbot properties: 09:19:37 INFO - { 09:19:37 INFO - "project": "", 09:19:37 INFO - "product": "firefox", 09:19:37 INFO - "script_repo_revision": "production", 09:19:37 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 09:19:37 INFO - "repository": "", 09:19:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 09:19:37 INFO - "buildid": "20170424075425", 09:19:37 INFO - "pgo_build": "False", 09:19:37 INFO - "basedir": "/builds/slave/test", 09:19:37 INFO - "buildnumber": 40, 09:19:37 INFO - "slavename": "t-yosemite-r7-0308", 09:19:37 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 09:19:37 INFO - "platform": "yosemite_r7", 09:19:37 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:19:37 INFO - "branch": "mozilla-central", 09:19:37 INFO - "repo_path": "mozilla-central", 09:19:37 INFO - "revision": "62a2d3693579fc77b1c510984ae471a860d03302", 09:19:37 INFO - "stage_platform": "macosx64", 09:19:37 INFO - "builduid": "82c461abe19e4c15b6b3f4432b9987a2", 09:19:37 INFO - "slavebuilddir": "test" 09:19:37 INFO - } 09:19:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZeMDxTkHR0maK5SSw8mNVA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 09:19:37 INFO - Running post-action listener: _resource_record_post_action 09:19:37 INFO - [mozharness: 2017-04-24 16:19:37.088029Z] Finished read-buildbot-config step (success) 09:19:37 INFO - [mozharness: 2017-04-24 16:19:37.088163Z] Running download-and-extract step. 09:19:37 INFO - Running pre-action listener: _resource_record_pre_action 09:19:37 INFO - Running main action method: download_and_extract 09:19:37 INFO - mkdir: /builds/slave/test/build/tests 09:19:37 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')]} 09:19:37 INFO - trying https://queue.taskcluster.net/v1/task/ZeMDxTkHR0maK5SSw8mNVA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 09:19:37 INFO - Downloading https://queue.taskcluster.net/v1/task/ZeMDxTkHR0maK5SSw8mNVA/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 09:19:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZeMDxTkHR0maK5SSw8mNVA/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 09:19:38 INFO - Downloaded 1325 bytes. 09:19:38 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:19:38 INFO - Using the following test package requirements: 09:19:38 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:19:38 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 09:19:38 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:19:38 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:19:38 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 09:19:38 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:19:38 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 09:19:38 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:19:38 INFO - u'jsshell-mac.zip'], 09:19:38 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:19:38 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 09:19:38 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:19:38 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:19:38 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 09:19:38 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:19:38 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 09:19:38 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:19:38 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 09:19:38 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:19:38 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 09:19:38 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:19:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZeMDxTkHR0maK5SSw8mNVA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:19:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZeMDxTkHR0maK5SSw8mNVA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:19:38 INFO - Fetch https://queue.taskcluster.net/v1/task/ZeMDxTkHR0maK5SSw8mNVA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:19:40 INFO - Content-Length response header: 52523291 09:19:40 INFO - Bytes received: 52523291 09:19:56 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 09:19:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZeMDxTkHR0maK5SSw8mNVA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:19:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZeMDxTkHR0maK5SSw8mNVA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:19:56 INFO - Fetch https://queue.taskcluster.net/v1/task/ZeMDxTkHR0maK5SSw8mNVA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:19:57 INFO - Content-Length response header: 52523291 09:19:57 INFO - Bytes received: 52523291 09:20:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ZeMDxTkHR0maK5SSw8mNVA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 09:20:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ZeMDxTkHR0maK5SSw8mNVA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:20:13 INFO - Fetch https://queue.taskcluster.net/v1/task/ZeMDxTkHR0maK5SSw8mNVA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 09:20:14 INFO - Content-Length response header: 14408822 09:20:14 INFO - Bytes received: 14408822 09:20:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:14 INFO - trying https://queue.taskcluster.net/v1/task/ZeMDxTkHR0maK5SSw8mNVA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:20:14 INFO - Downloading https://queue.taskcluster.net/v1/task/ZeMDxTkHR0maK5SSw8mNVA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 09:20:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ZeMDxTkHR0maK5SSw8mNVA/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 09:20:16 INFO - Downloaded 71039305 bytes. 09:20:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZeMDxTkHR0maK5SSw8mNVA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:20:16 INFO - mkdir: /builds/slave/test/properties 09:20:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:20:16 INFO - Writing to file /builds/slave/test/properties/build_url 09:20:16 INFO - Contents: 09:20:16 INFO - build_url:https://queue.taskcluster.net/v1/task/ZeMDxTkHR0maK5SSw8mNVA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:20:17 INFO - Running post-action listener: _resource_record_post_action 09:20:17 INFO - Running post-action listener: set_extra_try_arguments 09:20:17 INFO - [mozharness: 2017-04-24 16:20:17.280323Z] Finished download-and-extract step (success) 09:20:17 INFO - [mozharness: 2017-04-24 16:20:17.280451Z] Running populate-webroot step. 09:20:17 INFO - Running pre-action listener: _resource_record_pre_action 09:20:17 INFO - Running main action method: populate_webroot 09:20:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:20:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:20:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:20:17 INFO - '--tppagecycles', 09:20:17 INFO - '7'], 09:20:17 INFO - 'tests': ['tsvgm']}}, 09:20:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:20:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:20:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:20:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:20:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:20:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:20:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:20:17 INFO - 'talos_options': ['--disable-e10s'], 09:20:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:20:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:20:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:20:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:20:17 INFO - 'talos_options': ['--disable-e10s'], 09:20:17 INFO - 'tests': ['damp', 'tps']}, 09:20:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:20:17 INFO - 'tests': ['damp', 'tps']}, 09:20:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:20:17 INFO - 'tests': ['dromaeo_dom']}, 09:20:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:20:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:20:17 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:20:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:20:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:20:17 INFO - 'tests': ['a11yr', 09:20:17 INFO - 'ts_paint', 09:20:17 INFO - 'tpaint', 09:20:17 INFO - 'sessionrestore', 09:20:17 INFO - 'sessionrestore_no_auto_restore', 09:20:17 INFO - 'tabpaint']}, 09:20:17 INFO - 'other-e10s': {'tests': ['a11yr', 09:20:17 INFO - 'ts_paint', 09:20:17 INFO - 'tpaint', 09:20:17 INFO - 'sessionrestore', 09:20:17 INFO - 'sessionrestore_no_auto_restore', 09:20:17 INFO - 'tabpaint']}, 09:20:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:20:17 INFO - 'ts_paint', 09:20:17 INFO - 'tpaint', 09:20:17 INFO - 'sessionrestore', 09:20:17 INFO - 'sessionrestore_no_auto_restore', 09:20:17 INFO - 'tabpaint']}, 09:20:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:20:17 INFO - 'ts_paint', 09:20:17 INFO - 'tpaint', 09:20:17 INFO - 'sessionrestore', 09:20:17 INFO - 'sessionrestore_no_auto_restore', 09:20:17 INFO - 'tabpaint']}, 09:20:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:20:17 INFO - 'tests': ['a11yr', 09:20:17 INFO - 'ts_paint', 09:20:17 INFO - 'tpaint', 09:20:17 INFO - 'sessionrestore', 09:20:17 INFO - 'sessionrestore_no_auto_restore', 09:20:17 INFO - 'tabpaint']}, 09:20:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:20:17 INFO - 'tests': ['a11yr', 09:20:17 INFO - 'ts_paint', 09:20:17 INFO - 'tpaint', 09:20:17 INFO - 'sessionrestore', 09:20:17 INFO - 'sessionrestore_no_auto_restore', 09:20:17 INFO - 'tabpaint']}, 09:20:17 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:20:17 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:20:17 INFO - 'bloom_basic_ref']}, 09:20:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:20:17 INFO - 'tests': ['tsvgx', 09:20:17 INFO - 'tsvgr_opacity', 09:20:17 INFO - 'tart', 09:20:17 INFO - 'tscrollx', 09:20:17 INFO - 'cart', 09:20:17 INFO - 'tsvg_static']}, 09:20:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:20:17 INFO - 'tsvgr_opacity', 09:20:17 INFO - 'tart', 09:20:17 INFO - 'tscrollx', 09:20:17 INFO - 'cart', 09:20:17 INFO - 'tsvg_static']}, 09:20:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:20:17 INFO - 'talos_options': ['--disable-e10s'], 09:20:17 INFO - 'tests': ['tp5o']}, 09:20:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:20:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:20:17 INFO - 'talos_options': ['--disable-e10s', 09:20:17 INFO - '--xperf_path', 09:20:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:20:17 INFO - 'tests': ['tp5n']}, 09:20:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:20:17 INFO - 'talos_options': ['--xperf_path', 09:20:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:20:17 INFO - 'tests': ['tp5n']}}, 09:20:17 INFO - 'talos.zip': {'path': '', 09:20:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:20:17 INFO - Running post-action listener: _resource_record_post_action 09:20:17 INFO - [mozharness: 2017-04-24 16:20:17.299235Z] Finished populate-webroot step (success) 09:20:17 INFO - [mozharness: 2017-04-24 16:20:17.299369Z] Running create-virtualenv step. 09:20:17 INFO - Running pre-action listener: _resource_record_pre_action 09:20:17 INFO - Running main action method: create_virtualenv 09:20:17 INFO - Creating virtualenv /builds/slave/test/build/venv 09:20:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:20:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:20:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:20:17 INFO - Using real prefix '/tools/python27' 09:20:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:20:18 INFO - Installing distribute.............................................................................................................................................................................................done. 09:20:20 INFO - Installing pip.................done. 09:20:20 INFO - Return code: 0 09:20:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:20:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:20:21 INFO - Reading from file tmpfile_stdout 09:20:21 INFO - Output received: 09:20:21 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 09:20:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fc13b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc16768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff869da97d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9f1d30>, '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 0x10f917db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9e6be8>, '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.AbU0xuG7Q5/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.AgrjoJPR53/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 09:20:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:20:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:20:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AbU0xuG7Q5/Render', 09:20:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:21 INFO - 'HOME': '/Users/cltbld', 09:20:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:21 INFO - 'LOGNAME': 'cltbld', 09:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:21 INFO - 'MOZ_NO_REMOTE': '1', 09:20:21 INFO - 'NO_EM_RESTART': '1', 09:20:21 INFO - 'PAGER': '/bin/cat', 09:20:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:21 INFO - 'PWD': '/builds/slave/test', 09:20:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:21 INFO - 'SHELL': '/bin/bash', 09:20:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrjoJPR53/Listeners', 09:20:21 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 09:20:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:21 INFO - 'USER': 'cltbld', 09:20:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:21 INFO - 'XPC_FLAGS': '0x0', 09:20:21 INFO - 'XPC_SERVICE_NAME': '0', 09:20:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:22 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 09:20:22 INFO - Cleaning up... 09:20:22 INFO - Return code: 0 09:20:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:20: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')]} 09:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20: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')]} 09:20:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:22 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 0x10fc13b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc16768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff869da97d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9f1d30>, '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 0x10f917db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9e6be8>, '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.AbU0xuG7Q5/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.AgrjoJPR53/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 09:20:22 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 09:20:22 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 09:20:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AbU0xuG7Q5/Render', 09:20:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:22 INFO - 'HOME': '/Users/cltbld', 09:20:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:22 INFO - 'LOGNAME': 'cltbld', 09:20:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:22 INFO - 'MOZ_NO_REMOTE': '1', 09:20:22 INFO - 'NO_EM_RESTART': '1', 09:20:22 INFO - 'PAGER': '/bin/cat', 09:20:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:22 INFO - 'PWD': '/builds/slave/test', 09:20:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:22 INFO - 'SHELL': '/bin/bash', 09:20:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrjoJPR53/Listeners', 09:20:22 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 09:20:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:22 INFO - 'USER': 'cltbld', 09:20:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:22 INFO - 'XPC_FLAGS': '0x0', 09:20:22 INFO - 'XPC_SERVICE_NAME': '0', 09:20:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:22 INFO - Downloading/unpacking psutil>=3.1.1 09:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:20:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:20:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:20:26 INFO - Installing collected packages: psutil 09:20:26 INFO - Running setup.py install for psutil 09:20:26 INFO - building 'psutil._psutil_osx' extension 09:20:26 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 09:20:27 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 09:20:27 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 09:20:27 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 09:20:27 INFO - building 'psutil._psutil_posix' extension 09:20:27 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 09:20:27 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:20:27 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:20:27 INFO - ^ 09:20:27 INFO - 1 warning generated. 09:20:27 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 09:20:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:20:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:20:27 INFO - Successfully installed psutil 09:20:27 INFO - Cleaning up... 09:20:27 INFO - Return code: 0 09:20:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:20:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fc13b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc16768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff869da97d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9f1d30>, '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 0x10f917db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9e6be8>, '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.AbU0xuG7Q5/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.AgrjoJPR53/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 09:20:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:20:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:20:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AbU0xuG7Q5/Render', 09:20:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:27 INFO - 'HOME': '/Users/cltbld', 09:20:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:27 INFO - 'LOGNAME': 'cltbld', 09:20:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:27 INFO - 'MOZ_NO_REMOTE': '1', 09:20:27 INFO - 'NO_EM_RESTART': '1', 09:20:27 INFO - 'PAGER': '/bin/cat', 09:20:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:27 INFO - 'PWD': '/builds/slave/test', 09:20:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:27 INFO - 'SHELL': '/bin/bash', 09:20:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrjoJPR53/Listeners', 09:20:27 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 09:20:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:27 INFO - 'USER': 'cltbld', 09:20:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:27 INFO - 'XPC_FLAGS': '0x0', 09:20:27 INFO - 'XPC_SERVICE_NAME': '0', 09:20:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:28 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:30 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:20:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:20:30 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:20:30 INFO - Installing collected packages: mozsystemmonitor 09:20:30 INFO - Running setup.py install for mozsystemmonitor 09:20:30 INFO - Successfully installed mozsystemmonitor 09:20:30 INFO - Cleaning up... 09:20:31 INFO - Return code: 0 09:20:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:20:31 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')]} 09:20:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:31 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')]} 09:20:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:31 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 0x10fc13b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc16768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff869da97d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9f1d30>, '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 0x10f917db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9e6be8>, '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.AbU0xuG7Q5/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.AgrjoJPR53/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 09:20:31 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 09:20:31 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 09:20:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AbU0xuG7Q5/Render', 09:20:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:31 INFO - 'HOME': '/Users/cltbld', 09:20:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:31 INFO - 'LOGNAME': 'cltbld', 09:20:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:31 INFO - 'MOZ_NO_REMOTE': '1', 09:20:31 INFO - 'NO_EM_RESTART': '1', 09:20:31 INFO - 'PAGER': '/bin/cat', 09:20:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:31 INFO - 'PWD': '/builds/slave/test', 09:20:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:31 INFO - 'SHELL': '/bin/bash', 09:20:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrjoJPR53/Listeners', 09:20:31 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 09:20:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:31 INFO - 'USER': 'cltbld', 09:20:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:31 INFO - 'XPC_FLAGS': '0x0', 09:20:31 INFO - 'XPC_SERVICE_NAME': '0', 09:20:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:31 INFO - Downloading/unpacking jsonschema==2.5.1 09:20:31 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 09:20:31 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 09:20:31 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 09:20:31 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 09:20:31 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 09:20:31 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 09:20:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:20:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:20: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 09:20: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 09:20: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 09:20: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 09:20: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 09:20: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 09:20:34 INFO - Downloading functools32-3.2.3-2.tar.gz 09:20:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:20:34 INFO - warning: no files found matching '*.txt' 09:20:34 INFO - no previously-included directories found matching 'build' 09:20:34 INFO - no previously-included directories found matching 'dist' 09:20:34 INFO - no previously-included directories found matching '.git*' 09:20:34 INFO - Installing collected packages: jsonschema, functools32 09:20:34 INFO - Running setup.py install for functools32 09:20:34 INFO - warning: no files found matching '*.txt' 09:20:34 INFO - no previously-included directories found matching 'build' 09:20:34 INFO - no previously-included directories found matching 'dist' 09:20:34 INFO - no previously-included directories found matching '.git*' 09:20:34 INFO - Successfully installed jsonschema functools32 09:20:34 INFO - Cleaning up... 09:20:34 INFO - Return code: 0 09:20:34 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fc13b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc16768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff869da97d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9f1d30>, '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 0x10f917db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9e6be8>, '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.AbU0xuG7Q5/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.AgrjoJPR53/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 09:20:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 09:20:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 09:20:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AbU0xuG7Q5/Render', 09:20:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:34 INFO - 'HOME': '/Users/cltbld', 09:20:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:34 INFO - 'LOGNAME': 'cltbld', 09:20:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:34 INFO - 'MOZ_NO_REMOTE': '1', 09:20:34 INFO - 'NO_EM_RESTART': '1', 09:20:34 INFO - 'PAGER': '/bin/cat', 09:20:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:34 INFO - 'PWD': '/builds/slave/test', 09:20:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:34 INFO - 'SHELL': '/bin/bash', 09:20:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrjoJPR53/Listeners', 09:20:34 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 09:20:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:34 INFO - 'USER': 'cltbld', 09:20:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:34 INFO - 'XPC_FLAGS': '0x0', 09:20:34 INFO - 'XPC_SERVICE_NAME': '0', 09:20:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:34 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:20:34 INFO - Cleaning up... 09:20:34 INFO - Return code: 0 09:20:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fc13b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc16768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff869da97d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9f1d30>, '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 0x10f917db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9e6be8>, '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.AbU0xuG7Q5/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.AgrjoJPR53/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 09:20:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:20:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:20:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AbU0xuG7Q5/Render', 09:20:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:34 INFO - 'HOME': '/Users/cltbld', 09:20:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:34 INFO - 'LOGNAME': 'cltbld', 09:20:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:34 INFO - 'MOZ_NO_REMOTE': '1', 09:20:34 INFO - 'NO_EM_RESTART': '1', 09:20:34 INFO - 'PAGER': '/bin/cat', 09:20:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:34 INFO - 'PWD': '/builds/slave/test', 09:20:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:34 INFO - 'SHELL': '/bin/bash', 09:20:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrjoJPR53/Listeners', 09:20:34 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 09:20:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:34 INFO - 'USER': 'cltbld', 09:20:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:34 INFO - 'XPC_FLAGS': '0x0', 09:20:34 INFO - 'XPC_SERVICE_NAME': '0', 09:20:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:35 INFO - Downloading/unpacking blobuploader==1.2.4 09:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:37 INFO - Downloading blobuploader-1.2.4.tar.gz 09:20:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:20:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:20:38 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:38 INFO - Downloading docopt-0.6.1.tar.gz 09:20:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:20:39 INFO - Installing collected packages: blobuploader, requests, docopt 09:20:39 INFO - Running setup.py install for blobuploader 09:20:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:20:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:20:39 INFO - Running setup.py install for requests 09:20:39 INFO - Running setup.py install for docopt 09:20:39 INFO - Successfully installed blobuploader requests docopt 09:20:39 INFO - Cleaning up... 09:20:40 INFO - Return code: 0 09:20:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:40 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 0x10fc13b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc16768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff869da97d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9f1d30>, '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 0x10f917db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9e6be8>, '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.AbU0xuG7Q5/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.AgrjoJPR53/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 09:20:40 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 09:20:40 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 09:20:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AbU0xuG7Q5/Render', 09:20:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:40 INFO - 'HOME': '/Users/cltbld', 09:20:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:40 INFO - 'LOGNAME': 'cltbld', 09:20:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:40 INFO - 'MOZ_NO_REMOTE': '1', 09:20:40 INFO - 'NO_EM_RESTART': '1', 09:20:40 INFO - 'PAGER': '/bin/cat', 09:20:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:40 INFO - 'PWD': '/builds/slave/test', 09:20:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:40 INFO - 'SHELL': '/bin/bash', 09:20:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrjoJPR53/Listeners', 09:20:40 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 09:20:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:40 INFO - 'USER': 'cltbld', 09:20:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:40 INFO - 'XPC_FLAGS': '0x0', 09:20:40 INFO - 'XPC_SERVICE_NAME': '0', 09:20:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:20:40 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-QMKd9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:20:40 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-00Lnts-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:20:40 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-kzUPFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:20:40 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-kx5_TE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:20:40 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-8y61Cr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:20:40 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-WRnDP2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:20:40 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-PV0OCb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:20:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:20:40 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-V1agjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:20:41 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-G4M38B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:20:41 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-2cTvUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:20:41 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-SiweOD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:20:41 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-wevDkI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:20:41 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-EjFTNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:20:41 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-sb0VZS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:41 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-7x7tvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:20:41 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-WL9Ur8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:20:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:20:41 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-wgvfDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:20:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:20:42 INFO - Running setup.py install for manifestparser 09:20:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:20:42 INFO - Running setup.py install for mozcrash 09:20:42 INFO - Running setup.py install for mozdebug 09:20:42 INFO - Running setup.py install for mozdevice 09:20:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:20:42 INFO - Running setup.py install for mozfile 09:20:42 INFO - Running setup.py install for mozhttpd 09:20:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:20:42 INFO - Running setup.py install for mozinfo 09:20:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:20:43 INFO - Running setup.py install for mozInstall 09:20:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:20:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:20:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:20:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:20:43 INFO - Running setup.py install for mozleak 09:20:43 INFO - Running setup.py install for mozlog 09:20:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:20:43 INFO - Running setup.py install for moznetwork 09:20:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:20:43 INFO - Running setup.py install for mozprocess 09:20:43 INFO - Running setup.py install for mozprofile 09:20:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:20:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:20:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:20:43 INFO - Running setup.py install for mozrunner 09:20:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:20:44 INFO - Running setup.py install for mozscreenshot 09:20:44 INFO - Running setup.py install for moztest 09:20:44 INFO - Running setup.py install for mozversion 09:20:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:20:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:20:44 INFO - Cleaning up... 09:20:44 INFO - Return code: 0 09:20:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fc13b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc16768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff869da97d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9f1d30>, '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 0x10f917db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9e6be8>, '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.AbU0xuG7Q5/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.AgrjoJPR53/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 09:20:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:20:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:20:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AbU0xuG7Q5/Render', 09:20:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:44 INFO - 'HOME': '/Users/cltbld', 09:20:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:44 INFO - 'LOGNAME': 'cltbld', 09:20:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:44 INFO - 'MOZ_NO_REMOTE': '1', 09:20:44 INFO - 'NO_EM_RESTART': '1', 09:20:44 INFO - 'PAGER': '/bin/cat', 09:20:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:44 INFO - 'PWD': '/builds/slave/test', 09:20:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:44 INFO - 'SHELL': '/bin/bash', 09:20:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrjoJPR53/Listeners', 09:20:44 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 09:20:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:44 INFO - 'USER': 'cltbld', 09:20:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:44 INFO - 'XPC_FLAGS': '0x0', 09:20:44 INFO - 'XPC_SERVICE_NAME': '0', 09:20:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:20:44 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-8WmKu0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:20:44 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:20:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:20:44 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-_XwQCs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:20:45 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)) 09:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:20:45 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-mdUGug-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:20:45 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)) 09:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:20:45 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-uCBTbf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:20:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 09:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:20:45 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-LxA6hW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:20:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:20:45 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-OoEnY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:20:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:20:45 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-nwKQjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:20:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:20:45 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-ykfjoS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:20:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:20:45 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-VBDq1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:20:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:20:45 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-hZtBYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:20:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:20:45 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-pGe_ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:20:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:20:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:20:46 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-satomz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:20:46 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)) 09:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:20:46 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-Ynsaid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:20:46 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)) 09:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:20:46 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-v8rALx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:46 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-UJ2m9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:20:46 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-vxF2BK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:20:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:20:46 INFO - Running setup.py (path:/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/pip-SqAf2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:20:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:20:46 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:20:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:20:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:20:49 INFO - Downloading blessings-1.6.tar.gz 09:20:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:20:49 INFO - Installing collected packages: blessings 09:20:49 INFO - Running setup.py install for blessings 09:20:49 INFO - Successfully installed blessings 09:20:49 INFO - Cleaning up... 09:20:49 INFO - Return code: 0 09:20:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:20:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:20:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:20:49 INFO - Reading from file tmpfile_stdout 09:20:49 INFO - Current package versions: 09:20:49 INFO - blessings == 1.6 09:20:49 INFO - blobuploader == 1.2.4 09:20:49 INFO - docopt == 0.6.1 09:20:49 INFO - functools32 == 3.2.3-2 09:20:49 INFO - jsonschema == 2.5.1 09:20:49 INFO - manifestparser == 1.1 09:20:49 INFO - mozInstall == 1.12 09:20:49 INFO - mozcrash == 1.0 09:20:49 INFO - mozdebug == 0.1 09:20:49 INFO - mozdevice == 0.50 09:20:49 INFO - mozfile == 1.2 09:20:49 INFO - mozhttpd == 0.7 09:20:49 INFO - mozinfo == 0.9 09:20:49 INFO - mozleak == 0.1 09:20:49 INFO - mozlog == 3.4 09:20:49 INFO - moznetwork == 0.27 09:20:49 INFO - mozprocess == 0.25 09:20:49 INFO - mozprofile == 0.28 09:20:49 INFO - mozrunner == 6.13 09:20:49 INFO - mozscreenshot == 0.1 09:20:49 INFO - mozsystemmonitor == 0.3 09:20:49 INFO - moztest == 0.8 09:20:49 INFO - mozversion == 1.4 09:20:49 INFO - psutil == 3.1.1 09:20:49 INFO - requests == 1.2.3 09:20:49 INFO - wsgiref == 0.1.2 09:20:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:20:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:20:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fc13b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc16768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff869da97d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9f1d30>, '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 0x10f917db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9e6be8>, '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.AbU0xuG7Q5/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.AgrjoJPR53/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 09:20:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:20:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:20:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AbU0xuG7Q5/Render', 09:20:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:49 INFO - 'HOME': '/Users/cltbld', 09:20:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:49 INFO - 'LOGNAME': 'cltbld', 09:20:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:49 INFO - 'MOZ_NO_REMOTE': '1', 09:20:49 INFO - 'NO_EM_RESTART': '1', 09:20:49 INFO - 'PAGER': '/bin/cat', 09:20:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:49 INFO - 'PWD': '/builds/slave/test', 09:20:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:49 INFO - 'SHELL': '/bin/bash', 09:20:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrjoJPR53/Listeners', 09:20:49 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 09:20:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:49 INFO - 'USER': 'cltbld', 09:20:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:49 INFO - 'XPC_FLAGS': '0x0', 09:20:49 INFO - 'XPC_SERVICE_NAME': '0', 09:20:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:50 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)) 09:20:50 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)) 09:20:50 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)) 09:20:50 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)) 09:20:50 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)) 09:20:50 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)) 09:20:50 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)) 09:20:50 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)) 09:20:50 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)) 09:20:50 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)) 09:20:50 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)) 09:20:50 INFO - Cleaning up... 09:20:50 INFO - Return code: 0 09:20:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:20:50 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')]} 09:20:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:20:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:50 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')]} 09:20:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:20:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:20:50 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 0x10fc13b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fc16768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff869da97d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9f1d30>, '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 0x10f917db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9e6be8>, '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.AbU0xuG7Q5/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.AgrjoJPR53/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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 09:20:50 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 09:20:50 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 09:20:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AbU0xuG7Q5/Render', 09:20:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:20:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:20:50 INFO - 'HOME': '/Users/cltbld', 09:20:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:20:50 INFO - 'LOGNAME': 'cltbld', 09:20:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:20:50 INFO - 'MOZ_NO_REMOTE': '1', 09:20:50 INFO - 'NO_EM_RESTART': '1', 09:20:50 INFO - 'PAGER': '/bin/cat', 09:20:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:20:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:20:50 INFO - 'PWD': '/builds/slave/test', 09:20:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:20:50 INFO - 'SHELL': '/bin/bash', 09:20:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrjoJPR53/Listeners', 09:20:50 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 09:20:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:20:50 INFO - 'USER': 'cltbld', 09:20:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:20:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:20:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:20:50 INFO - 'XPC_FLAGS': '0x0', 09:20:50 INFO - 'XPC_SERVICE_NAME': '0', 09:20:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:20:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:20:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:20:50 INFO - Cleaning up... 09:20:50 INFO - Return code: 0 09:20:50 INFO - Running post-action listener: _resource_record_post_action 09:20:50 INFO - Running post-action listener: _start_resource_monitoring 09:20:50 INFO - Starting resource monitoring. 09:20:50 INFO - [mozharness: 2017-04-24 16:20:50.420372Z] Finished create-virtualenv step (success) 09:20:50 INFO - [mozharness: 2017-04-24 16:20:50.421343Z] Running install step. 09:20:50 INFO - Running pre-action listener: _resource_record_pre_action 09:20:50 INFO - Running main action method: install 09:20:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:20:50 INFO - Reading from file tmpfile_stdout 09:20:50 INFO - Detecting whether we're running mozinstall >=1.0... 09:20:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:20:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:20:50 INFO - Reading from file tmpfile_stdout 09:20:50 INFO - Output received: 09:20:50 INFO - Usage: mozinstall [options] installer 09:20:50 INFO - Options: 09:20:50 INFO - -h, --help show this help message and exit 09:20:50 INFO - -d DEST, --destination=DEST 09:20:50 INFO - Directory to install application into. [default: 09:20:50 INFO - "/builds/slave/test"] 09:20:50 INFO - --app=APP Application being installed. [default: firefox] 09:20:50 INFO - mkdir: /builds/slave/test/build/application 09:20:50 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'] 09:20:50 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 09:21:10 INFO - Reading from file tmpfile_stdout 09:21:10 INFO - Output received: 09:21:10 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:21:10 INFO - Running post-action listener: _resource_record_post_action 09:21:10 INFO - [mozharness: 2017-04-24 16:21:10.522984Z] Finished install step (success) 09:21:10 INFO - [mozharness: 2017-04-24 16:21:10.523112Z] Running run-tests step. 09:21:10 INFO - Running pre-action listener: _resource_record_pre_action 09:21:10 INFO - Running main action method: run_tests 09:21:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:21:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:21:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:21:10 INFO - 2017-04-24 09:21:10.537 screenresolution[1625:7405] starting screenresolution argv=screenresolution get 09:21:10 INFO - 2017-04-24 09:21:10.540 screenresolution[1625:7405] Display 0: 1600x1200x32@60 09:21:10 INFO - 2017-04-24 09:21:10.546 screenresolution[1626:7408] starting screenresolution argv=screenresolution list 09:21:10 INFO - Available Modes on Display 0 09:21:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:21:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:21:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:21:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:21:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:21:10 INFO - Intel Iris: 09:21:10 INFO - Chipset Model: Intel Iris 09:21:10 INFO - Type: GPU 09:21:10 INFO - Bus: Built-In 09:21:10 INFO - VRAM (Dynamic, Max): 1536 MB 09:21:10 INFO - Vendor: Intel (0x8086) 09:21:10 INFO - Device ID: 0x0a2e 09:21:10 INFO - Revision ID: 0x0009 09:21:10 INFO - Displays: 09:21:10 INFO - Display: 09:21:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:21:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:21:10 INFO - Display Serial Number: 1600x1200 60 09:21:10 INFO - Main Display: Yes 09:21:10 INFO - Mirror: Off 09:21:10 INFO - Online: Yes 09:21:10 INFO - Rotation: Supported 09:21:10 INFO - Return code: 0 09:21:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:21:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:21:10 INFO - Python 2.7.3 09:21:10 INFO - Return code: 0 09:21:10 INFO - grabbing minidump binary from tooltool 09:21:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:21:10 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f9f1d30>, '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 0x10f917db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f9e6be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:21:10 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:21:10 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:21:10 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 09:21:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:21:10 INFO - Return code: 0 09:21:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:21:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:21:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:21:10 INFO - ENV: RUST_BACKTRACE is now 1 09:21:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:21:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:21:10 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/ZeMDxTkHR0maK5SSw8mNVA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0308', '--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 09:21:10 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/ZeMDxTkHR0maK5SSw8mNVA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0308 --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 09:21:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.AbU0xuG7Q5/Render', 09:21:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:21:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:21:10 INFO - 'HOME': '/Users/cltbld', 09:21:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:21:10 INFO - 'LOGNAME': 'cltbld', 09:21:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:21:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:21:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:21:10 INFO - 'MOZ_NO_REMOTE': '1', 09:21:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:21:10 INFO - 'NO_EM_RESTART': '1', 09:21:10 INFO - 'PAGER': '/bin/cat', 09:21:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:21:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:21:10 INFO - 'PWD': '/builds/slave/test', 09:21:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:21:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:21:10 INFO - 'RUST_BACKTRACE': '1', 09:21:10 INFO - 'SHELL': '/bin/bash', 09:21:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AgrjoJPR53/Listeners', 09:21:10 INFO - 'TMPDIR': '/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/', 09:21:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:21:10 INFO - 'USER': 'cltbld', 09:21:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:21:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:21:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:21:10 INFO - 'XPC_FLAGS': '0x0', 09:21:10 INFO - 'XPC_SERVICE_NAME': '0', 09:21:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:21:10 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/ZeMDxTkHR0maK5SSw8mNVA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0308', '--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 09:21:11 INFO - mozversion application_buildid: 20170424075425 09:21:11 INFO - mozversion application_changeset: 62a2d3693579fc77b1c510984ae471a860d03302 09:21:11 INFO - mozversion application_display_name: Nightly 09:21:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:21:11 INFO - mozversion application_name: Firefox 09:21:11 INFO - mozversion application_remotingname: firefox 09:21:11 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:21:11 INFO - mozversion application_vendor: Mozilla 09:21:11 INFO - mozversion application_version: 55.0a1 09:21:11 INFO - mozversion platform_buildid: 20170424075425 09:21:11 INFO - mozversion platform_changeset: 62a2d3693579fc77b1c510984ae471a860d03302 09:21:11 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:21:11 INFO - mozversion platform_version: 55.0a1 09:21:11 INFO - using testdate: 1493050871 09:21:11 INFO - actual date: 1493050871 09:21:11 INFO - starting webserver on 'localhost:49243' 09:21:11 INFO - SUITE-START | Running 2 tests 09:21:11 INFO - TEST-START | dromaeo_css 09:21:11 INFO - operating with platform_type : mac_ 09:21:11 INFO - Initialising browser for dromaeo_css test... 09:21:11 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/tmpQy74Kc/profile http://localhost:49243/getInfo.html) 09:21:14 INFO - PID 1636 | 2017-04-24 09:21:14.166 plugin-container[1638:7593] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9743, name = 'com.apple.tsm.portname' 09:21:14 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:21:14 INFO - PID 1636 | 2017-04-24 09:21:14.169 plugin-container[1638:7593] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4917, name = 'com.apple.CFPasteboardClient' 09:21:14 INFO - PID 1636 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:21:14 INFO - PID 1636 | 2017-04-24 09:21:14.169 plugin-container[1638:7593] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:21:14 INFO - PID 1636 | __metrics Screen width/height:1600/1200 09:21:14 INFO - PID 1636 | colorDepth:24 09:21:14 INFO - PID 1636 | Browser inner width/height: 1024/689 09:21:14 INFO - PID 1636 | __metrics 09:21:14 ERROR - PID 1636 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 09:21:15 INFO - TEST-INFO | 1636: exit 0 09:21:15 INFO - Browser initialized. 09:21:15 INFO - Running cycle 1/1 for dromaeo_css test... 09:21:15 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/tmpQy74Kc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:21:17 INFO - PID 1639 | 2017-04-24 09:21:17.893 plugin-container[1643:7782] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x4447, name = 'com.apple.tsm.portname' 09:21:17 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:21:17 INFO - PID 1639 | 2017-04-24 09:21:17.894 plugin-container[1643:7782] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x9a0b, name = 'com.apple.CFPasteboardClient' 09:21:17 INFO - PID 1639 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:21:17 INFO - PID 1639 | 2017-04-24 09:21:17.894 plugin-container[1643:7782] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:21:27 INFO - PID 1639 | RSS: Main: 236515328 09:21:27 INFO - PID 1639 | 09:24:31 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 09:24:33 INFO - PID 1639 | RSS: Main: 252096512 09:24:33 INFO - PID 1639 | 09:26:15 INFO - PID 1639 | ************************* 09:26:15 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 09:26:15 INFO - PID 1639 | 09:26:15 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:26:15 INFO - PID 1639 | Full stack: 09:26:15 INFO - PID 1639 | ************************* 09:26:15 INFO - PID 1639 | ************************* 09:26:15 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 09:26:15 INFO - PID 1639 | 09:26:15 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:26:15 INFO - PID 1639 | Full stack: 09:26:15 INFO - PID 1639 | ************************* 09:26:15 INFO - PID 1639 | ************************* 09:26:15 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 09:26:15 INFO - PID 1639 | 09:26:15 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:26:15 INFO - PID 1639 | Full stack: 09:26:15 INFO - PID 1639 | ************************* 09:26:15 INFO - PID 1639 | ************************* 09:26:15 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 09:26:15 INFO - PID 1639 | 09:26:15 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:26:15 INFO - PID 1639 | Full stack: 09:26:15 INFO - PID 1639 | ************************* 09:27:35 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 09:27:35 INFO - PID 1639 | RSS: Main: 258789376 09:27:35 INFO - PID 1639 | 09:30:37 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 09:30:38 INFO - PID 1639 | RSS: Main: 266649600 09:30:38 INFO - PID 1639 | 09:33:39 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 09:33:40 INFO - PID 1639 | RSS: Main: 260116480 09:33:40 INFO - PID 1639 | 09:36:43 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 09:36:43 INFO - PID 1639 | RSS: Main: 273199104 09:36:43 INFO - PID 1639 | 09:39:45 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 09:39:45 INFO - PID 1639 | RSS: Main: 267743232 09:39:45 INFO - PID 1639 | 09:39:45 INFO - PID 1639 | __start_tp_report 09:39:45 INFO - PID 1639 | _x_x_mozilla_page_load 09:39:45 INFO - PID 1639 | _x_x_mozilla_page_load_details 09:39:45 INFO - PID 1639 | |i|pagename|runs| 09:39:45 INFO - PID 1639 | |0;dojo.html;3629.110867837382;3638.1814091829333;3657.652523010313;3671.7246206534514;3682.484452176694;4830.9275360869615;5898.705064746756;6103.701349646945;6238.500919926406;6262.40507151821;6161.938380616192;6174.289956654986;6187.5668703190795;6250.1249825024415;6252.749890004406;5392.164214546751;5447.801483673606;5487.204355368469;5553.111502159655;5567.3040869891265;5590.552755779528;5616.410276920926;5617.410171931929;5625.099984002561;5625.8593535161535;5424.755885985141;5532.723363831792;5536.280283563111;5538.6399884007415;5541.445855414487;5499.872526132133;5511.696856672881;5530.308711411074;5540.141278101901;5543.833684989457;5388.46115388458;5440.455954404528;5464.12573988164;5488.91766623501;5538.667679939216;6108.2813625860135;6111.816645500642;6210.378962103799;6226.190595222637;6243.1883855099;6724.394804467622;6774.932250677529;6779.62712050837;6780.254172041121;6798.728050877959;6843.794686159423;6904.4821638377325;6906.930930690729;6918.861622767567;6927.134108236471;6237.500999919996;6262.029385445263;6303.180586523723;6393.328700486429;6406.679666016727;6951.200611929592;6993.055937448481;6996;7008.264132266038;7022.683979220948;5540.335159780771;6325.652089135142;6502;6524.836879078061;6541.771038013741;6754.5609535380045;6782.016607591871;6817.522773405814;6838.14523184602;6867.519273650796;6502.382273683992;6544.541882068304;6606.240282367493;6734.528582999241;6762.391384775394;6672.5329226953645;6770.458363330922;6781.694823732944;6812.216595091628;6814.48891333152;5370.194470829407;5380.435054319319;5387.919181212285;5390.757415916293;5435.537979271806;4733.668643194943;4765.547273009059;4796.2805579162705;4825.806967721252;4827.444843843003;6212.596181248205;6220.34686357935;6302.527310451735;6328.525360597973;6365.809025729235;6821.522493425512;6832;6860.588364698134;6872.072270243553;6872.278410766898;4989.351384320015;5810.825675229666;6297.307296197415;6320.020396838498;6326.177596912372;5145.202493613421;5823.184754134425;5875.3243377012195;6004.42957918997;6056.00075987466;7031.437485001187;7043.2604576518725;7053.647317633995;7054.224035356209;7060.8940865886025;6774.525783195326;6786.626735529593;6838.897416538656;6844.657767111525;6854.657267136524;6718.462522998246;6810.897836532555;6942.652867356713;6973.023776671169;7025.964870175821;5590.720463976866;6769.424598908951;6776.15298087739;6782.69477873487;6793.72825086991;6358.586691865014;6620.437262832713;6836.965815171091;6857.005734168418;6874.759383421556;6556.3443655634055;6631.63526006055;6646.667666616747;6653;6654.367835055662;6386.201724784402;6453.45145662624;6497.057926600522;6635.170603674541;6644.269130395749;5354.170103633943;6479.935200647933;6497.220333560003;6513.739450422119;6529;6629.569078009914;6658.5671931324305;6658.667066646745;6663.933360666331;6678.332166783282;6280.874382512233;6346.238451385863;6492.967535162483;6506.3818937200895;6521.739130434729 09:39:45 INFO - PID 1639 | |1;ext.html;676.3912478769107;750.9299248570785;837.1795640272533;1039.9220058495614;1271.2054965646478;37103.62896371039;38230;38264.617353826456;38296.61703382965;38432;38734.61265387345;38812;39114;39156;39298.803505982505;6588.374104460068;8068.193180681944;8312.958435207816;8570.914290857074;8571.528565928871;8566.014908285533;8608.096149904264;8627.43921645091;8654.177853103945;8667.133286671315;8608.354373421987;8675.869861952044;8676.349273804459;8696.17386348299;8707.912920870805;8608.354373421987;8637.740867773977;8646.999999999969;8655.134486551326;8663;8543.700970466067;8588.269997050258;8608.354373422018;8611.526366049864;8622.482651040958;38076.809615951744;38149.427758583646;38156;38204.61795382039;38228.808855955824;2886.336142687173;3375.4936759486272;3583;3617.2946275476293;3656.6160553141804;27604.89580416781;28595;30688.693113068806;30690.23274418135;30734.38531229363;3101.5192645139814;3182.9363412731614;3188.5854838871032;3192.122166404234;3203.1511649412923;257473;294757;296564;306653;310315.8968410332;52518;52542.211866821264;52828.73585632047;52846;53012.20481692778;53052.20421693678;54080.459195407544;54197;54722.084727034366;54826.88798340061;14066.015378923377;14086.718265634834;14122.152670839783;14125.223112728898;14151.575452736435;11183.608573699881;11252.480915076523;11266.267692599955;11274.7181320466;11275.718107047389;11518.481668324945;14050.789238161437;14103.78844317336;14113.435462581587;14145.858541414455;6186.938130618726;6201.224846894138;6215.96892015537;6219.968900155561;6235.875282494416;980.5244456438621;1007.7581380468635;1046.5081411736471;1059.6873922192972;1083.7182332593425;22412.88793556022;23672;24609;24826.627600586005;24832.5033499329;1126.3354620773619;1127.7688073944985;1146.644540192543;1162.023899924051;1162.9127815413879;11181.496832642551;12419.75160496785;12594.055445841599;12633.052521060774;12702.682432939066;279544;280198;282646;282963;283160;54023.72988135113;54251;54273.91452170935;54278.45721542813;54541.72729136329;1350.2978451205317;1524.3216768538116;1547.7059358721806;1555.2301610702548;1561.8984765990174;24146.517069658155;24171.75828241695;24329.27012189637;24364.26907192787;24426;37683.05792355213;37750;37848.43227351537;37949.81025094857;37988.81005594954;220836;267917.86862379167;268378;268877;269506;35789.82105089458;36164.4575331365;36753.63246367609;36806.26387472182;36966.815165923996;45946.77026614846;45965.08069838651;45994.620161395214;46014.309785353915;47123;30785.92249271265;31092.533611995386;31446;31804.68195318017;31961.840190798895;29766;30531.9313824024;30816.229594260323;30878;31436;31391;31560.842195788875;31969.360612788078;32394.838025810663;32413.18967025843;26156.869215653798;30926;31732.841335793175;32416.83791581027;32784;20147.79852201518;22854.918867133758;24381.878090609433;24392.87803560971;25242.990280388578 09:39:45 INFO - PID 1639 | |2;jquery.html;388.67157252121956;435.7254929394483;438.6929149595284;450.1110307143391;462.9560341430077;20293.695594566074;21536.676949845765;22199.1120355186;22369.10523579059;22448.88775556124;21748;22508.66237006442;22930.197443089495;23191.304260872203;23443.1794887179;6110.3278639349855;6134.969325153368;6385.680715964207;6390.370455533855;6418.069379939906;6096.146539484475;6267.185265915447;6273;6274.4353008229255;6284.057391391282;5338;6152.077188421727;6153.984592542225;6196.039613859859;6225.564210505267;6021.638701677892;6193.721282542297;6222.377762223764;6228.22147231596;6232.345603711613;5337.226102215196;5476.17857321401;5554.1391084381585;5564.4991950724625;5573.052581061189;26917.865410673017;27074.646267686538;27211.863940680367;27290.727092729016;27714.5842812358;2230.464688474771;2279.623862062758;2296.448852275442;2297.873616951067;2300.4363930836885;17004.574885627957;17222.827771722248;17363.82636173635;17576.209070591725;17719;2105.6734257417884;2123.3968353892865;2192.199847055829;2194.7476040255415;2195.4621117826077;120236;145028;145421.2728936359;146537.80193297108;146913;12274.693132671755;12533.561325353568;12741.36293185337;12770.744585108247;12821.935890320488;16285.430009949594;16309.755353669705;16352.018878867306;16358.591035223977;16368;8486.702965396182;8743.256823170103;8767.25478334336;8776.956115219384;8860.202581767671;8200.58997050145;8212;8222.83554328922;8362.247397734232;8383.622736976851;7652.349550288288;7703.345215656732;7721.498102623312;7752.4573279869865;7762.379009679212;2121.4590279478634;2136.5620047890147;2138.101997161196;2139.775323591032;2158.169104894627;985.1675334342469;987.693814917378;997.9301448898508;1022.4274406332478;1047.9625171080575;21036.579268414545;21337.546182189246;21509.67735483969;21590.892045539673;21636.918154092233;833.8332333533317;1047.0733400940223;1047.8009178256107;1062.9946850265699;1064.7923654887377;10404.58381664725;10959.56161753521;11057.22599418033;11123;11149.832752508719;515803;516025;517023.4148829307;519941;520238;109732;124582;129214.35392822976;129475.35262323817;130305;1198.9460474278678;1218.7623413434474;1232.679503329123;1249.1568191470903;1252.8684488128615;19529;22374.216902408338;22660.546789064458;22967.88516057409;23015.65476517887;47676.523234767206;51810;54604.726976364866;54924.725376372866;55793.32620021406;69778.30221697719;70547.29452705407;70740.64629677024;71282.28717712757;71813;7973.840523189388;8927.285817134743;9111.952125505652;9129.087091290818;9285.767855803659;10731;14810.555683329518;14874;15031.699366012837;15105.924470377578;12086.879131208576;12106.213096148722;12175.939120304341;12326.691832704255;12421.44103515362;11678.182527223013;11709.004734597655;11726.472308745957;11962.641120766391;11964;12452.252864828139;12515.123941324384;12550.1842380245;12762;12793.168444051107;8963.193312601898;9087.772805679911;9161.908380916106;9315.34792564514;9328.440293582407;12075.215111017756;12171.695707607381;12340.876591234331;12390.442430090849;12451.066170037102 09:39:45 INFO - PID 1639 | |3;mootools.html;1273.1851614966417;1377.6073818961597;1394.8047273381721;1420.7442660321137;1426.97859532107;10576.841347379795;11270.380129092908;11369;12003.75992480151;12167.634970950885;11807.291562506256;12105;12107.334096624681;12138.393080345992;12178.756424871497;2526.3684078980255;2589.896404143832;2590.7150213476502;2591.0931174089105;2598.051711125435;2504.561701702204;2553.8212325137247;2559.8480683692414;2561.884715187821;2562.295368773593;2178.9564208715815;2505.1983365323103;2550.7194208637034;2558.104663367825;2558.4371438283547;2488.738682438345;2517.446161844391;2543.605741110131;2547.707013693412;2552.553303171947;2455.2143314139485;2535.657686212356;2540.809439292042;2542.4660821227562;2565.846049237033;11930;11983.340916249603;12008.339541325224;12064.276143431334;12086.395680216043;6380.277325122237;6599.142111525519;6605.9339406605795;6607.933920660828;6617.867642647168;4032.5362583303004;4392.89017774555;4441.400410944513;4488.236999710057;4497.168023915586;1237.449335045905;1257.5849969510132;1292.65744577687;1295.1322613848745;1304.7586196553573;14253.714925701635;14628.926855365655;16961.745573816403;17145.914270428693;17159.82840171595;4858.951410485921;5744.540436765049;5746.712664366765;5889.4993925515955;5956.106584012433;12482.687932801753;12513.93743031279;12598.433070511848;12633;12639.11526193176;6770.796876093725;6775;6789.5586786859685;6791.049253104569;6852.109225800614;6046.546509011841;6077.270727512727;6223.533235007392;6232.968835155795;6238.157848690369;3767.4348847672522;4100.851761506783;4485.170243504962;4509.143262780061;4516.16450956574;1287.6008437384442;1310.9381401065168;1312.3175948506723;1323.4772264955288;1325.6089453611207;792.5165648954134;798.5727635714865;817.8323443694028;826.4710585225461;849.9277561407226;6236.688165591702;6286.497080233662;6437.130987316746;6472.579282346726;6558.114654521674;590.8995470769979;601.7382438639206;604.2748701558148;606.5602438232335;610.8198081565948;3701.3152566775234;3926.3521518949055;3962.40563915415;3986.242613903349;4346.434963454793;14858.851411485746;15324.23378831054;15401.691966160613;15421.383144674312;15437;13730.313484325743;14052.36764345607;14747.18890461035;15081.54755357341;15344.462943796914;8524.445911015764;8602.311815054905;8692.217700406994;8768;8794.42836215644;6946.5137440378685;7018.894716579358;7196.568205907663;7224.349808517259;7351.4118870489165;13604.183748975092;13949.442022318994;14047.367868446148;14051.508197213048;14233.857661423668;11954.940225298818;13915.512957046454;13990.440382384591;14071.718565628425;14273;9687.370320929118;9793.02069793015;9888.258380621626;9897.455639939872;9920.652777152765;7772.844543108993;10653.627123050655;10989.835152472879;10992.340459572131;11000.064994475239;9136.26909847224;9186.540672966192;9296.07039296065;9347.971723110588;9486.098820612031;8448.957755211184;9083.227925626396;9098.681546145854;9145.359824812465;9154.67958621445;8200.589970501333;8376.413651044368;8411.45325553837;8460.323174146177;8501.617427215666;4958;5988.461038506555;6048.334683184758;6177.536684748572;6258.468030217483;5493.862653433696;5962.582619216613;6181.474574661204;6267.843303917439;6294.842628934313 09:39:45 INFO - PID 1639 | |4;prototype.html;377.56202804746493;411.9855805046822;415.78387196244023;418.7445658148527;430.96121349078595;5467.863303417416;6232.875342493147;6344.143540622014;6401.391867772566;6406.871862562746;4542.454905411347;5931.492066029816;6119.908201376972;6220;6224.751009959597;3889.533256009269;4311.978440107795;4677.6257899367965;4721.527847215285;4731.81072757091;3882.514685664292;4720.881977950545;4724.929126063112;4739.857804265877;4758.738269395182;4337.566243375653;4502.504724480321;4512.210363186446;4518.344839998198;4519.254323036695;4064.593540645941;4219.51475580306;4468.664850136252;4501.054778496536;4550.431196100488;3902.536548794202;3926.391409331558;3933.331333673282;3939.4984185042704;3943.2704949584418;4641;5498.752556134984;5814.476697097281;6049.969750151221;6092.451679348836;4678.906421871578;5366;5405.837824865261;5434.3207099112615;5449.264349312832;5837.678927658977;6123.2652081750475;6702.095217145672;6710.563813352116;6710.865782684368;3738.9904725723904;4090.670532077057;4400.559944005606;4460.1525710114975;4462.263726485126;6080.726367313438;6865.759698410531;6892.758753443605;6994.965025174842;7018;3751.381022131318;4427.535108813592;4505.954940450619;4515.284192007082;4521.231390663529;3466.2894106708063;4416.80124394403;4583.220852455091;4590.875235567308;4591.058832939239;4544.795484203152;4969.503049695074;5216.426193118754;5357.5446087082255;5429.56563474921;5939.22790037301;6624.687656171914;6651.966740166268;6653.170378145952;6703.631300278532;1440.7406666799866;1506.9171195584347;1567.1694002178863;1567.5924259692563;1574.9370025199094;965.6089283840056;1030.9278350515542;1034.591336422109;1034.984475232872;1041.8124737547314;5929.318128415288;5935.50708702346;6215.285242197115;6218.409251121137;6250.218722659668;5737.963023126813;5768.711564421762;6877.243503214642;6912.861742765217;6947.89578156328;5040.722760248148;6152;6198.9151898417595;6281.152044474029;6327.620342779448;3576.338377400189;3593.1735700788963;3613.2231570212007;3640.4539319102346;3649.5255616770182;6291.084967581243;6591.703373348211;6802.455803535705;7145.035420218204;7161.820954476179;7080;7131.25121862197;7140.92859071413;7166.928330716731;7197.676104575306;5887.705614719247;6477.740890364427;6609.6376391581325;7202.4238060954995;7213.6032518212005;5790.420957904176;6358.618482891041;6527.281998980204;6904.482163837632;6984.895226571504;5809.564282678732;6104.145419641165;6211.689415529296;6847.794566163023;6882.69027893736;6272.686365681607;7047.929520704727;7234.865714614096;7262.854742905218;7265.600391978492;3784.375578029594;4548.0216105993995;4549.363089167586;4561.064981678815;4563.589276964956;5314.4951229633125;5728.713564321684;6873.312668733087;6995.475339349671;7061.752838650623;5906.312627754275;6736.595804251565;6756.223034351113;6757.797266082025;6763.004913550612;6448.967755161382;6693.966530167318;6748.797536073729;6753.15585551806;6755.973208037471;5622.550195984393;6513.381228783258;6526.641034742945;6547.672616369067;6618.8345291368105;6122.571420000557;6499.642519661464;6649.966750166412;6726.125603671687;6764.797056088325;5992.490638295793;6540.313267106885;6552;6571.441427478718;6587.901181482377 09:39:45 INFO - PID 1639 | |5;yui.html;830.1490971753948;837.3761547647;848.3298194426402;859.912211053018;871.599064430362;14385.496507622236;14997;15991;16283;16325.510234692949;15188.392464301442;16756.66486670266;16995.660086798256;17099.145042747874;17223.655526889455;968.3512046928539;976.4239098931629;994.3834822410116;998.7802683409639;1001.6694490818049;965.7923546437514;971.8493633486821;980.9558569864338;980.9754756131118;984.6307634637011;1014.8325526288154;1028.9176865850752;1029.6653587584065;1031.5461197073264;1034.5034383495927;879.7140929197973;994.820932232198;1011.9374656610603;1024.1806554756165;1033.1992705653142;692.4114502672738;733.1495465260326;753.7663324369408;760.2891296637662;761.2235519769804;15208.391664333414;15228.390864365412;15236.314365853563;15348.309326080353;15490.845091549165;16339.59151021234;16393.180340982904;16580.6683866322;16742.656028156067;16796.076215808127;11784.646460606196;13445.462181512728;13562.86437135626;13913.234772087531;13917.443302267897;3391.1522119470133;3417.5044618530424;3420.7776494527775;3423.058658868806;3423.6747508986605;122996.38501807523;123171.3841430796;123982;124114;124589.37705311507;10780.892191078146;10921.781564368668;11855.881441185651;11991.160618756603;11993.64019079429;19923.10346034432;20105.29631462892;20368.796312036986;20407.591848162952;20414.38756837297;6916.1700595927805;7480.3641690456925;7565.054368203974;7719.961400192963;7751.961240193763;3260.6576309487637;3768.4347347898033;3818.4272359145793;3824.101336185994;3828.5405751310022;3687.4468829675225;4305.870823875289;4821.879453013633;4881.902361952741;4896.632752543574;968.1867231525412;989.6338354808767;1006.4464544500496;1007.8740157480315;1015.97460063499;556.4880310114704;604.0221706984609;611.8959776837949;622.0762168180248;634.9396807303299;10044.748881278027;10917.945410273056;11475.368854713071;11796.46915888787;11936.940315298541;489.43959166753865;642.5590960407046;651.9022146677942;658.9967050164719;674.430106559956;5388.191771234267;5648.293963254593;5661.179129026351;5695.345035320908;5782.45066718661;61976;67983;86844.56577717197;93609;94688;79112;81461;81998.18001820025;82004.76992845112;82811.7578236327;70305.64847175732;75859;77066.61466692631;77712;77938;11926.224795388272;12367.701391353778;12372.381380930738;12418.503259869503;12437.93781031089;39558.40662390009;39755;39801.80099099486;40044.79977600093;40970.77087687374;52691.73654131858;52758.736206318725;53292.59371687601;53446.465535345706;53463.4653653474;13826.446942122202;15524.456644017406;15799.921000394925;15960.042397456189;16867.325306987583;17932.372366967094;18400;18418.171182297097;18484.907575462035;18597.34909278169;13893.166410015432;16679;16866.072366019496;17250.913745431193;17260.568485787957;16575;16935.491935241964;17040.06279654631;17140.40008599693;17185.31258749636;15470.5358839235;15560.766588500956;15702.607434814221;16721.996680199227;16735.91632041832;9551.761205969906;10678.57285708563;10779.461026948778;11012.119030477383;11144.60993865211;12065.517379304729;12091.57679481214;12115.273083614658;12183.025357971519;12320.630381088582 09:39:45 INFO - PID 1639 | __end_tp_report 09:39:45 INFO - PID 1639 | __start_cc_report 09:39:45 INFO - PID 1639 | _x_x_mozilla_cycle_collect,414 09:39:45 INFO - PID 1639 | __end_cc_report 09:39:45 INFO - PID 1639 | __startTimestamp1493051985838__endTimestamp 09:39:45 INFO - PID 1639 | 09:39:45 INFO - PID 1639 | ------- Summary: start ------- 09:39:45 INFO - PID 1639 | Number of tests: 6 09:39:45 INFO - PID 1639 | 09:39:45 INFO - PID 1639 | [#0] dojo.html Cycles:165 Average:6199.43 Median:6406.68 stddev:749.89 (11.7%) stddev-sans-first:724.57 09:39:45 INFO - PID 1639 | Values: 3629.1 3638.2 3657.7 3671.7 3682.5 4830.9 5898.7 6103.7 6238.5 6262.4 6161.9 6174.3 6187.6 6250.1 6252.7 5392.2 5447.8 5487.2 5553.1 5567.3 5590.6 5616.4 5617.4 5625.1 5625.9 5424.8 5532.7 5536.3 5538.6 5541.4 5499.9 5511.7 5530.3 5540.1 5543.8 5388.5 5440.5 5464.1 5488.9 5538.7 6108.3 6111.8 6210.4 6226.2 6243.2 6724.4 6774.9 6779.6 6780.3 6798.7 6843.8 6904.5 6906.9 6918.9 6927.1 6237.5 6262.0 6303.2 6393.3 6406.7 6951.2 6993.1 6996.0 7008.3 7022.7 5540.3 6325.7 6502.0 6524.8 6541.8 6754.6 6782.0 6817.5 6838.1 6867.5 6502.4 6544.5 6606.2 6734.5 6762.4 6672.5 6770.5 6781.7 6812.2 6814.5 5370.2 5380.4 5387.9 5390.8 5435.5 4733.7 4765.5 4796.3 4825.8 4827.4 6212.6 6220.3 6302.5 6328.5 6365.8 6821.5 6832.0 6860.6 6872.1 6872.3 4989.4 5810.8 6297.3 6320.0 6326.2 5145.2 5823.2 5875.3 6004.4 6056.0 7031.4 7043.3 7053.6 7054.2 7060.9 6774.5 6786.6 6838.9 6844.7 6854.7 6718.5 6810.9 6942.7 6973.0 7026.0 5590.7 6769.4 6776.2 6782.7 6793.7 6358.6 6620.4 6837.0 6857.0 6874.8 6556.3 6631.6 6646.7 6653.0 6654.4 6386.2 6453.5 6497.1 6635.2 6644.3 5354.2 6479.9 6497.2 6513.7 6529.0 6629.6 6658.6 6658.7 6663.9 6678.3 6280.9 6346.2 6493.0 6506.4 6521.7 09:39:45 INFO - PID 1639 | 09:39:45 INFO - PID 1639 | [#1] ext.html Cycles:180 Average:43568.30 Median:31965.60 stddev:72928.90 (228.1%) stddev-sans-first:73062.37 09:39:45 INFO - PID 1639 | Values: 676.4 750.9 837.2 1039.9 1271.2 37103.6 38230.0 38264.6 38296.6 38432.0 38734.6 38812.0 39114.0 39156.0 39298.8 6588.4 8068.2 8313.0 8570.9 8571.5 8566.0 8608.1 8627.4 8654.2 8667.1 8608.4 8675.9 8676.3 8696.2 8707.9 8608.4 8637.7 8647.0 8655.1 8663.0 8543.7 8588.3 8608.4 8611.5 8622.5 38076.8 38149.4 38156.0 38204.6 38228.8 2886.3 3375.5 3583.0 3617.3 3656.6 27604.9 28595.0 30688.7 30690.2 30734.4 3101.5 3182.9 3188.6 3192.1 3203.2 257473.0 294757.0 296564.0 306653.0 310315.9 52518.0 52542.2 52828.7 52846.0 53012.2 53052.2 54080.5 54197.0 54722.1 54826.9 14066.0 14086.7 14122.2 14125.2 14151.6 11183.6 11252.5 11266.3 11274.7 11275.7 11518.5 14050.8 14103.8 14113.4 14145.9 6186.9 6201.2 6216.0 6220.0 6235.9 980.5 1007.8 1046.5 1059.7 1083.7 22412.9 23672.0 24609.0 24826.6 24832.5 1126.3 1127.8 1146.6 1162.0 1162.9 11181.5 12419.8 12594.1 12633.1 12702.7 279544.0 280198.0 282646.0 282963.0 283160.0 54023.7 54251.0 54273.9 54278.5 54541.7 1350.3 1524.3 1547.7 1555.2 1561.9 24146.5 24171.8 24329.3 24364.3 24426.0 37683.1 37750.0 37848.4 37949.8 37988.8 220836.0 267917.9 268378.0 268877.0 269506.0 35789.8 36164.5 36753.6 36806.3 36966.8 45946.8 45965.1 45994.6 46014.3 47123.0 30785.9 31092.5 31446.0 31804.7 31961.8 29766.0 30531.9 30816.2 30878.0 31436.0 31391.0 31560.8 31969.4 32394.8 32413.2 26156.9 30926.0 31732.8 32416.8 32784.0 20147.8 22854.9 24381.9 24392.9 25243.0 09:39:45 INFO - PID 1639 | 09:39:45 INFO - PID 1639 | [#2] jquery.html Cycles:180 Average:34055.14 Median:22584.60 stddev:87588.59 (387.8%) stddev-sans-first:87797.83 09:39:45 INFO - PID 1639 | Values: 388.7 435.7 438.7 450.1 463.0 20293.7 21536.7 22199.1 22369.1 22448.9 21748.0 22508.7 22930.2 23191.3 23443.2 6110.3 6135.0 6385.7 6390.4 6418.1 6096.1 6267.2 6273.0 6274.4 6284.1 5338.0 6152.1 6154.0 6196.0 6225.6 6021.6 6193.7 6222.4 6228.2 6232.3 5337.2 5476.2 5554.1 5564.5 5573.1 26917.9 27074.6 27211.9 27290.7 27714.6 2230.5 2279.6 2296.4 2297.9 2300.4 17004.6 17222.8 17363.8 17576.2 17719.0 2105.7 2123.4 2192.2 2194.7 2195.5 120236.0 145028.0 145421.3 146537.8 146913.0 12274.7 12533.6 12741.4 12770.7 12821.9 16285.4 16309.8 16352.0 16358.6 16368.0 8486.7 8743.3 8767.3 8777.0 8860.2 8200.6 8212.0 8222.8 8362.2 8383.6 7652.3 7703.3 7721.5 7752.5 7762.4 2121.5 2136.6 2138.1 2139.8 2158.2 985.2 987.7 997.9 1022.4 1048.0 21036.6 21337.5 21509.7 21590.9 21636.9 833.8 1047.1 1047.8 1063.0 1064.8 10404.6 10959.6 11057.2 11123.0 11149.8 515803.0 516025.0 517023.4 519941.0 520238.0 109732.0 124582.0 129214.4 129475.4 130305.0 1198.9 1218.8 1232.7 1249.2 1252.9 19529.0 22374.2 22660.5 22967.9 23015.7 47676.5 51810.0 54604.7 54924.7 55793.3 69778.3 70547.3 70740.6 71282.3 71813.0 7973.8 8927.3 9112.0 9129.1 9285.8 10731.0 14810.6 14874.0 15031.7 15105.9 12086.9 12106.2 12175.9 12326.7 12421.4 11678.2 11709.0 11726.5 11962.6 11964.0 12452.3 12515.1 12550.2 12762.0 12793.2 8963.2 9087.8 9161.9 9315.3 9328.4 12075.2 12171.7 12340.9 12390.4 12451.1 09:39:45 INFO - PID 1639 | 09:39:45 INFO - PID 1639 | [#3] mootools.html Cycles:180 Average:7178.64 Median:3846.89 stddev:4559.74 (118.5%) stddev-sans-first:4550.93 09:39:45 INFO - PID 1639 | Values: 1273.2 1377.6 1394.8 1420.7 1427.0 10576.8 11270.4 11369.0 12003.8 12167.6 11807.3 12105.0 12107.3 12138.4 12178.8 2526.4 2589.9 2590.7 2591.1 2598.1 2504.6 2553.8 2559.8 2561.9 2562.3 2179.0 2505.2 2550.7 2558.1 2558.4 2488.7 2517.4 2543.6 2547.7 2552.6 2455.2 2535.7 2540.8 2542.5 2565.8 11930.0 11983.3 12008.3 12064.3 12086.4 6380.3 6599.1 6605.9 6607.9 6617.9 4032.5 4392.9 4441.4 4488.2 4497.2 1237.4 1257.6 1292.7 1295.1 1304.8 14253.7 14628.9 16961.7 17145.9 17159.8 4859.0 5744.5 5746.7 5889.5 5956.1 12482.7 12513.9 12598.4 12633.0 12639.1 6770.8 6775.0 6789.6 6791.0 6852.1 6046.5 6077.3 6223.5 6233.0 6238.2 3767.4 4100.9 4485.2 4509.1 4516.2 1287.6 1310.9 1312.3 1323.5 1325.6 792.5 798.6 817.8 826.5 849.9 6236.7 6286.5 6437.1 6472.6 6558.1 590.9 601.7 604.3 606.6 610.8 3701.3 3926.4 3962.4 3986.2 4346.4 14858.9 15324.2 15401.7 15421.4 15437.0 13730.3 14052.4 14747.2 15081.5 15344.5 8524.4 8602.3 8692.2 8768.0 8794.4 6946.5 7018.9 7196.6 7224.3 7351.4 13604.2 13949.4 14047.4 14051.5 14233.9 11954.9 13915.5 13990.4 14071.7 14273.0 9687.4 9793.0 9888.3 9897.5 9920.7 7772.8 10653.6 10989.8 10992.3 11000.1 9136.3 9186.5 9296.1 9348.0 9486.1 8449.0 9083.2 9098.7 9145.4 9154.7 8200.6 8376.4 8411.5 8460.3 8501.6 4958.0 5988.5 6048.3 6177.5 6258.5 5493.9 5962.6 6181.5 6267.8 6294.8 09:39:45 INFO - PID 1639 | 09:39:45 INFO - PID 1639 | [#4] prototype.html Cycles:180 Average:5318.34 Median:5930.41 stddev:1692.38 (28.5%) stddev-sans-first:1656.00 09:39:45 INFO - PID 1639 | Values: 377.6 412.0 415.8 418.7 431.0 5467.9 6232.9 6344.1 6401.4 6406.9 4542.5 5931.5 6119.9 6220.0 6224.8 3889.5 4312.0 4677.6 4721.5 4731.8 3882.5 4720.9 4724.9 4739.9 4758.7 4337.6 4502.5 4512.2 4518.3 4519.3 4064.6 4219.5 4468.7 4501.1 4550.4 3902.5 3926.4 3933.3 3939.5 3943.3 4641.0 5498.8 5814.5 6050.0 6092.5 4678.9 5366.0 5405.8 5434.3 5449.3 5837.7 6123.3 6702.1 6710.6 6710.9 3739.0 4090.7 4400.6 4460.2 4462.3 6080.7 6865.8 6892.8 6995.0 7018.0 3751.4 4427.5 4506.0 4515.3 4521.2 3466.3 4416.8 4583.2 4590.9 4591.1 4544.8 4969.5 5216.4 5357.5 5429.6 5939.2 6624.7 6652.0 6653.2 6703.6 1440.7 1506.9 1567.2 1567.6 1574.9 965.6 1030.9 1034.6 1035.0 1041.8 5929.3 5935.5 6215.3 6218.4 6250.2 5738.0 5768.7 6877.2 6912.9 6947.9 5040.7 6152.0 6198.9 6281.2 6327.6 3576.3 3593.2 3613.2 3640.5 3649.5 6291.1 6591.7 6802.5 7145.0 7161.8 7080.0 7131.3 7140.9 7166.9 7197.7 5887.7 6477.7 6609.6 7202.4 7213.6 5790.4 6358.6 6527.3 6904.5 6984.9 5809.6 6104.1 6211.7 6847.8 6882.7 6272.7 7047.9 7234.9 7262.9 7265.6 3784.4 4548.0 4549.4 4561.1 4563.6 5314.5 5728.7 6873.3 6995.5 7061.8 5906.3 6736.6 6756.2 6757.8 6763.0 6449.0 6694.0 6748.8 6753.2 6756.0 5622.6 6513.4 6526.6 6547.7 6618.8 6122.6 6499.6 6650.0 6726.1 6764.8 5992.5 6540.3 6552.0 6571.4 6587.9 09:39:45 INFO - PID 1639 | 09:39:45 INFO - PID 1639 | [#5] yui.html Cycles:180 Average:20184.65 Median:19260.23 stddev:27988.25 (145.3%) stddev-sans-first:28029.03 09:39:45 INFO - PID 1639 | Values: 830.1 837.4 848.3 859.9 871.6 14385.5 14997.0 15991.0 16283.0 16325.5 15188.4 16756.7 16995.7 17099.1 17223.7 968.4 976.4 994.4 998.8 1001.7 965.8 971.8 981.0 981.0 984.6 1014.8 1028.9 1029.7 1031.5 1034.5 879.7 994.8 1011.9 1024.2 1033.2 692.4 733.1 753.8 760.3 761.2 15208.4 15228.4 15236.3 15348.3 15490.8 16339.6 16393.2 16580.7 16742.7 16796.1 11784.6 13445.5 13562.9 13913.2 13917.4 3391.2 3417.5 3420.8 3423.1 3423.7 122996.4 123171.4 123982.0 124114.0 124589.4 10780.9 10921.8 11855.9 11991.2 11993.6 19923.1 20105.3 20368.8 20407.6 20414.4 6916.2 7480.4 7565.1 7720.0 7752.0 3260.7 3768.4 3818.4 3824.1 3828.5 3687.4 4305.9 4821.9 4881.9 4896.6 968.2 989.6 1006.4 1007.9 1016.0 556.5 604.0 611.9 622.1 634.9 10044.7 10917.9 11475.4 11796.5 11936.9 489.4 642.6 651.9 659.0 674.4 5388.2 5648.3 5661.2 5695.3 5782.5 61976.0 67983.0 86844.6 93609.0 94688.0 79112.0 81461.0 81998.2 82004.8 82811.8 70305.6 75859.0 77066.6 77712.0 77938.0 11926.2 12367.7 12372.4 12418.5 12437.9 39558.4 39755.0 39801.8 40044.8 40970.8 52691.7 52758.7 53292.6 53446.5 53463.5 13826.4 15524.5 15799.9 15960.0 16867.3 17932.4 18400.0 18418.2 18484.9 18597.3 13893.2 16679.0 16866.1 17250.9 17260.6 16575.0 16935.5 17040.1 17140.4 17185.3 15470.5 15560.8 15702.6 16722.0 16735.9 9551.8 10678.6 10779.5 11012.1 11144.6 12065.5 12091.6 12115.3 12183.0 12320.6 09:39:45 INFO - PID 1639 | -------- Summary: end -------- 09:39:45 INFO - PID 1639 | 09:39:46 INFO - TEST-INFO | 1639: exit 0 09:39:46 INFO - TEST-OK | dromaeo_css | took 1115352ms 09:39:46 INFO - TEST-START | kraken 09:39:46 INFO - operating with platform_type : mac_ 09:39:46 INFO - Initialising browser for kraken test... 09:39:46 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/tmpH0GHxy/profile http://localhost:49243/getInfo.html) 09:39:49 INFO - PID 1651 | 2017-04-24 09:39:49.138 plugin-container[1652:10108] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x923f, name = 'com.apple.tsm.portname' 09:39:49 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:39:49 INFO - PID 1651 | 2017-04-24 09:39:49.141 plugin-container[1652:10108] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x980b, name = 'com.apple.CFPasteboardClient' 09:39:49 INFO - PID 1651 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:39:49 INFO - PID 1651 | 2017-04-24 09:39:49.142 plugin-container[1652:10108] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:39:49 INFO - PID 1651 | __metrics Screen width/height:1600/1200 09:39:49 INFO - PID 1651 | colorDepth:24 09:39:49 INFO - PID 1651 | Browser inner width/height: 1024/689 09:39:49 INFO - PID 1651 | __metrics 09:39:49 ERROR - PID 1651 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3403: TypeError: this.tabs is undefined 09:39:50 INFO - TEST-INFO | 1651: exit 0 09:39:50 INFO - Browser initialized. 09:39:50 INFO - Running cycle 1/1 for kraken test... 09:39:50 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/T/tmpH0GHxy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:39:52 INFO - PID 1653 | 2017-04-24 09:39:52.589 plugin-container[1654:10238] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x933f, name = 'com.apple.tsm.portname' 09:39:52 INFO - PID 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:39:52 INFO - PID 1653 | 2017-04-24 09:39:52.590 plugin-container[1654:10238] *** CFMessagePort: bootstrap_register(): failed 1100 (0x44c) 'Permission denied', port = 0x960b, name = 'com.apple.CFPasteboardClient' 09:39:52 INFO - PID 1653 | See /usr/include/servers/bootstrap_defs.h for the error codes. 09:39:52 INFO - PID 1653 | 2017-04-24 09:39:52.590 plugin-container[1654:10238] Failed to allocate communication port for com.apple.CFPasteboardClient; this is likely due to sandbox restrictions 09:40:02 INFO - PID 1653 | RSS: Main: 237641728 09:40:02 INFO - PID 1653 | 09:40:05 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 09:40:06 INFO - PID 1653 | RSS: Main: 249225216 09:40:06 INFO - PID 1653 | 09:40:09 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 09:40:09 INFO - PID 1653 | RSS: Main: 257687552 09:40:09 INFO - PID 1653 | 09:40:13 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 09:40:13 INFO - PID 1653 | RSS: Main: 260366336 09:40:13 INFO - PID 1653 | 09:40:15 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 09:40:16 INFO - PID 1653 | RSS: Main: 261341184 09:40:16 INFO - PID 1653 | 09:40:18 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:40:19 INFO - PID 1653 | RSS: Main: 263073792 09:40:19 INFO - PID 1653 | 09:40:21 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 09:40:22 INFO - PID 1653 | RSS: Main: 268390400 09:40:22 INFO - PID 1653 | 09:40:25 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 09:40:26 INFO - PID 1653 | RSS: Main: 270053376 09:40:26 INFO - PID 1653 | 09:40:29 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 09:40:29 INFO - PID 1653 | RSS: Main: 269729792 09:40:29 INFO - PID 1653 | 09:40:31 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:40:31 INFO - PID 1653 | RSS: Main: 268976128 09:40:31 INFO - PID 1653 | 09:40:33 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:40:34 INFO - PID 1653 | RSS: Main: 269094912 09:40:34 INFO - PID 1653 | 09:40:36 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:40:36 INFO - PID 1653 | RSS: Main: 268652544 09:40:36 INFO - PID 1653 | 09:40:39 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:40:40 INFO - PID 1653 | RSS: Main: 268750848 09:40:40 INFO - PID 1653 | 09:40:43 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:40:44 INFO - PID 1653 | RSS: Main: 269053952 09:40:44 INFO - PID 1653 | 09:40:46 INFO - PID 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 09:40:46 INFO - PID 1653 | RSS: Main: 270675968 09:40:46 INFO - PID 1653 | 09:40:46 INFO - PID 1653 | __start_tp_report 09:40:46 INFO - PID 1653 | _x_x_mozilla_page_load 09:40:46 INFO - PID 1653 | _x_x_mozilla_page_load_details 09:40:46 INFO - PID 1653 | |i|pagename|runs| 09:40:46 INFO - PID 1653 | |0;ai-astar;117;169;114;116;115;135;170;109;166;168 09:40:46 INFO - PID 1653 | |1;audio-beat-detection;132;107;111;146;109;128;141;95;152;148 09:40:46 INFO - PID 1653 | |2;audio-dft;195;209;210;223;208;208;181;267;239;277 09:40:46 INFO - PID 1653 | |3;audio-fft;85;46;68;114;86;86;61;58;76;59 09:40:46 INFO - PID 1653 | |4;audio-oscillator;89;70;80;72;69;68;88;70;71;88 09:40:46 INFO - PID 1653 | |5;imaging-gaussian-blur;90;90;89;107;91;88;94;88;89;89 09:40:46 INFO - PID 1653 | |6;imaging-darkroom;96;98;96;96;96;96;96;100;97;103 09:40:46 INFO - PID 1653 | |7;imaging-desaturate;94;131;142;95;90;92;95;90;93;95 09:40:46 INFO - PID 1653 | |8;json-parse-financial;47;51;59;67;75;54;52;50;51;50 09:40:46 INFO - PID 1653 | |9;json-stringify-tinderbox;59;60;60;59;63;61;54;56;55;58 09:40:46 INFO - PID 1653 | |10;stanford-crypto-aes;81;84;84;82;83;80;83;82;81;82 09:40:46 INFO - PID 1653 | |11;stanford-crypto-ccm;137;134;147;141;136;140;136;136;185;136 09:40:46 INFO - PID 1653 | |12;stanford-crypto-pbkdf2;183;187;178;177;174;242;231;202;182;179 09:40:46 INFO - PID 1653 | |13;stanford-crypto-sha256-iterative;68;69;68;83;80;85;88;65;53;93 09:40:46 INFO - PID 1653 | __end_tp_report 09:40:46 INFO - PID 1653 | __start_cc_report 09:40:46 INFO - PID 1653 | _x_x_mozilla_cycle_collect,986 09:40:46 INFO - PID 1653 | __end_cc_report 09:40:46 INFO - PID 1653 | __startTimestamp1493052046315__endTimestamp 09:40:46 INFO - PID 1653 | 09:40:46 INFO - PID 1653 | ------- Summary: start ------- 09:40:46 INFO - PID 1653 | Number of tests: 14 09:40:46 INFO - PID 1653 | 09:40:46 INFO - PID 1653 | [#0] ai-astar Cycles:10 Average:137.90 Median:150.50 stddev:26.98 (17.9%) stddev-sans-first:27.53 09:40:46 INFO - PID 1653 | Values: 117.0 169.0 114.0 116.0 115.0 135.0 170.0 109.0 166.0 168.0 09:40:46 INFO - PID 1653 | 09:40:46 INFO - PID 1653 | [#1] audio-beat-detection Cycles:10 Average:126.90 Median:143.50 stddev:20.15 (14.0%) stddev-sans-first:21.28 09:40:46 INFO - PID 1653 | Values: 132.0 107.0 111.0 146.0 109.0 128.0 141.0 95.0 152.0 148.0 09:40:46 INFO - PID 1653 | 09:40:46 INFO - PID 1653 | [#2] audio-dft Cycles:10 Average:221.70 Median:216.50 stddev:30.65 (14.2%) stddev-sans-first:30.95 09:40:46 INFO - PID 1653 | Values: 195.0 209.0 210.0 223.0 208.0 208.0 181.0 267.0 239.0 277.0 09:40:46 INFO - PID 1653 | 09:40:46 INFO - PID 1653 | [#3] audio-fft Cycles:10 Average:73.90 Median:72.00 stddev:19.67 (27.3%) stddev-sans-first:20.45 09:40:46 INFO - PID 1653 | Values: 85.0 46.0 68.0 114.0 86.0 86.0 61.0 58.0 76.0 59.0 09:40:46 INFO - PID 1653 | 09:40:46 INFO - PID 1653 | [#4] audio-oscillator Cycles:10 Average:76.50 Median:76.00 stddev:8.80 (11.6%) stddev-sans-first:8.08 09:40:46 INFO - PID 1653 | Values: 89.0 70.0 80.0 72.0 69.0 68.0 88.0 70.0 71.0 88.0 09:40:46 INFO - PID 1653 | 09:40:46 INFO - PID 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:91.50 Median:89.50 stddev:5.72 (6.4%) stddev-sans-first:6.04 09:40:46 INFO - PID 1653 | Values: 90.0 90.0 89.0 107.0 91.0 88.0 94.0 88.0 89.0 89.0 09:40:46 INFO - PID 1653 | 09:40:46 INFO - PID 1653 | [#6] imaging-darkroom Cycles:10 Average:97.40 Median:96.00 stddev:2.37 (2.5%) stddev-sans-first:2.46 09:40:46 INFO - PID 1653 | Values: 96.0 98.0 96.0 96.0 96.0 96.0 96.0 100.0 97.0 103.0 09:40:46 INFO - PID 1653 | 09:40:46 INFO - PID 1653 | [#7] imaging-desaturate Cycles:10 Average:101.70 Median:93.50 stddev:18.62 (19.9%) stddev-sans-first:19.54 09:40:46 INFO - PID 1653 | Values: 94.0 131.0 142.0 95.0 90.0 92.0 95.0 90.0 93.0 95.0 09:40:46 INFO - PID 1653 | 09:40:46 INFO - PID 1653 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:53.00 stddev:8.90 (16.8%) stddev-sans-first:8.88 09:40:46 INFO - PID 1653 | Values: 47.0 51.0 59.0 67.0 75.0 54.0 52.0 50.0 51.0 50.0 09:40:46 INFO - PID 1653 | 09:40:46 INFO - PID 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:58.50 Median:59.50 stddev:2.80 (4.7%) stddev-sans-first:2.96 09:40:46 INFO - PID 1653 | Values: 59.0 60.0 60.0 59.0 63.0 61.0 54.0 56.0 55.0 58.0 09:40:46 INFO - PID 1653 | 09:40:46 INFO - PID 1653 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:82.50 stddev:1.32 (1.6%) stddev-sans-first:1.32 09:40:46 INFO - PID 1653 | Values: 81.0 84.0 84.0 82.0 83.0 80.0 83.0 82.0 81.0 82.0 09:40:46 INFO - PID 1653 | 09:40:46 INFO - PID 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:142.80 Median:138.50 stddev:15.30 (11.0%) stddev-sans-first:16.08 09:40:46 INFO - PID 1653 | Values: 137.0 134.0 147.0 141.0 136.0 140.0 136.0 136.0 185.0 136.0 09:40:46 INFO - PID 1653 | 09:40:46 INFO - PID 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:193.50 Median:185.00 stddev:24.08 (13.0%) stddev-sans-first:25.24 09:40:46 INFO - PID 1653 | Values: 183.0 187.0 178.0 177.0 174.0 242.0 231.0 202.0 182.0 179.0 09:40:46 INFO - PID 1653 | 09:40:46 INFO - PID 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.20 Median:81.50 stddev:12.47 (15.3%) stddev-sans-first:12.95 09:40:46 INFO - PID 1653 | Values: 68.0 69.0 68.0 83.0 80.0 85.0 88.0 65.0 53.0 93.0 09:40:46 INFO - PID 1653 | -------- Summary: end -------- 09:40:46 INFO - PID 1653 | 09:40:47 INFO - TEST-INFO | 1653: exit 0 09:40:47 INFO - TEST-OK | kraken | took 60875ms 09:40:47 INFO - SUITE-END | took 1176s 09:40:47 INFO - Completed test suite (00:19:36) 09:40:47 INFO - javascript benchmark 09:40:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7849.93263581094, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3629.110867837382, 3638.1814091829333, 3657.652523010313, 3671.7246206534514, 3682.484452176694, 4830.9275360869615, 5898.705064746756, 6103.701349646945, 6238.500919926406, 6262.40507151821, 6161.938380616192, 6174.289956654986, 6187.5668703190795, 6250.1249825024415, 6252.749890004406, 5392.164214546751, 5447.801483673606, 5487.204355368469, 5553.111502159655, 5567.3040869891265, 5590.552755779528, 5616.410276920926, 5617.410171931929, 5625.099984002561, 5625.8593535161535, 5424.755885985141, 5532.723363831792, 5536.280283563111, 5538.6399884007415, 5541.445855414487, 5499.872526132133, 5511.696856672881, 5530.308711411074, 5540.141278101901, 5543.833684989457, 5388.46115388458, 5440.455954404528, 5464.12573988164, 5488.91766623501, 5538.667679939216, 6108.2813625860135, 6111.816645500642, 6210.378962103799, 6226.190595222637, 6243.1883855099, 6724.394804467622, 6774.932250677529, 6779.62712050837, 6780.254172041121, 6798.728050877959, 6843.794686159423, 6904.4821638377325, 6906.930930690729, 6918.861622767567, 6927.134108236471, 6237.500999919996, 6262.029385445263, 6303.180586523723, 6393.328700486429, 6406.679666016727, 6951.200611929592, 6993.055937448481, 6996.0, 7008.264132266038, 7022.683979220948, 5540.335159780771, 6325.652089135142, 6502.0, 6524.836879078061, 6541.771038013741, 6754.5609535380045, 6782.016607591871, 6817.522773405814, 6838.14523184602, 6867.519273650796, 6502.382273683992, 6544.541882068304, 6606.240282367493, 6734.528582999241, 6762.391384775394, 6672.5329226953645, 6770.458363330922, 6781.694823732944, 6812.216595091628, 6814.48891333152, 5370.194470829407, 5380.435054319319, 5387.919181212285, 5390.757415916293, 5435.537979271806, 4733.668643194943, 4765.547273009059, 4796.2805579162705, 4825.806967721252, 4827.444843843003, 6212.596181248205, 6220.34686357935, 6302.527310451735, 6328.525360597973, 6365.809025729235, 6821.522493425512, 6832.0, 6860.588364698134, 6872.072270243553, 6872.278410766898, 4989.351384320015, 5810.825675229666, 6297.307296197415, 6320.020396838498, 6326.177596912372, 5145.202493613421, 5823.184754134425, 5875.3243377012195, 6004.42957918997, 6056.00075987466, 7031.437485001187, 7043.2604576518725, 7053.647317633995, 7054.224035356209, 7060.8940865886025, 6774.525783195326, 6786.626735529593, 6838.897416538656, 6844.657767111525, 6854.657267136524, 6718.462522998246, 6810.897836532555, 6942.652867356713, 6973.023776671169, 7025.964870175821, 5590.720463976866, 6769.424598908951, 6776.15298087739, 6782.69477873487, 6793.72825086991, 6358.586691865014, 6620.437262832713, 6836.965815171091, 6857.005734168418, 6874.759383421556, 6556.3443655634055, 6631.63526006055, 6646.667666616747, 6653.0, 6654.367835055662, 6386.201724784402, 6453.45145662624, 6497.057926600522, 6635.170603674541, 6644.269130395749, 5354.170103633943, 6479.935200647933, 6497.220333560003, 6513.739450422119, 6529.0, 6629.569078009914, 6658.5671931324305, 6658.667066646745, 6663.933360666331, 6678.332166783282, 6280.874382512233, 6346.238451385863, 6492.967535162483, 6506.3818937200895, 6521.739130434729], "value": 6150.846938723066, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [676.3912478769107, 750.9299248570785, 837.1795640272533, 1039.9220058495614, 1271.2054965646478, 37103.62896371039, 38230.0, 38264.617353826456, 38296.61703382965, 38432.0, 38734.61265387345, 38812.0, 39114.0, 39156.0, 39298.803505982505, 6588.374104460068, 8068.193180681944, 8312.958435207816, 8570.914290857074, 8571.528565928871, 8566.014908285533, 8608.096149904264, 8627.43921645091, 8654.177853103945, 8667.133286671315, 8608.354373421987, 8675.869861952044, 8676.349273804459, 8696.17386348299, 8707.912920870805, 8608.354373421987, 8637.740867773977, 8646.999999999969, 8655.134486551326, 8663.0, 8543.700970466067, 8588.269997050258, 8608.354373422018, 8611.526366049864, 8622.482651040958, 38076.809615951744, 38149.427758583646, 38156.0, 38204.61795382039, 38228.808855955824, 2886.336142687173, 3375.4936759486272, 3583.0, 3617.2946275476293, 3656.6160553141804, 27604.89580416781, 28595.0, 30688.693113068806, 30690.23274418135, 30734.38531229363, 3101.5192645139814, 3182.9363412731614, 3188.5854838871032, 3192.122166404234, 3203.1511649412923, 257473.0, 294757.0, 296564.0, 306653.0, 310315.8968410332, 52518.0, 52542.211866821264, 52828.73585632047, 52846.0, 53012.20481692778, 53052.20421693678, 54080.459195407544, 54197.0, 54722.084727034366, 54826.88798340061, 14066.015378923377, 14086.718265634834, 14122.152670839783, 14125.223112728898, 14151.575452736435, 11183.608573699881, 11252.480915076523, 11266.267692599955, 11274.7181320466, 11275.718107047389, 11518.481668324945, 14050.789238161437, 14103.78844317336, 14113.435462581587, 14145.858541414455, 6186.938130618726, 6201.224846894138, 6215.96892015537, 6219.968900155561, 6235.875282494416, 980.5244456438621, 1007.7581380468635, 1046.5081411736471, 1059.6873922192972, 1083.7182332593425, 22412.88793556022, 23672.0, 24609.0, 24826.627600586005, 24832.5033499329, 1126.3354620773619, 1127.7688073944985, 1146.644540192543, 1162.023899924051, 1162.9127815413879, 11181.496832642551, 12419.75160496785, 12594.055445841599, 12633.052521060774, 12702.682432939066, 279544.0, 280198.0, 282646.0, 282963.0, 283160.0, 54023.72988135113, 54251.0, 54273.91452170935, 54278.45721542813, 54541.72729136329, 1350.2978451205317, 1524.3216768538116, 1547.7059358721806, 1555.2301610702548, 1561.8984765990174, 24146.517069658155, 24171.75828241695, 24329.27012189637, 24364.26907192787, 24426.0, 37683.05792355213, 37750.0, 37848.43227351537, 37949.81025094857, 37988.81005594954, 220836.0, 267917.86862379167, 268378.0, 268877.0, 269506.0, 35789.82105089458, 36164.4575331365, 36753.63246367609, 36806.26387472182, 36966.815165923996, 45946.77026614846, 45965.08069838651, 45994.620161395214, 46014.309785353915, 47123.0, 30785.92249271265, 31092.533611995386, 31446.0, 31804.68195318017, 31961.840190798895, 29766.0, 30531.9313824024, 30816.229594260323, 30878.0, 31436.0, 31391.0, 31560.842195788875, 31969.360612788078, 32394.838025810663, 32413.18967025843, 26156.869215653798, 30926.0, 31732.841335793175, 32416.83791581027, 32784.0, 20147.79852201518, 22854.918867133758, 24381.878090609433, 24392.87803560971, 25242.990280388578], "value": 17537.431170891974, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.67157252121956, 435.7254929394483, 438.6929149595284, 450.1110307143391, 462.9560341430077, 20293.695594566074, 21536.676949845765, 22199.1120355186, 22369.10523579059, 22448.88775556124, 21748.0, 22508.66237006442, 22930.197443089495, 23191.304260872203, 23443.1794887179, 6110.3278639349855, 6134.969325153368, 6385.680715964207, 6390.370455533855, 6418.069379939906, 6096.146539484475, 6267.185265915447, 6273.0, 6274.4353008229255, 6284.057391391282, 5338.0, 6152.077188421727, 6153.984592542225, 6196.039613859859, 6225.564210505267, 6021.638701677892, 6193.721282542297, 6222.377762223764, 6228.22147231596, 6232.345603711613, 5337.226102215196, 5476.17857321401, 5554.1391084381585, 5564.4991950724625, 5573.052581061189, 26917.865410673017, 27074.646267686538, 27211.863940680367, 27290.727092729016, 27714.5842812358, 2230.464688474771, 2279.623862062758, 2296.448852275442, 2297.873616951067, 2300.4363930836885, 17004.574885627957, 17222.827771722248, 17363.82636173635, 17576.209070591725, 17719.0, 2105.6734257417884, 2123.3968353892865, 2192.199847055829, 2194.7476040255415, 2195.4621117826077, 120236.0, 145028.0, 145421.2728936359, 146537.80193297108, 146913.0, 12274.693132671755, 12533.561325353568, 12741.36293185337, 12770.744585108247, 12821.935890320488, 16285.430009949594, 16309.755353669705, 16352.018878867306, 16358.591035223977, 16368.0, 8486.702965396182, 8743.256823170103, 8767.25478334336, 8776.956115219384, 8860.202581767671, 8200.58997050145, 8212.0, 8222.83554328922, 8362.247397734232, 8383.622736976851, 7652.349550288288, 7703.345215656732, 7721.498102623312, 7752.4573279869865, 7762.379009679212, 2121.4590279478634, 2136.5620047890147, 2138.101997161196, 2139.775323591032, 2158.169104894627, 985.1675334342469, 987.693814917378, 997.9301448898508, 1022.4274406332478, 1047.9625171080575, 21036.579268414545, 21337.546182189246, 21509.67735483969, 21590.892045539673, 21636.918154092233, 833.8332333533317, 1047.0733400940223, 1047.8009178256107, 1062.9946850265699, 1064.7923654887377, 10404.58381664725, 10959.56161753521, 11057.22599418033, 11123.0, 11149.832752508719, 515803.0, 516025.0, 517023.4148829307, 519941.0, 520238.0, 109732.0, 124582.0, 129214.35392822976, 129475.35262323817, 130305.0, 1198.9460474278678, 1218.7623413434474, 1232.679503329123, 1249.1568191470903, 1252.8684488128615, 19529.0, 22374.216902408338, 22660.546789064458, 22967.88516057409, 23015.65476517887, 47676.523234767206, 51810.0, 54604.726976364866, 54924.725376372866, 55793.32620021406, 69778.30221697719, 70547.29452705407, 70740.64629677024, 71282.28717712757, 71813.0, 7973.840523189388, 8927.285817134743, 9111.952125505652, 9129.087091290818, 9285.767855803659, 10731.0, 14810.555683329518, 14874.0, 15031.699366012837, 15105.924470377578, 12086.879131208576, 12106.213096148722, 12175.939120304341, 12326.691832704255, 12421.44103515362, 11678.182527223013, 11709.004734597655, 11726.472308745957, 11962.641120766391, 11964.0, 12452.252864828139, 12515.123941324384, 12550.1842380245, 12762.0, 12793.168444051107, 8963.193312601898, 9087.772805679911, 9161.908380916106, 9315.34792564514, 9328.440293582407, 12075.215111017756, 12171.695707607381, 12340.876591234331, 12390.442430090849, 12451.066170037102], "value": 10495.042793646597, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1273.1851614966417, 1377.6073818961597, 1394.8047273381721, 1420.7442660321137, 1426.97859532107, 10576.841347379795, 11270.380129092908, 11369.0, 12003.75992480151, 12167.634970950885, 11807.291562506256, 12105.0, 12107.334096624681, 12138.393080345992, 12178.756424871497, 2526.3684078980255, 2589.896404143832, 2590.7150213476502, 2591.0931174089105, 2598.051711125435, 2504.561701702204, 2553.8212325137247, 2559.8480683692414, 2561.884715187821, 2562.295368773593, 2178.9564208715815, 2505.1983365323103, 2550.7194208637034, 2558.104663367825, 2558.4371438283547, 2488.738682438345, 2517.446161844391, 2543.605741110131, 2547.707013693412, 2552.553303171947, 2455.2143314139485, 2535.657686212356, 2540.809439292042, 2542.4660821227562, 2565.846049237033, 11930.0, 11983.340916249603, 12008.339541325224, 12064.276143431334, 12086.395680216043, 6380.277325122237, 6599.142111525519, 6605.9339406605795, 6607.933920660828, 6617.867642647168, 4032.5362583303004, 4392.89017774555, 4441.400410944513, 4488.236999710057, 4497.168023915586, 1237.449335045905, 1257.5849969510132, 1292.65744577687, 1295.1322613848745, 1304.7586196553573, 14253.714925701635, 14628.926855365655, 16961.745573816403, 17145.914270428693, 17159.82840171595, 4858.951410485921, 5744.540436765049, 5746.712664366765, 5889.4993925515955, 5956.106584012433, 12482.687932801753, 12513.93743031279, 12598.433070511848, 12633.0, 12639.11526193176, 6770.796876093725, 6775.0, 6789.5586786859685, 6791.049253104569, 6852.109225800614, 6046.546509011841, 6077.270727512727, 6223.533235007392, 6232.968835155795, 6238.157848690369, 3767.4348847672522, 4100.851761506783, 4485.170243504962, 4509.143262780061, 4516.16450956574, 1287.6008437384442, 1310.9381401065168, 1312.3175948506723, 1323.4772264955288, 1325.6089453611207, 792.5165648954134, 798.5727635714865, 817.8323443694028, 826.4710585225461, 849.9277561407226, 6236.688165591702, 6286.497080233662, 6437.130987316746, 6472.579282346726, 6558.114654521674, 590.8995470769979, 601.7382438639206, 604.2748701558148, 606.5602438232335, 610.8198081565948, 3701.3152566775234, 3926.3521518949055, 3962.40563915415, 3986.242613903349, 4346.434963454793, 14858.851411485746, 15324.23378831054, 15401.691966160613, 15421.383144674312, 15437.0, 13730.313484325743, 14052.36764345607, 14747.18890461035, 15081.54755357341, 15344.462943796914, 8524.445911015764, 8602.311815054905, 8692.217700406994, 8768.0, 8794.42836215644, 6946.5137440378685, 7018.894716579358, 7196.568205907663, 7224.349808517259, 7351.4118870489165, 13604.183748975092, 13949.442022318994, 14047.367868446148, 14051.508197213048, 14233.857661423668, 11954.940225298818, 13915.512957046454, 13990.440382384591, 14071.718565628425, 14273.0, 9687.370320929118, 9793.02069793015, 9888.258380621626, 9897.455639939872, 9920.652777152765, 7772.844543108993, 10653.627123050655, 10989.835152472879, 10992.340459572131, 11000.064994475239, 9136.26909847224, 9186.540672966192, 9296.07039296065, 9347.971723110588, 9486.098820612031, 8448.957755211184, 9083.227925626396, 9098.681546145854, 9145.359824812465, 9154.67958621445, 8200.589970501333, 8376.413651044368, 8411.45325553837, 8460.323174146177, 8501.617427215666, 4958.0, 5988.461038506555, 6048.334683184758, 6177.536684748572, 6258.468030217483, 5493.862653433696, 5962.582619216613, 6181.474574661204, 6267.843303917439, 6294.842628934313], "value": 5373.9485012226205, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.56202804746493, 411.9855805046822, 415.78387196244023, 418.7445658148527, 430.96121349078595, 5467.863303417416, 6232.875342493147, 6344.143540622014, 6401.391867772566, 6406.871862562746, 4542.454905411347, 5931.492066029816, 6119.908201376972, 6220.0, 6224.751009959597, 3889.533256009269, 4311.978440107795, 4677.6257899367965, 4721.527847215285, 4731.81072757091, 3882.514685664292, 4720.881977950545, 4724.929126063112, 4739.857804265877, 4758.738269395182, 4337.566243375653, 4502.504724480321, 4512.210363186446, 4518.344839998198, 4519.254323036695, 4064.593540645941, 4219.51475580306, 4468.664850136252, 4501.054778496536, 4550.431196100488, 3902.536548794202, 3926.391409331558, 3933.331333673282, 3939.4984185042704, 3943.2704949584418, 4641.0, 5498.752556134984, 5814.476697097281, 6049.969750151221, 6092.451679348836, 4678.906421871578, 5366.0, 5405.837824865261, 5434.3207099112615, 5449.264349312832, 5837.678927658977, 6123.2652081750475, 6702.095217145672, 6710.563813352116, 6710.865782684368, 3738.9904725723904, 4090.670532077057, 4400.559944005606, 4460.1525710114975, 4462.263726485126, 6080.726367313438, 6865.759698410531, 6892.758753443605, 6994.965025174842, 7018.0, 3751.381022131318, 4427.535108813592, 4505.954940450619, 4515.284192007082, 4521.231390663529, 3466.2894106708063, 4416.80124394403, 4583.220852455091, 4590.875235567308, 4591.058832939239, 4544.795484203152, 4969.503049695074, 5216.426193118754, 5357.5446087082255, 5429.56563474921, 5939.22790037301, 6624.687656171914, 6651.966740166268, 6653.170378145952, 6703.631300278532, 1440.7406666799866, 1506.9171195584347, 1567.1694002178863, 1567.5924259692563, 1574.9370025199094, 965.6089283840056, 1030.9278350515542, 1034.591336422109, 1034.984475232872, 1041.8124737547314, 5929.318128415288, 5935.50708702346, 6215.285242197115, 6218.409251121137, 6250.218722659668, 5737.963023126813, 5768.711564421762, 6877.243503214642, 6912.861742765217, 6947.89578156328, 5040.722760248148, 6152.0, 6198.9151898417595, 6281.152044474029, 6327.620342779448, 3576.338377400189, 3593.1735700788963, 3613.2231570212007, 3640.4539319102346, 3649.5255616770182, 6291.084967581243, 6591.703373348211, 6802.455803535705, 7145.035420218204, 7161.820954476179, 7080.0, 7131.25121862197, 7140.92859071413, 7166.928330716731, 7197.676104575306, 5887.705614719247, 6477.740890364427, 6609.6376391581325, 7202.4238060954995, 7213.6032518212005, 5790.420957904176, 6358.618482891041, 6527.281998980204, 6904.482163837632, 6984.895226571504, 5809.564282678732, 6104.145419641165, 6211.689415529296, 6847.794566163023, 6882.69027893736, 6272.686365681607, 7047.929520704727, 7234.865714614096, 7262.854742905218, 7265.600391978492, 3784.375578029594, 4548.0216105993995, 4549.363089167586, 4561.064981678815, 4563.589276964956, 5314.4951229633125, 5728.713564321684, 6873.312668733087, 6995.475339349671, 7061.752838650623, 5906.312627754275, 6736.595804251565, 6756.223034351113, 6757.797266082025, 6763.004913550612, 6448.967755161382, 6693.966530167318, 6748.797536073729, 6753.15585551806, 6755.973208037471, 5622.550195984393, 6513.381228783258, 6526.641034742945, 6547.672616369067, 6618.8345291368105, 6122.571420000557, 6499.642519661464, 6649.966750166412, 6726.125603671687, 6764.797056088325, 5992.490638295793, 6540.313267106885, 6552.0, 6571.441427478718, 6587.901181482377], "value": 4798.265265105896, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [830.1490971753948, 837.3761547647, 848.3298194426402, 859.912211053018, 871.599064430362, 14385.496507622236, 14997.0, 15991.0, 16283.0, 16325.510234692949, 15188.392464301442, 16756.66486670266, 16995.660086798256, 17099.145042747874, 17223.655526889455, 968.3512046928539, 976.4239098931629, 994.3834822410116, 998.7802683409639, 1001.6694490818049, 965.7923546437514, 971.8493633486821, 980.9558569864338, 980.9754756131118, 984.6307634637011, 1014.8325526288154, 1028.9176865850752, 1029.6653587584065, 1031.5461197073264, 1034.5034383495927, 879.7140929197973, 994.820932232198, 1011.9374656610603, 1024.1806554756165, 1033.1992705653142, 692.4114502672738, 733.1495465260326, 753.7663324369408, 760.2891296637662, 761.2235519769804, 15208.391664333414, 15228.390864365412, 15236.314365853563, 15348.309326080353, 15490.845091549165, 16339.59151021234, 16393.180340982904, 16580.6683866322, 16742.656028156067, 16796.076215808127, 11784.646460606196, 13445.462181512728, 13562.86437135626, 13913.234772087531, 13917.443302267897, 3391.1522119470133, 3417.5044618530424, 3420.7776494527775, 3423.058658868806, 3423.6747508986605, 122996.38501807523, 123171.3841430796, 123982.0, 124114.0, 124589.37705311507, 10780.892191078146, 10921.781564368668, 11855.881441185651, 11991.160618756603, 11993.64019079429, 19923.10346034432, 20105.29631462892, 20368.796312036986, 20407.591848162952, 20414.38756837297, 6916.1700595927805, 7480.3641690456925, 7565.054368203974, 7719.961400192963, 7751.961240193763, 3260.6576309487637, 3768.4347347898033, 3818.4272359145793, 3824.101336185994, 3828.5405751310022, 3687.4468829675225, 4305.870823875289, 4821.879453013633, 4881.902361952741, 4896.632752543574, 968.1867231525412, 989.6338354808767, 1006.4464544500496, 1007.8740157480315, 1015.97460063499, 556.4880310114704, 604.0221706984609, 611.8959776837949, 622.0762168180248, 634.9396807303299, 10044.748881278027, 10917.945410273056, 11475.368854713071, 11796.46915888787, 11936.940315298541, 489.43959166753865, 642.5590960407046, 651.9022146677942, 658.9967050164719, 674.430106559956, 5388.191771234267, 5648.293963254593, 5661.179129026351, 5695.345035320908, 5782.45066718661, 61976.0, 67983.0, 86844.56577717197, 93609.0, 94688.0, 79112.0, 81461.0, 81998.18001820025, 82004.76992845112, 82811.7578236327, 70305.64847175732, 75859.0, 77066.61466692631, 77712.0, 77938.0, 11926.224795388272, 12367.701391353778, 12372.381380930738, 12418.503259869503, 12437.93781031089, 39558.40662390009, 39755.0, 39801.80099099486, 40044.79977600093, 40970.77087687374, 52691.73654131858, 52758.736206318725, 53292.59371687601, 53446.465535345706, 53463.4653653474, 13826.446942122202, 15524.456644017406, 15799.921000394925, 15960.042397456189, 16867.325306987583, 17932.372366967094, 18400.0, 18418.171182297097, 18484.907575462035, 18597.34909278169, 13893.166410015432, 16679.0, 16866.072366019496, 17250.913745431193, 17260.568485787957, 16575.0, 16935.491935241964, 17040.06279654631, 17140.40008599693, 17185.31258749636, 15470.5358839235, 15560.766588500956, 15702.607434814221, 16721.996680199227, 16735.91632041832, 9551.761205969906, 10678.57285708563, 10779.461026948778, 11012.119030477383, 11144.60993865211, 12065.517379304729, 12091.57679481214, 12115.273083614658, 12183.025357971519, 12320.630381088582], "value": 8014.979288286416, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1535.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 169.0, 114.0, 116.0, 115.0, 135.0, 170.0, 109.0, 166.0, 168.0], "value": 137.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 107.0, 111.0, 146.0, 109.0, 128.0, 141.0, 95.0, 152.0, 148.0], "value": 126.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 209.0, 210.0, 223.0, 208.0, 208.0, 181.0, 267.0, 239.0, 277.0], "value": 221.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 46.0, 68.0, 114.0, 86.0, 86.0, 61.0, 58.0, 76.0, 59.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 80.0, 72.0, 69.0, 68.0, 88.0, 70.0, 71.0, 88.0], "value": 76.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 89.0, 107.0, 91.0, 88.0, 94.0, 88.0, 89.0, 89.0], "value": 91.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 96.0, 100.0, 97.0, 103.0], "value": 97.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 131.0, 142.0, 95.0, 90.0, 92.0, 95.0, 90.0, 93.0, 95.0], "value": 101.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [47.0, 51.0, 59.0, 67.0, 75.0, 54.0, 52.0, 50.0, 51.0, 50.0], "value": 55.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 60.0, 60.0, 59.0, 63.0, 61.0, 54.0, 56.0, 55.0, 58.0], "value": 58.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 84.0, 82.0, 83.0, 80.0, 83.0, 82.0, 81.0, 82.0], "value": 82.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 134.0, 147.0, 141.0, 136.0, 140.0, 136.0, 136.0, 185.0, 136.0], "value": 142.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 187.0, 178.0, 177.0, 174.0, 242.0, 231.0, 202.0, 182.0, 179.0], "value": 193.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 83.0, 80.0, 85.0, 88.0, 65.0, 53.0, 93.0], "value": 75.2, "unit": "score"}]}]} 09:40:47 INFO - Return code: 0 09:40:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:40:47 ERROR - # TBPL SUCCESS # 09:40:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:40:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:40:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:40:47 INFO - 2017-04-24 09:40:47.592 screenresolution[1658:10632] starting screenresolution argv=screenresolution get 09:40:47 INFO - 2017-04-24 09:40:47.594 screenresolution[1658:10632] Display 0: 1600x1200x32@60 09:40:47 INFO - 2017-04-24 09:40:47.600 screenresolution[1659:10635] starting screenresolution argv=screenresolution list 09:40:47 INFO - Available Modes on Display 0 09:40:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:40:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:40:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:40:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:40:47 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:40:47 INFO - Intel Iris: 09:40:47 INFO - Chipset Model: Intel Iris 09:40:47 INFO - Type: GPU 09:40:47 INFO - Bus: Built-In 09:40:47 INFO - VRAM (Dynamic, Max): 1536 MB 09:40:47 INFO - Vendor: Intel (0x8086) 09:40:47 INFO - Device ID: 0x0a2e 09:40:47 INFO - Revision ID: 0x0009 09:40:47 INFO - Displays: 09:40:47 INFO - Display: 09:40:47 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:40:47 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:40:47 INFO - Display Serial Number: 1600x1200 60 09:40:47 INFO - Main Display: Yes 09:40:47 INFO - Mirror: Off 09:40:47 INFO - Online: Yes 09:40:47 INFO - Rotation: Supported 09:40:47 INFO - Return code: 0 09:40:47 INFO - Running post-action listener: _resource_record_post_action 09:40:47 INFO - [mozharness: 2017-04-24 16:40:47.846170Z] Finished run-tests step (success) 09:40:47 INFO - Running post-run listener: _resource_record_post_run 09:40:47 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 39098880; Write bytes: 508114944; Read time: 251; Write time: 1590 09:40:47 INFO - TinderboxPrint: CPU usage
54.0% 09:40:47 INFO - TinderboxPrint: I/O read bytes / time
39,098,880 / 251 09:40:47 INFO - TinderboxPrint: I/O write bytes / time
508,114,944 / 1,590 09:40:47 INFO - TinderboxPrint: CPU idle
2,202.8 (46.0%) 09:40:47 INFO - TinderboxPrint: CPU system
959.8 (20.1%) 09:40:47 INFO - TinderboxPrint: CPU user
1,623.0 (33.9%) 09:40:47 INFO - TinderboxPrint: Swap in / out
247,173,120 / 0 09:40:47 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209254912; Write bytes: 208973824; Read time: 15829; Write time: 453 09:40:47 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 35142144; Write bytes: 296468480; Read time: 224; Write time: 1125 09:40:48 INFO - Running post-run listener: _upload_blobber_files 09:40:48 INFO - Blob upload gear active. 09:40:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:40:48 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 09:40:48 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'] 09:40:48 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 09:40:48 INFO - (blobuploader) - INFO - Open directory for files ... 09:40:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:40:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:40:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:40:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:40:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:40:49 INFO - (blobuploader) - INFO - Done attempting. 09:40:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:40:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:40:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:40:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:40:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:40:50 INFO - (blobuploader) - INFO - Done attempting. 09:40:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:40:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:40:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:40:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:40:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:40:51 INFO - (blobuploader) - INFO - Done attempting. 09:40:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:40:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:40:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:40:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:40:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:40:54 INFO - (blobuploader) - INFO - Done attempting. 09:40:54 INFO - (blobuploader) - INFO - Iteration through files over. 09:40:54 INFO - Return code: 0 09:40:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:40:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:40:54 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8537ee48cd0a22ef3121c7daf5095eebd43b9668e1665a5081aa6a0a467f56c4f4964c808f2a3a181648235afde38316a4d47206906554aa851758cf7f285d31", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2152ec7f69cbc5d3aa507a14eeb9d89eaa6c668a7702fd5b024bd4ad5e99716a4b42fad6a7109fa1cee095243c4394ceba92149cd40bc878f3a20f8c0dbcda1e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58ee8d4555b3bcd1e402b0e448175a793fd615d53cc5cbd55e9ee046ef3a81f805fd097f692672a3f8049a1bbb42bde56e6873fe1de0b86eda210e2b03a92766", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a6e17fa2eb9c60df28f7c58ba9ff5c8f3063822d012f4ba600ea6440e88b6d72ab5732ce3c3409f295e9758ce02e2d0e5e7ca990be218baee9a2dfa4658eaa7"} 09:40:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:40:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:40:54 INFO - Contents: 09:40:54 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8537ee48cd0a22ef3121c7daf5095eebd43b9668e1665a5081aa6a0a467f56c4f4964c808f2a3a181648235afde38316a4d47206906554aa851758cf7f285d31", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2152ec7f69cbc5d3aa507a14eeb9d89eaa6c668a7702fd5b024bd4ad5e99716a4b42fad6a7109fa1cee095243c4394ceba92149cd40bc878f3a20f8c0dbcda1e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58ee8d4555b3bcd1e402b0e448175a793fd615d53cc5cbd55e9ee046ef3a81f805fd097f692672a3f8049a1bbb42bde56e6873fe1de0b86eda210e2b03a92766", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a6e17fa2eb9c60df28f7c58ba9ff5c8f3063822d012f4ba600ea6440e88b6d72ab5732ce3c3409f295e9758ce02e2d0e5e7ca990be218baee9a2dfa4658eaa7"} 09:40:54 INFO - Running post-run listener: copy_logs_to_upload_dir 09:40:54 INFO - Copying logs to upload dir... 09:40:54 INFO - mkdir: /builds/slave/test/build/upload/logs 09:40:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1279.762761 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2017-04-24 09:40:54.386493) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 09:40:54.389911) ========= 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.AbU0xuG7Q5/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.AgrjoJPR53/Listeners TMPDIR=/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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/8537ee48cd0a22ef3121c7daf5095eebd43b9668e1665a5081aa6a0a467f56c4f4964c808f2a3a181648235afde38316a4d47206906554aa851758cf7f285d31", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2152ec7f69cbc5d3aa507a14eeb9d89eaa6c668a7702fd5b024bd4ad5e99716a4b42fad6a7109fa1cee095243c4394ceba92149cd40bc878f3a20f8c0dbcda1e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58ee8d4555b3bcd1e402b0e448175a793fd615d53cc5cbd55e9ee046ef3a81f805fd097f692672a3f8049a1bbb42bde56e6873fe1de0b86eda210e2b03a92766", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a6e17fa2eb9c60df28f7c58ba9ff5c8f3063822d012f4ba600ea6440e88b6d72ab5732ce3c3409f295e9758ce02e2d0e5e7ca990be218baee9a2dfa4658eaa7"} build_url:https://queue.taskcluster.net/v1/task/ZeMDxTkHR0maK5SSw8mNVA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011115 build_url: 'https://queue.taskcluster.net/v1/task/ZeMDxTkHR0maK5SSw8mNVA/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/8537ee48cd0a22ef3121c7daf5095eebd43b9668e1665a5081aa6a0a467f56c4f4964c808f2a3a181648235afde38316a4d47206906554aa851758cf7f285d31", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2152ec7f69cbc5d3aa507a14eeb9d89eaa6c668a7702fd5b024bd4ad5e99716a4b42fad6a7109fa1cee095243c4394ceba92149cd40bc878f3a20f8c0dbcda1e", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/58ee8d4555b3bcd1e402b0e448175a793fd615d53cc5cbd55e9ee046ef3a81f805fd097f692672a3f8049a1bbb42bde56e6873fe1de0b86eda210e2b03a92766", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0a6e17fa2eb9c60df28f7c58ba9ff5c8f3063822d012f4ba600ea6440e88b6d72ab5732ce3c3409f295e9758ce02e2d0e5e7ca990be218baee9a2dfa4658eaa7"}' ========= master_lag: 0.04 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-24 09:40:54.442234) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 09:40:54.442598) ========= 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.AbU0xuG7Q5/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.AgrjoJPR53/Listeners TMPDIR=/var/folders/d6/1wq_728n79bd9134fc4zhpd400000w/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.005210 ========= master_lag: 0.07 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-24 09:40:54.513372) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 09:40:54.513765) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-24 09:40:54.514170) ========= ========= Total master_lag: 0.59 =========