builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0246 starttime: 1493908868.2 results: success (0) buildid: 20170504053521 builduid: d8410388472a4ec8b99645cd291a43dd revision: 0f9c07711141cfa8429c1e28359260c51a11f6ee ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 07:41:08.204091) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 07:41:08.204683) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 07:41:08.205064) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 07:41:08.232858) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 07:41:08.233328) ========= 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.1rKRTDnjv1/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.hKolWtG6p4/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-05-04 07:41:08-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.3M=0.001s 2017-05-04 07:41:08 (18.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.138949 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 07:41:08.398948) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 07:41:08.399572) ========= 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.1rKRTDnjv1/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.hKolWtG6p4/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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.030505 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 07:41:08.454731) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-04 07:41:08.455165) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0f9c07711141cfa8429c1e28359260c51a11f6ee --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 0f9c07711141cfa8429c1e28359260c51a11f6ee --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1rKRTDnjv1/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.hKolWtG6p4/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-05-04 07:41:08,559 truncating revision to first 12 chars 2017-05-04 07:41:08,559 Setting DEBUG logging. 2017-05-04 07:41:08,559 attempt 1/10 2017-05-04 07:41:08,559 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/0f9c07711141?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-04 07:41:10,299 unpacking tar archive at: mozilla-beta-0f9c07711141/testing/mozharness/ program finished with exit code 0 elapsedTime=2.270154 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-05-04 07:41:10.750789) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 07:41:10.751269) ========= script_repo_revision: 0f9c07711141cfa8429c1e28359260c51a11f6ee ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 07:41:10.751727) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 07:41:10.752039) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 07:41:10.772738) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-05-04 07:41:10.773045) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1rKRTDnjv1/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.hKolWtG6p4/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 07:41:10 INFO - MultiFileLogger online at 20170504 07:41:10 in /builds/slave/test 07:41:10 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 07:41:10 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:41:10 INFO - {'append_to_log': False, 07:41:10 INFO - 'base_work_dir': '/builds/slave/test', 07:41:10 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:41:10 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:41:10 INFO - 'branch': 'Mozilla-Beta', 07:41:10 INFO - 'buildbot_json_path': 'buildprops.json', 07:41:10 INFO - 'config_files': ('talos/mac_config.py',), 07:41:10 INFO - 'default_actions': ('clobber', 07:41:10 INFO - 'read-buildbot-config', 07:41:10 INFO - 'download-and-extract', 07:41:10 INFO - 'populate-webroot', 07:41:10 INFO - 'create-virtualenv', 07:41:10 INFO - 'install', 07:41:10 INFO - 'run-tests'), 07:41:10 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:41:10 INFO - 'download_minidump_stackwalk': True, 07:41:10 INFO - 'download_symbols': 'ondemand', 07:41:10 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:41:10 INFO - 'tooltool.py': '/tools/tooltool.py', 07:41:10 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:41:10 INFO - '/tools/misc-python/virtualenv.py')}, 07:41:10 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:41:10 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:41:10 INFO - 'gecko_profile': False, 07:41:10 INFO - 'gecko_profile_interval': 0, 07:41:10 INFO - 'installer_path': 'installer.exe', 07:41:10 INFO - 'log_level': 'info', 07:41:10 INFO - 'log_name': 'talos', 07:41:10 INFO - 'log_to_console': True, 07:41:10 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:41:10 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:41:10 INFO - 'opt_config_files': (), 07:41:10 INFO - 'pip_index': False, 07:41:10 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:41:10 INFO - 'cmd': ('bash', 07:41:10 INFO - '-c', 07:41:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:41:10 INFO - 'enabled': True, 07:41:10 INFO - 'halt_on_failure': False, 07:41:10 INFO - 'name': 'check_screen_resolution'},), 07:41:10 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:41:10 INFO - 'cmd': ('bash', 07:41:10 INFO - '-c', 07:41:10 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:41:10 INFO - 'enabled': True, 07:41:10 INFO - 'halt_on_failure': False, 07:41:10 INFO - 'name': 'check_screen_resolution'},), 07:41:10 INFO - 'run_cmd_checks_enabled': True, 07:41:10 INFO - 'suite': 'dromaeojs', 07:41:10 INFO - 'system_bits': '32', 07:41:10 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:41:10 INFO - 'title': 't-yosemite-r7-0246', 07:41:10 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:41:10 INFO - 'use_talos_json': True, 07:41:10 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:41:10 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:41:10 INFO - 'work_dir': 'build'} 07:41:10 INFO - [mozharness: 2017-05-04 14:41:10.985697Z] Running clobber step. 07:41:10 INFO - Running pre-action listener: _resource_record_pre_action 07:41:10 INFO - Running main action method: clobber 07:41:10 INFO - rmtree: /builds/slave/test/build 07:41:10 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:41:13 INFO - Running post-action listener: _resource_record_post_action 07:41:13 INFO - [mozharness: 2017-05-04 14:41:13.419953Z] Finished clobber step (success) 07:41:13 INFO - [mozharness: 2017-05-04 14:41:13.420110Z] Running read-buildbot-config step. 07:41:13 INFO - Running pre-action listener: _resource_record_pre_action 07:41:13 INFO - Running main action method: read_buildbot_config 07:41:13 INFO - Using buildbot properties: 07:41:13 INFO - { 07:41:13 INFO - "project": "", 07:41:13 INFO - "product": "firefox", 07:41:13 INFO - "script_repo_revision": "production", 07:41:13 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 07:41:13 INFO - "repository": "", 07:41:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 07:41:13 INFO - "buildid": "20170504053521", 07:41:13 INFO - "pgo_build": "False", 07:41:13 INFO - "basedir": "/builds/slave/test", 07:41:13 INFO - "buildnumber": 3, 07:41:13 INFO - "slavename": "t-yosemite-r7-0246", 07:41:13 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 07:41:13 INFO - "platform": "yosemite_r7", 07:41:13 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 07:41:13 INFO - "branch": "mozilla-beta", 07:41:13 INFO - "repo_path": "releases/mozilla-beta", 07:41:13 INFO - "revision": "0f9c07711141cfa8429c1e28359260c51a11f6ee", 07:41:13 INFO - "stage_platform": "macosx64", 07:41:13 INFO - "builduid": "d8410388472a4ec8b99645cd291a43dd", 07:41:13 INFO - "slavebuilddir": "test" 07:41:13 INFO - } 07:41:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/B2IeK8CrRMCSwg9h-5LD2Q/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 07:41:13 INFO - Running post-action listener: _resource_record_post_action 07:41:13 INFO - [mozharness: 2017-05-04 14:41:13.423265Z] Finished read-buildbot-config step (success) 07:41:13 INFO - [mozharness: 2017-05-04 14:41:13.423366Z] Running download-and-extract step. 07:41:13 INFO - Running pre-action listener: _resource_record_pre_action 07:41:13 INFO - Running main action method: download_and_extract 07:41:13 INFO - mkdir: /builds/slave/test/build/tests 07:41:13 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')]} 07:41:13 INFO - trying https://queue.taskcluster.net/v1/task/B2IeK8CrRMCSwg9h-5LD2Q/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 07:41:13 INFO - Downloading https://queue.taskcluster.net/v1/task/B2IeK8CrRMCSwg9h-5LD2Q/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 07:41:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B2IeK8CrRMCSwg9h-5LD2Q/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 07:41:14 INFO - Downloaded 1287 bytes. 07:41:14 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 07:41:14 INFO - Using the following test package requirements: 07:41:14 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:41:14 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 07:41:14 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 07:41:14 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:41:14 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 07:41:14 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:41:14 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 07:41:14 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 07:41:14 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:41:14 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 07:41:14 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 07:41:14 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:41:14 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 07:41:14 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:41:14 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 07:41:14 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:41:14 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 07:41:14 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:41:14 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 07:41:14 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 07:41:14 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B2IeK8CrRMCSwg9h-5LD2Q/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 07:41:14 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B2IeK8CrRMCSwg9h-5LD2Q/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 07:41:14 INFO - Fetch https://queue.taskcluster.net/v1/task/B2IeK8CrRMCSwg9h-5LD2Q/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 07:41:15 INFO - Expected file size: 51223560 07:41:15 INFO - Obtained file size: 51223560 07:41:31 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 07:41:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B2IeK8CrRMCSwg9h-5LD2Q/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 07:41:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B2IeK8CrRMCSwg9h-5LD2Q/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 07:41:31 INFO - Fetch https://queue.taskcluster.net/v1/task/B2IeK8CrRMCSwg9h-5LD2Q/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 07:41:33 INFO - Expected file size: 51223560 07:41:33 INFO - Obtained file size: 51223560 07:41:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/B2IeK8CrRMCSwg9h-5LD2Q/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 07:41:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/B2IeK8CrRMCSwg9h-5LD2Q/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 07:41:48 INFO - Fetch https://queue.taskcluster.net/v1/task/B2IeK8CrRMCSwg9h-5LD2Q/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 07:41:49 INFO - Expected file size: 14404449 07:41:49 INFO - Obtained file size: 14404449 07:41: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')]} 07:41:50 INFO - trying https://queue.taskcluster.net/v1/task/B2IeK8CrRMCSwg9h-5LD2Q/artifacts/public/build/firefox-54.0.en-US.mac.dmg 07:41:50 INFO - Downloading https://queue.taskcluster.net/v1/task/B2IeK8CrRMCSwg9h-5LD2Q/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 07:41:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/B2IeK8CrRMCSwg9h-5LD2Q/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 07:41:51 INFO - Downloaded 59546997 bytes. 07:41:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B2IeK8CrRMCSwg9h-5LD2Q/artifacts/public/build/firefox-54.0.en-US.mac.dmg 07:41:51 INFO - mkdir: /builds/slave/test/properties 07:41:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:41:51 INFO - Writing to file /builds/slave/test/properties/build_url 07:41:51 INFO - Contents: 07:41:51 INFO - build_url:https://queue.taskcluster.net/v1/task/B2IeK8CrRMCSwg9h-5LD2Q/artifacts/public/build/firefox-54.0.en-US.mac.dmg 07:41:52 INFO - Running post-action listener: _resource_record_post_action 07:41:52 INFO - Running post-action listener: set_extra_try_arguments 07:41:52 INFO - [mozharness: 2017-05-04 14:41:52.482879Z] Finished download-and-extract step (success) 07:41:52 INFO - [mozharness: 2017-05-04 14:41:52.483022Z] Running populate-webroot step. 07:41:52 INFO - Running pre-action listener: _resource_record_pre_action 07:41:52 INFO - Running main action method: populate_webroot 07:41:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:41:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:41:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:41:52 INFO - '--tppagecycles', 07:41:52 INFO - '7'], 07:41:52 INFO - 'tests': ['tsvgm']}}, 07:41:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:41:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:41:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:41:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:41:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:41:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:41:52 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:41:52 INFO - 'talos_options': ['--disable-e10s'], 07:41:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:41:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:41:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:41:52 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:41:52 INFO - 'talos_options': ['--disable-e10s'], 07:41:52 INFO - 'tests': ['damp', 'tps']}, 07:41:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:41:52 INFO - 'tests': ['damp', 'tps']}, 07:41:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:41:52 INFO - 'tests': ['dromaeo_dom']}, 07:41:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:41:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:41:52 INFO - 'tests': ['basic_compositor_video']}, 07:41:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:41:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:41:52 INFO - 'tests': ['a11yr', 07:41:52 INFO - 'ts_paint', 07:41:52 INFO - 'tpaint', 07:41:52 INFO - 'sessionrestore', 07:41:52 INFO - 'sessionrestore_no_auto_restore', 07:41:52 INFO - 'tabpaint']}, 07:41:52 INFO - 'other-e10s': {'tests': ['a11yr', 07:41:52 INFO - 'ts_paint', 07:41:52 INFO - 'tpaint', 07:41:52 INFO - 'sessionrestore', 07:41:52 INFO - 'sessionrestore_no_auto_restore', 07:41:52 INFO - 'tabpaint']}, 07:41:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:41:52 INFO - 'ts_paint', 07:41:52 INFO - 'tpaint', 07:41:52 INFO - 'sessionrestore', 07:41:52 INFO - 'sessionrestore_no_auto_restore', 07:41:52 INFO - 'tabpaint']}, 07:41:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:41:52 INFO - 'ts_paint', 07:41:52 INFO - 'tpaint', 07:41:52 INFO - 'sessionrestore', 07:41:52 INFO - 'sessionrestore_no_auto_restore', 07:41:52 INFO - 'tabpaint']}, 07:41:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:41:52 INFO - 'tests': ['a11yr', 07:41:52 INFO - 'ts_paint', 07:41:52 INFO - 'tpaint', 07:41:52 INFO - 'sessionrestore', 07:41:52 INFO - 'sessionrestore_no_auto_restore', 07:41:52 INFO - 'tabpaint']}, 07:41:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:41:52 INFO - 'tests': ['a11yr', 07:41:52 INFO - 'ts_paint', 07:41:52 INFO - 'tpaint', 07:41:52 INFO - 'sessionrestore', 07:41:52 INFO - 'sessionrestore_no_auto_restore', 07:41:52 INFO - 'tabpaint']}, 07:41:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:41:52 INFO - 'tests': ['tsvgx', 07:41:52 INFO - 'tsvgr_opacity', 07:41:52 INFO - 'tart', 07:41:52 INFO - 'tscrollx', 07:41:52 INFO - 'cart', 07:41:52 INFO - 'tsvg_static']}, 07:41:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:41:52 INFO - 'tsvgr_opacity', 07:41:52 INFO - 'tart', 07:41:52 INFO - 'tscrollx', 07:41:52 INFO - 'cart', 07:41:52 INFO - 'tsvg_static']}, 07:41:52 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:41:52 INFO - 'talos_options': ['--disable-e10s'], 07:41:52 INFO - 'tests': ['tp5o']}, 07:41:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:41:52 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:41:52 INFO - 'talos_options': ['--disable-e10s', 07:41:52 INFO - '--xperf_path', 07:41:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:41:52 INFO - 'tests': ['tp5n']}, 07:41:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:41:52 INFO - 'talos_options': ['--xperf_path', 07:41:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:41:52 INFO - 'tests': ['tp5n']}}, 07:41:52 INFO - 'talos.zip': {'path': '', 07:41:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:41:52 INFO - Running post-action listener: _resource_record_post_action 07:41:52 INFO - [mozharness: 2017-05-04 14:41:52.501811Z] Finished populate-webroot step (success) 07:41:52 INFO - [mozharness: 2017-05-04 14:41:52.501952Z] Running create-virtualenv step. 07:41:52 INFO - Running pre-action listener: _resource_record_pre_action 07:41:52 INFO - Running main action method: create_virtualenv 07:41:52 INFO - Creating virtualenv /builds/slave/test/build/venv 07:41:52 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 07:41:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:41:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:41:52 INFO - Using real prefix '/tools/python27' 07:41:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:41:53 INFO - Installing distribute.............................................................................................................................................................................................done. 07:41:56 INFO - Installing pip.................done. 07:41:56 INFO - Return code: 0 07:41:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:41:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:41:56 INFO - Reading from file tmpfile_stdout 07:41:56 INFO - Output received: 07:41:56 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) 07:41:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:56 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 0x10e005b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e008768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc47a54b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde3d30>, '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 0x10dd0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd8be8>, '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.1rKRTDnjv1/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.hKolWtG6p4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 07:41:56 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 07:41:56 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 07:41:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1rKRTDnjv1/Render', 07:41:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:56 INFO - 'HOME': '/Users/cltbld', 07:41:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:56 INFO - 'LOGNAME': 'cltbld', 07:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:56 INFO - 'MOZ_NO_REMOTE': '1', 07:41:56 INFO - 'NO_EM_RESTART': '1', 07:41:56 INFO - 'PAGER': '/bin/cat', 07:41:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:56 INFO - 'PWD': '/builds/slave/test', 07:41:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:56 INFO - 'SHELL': '/bin/bash', 07:41:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hKolWtG6p4/Listeners', 07:41:56 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 07:41:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:56 INFO - 'USER': 'cltbld', 07:41:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:56 INFO - 'XPC_FLAGS': '0x0', 07:41:56 INFO - 'XPC_SERVICE_NAME': '0', 07:41:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:56 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 07:41:56 INFO - Cleaning up... 07:41:56 INFO - Return code: 0 07:41:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:41:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:41:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:41:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:41:56 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 0x10e005b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e008768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc47a54b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde3d30>, '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 0x10dd0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd8be8>, '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.1rKRTDnjv1/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.hKolWtG6p4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 07:41:56 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 07:41:56 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 07:41:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1rKRTDnjv1/Render', 07:41:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:41:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:41:56 INFO - 'HOME': '/Users/cltbld', 07:41:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:41:56 INFO - 'LOGNAME': 'cltbld', 07:41:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:41:56 INFO - 'MOZ_NO_REMOTE': '1', 07:41:56 INFO - 'NO_EM_RESTART': '1', 07:41:56 INFO - 'PAGER': '/bin/cat', 07:41:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:41:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:41:56 INFO - 'PWD': '/builds/slave/test', 07:41:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:41:56 INFO - 'SHELL': '/bin/bash', 07:41:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hKolWtG6p4/Listeners', 07:41:56 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 07:41:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:41:56 INFO - 'USER': 'cltbld', 07:41:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:41:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:41:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:41:56 INFO - 'XPC_FLAGS': '0x0', 07:41:56 INFO - 'XPC_SERVICE_NAME': '0', 07:41:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:41:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:41:57 INFO - Downloading/unpacking psutil>=3.1.1 07:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:41:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:41:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:41:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:41:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:41:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:41:59 INFO - Installing collected packages: psutil 07:41:59 INFO - Running setup.py install for psutil 07:41:59 INFO - building 'psutil._psutil_osx' extension 07:41:59 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 07:41:59 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 07:42:00 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 07:42:00 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 07:42:00 INFO - building 'psutil._psutil_posix' extension 07:42:00 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 07:42:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:42:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:42:00 INFO - ^ 07:42:00 INFO - 1 warning generated. 07:42:00 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 07:42:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:42:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:42:00 INFO - Successfully installed psutil 07:42:00 INFO - Cleaning up... 07:42:00 INFO - Return code: 0 07:42:00 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:42:00 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')]} 07:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:00 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')]} 07:42:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:00 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 0x10e005b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e008768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc47a54b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde3d30>, '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 0x10dd0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd8be8>, '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.1rKRTDnjv1/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.hKolWtG6p4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 07:42:00 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 07:42:00 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 07:42:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1rKRTDnjv1/Render', 07:42:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:00 INFO - 'HOME': '/Users/cltbld', 07:42:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:00 INFO - 'LOGNAME': 'cltbld', 07:42:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:00 INFO - 'MOZ_NO_REMOTE': '1', 07:42:00 INFO - 'NO_EM_RESTART': '1', 07:42:00 INFO - 'PAGER': '/bin/cat', 07:42:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:00 INFO - 'PWD': '/builds/slave/test', 07:42:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:00 INFO - 'SHELL': '/bin/bash', 07:42:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hKolWtG6p4/Listeners', 07:42:00 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 07:42:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:00 INFO - 'USER': 'cltbld', 07:42:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:00 INFO - 'XPC_FLAGS': '0x0', 07:42:00 INFO - 'XPC_SERVICE_NAME': '0', 07:42:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:00 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:02 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:42:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:42:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:42:02 INFO - Installing collected packages: mozsystemmonitor 07:42:02 INFO - Running setup.py install for mozsystemmonitor 07:42:02 INFO - Successfully installed mozsystemmonitor 07:42:02 INFO - Cleaning up... 07:42:02 INFO - Return code: 0 07:42:02 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:42:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10e005b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e008768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc47a54b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde3d30>, '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 0x10dd0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd8be8>, '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.1rKRTDnjv1/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.hKolWtG6p4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 07:42:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:42:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:42:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1rKRTDnjv1/Render', 07:42:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:02 INFO - 'HOME': '/Users/cltbld', 07:42:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:02 INFO - 'LOGNAME': 'cltbld', 07:42:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:02 INFO - 'MOZ_NO_REMOTE': '1', 07:42:02 INFO - 'NO_EM_RESTART': '1', 07:42:02 INFO - 'PAGER': '/bin/cat', 07:42:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:02 INFO - 'PWD': '/builds/slave/test', 07:42:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:02 INFO - 'SHELL': '/bin/bash', 07:42:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hKolWtG6p4/Listeners', 07:42:02 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 07:42:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:02 INFO - 'USER': 'cltbld', 07:42:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:02 INFO - 'XPC_FLAGS': '0x0', 07:42:02 INFO - 'XPC_SERVICE_NAME': '0', 07:42:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:02 INFO - Downloading/unpacking jsonschema==2.5.1 07:42:02 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 07:42:02 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 07:42:02 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 07:42:02 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 07:42:02 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 07:42:02 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 07:42:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:42:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:42:04 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 07:42:04 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 07:42:04 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 07:42:04 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 07:42:04 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 07:42:04 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 07:42:04 INFO - Downloading functools32-3.2.3-2.tar.gz 07:42:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:42:04 INFO - warning: no files found matching '*.txt' 07:42:04 INFO - no previously-included directories found matching 'build' 07:42:04 INFO - no previously-included directories found matching 'dist' 07:42:04 INFO - no previously-included directories found matching '.git*' 07:42:04 INFO - Installing collected packages: jsonschema, functools32 07:42:04 INFO - Running setup.py install for functools32 07:42:04 INFO - warning: no files found matching '*.txt' 07:42:04 INFO - no previously-included directories found matching 'build' 07:42:04 INFO - no previously-included directories found matching 'dist' 07:42:04 INFO - no previously-included directories found matching '.git*' 07:42:04 INFO - Successfully installed jsonschema functools32 07:42:04 INFO - Cleaning up... 07:42:04 INFO - Return code: 0 07:42:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:42:04 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')]} 07:42:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:04 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')]} 07:42:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:05 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 0x10e005b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e008768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc47a54b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde3d30>, '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 0x10dd0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd8be8>, '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.1rKRTDnjv1/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.hKolWtG6p4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 07:42:05 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 07:42:05 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 07:42:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1rKRTDnjv1/Render', 07:42:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:05 INFO - 'HOME': '/Users/cltbld', 07:42:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:05 INFO - 'LOGNAME': 'cltbld', 07:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:05 INFO - 'MOZ_NO_REMOTE': '1', 07:42:05 INFO - 'NO_EM_RESTART': '1', 07:42:05 INFO - 'PAGER': '/bin/cat', 07:42:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:05 INFO - 'PWD': '/builds/slave/test', 07:42:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:05 INFO - 'SHELL': '/bin/bash', 07:42:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hKolWtG6p4/Listeners', 07:42:05 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 07:42:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:05 INFO - 'USER': 'cltbld', 07:42:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:05 INFO - 'XPC_FLAGS': '0x0', 07:42:05 INFO - 'XPC_SERVICE_NAME': '0', 07:42:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:42:05 INFO - Cleaning up... 07:42:05 INFO - Return code: 0 07:42:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:42:05 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')]} 07:42:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:05 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')]} 07:42:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:05 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 0x10e005b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e008768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc47a54b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde3d30>, '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 0x10dd0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd8be8>, '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.1rKRTDnjv1/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.hKolWtG6p4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 07:42:05 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 07:42:05 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 07:42:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1rKRTDnjv1/Render', 07:42:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:05 INFO - 'HOME': '/Users/cltbld', 07:42:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:05 INFO - 'LOGNAME': 'cltbld', 07:42:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:05 INFO - 'MOZ_NO_REMOTE': '1', 07:42:05 INFO - 'NO_EM_RESTART': '1', 07:42:05 INFO - 'PAGER': '/bin/cat', 07:42:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:05 INFO - 'PWD': '/builds/slave/test', 07:42:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:05 INFO - 'SHELL': '/bin/bash', 07:42:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hKolWtG6p4/Listeners', 07:42:05 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 07:42:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:05 INFO - 'USER': 'cltbld', 07:42:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:05 INFO - 'XPC_FLAGS': '0x0', 07:42:05 INFO - 'XPC_SERVICE_NAME': '0', 07:42:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:06 INFO - Downloading/unpacking blobuploader==1.2.4 07:42:06 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 07:42:06 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 07:42:06 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 07:42:06 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 07:42:06 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 07:42:06 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 07:42:07 INFO - Downloading blobuploader-1.2.4.tar.gz 07:42:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:42:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:42:08 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 07:42:08 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 07:42:08 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 07:42:08 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 07:42:08 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 07:42:08 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 07:42:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:42:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:42:08 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 07:42:08 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 07:42:08 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 07:42:08 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 07:42:08 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 07:42:08 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 07:42:08 INFO - Downloading docopt-0.6.1.tar.gz 07:42:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:42:08 INFO - Installing collected packages: blobuploader, requests, docopt 07:42:08 INFO - Running setup.py install for blobuploader 07:42:08 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:42:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:42:09 INFO - Running setup.py install for requests 07:42:09 INFO - Running setup.py install for docopt 07:42:09 INFO - Successfully installed blobuploader requests docopt 07:42:09 INFO - Cleaning up... 07:42:09 INFO - Return code: 0 07:42:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:42:09 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')]} 07:42:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:09 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')]} 07:42:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:09 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 0x10e005b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e008768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc47a54b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde3d30>, '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 0x10dd0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd8be8>, '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.1rKRTDnjv1/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.hKolWtG6p4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 07:42:09 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 07:42:09 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 07:42:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1rKRTDnjv1/Render', 07:42:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:09 INFO - 'HOME': '/Users/cltbld', 07:42:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:09 INFO - 'LOGNAME': 'cltbld', 07:42:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:09 INFO - 'MOZ_NO_REMOTE': '1', 07:42:09 INFO - 'NO_EM_RESTART': '1', 07:42:09 INFO - 'PAGER': '/bin/cat', 07:42:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:09 INFO - 'PWD': '/builds/slave/test', 07:42:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:09 INFO - 'SHELL': '/bin/bash', 07:42:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hKolWtG6p4/Listeners', 07:42:09 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 07:42:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:09 INFO - 'USER': 'cltbld', 07:42:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:09 INFO - 'XPC_FLAGS': '0x0', 07:42:09 INFO - 'XPC_SERVICE_NAME': '0', 07:42:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:42:10 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-HAe047-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:42:10 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-K8n7Di-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:42:10 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-9ivN9F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:42:10 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-peLTKa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:42:10 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-BPRa0P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:42:10 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-ZnORpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:42:10 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-1ekuwW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:42:10 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-6WMUBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:42:10 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-9p1Nsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:42:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:42:10 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-C_4Z6r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:42:11 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-4DzKc_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:42:11 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-yZ2TX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:42:11 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-4saJsh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:42:11 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-i9xFJD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:11 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-NVgibM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:42:11 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-Z9uCjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:42:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:42:11 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-Gf_0r9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:42:11 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:42:11 INFO - Running setup.py install for manifestparser 07:42:11 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:42:11 INFO - Running setup.py install for mozcrash 07:42:12 INFO - Running setup.py install for mozdebug 07:42:12 INFO - Running setup.py install for mozdevice 07:42:12 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:42:12 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:42:12 INFO - Running setup.py install for mozfile 07:42:12 INFO - Running setup.py install for mozhttpd 07:42:12 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:42:12 INFO - Running setup.py install for mozinfo 07:42:12 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:42:12 INFO - Running setup.py install for mozInstall 07:42:12 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:42:12 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:42:12 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:42:12 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:42:12 INFO - Running setup.py install for mozleak 07:42:13 INFO - Running setup.py install for mozlog 07:42:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:42:13 INFO - Running setup.py install for moznetwork 07:42:13 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:42:13 INFO - Running setup.py install for mozprocess 07:42:13 INFO - Running setup.py install for mozprofile 07:42:13 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:42:13 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:42:13 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:42:13 INFO - Running setup.py install for mozrunner 07:42:13 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:42:13 INFO - Running setup.py install for mozscreenshot 07:42:13 INFO - Running setup.py install for moztest 07:42:14 INFO - Running setup.py install for mozversion 07:42:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:42:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:42:14 INFO - Cleaning up... 07:42:14 INFO - Return code: 0 07:42:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:42: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')]} 07:42:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42: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')]} 07:42:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:14 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 0x10e005b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e008768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc47a54b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde3d30>, '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 0x10dd0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd8be8>, '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.1rKRTDnjv1/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.hKolWtG6p4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 07:42:14 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 07:42:14 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 07:42:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1rKRTDnjv1/Render', 07:42:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:14 INFO - 'HOME': '/Users/cltbld', 07:42:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:14 INFO - 'LOGNAME': 'cltbld', 07:42:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:14 INFO - 'MOZ_NO_REMOTE': '1', 07:42:14 INFO - 'NO_EM_RESTART': '1', 07:42:14 INFO - 'PAGER': '/bin/cat', 07:42:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:14 INFO - 'PWD': '/builds/slave/test', 07:42:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:14 INFO - 'SHELL': '/bin/bash', 07:42:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hKolWtG6p4/Listeners', 07:42:14 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 07:42:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:14 INFO - 'USER': 'cltbld', 07:42:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:14 INFO - 'XPC_FLAGS': '0x0', 07:42:14 INFO - 'XPC_SERVICE_NAME': '0', 07:42:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:42:14 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-JKcDaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:42:14 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)) 07:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:42:14 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-1VWoT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:42:14 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)) 07:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:42:14 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-jOQ1T5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:42:14 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)) 07:42:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:42:14 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-g4DKYQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:42:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:42:15 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-8UwF_C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:42:15 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)) 07:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:42:15 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-9PHCyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:42:15 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)) 07:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:42:15 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-VM3Zfd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:42:15 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)) 07:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:42:15 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-b6EF_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:42:15 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)) 07:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:42:15 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-_sf8Ab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:42:15 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)) 07:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:42:15 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-bvJkrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:42:15 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)) 07:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:42:15 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-D43cxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:42:15 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)) 07:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:42:15 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-Oon4tq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:42:15 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)) 07:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:42:15 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-7vk48g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:42:15 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)) 07:42:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:42:15 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-ajhwVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:42:16 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)) 07:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:16 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-9mj9v1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:42:16 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)) 07:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:42:16 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-5NbuHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:42:16 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)) 07:42:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:42:16 INFO - Running setup.py (path:/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/pip-LgVJEo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:42:16 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)) 07:42:16 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)) 07:42:16 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)) 07:42:16 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)) 07:42:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:42:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:42:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:42:16 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 07:42:16 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 07:42:16 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 07:42:16 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 07:42:16 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 07:42:16 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 07:42:17 INFO - Downloading blessings-1.6.tar.gz 07:42:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:42:17 INFO - Installing collected packages: blessings 07:42:17 INFO - Running setup.py install for blessings 07:42:18 INFO - Successfully installed blessings 07:42:18 INFO - Cleaning up... 07:42:18 INFO - Return code: 0 07:42:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:42:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:42:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:42:18 INFO - Reading from file tmpfile_stdout 07:42:18 INFO - Current package versions: 07:42:18 INFO - blessings == 1.6 07:42:18 INFO - blobuploader == 1.2.4 07:42:18 INFO - docopt == 0.6.1 07:42:18 INFO - functools32 == 3.2.3-2 07:42:18 INFO - jsonschema == 2.5.1 07:42:18 INFO - manifestparser == 1.1 07:42:18 INFO - mozInstall == 1.12 07:42:18 INFO - mozcrash == 1.0 07:42:18 INFO - mozdebug == 0.1 07:42:18 INFO - mozdevice == 0.49 07:42:18 INFO - mozfile == 1.2 07:42:18 INFO - mozhttpd == 0.7 07:42:18 INFO - mozinfo == 0.9 07:42:18 INFO - mozleak == 0.1 07:42:18 INFO - mozlog == 3.4 07:42:18 INFO - moznetwork == 0.27 07:42:18 INFO - mozprocess == 0.25 07:42:18 INFO - mozprofile == 0.28 07:42:18 INFO - mozrunner == 6.13 07:42:18 INFO - mozscreenshot == 0.1 07:42:18 INFO - mozsystemmonitor == 0.3 07:42:18 INFO - moztest == 0.8 07:42:18 INFO - mozversion == 1.4 07:42:18 INFO - psutil == 3.1.1 07:42:18 INFO - requests == 1.2.3 07:42:18 INFO - wsgiref == 0.1.2 07:42:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:42:18 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')]} 07:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:18 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')]} 07:42:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:18 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 0x10e005b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e008768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc47a54b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde3d30>, '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 0x10dd0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd8be8>, '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.1rKRTDnjv1/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.hKolWtG6p4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 07:42:18 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 07:42:18 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 07:42:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1rKRTDnjv1/Render', 07:42:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:18 INFO - 'HOME': '/Users/cltbld', 07:42:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:18 INFO - 'LOGNAME': 'cltbld', 07:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:18 INFO - 'MOZ_NO_REMOTE': '1', 07:42:18 INFO - 'NO_EM_RESTART': '1', 07:42:18 INFO - 'PAGER': '/bin/cat', 07:42:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:18 INFO - 'PWD': '/builds/slave/test', 07:42:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:18 INFO - 'SHELL': '/bin/bash', 07:42:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hKolWtG6p4/Listeners', 07:42:18 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 07:42:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:18 INFO - 'USER': 'cltbld', 07:42:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:18 INFO - 'XPC_FLAGS': '0x0', 07:42:18 INFO - 'XPC_SERVICE_NAME': '0', 07:42:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:18 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)) 07:42:18 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)) 07:42:18 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)) 07:42:18 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)) 07:42:18 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)) 07:42:18 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)) 07:42:18 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)) 07:42:18 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)) 07:42:18 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)) 07:42:18 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)) 07:42:18 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)) 07:42:18 INFO - Cleaning up... 07:42:18 INFO - Return code: 0 07:42:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:42:18 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')]} 07:42:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:18 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')]} 07:42:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:18 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 0x10e005b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10e008768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc47a54b8e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10dde3d30>, '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 0x10dd0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd8be8>, '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.1rKRTDnjv1/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.hKolWtG6p4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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 07:42:18 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 07:42:18 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 07:42:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1rKRTDnjv1/Render', 07:42:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:18 INFO - 'HOME': '/Users/cltbld', 07:42:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:18 INFO - 'LOGNAME': 'cltbld', 07:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:18 INFO - 'MOZ_NO_REMOTE': '1', 07:42:18 INFO - 'NO_EM_RESTART': '1', 07:42:18 INFO - 'PAGER': '/bin/cat', 07:42:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:18 INFO - 'PWD': '/builds/slave/test', 07:42:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:18 INFO - 'SHELL': '/bin/bash', 07:42:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hKolWtG6p4/Listeners', 07:42:18 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 07:42:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:18 INFO - 'USER': 'cltbld', 07:42:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:18 INFO - 'XPC_FLAGS': '0x0', 07:42:18 INFO - 'XPC_SERVICE_NAME': '0', 07:42:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:18 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:42:18 INFO - Cleaning up... 07:42:18 INFO - Return code: 0 07:42:18 INFO - Running post-action listener: _resource_record_post_action 07:42:18 INFO - Running post-action listener: _start_resource_monitoring 07:42:18 INFO - Starting resource monitoring. 07:42:18 INFO - [mozharness: 2017-05-04 14:42:18.919783Z] Finished create-virtualenv step (success) 07:42:18 INFO - [mozharness: 2017-05-04 14:42:18.920819Z] Running install step. 07:42:18 INFO - Running pre-action listener: _resource_record_pre_action 07:42:18 INFO - Running main action method: install 07:42:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:42:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:42:19 INFO - Reading from file tmpfile_stdout 07:42:19 INFO - Detecting whether we're running mozinstall >=1.0... 07:42:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:42:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:42:19 INFO - Reading from file tmpfile_stdout 07:42:19 INFO - Output received: 07:42:19 INFO - Usage: mozinstall [options] installer 07:42:19 INFO - Options: 07:42:19 INFO - -h, --help show this help message and exit 07:42:19 INFO - -d DEST, --destination=DEST 07:42:19 INFO - Directory to install application into. [default: 07:42:19 INFO - "/builds/slave/test"] 07:42:19 INFO - --app=APP Application being installed. [default: firefox] 07:42:19 INFO - mkdir: /builds/slave/test/build/application 07:42:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:42:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 07:42:34 INFO - Reading from file tmpfile_stdout 07:42:34 INFO - Output received: 07:42:34 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 07:42:34 INFO - Running post-action listener: _resource_record_post_action 07:42:34 INFO - [mozharness: 2017-05-04 14:42:34.387270Z] Finished install step (success) 07:42:34 INFO - [mozharness: 2017-05-04 14:42:34.387394Z] Running run-tests step. 07:42:34 INFO - Running pre-action listener: _resource_record_pre_action 07:42:34 INFO - Running main action method: run_tests 07:42:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:42:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:42:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:42:34 INFO - 2017-05-04 07:42:34.401 screenresolution[1625:7494] starting screenresolution argv=screenresolution get 07:42:34 INFO - 2017-05-04 07:42:34.404 screenresolution[1625:7494] Display 0: 1600x1200x32@60 07:42:34 INFO - 2017-05-04 07:42:34.410 screenresolution[1626:7496] starting screenresolution argv=screenresolution list 07:42:34 INFO - Available Modes on Display 0 07:42:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:42:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:42:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:42:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:42:34 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:42:34 INFO - Intel Iris: 07:42:34 INFO - Chipset Model: Intel Iris 07:42:34 INFO - Type: GPU 07:42:34 INFO - Bus: Built-In 07:42:34 INFO - VRAM (Dynamic, Max): 1536 MB 07:42:34 INFO - Vendor: Intel (0x8086) 07:42:34 INFO - Device ID: 0x0a2e 07:42:34 INFO - Revision ID: 0x0009 07:42:34 INFO - Displays: 07:42:34 INFO - Display: 07:42:34 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:42:34 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:42:34 INFO - Display Serial Number: 1600x1200 60 07:42:34 INFO - Main Display: Yes 07:42:34 INFO - Mirror: Off 07:42:34 INFO - Online: Yes 07:42:34 INFO - Rotation: Supported 07:42:34 INFO - Return code: 0 07:42:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:42:34 INFO - Python 2.7.3 07:42:34 INFO - Return code: 0 07:42:34 INFO - grabbing minidump binary from tooltool 07:42: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')]} 07:42:34 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 0x10dde3d30>, '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 0x10dd0adb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ddd8be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:42:34 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 07:42:34 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 07:42:34 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 07:42:34 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:42:34 INFO - Return code: 0 07:42:34 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:42:34 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:42:34 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:42:34 INFO - ENV: RUST_BACKTRACE is now 1 07:42:34 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:42:34 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:42:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B2IeK8CrRMCSwg9h-5LD2Q/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0246', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B2IeK8CrRMCSwg9h-5LD2Q/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0246 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:42:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1rKRTDnjv1/Render', 07:42:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:42:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:42:34 INFO - 'HOME': '/Users/cltbld', 07:42:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:42:34 INFO - 'LOGNAME': 'cltbld', 07:42:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:42:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:34 INFO - 'MOZ_NO_REMOTE': '1', 07:42:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:42:34 INFO - 'NO_EM_RESTART': '1', 07:42:34 INFO - 'PAGER': '/bin/cat', 07:42:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:34 INFO - 'PWD': '/builds/slave/test', 07:42:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:42:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:42:34 INFO - 'RUST_BACKTRACE': '1', 07:42:34 INFO - 'SHELL': '/bin/bash', 07:42:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.hKolWtG6p4/Listeners', 07:42:34 INFO - 'TMPDIR': '/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/', 07:42:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:42:34 INFO - 'USER': 'cltbld', 07:42:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:42:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:34 INFO - 'XPC_FLAGS': '0x0', 07:42:34 INFO - 'XPC_SERVICE_NAME': '0', 07:42:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:42:34 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B2IeK8CrRMCSwg9h-5LD2Q/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0246', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:42:34 INFO - mozversion application_buildid: 20170504053521 07:42:34 INFO - mozversion application_changeset: 0f9c07711141cfa8429c1e28359260c51a11f6ee 07:42:34 INFO - mozversion application_display_name: Firefox 07:42:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:42:34 INFO - mozversion application_name: Firefox 07:42:34 INFO - mozversion application_remotingname: firefox 07:42:34 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:42:34 INFO - mozversion application_vendor: Mozilla 07:42:34 INFO - mozversion application_version: 54.0 07:42:34 INFO - mozversion platform_buildid: 20170504053521 07:42:34 INFO - mozversion platform_changeset: 0f9c07711141cfa8429c1e28359260c51a11f6ee 07:42:34 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:42:34 INFO - mozversion platform_version: 54.0 07:42:34 INFO - using testdate: 1493908954 07:42:34 INFO - actual date: 1493908954 07:42:34 INFO - starting webserver on 'localhost:49246' 07:42:35 INFO - SUITE-START | Running 2 tests 07:42:35 INFO - TEST-START | dromaeo_css 07:42:35 INFO - operating with platform_type : mac_ 07:42:35 INFO - Initialising browser for dromaeo_css test... 07:42:35 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmp7mn5mT/profile http://localhost:49246/getInfo.html) 07:42:37 INFO - PROCESS | 1636 | __metrics Screen width/height:1600/1200 07:42:37 INFO - PROCESS | 1636 | colorDepth:24 07:42:37 INFO - PROCESS | 1636 | Browser inner width/height: 1024/689 07:42:37 INFO - PROCESS | 1636 | __metrics 07:42:37 INFO - PROCESS | 1636 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:42:37 INFO - PROCESS | 1636 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:42:38 INFO - TEST-INFO | 1636: exit 0 07:42:38 INFO - Browser initialized. 07:42:38 INFO - Running cycle 1/1 for dromaeo_css test... 07:42:38 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmp7mn5mT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:42:50 INFO - PROCESS | 1639 | RSS: Main: 168894464 07:42:50 INFO - PROCESS | 1639 | 07:45:53 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49246/tests/dromaeo/cssquery-ext.html) 07:45:56 INFO - PROCESS | 1639 | RSS: Main: 380338176 07:45:56 INFO - PROCESS | 1639 | 07:48:59 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-ext.html (next: http://localhost:49246/tests/dromaeo/cssquery-jquery.html) 07:49:00 INFO - PROCESS | 1639 | RSS: Main: 304123904 07:49:00 INFO - PROCESS | 1639 | 07:52:02 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49246/tests/dromaeo/cssquery-mootools.html) 07:52:02 INFO - PROCESS | 1639 | RSS: Main: 303706112 07:52:02 INFO - PROCESS | 1639 | 07:55:05 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49246/tests/dromaeo/cssquery-prototype.html) 07:55:06 INFO - PROCESS | 1639 | RSS: Main: 289234944 07:55:06 INFO - PROCESS | 1639 | 07:58:09 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49246/tests/dromaeo/cssquery-yui.html) 07:58:10 INFO - PROCESS | 1639 | RSS: Main: 276426752 07:58:10 INFO - PROCESS | 1639 | 08:01:13 INFO - PROCESS | 1639 | Cycle 1(1): loaded http://localhost:49246/tests/dromaeo/cssquery-yui.html (next: http://localhost:49246/tests/dromaeo/cssquery-dojo.html) 08:01:13 INFO - PROCESS | 1639 | RSS: Main: 315543552 08:01:13 INFO - PROCESS | 1639 | 08:01:13 INFO - PROCESS | 1639 | __start_tp_report 08:01:13 INFO - PROCESS | 1639 | _x_x_mozilla_page_load 08:01:13 INFO - PROCESS | 1639 | _x_x_mozilla_page_load_details 08:01:13 INFO - PROCESS | 1639 | |i|pagename|runs| 08:01:13 INFO - PROCESS | 1639 | |0;dojo.html;3441.6386279440676;3446.758726889119;3453;3466.653334666532;3475.0443628002304;5981.671008094553;6067.180930574382;6071.015492754991;6088.421599948009;6098.359672234413;5679.204911312419;5988;6053.364396738345;6058.39416058395;6065.636061836281;5278.604104692145;5289.841304760864;5304.6286759926825;5325.440828712987;5433.755481003364;5241.842744717665;5252.212168174766;5323.387810401795;5337.546308563777;5419.5393391561765;4442.511323754385;5340.946590534084;5340.946590534103;5345.652532585389;5347.866303342409;5326.520613144836;5335.866603334909;5343;5343.786248550054;5347.786088556453;5180.352455943007;5286.920696189561;5302.496262855023;5309.893802123975;5335.413104558495;5992.610480318765;6000.069989151689;6006.699665016732;6008.158857759917;6015.879682406371;6242.625442473421;6248.250209974786;6259.530535209878;6263.71813268404;6267.05994100884;6289.40250676185;6289.811305660837;6329.810105696836;6353.9682301588655;6374.649394283312;6033.245844269466;6047.697615119227;6047.848803779897;6076.453119219247;6086.965215913306;6259.812205633838;6300.936990630126;6547.443467305237;6549.901751473732;6579.342065793382;6210.596311239755;6210.658413787285;6257.561970662101;6257.624542527463;6302.747890084345;6403.903941440882;6413.807585772434;6418.614883107029;6420.935790642127;6448.806535803933;6192.195014648067;6331.113644089831;6343.841403964845;6356.237251529846;6359.96820015897;6171.13604095427;6234.064890266405;6248.50011999039;6256.092866534327;6269.46709529686;5015.14742493777;5162.380514338229;5188.169892817131;5194.636375453758;5200.817971370984;4551.340055691972;4567.177907976529;4575.359449677047;4594.425696787902;4602.953970460319;4795.928061079087;6109;6184.690765461799;6204.193454850841;6213.813585592439;6219.689015549205;6282.968585157045;6283;6309.526785491106;6346.428821406003;6171.13604095427;6185.969070154621;6195.628262304276;6198.566100372931;6205.751769929243;5573.247611572467;5602.327720673546;5631.18347839561;5634.295713035871;5650.85872853182;6297.716602752978;6323.9683801580695;6508.9349106508325;6621.106150669598;6626.801195964033;6368.713407896563;6376.107344971615;6396.136521569715;6399.488040956805;6400.423961843457;6566.474682025522;6585.407313341822;6594.142761440982;6595.505337099641;6604.405603495708;6213.813585592439;6270.341614130633;6276;6288.905666414916;6363.61818290904;6291.905621415774;6298.02380631003;6302.968485157545;6311.936880631135;6313.116163737172;6219.844503887439;6294.244690637152;6301.117843501822;6309.684515774285;6328.398802113792;4977.303177555217;5131.461196574455;6249.156363890998;6326.525510586816;6330.430261276507;6254.2807577129215;6279.811605651837;6283.5601507895835;6291.307956124914;6291.339409362135;6151.6001459904965;6215.098810672337;6255.40573645503;6273.874522509433;6351.68241587928;5947.04847224442;5965.91051134242;6031.457168854824;6222.128901953821;6270 08:01:13 INFO - PROCESS | 1639 | |1;ext.html;814.5112932240654;823.7487566292281;909.4316052467208;916.5325683901212;918.0360621347584;39578.80210598947;40354.596454035454;42863.785681071626;43066;43133.568664313345;41979.37030944531;42106.57893421065;42181.578184218146;42192.99999999992;43250.56749432505;7972.681092756283;9659.13067823894;9796.118349348557;9813.558389872438;9817.263705222102;8042;11767.529298828036;11884.881151188507;12181.939090304537;12211.32837693931;11965.940170299136;11994.580189693363;12002.699932501713;12003;12012.399380031007;11909.166358354918;11934.880651193507;11936.224145430519;11941.223820451729;11948.044156467462;11535.884641153565;11564.53741850325;11589.188756787029;11594.362310073027;11599.536018559247;33664.49503257453;34997.825010875036;38943;39007.6347327845;39058;3974.4038394240806;4029.6977726670616;4031.213913286881;4038.676905847525;4066.410370496291;28482.430351392857;29032;29981.55027674565;30585.388292234253;30749.8462507686;3291.4569096099117;3301.4552598821165;3317.253617935969;3451.6548345165534;3453.620101788801;322399.3880030585;327922;328236;328237;328326.35836820665;42376;43159.9210019752;52108.73945630248;52217;52243.69390765261;45208.54791452109;45380.77309613431;45453.77273113613;45524.54475455269;53305;15040.849591503946;15407.691846163014;15418.768718469231;15453.768193476883;15475.303611337516;13286.468541258242;13306.933465332611;13327.866721332663;13343.532976345976;13346;12089.335086570147;12095.334756588472;12129;12139.96810271137;12194.51221951112;4748.8337908173735;4825.758712064383;5826.659868230331;5830.766769329264;5845.357010728816;1152.948117334722;1155.589765633205;1156.462245056053;1166.5392170092935;1206.3003457994341;25882.482350352886;26765.732342676714;26969.325766855985;27121.728782712315;27141.592876106875;1287.1118927939692;1289.5615490733007;1291.1478424239956;1340.9731805363838;1348.9460421583026;13523.32383380827;13915.165090094626;14097.083689560352;14171.78742318866;14281.64295892611;470657;472071.6396417996;472688;473079.6346018248;473205;55565.722171389694;55751;55879.16181257284;56000;56007.43992560104;1476.7932489451484;1489.53079779869;1500.219885659451;1556.2763315058553;1558.9766153507705;26069.348266293495;26630.600540992287;27228.183154505397;27256.773445194616;27379.452410952068;37213.44179837359;37224.62775372212;37258.25483490261;37317.626823731414;37327.626723732414;440636;441959;442285;443405;472973.6351318359;24786.884590193844;24999.625005624566;25105.121320753686;26516.867415662797;29402.264943376587;30498.542521861746;30872;37818.86543403702;38580.228395432496;39109.41335880021;27552.86223568869;27664.723352766214;28096.01663941752;28403.289917752223;28560.57159142573;27562.862185688944;27819.94476345681;28087.297817554725;28389;28393.716062839107;23335;32661.34677306488;32671.509927351584;32761.836190818893;32773.508397374535;20725.68911466299;28171.71828281691;28200.576991345555;28598.42803143967;28802.855985719936;22334.77158756284;22409.77590224142;22747.545049098593;22760;22792.430189244737 08:01:13 INFO - PROCESS | 1639 | |2;jquery.html;352.48361150913905;368.6276860371026;434.8564973558725;437.5602519467934;442.7520588470457;20963.37109886702;21039.47401314968;22515.324540263777;22518.09927602898;22739.658905116416;22346.10615575379;22682.659760103612;23200.535989280248;23229.070837166535;24129;6607.933920660792;6864.931350686504;6880.2775708550635;6927.168739751211;6930.5841649500935;7313.195548489662;7593.430492713041;7781.416393770462;7782.066152061732;7801.414893882981;7592.924070759277;7641.808954776119;7644.197359277251;7733.535987840747;7767.805804854867;7528.8117797054965;7732.226777322251;7791.259830316139;7803.921960780376;7808.297253247179;7644.885326720104;7654.196309387546;7663.271989161077;7669.961650191769;7679.078510578766;27128.86435567829;27572.862135689393;28151.296217594518;28239.01163459269;28512;3024.5311976643657;3440.415129428003;3450.8274586270586;3517.4196257617464;3528.6824185823143;15191.696166076617;16466.75299870503;16659.41692040785;16712.331506739716;16985.745213821803;2048.897555122238;2099.7060411542398;2099.88450635215;2102.085592767151;2104.2740254612136;128027;154517.22741386332;158552;158676.20661896616;160150;15052.698946021019;20587.4853128673;20732.58534829295;20917.267895623885;20939.68590471144;32225.838870805495;32576.02271931846;32874.342513149604;32888;32908.83545582257;8769.517676527852;10713.517891694737;10894.346339219672;11071.5571377144;11259.155563332619;9192.724218273463;9199.804025476646;9216.308776841764;9381.29640276982;9389.577469013911;9460.337776355727;9520.152785188247;9668.564914578861;9693.6122555097;9721.46531940736;3544.61009288978;3790.469334293201;3836.3478208704028;3974.9205015900097;3980.5024371953505;959.3332633819429;967.9854802177832;974.4056125763278;980.8528720691953;990.9653162139291;21311.36065918025;21330;21342.78657213408;21426.892865535574;21429;966.3622009473854;967.5791030901439;976.9413835169912;990.2078337330252;990.8910019897805;10320.948395257976;10911.745149307773;11019.504122314514;11160.665180044612;11175.664730058112;781763;801403;808302;812433;824248.8787556024;146944.26527867292;147216.26391868186;147806.52193478143;152227.23886380496;153469;1231.9260844349367;1273.0833799664226;1327.1307293722627;1327.9854729763576;1330.3747238797944;19265;19589.216431342586;19886;19893;19928.50178745543;60708;60745.088823668564;61255.693721531105;62381.37618623937;63433.04850427155;87397.56301218453;87419;88210;90719.09280907107;90988.09011909796;9788.216942644429;11000.449977500934;11452.484638191134;11682.532698691957;11731.88268117308;8829.514376709343;12744.74510509803;13144.671383215496;13152.80270795958;14046;11050.557977680803;11156.49795759209;11350.148738844455;11362.602308919479;11468.82796758066;10369;10411.063004329646;10519.16254434593;10687.946560267459;10805.081568066802;11333.376664283544;11527.02317700392;11533.308001519936;11543.961043506124;11914.98722608588;11001.669949901516;11438.19932604743;11447.313161210353;11450.255733377304;11697.883021169679;11064;11200.031792869624;11206.943965280121;11264.436778161224;11410.087193024372 08:01:13 INFO - PROCESS | 1639 | |3;mootools.html;1212.6786401603572;1389.4581113365787;1603.2384617306782;1624.2528436919024;1626.0487614745373;9386.953065234673;9812.705618831438;9829.7542561436;10015.899841001607;10030.648927287546;9787.657431989881;10911.618093366733;11208.66374008781;11210.383428911407;11636.767264654702;2464.7412021737728;2511.711153217376;2514.182890560566;2515.346010037394;2516.660250866137;2412.7225369082603;2477.715062767778;2481.8262721609494;2487.4154573675173;2487.514934587747;2083.7395325584303;2150.021740108247;2154.859934104286;2160;2163.675448682702;2393.5811233034237;2498.375406148463;2510.987445062763;2514.5473814713346;2518.2319392585255;2436.281297017384;2466.3710753757678;2491.252624212747;2494.900203991838;2499.7125330587032;11150.66548003553;11400.771984560346;11538.48076836536;11542.480588373543;11557.133215008907;5979.19280897082;6158.8768224635705;6160.722767475474;6161;6178.969105154445;3596.9100772480638;3728.0866187783895;3741.3639681254253;3787.4129509926006;3822.8722526854367;1266.9104570069733;1945.9902700486407;1957.9818494382982;1995.122146255643;2055.876647401161;15690;15912.204389780465;15934.52196434109;15959.202039897958;15994.200289985454;5010.824621138316;5148.459411761786;5181.766820493087;5224.216367544823;5230.032443997872;12214.389280535937;12266.754664906652;12304;12309.753804923852;12322.075844311712;6008.369121242294;6040.486558642477;6041.335453100155;6057.3336932937345;6073.119397687311;5371.543418809445;5455.8363249102595;5490.533304669068;5570.498655121059;5578.163275508706;3968.6771734407985;4088.570700076449;4089.91820163601;4133.235351459929;4138;1056.0759335581367;1063.1919740996743;1066.722652110457;1085.8154113800515;1086.7772106718103;962.956666949989;969.6266937229218;975.4050029482011;984.773502094508;1013.5793645636978;6758.256591774901;6851.965740171367;6900.551464154814;7019.613921234381;7024.121984751906;831.538496134639;999.9000099989943;1026.440589878518;1042.4735508568124;1047.225053460449;4036.6367026967714;4213.367994800805;4275.508316543637;4344.500382455994;4350.499692535335;13918.791218131737;14530.564083077525;14538;14548.709025819637;14552.563423097325;14104.294785260696;14330;14391.712165756626;14411.855881441052;14426.927865360816;10645.467726613639;10863.293885897392;10864.96782805648;10889.346639201673;10904.291221070605;5316.920246196233;6575.961451949911;6639.966800165968;6692.163479565054;7108.715651374094;12551.497940082294;12810.807837882252;13050.477980880658;13155.144915580457;13163.802542961672;11703.941480292544;12026.338551379758;12054.397280136134;13390.531331403354;13406.061575689608;9016.504092274725;9511.381760185566;9541.188998935168;9558.95220523893;9562.61749530011;10340.638077667245;10498.632547860789;10565.471726413802;10606.734831629272;10632.681019569425;8927.464352138892;8968.730938071869;9023.962244341723;9030.187283144549;9160.175584197454;7881.369490440866;8300.792480188044;8418.621162047844;8471.745847624581;8485.703000394957;8014.278714915686;8027.678892844221;8030.518168909651;8116.472429292077;8133.227343402367;5932.199153114447;5955.40445955401;5958.225430693982;6137.723802428991;6171.506279497719;6015.699215039318;6205.162303089206;6205.565610407228;6251.9687401562705;6290.402411770874 08:01:13 INFO - PROCESS | 1639 | |4;prototype.html;373.86540845295707;387.94956655634763;391.594699486032;391.990200244994;394.08768700458427;4731.574158325754;4766.142094423002;4772.210421092091;5116.667416617917;5175.663581867176;4451.666125040627;4534.909301813962;4867.683600565961;4880.609551235902;5103.897922041557;3218.243712727513;3594.442861356481;4034.5763694812063;4093.2222877653153;4140.50313962325;3324.7838890472162;3812.7504772184407;4091.3453847384426;4133.813978370966;4185.9744362631045;3834.5206849143856;4109.301418758818;4113.56807535209;4126.76197140858;4171.812268447927;3447.3105378924065;3556.826247338385;4028.992751812047;4074.9796251018556;4112.342025275956;3305.5702758641464;3814.8664796731982;3819.350710379242;3835.5013848199833;3853.6724378427866;4134.904250373654;4406.25093734066;4662.533746625344;4838.854834354975;4895.9510404895855;4296.679792911824;4547.795349209294;4708.223143181371;4778.307145463888;4814.398200224972;4555.612772914306;4653.325267836179;4929.580985616227;5019.824306149304;5252.763625636855;3574.392353299945;4101.85643502479;4297.72064815786;4298.506866017702;4348.086901750637;5473.480019398151;5645.661260324353;5646.54827613794;5674.120256579338;5724.570657200685;3576.98211508946;4203.747775133502;4330.328799036154;4350.760708161081;4355.695101342939;3755.887323380303;3974.463447434617;4323.675724320626;4449.621782148489;4527.117212143667;4178.707490475637;4414.867553973386;4524.891401606562;4834.444038935568;4840.273958906192;4741.799285482286;4852.878678033077;5194.506521880416;5226.895462090737;5302.602304827154;1387.653086728318;1392.6866455047534;1420.7371636247328;1525.9323616499705;1548.3651702801797;892.8794612727329;966.8211380894417;1135.0635725526474;1146.1174895330716;1194.665493661776;5215.044358365613;5229.424763276036;5239.629379885648;5271.575075465253;5308.283381743492;5372.549411658831;5632.324121105494;5639.6334238274385;5654.37801841797;5675.886482270332;4775.856724298276;5071.819117779391;5140.151874940668;5191.6884986900905;5270.4188743376835;2436.2713760588254;2560.7823335016733;2642.973570264311;2838.389746204576;2861.467601172977;4965.577925876341;5140.193918686041;5646.830595082072;5661.773529058792;5672.8865422691315;4435.866923992286;4583.983047459107;5497.059073395714;5518.503334699896;5726.707143392566;4747.64392670558;5409.161579955114;5507.834764957058;5526.06056970316;5719.828405147852;4521.84173553924;4974.701517908937;5342.973285133549;5544.362398324083;5551.500364967173;4532.252178390529;4713.505081966344;4822.493638168082;4836.879078023077;5304.443033481429;4665.836695715634;5426.8371948841595;5593.461798005581;5630.943690563042;5671.688057156731;3836.9831994522033;4161.875143745692;4271.594198551133;4390.3414487827085;4468.603861065679;4536.57488596121;4697.624190064855;5243.68537887728;5479.821838304783;5629.4652008059165;4232.101010807607;4405.427294451701;4508.684392092653;5052.863105801165;5294.364676238876;4726;4773.09311230865;5295.629305948547;5301.416844147064;5430.782768689208;4110.46563946685;4558.498565157896;5127.589792816491;5264.447233040476;5332.840014799563;4664.160451118832;5051.438735691402;5178.016176926522;5333.573314134782;5490.176473529003;4534.13851368239;4809.917768502059;4882.951170488392;5215.4353693892435;5269.4730526947 08:01:13 INFO - PROCESS | 1639 | |5;yui.html;746.7423738810115;763.6601712238053;766.76613632842;886.3573908916037;891.2290868398835;15515.844841551596;17438.651226975453;17442.215100320485;17453.563660908483;17460.56348591286;16098.678026439464;16142.919285403586;16313.673726525461;16347.100909449975;16347.673046539063;991.1327588360167;991.4299277915192;998.1715176403604;1013.9949300253488;1034.5189486888596;1021.6781713760179;1022.9948850255738;1023.3092662452815;1024.109025148122;1024.692592222334;1059.099765199582;1064.0742553978012;1066.1257768629728;1066.4081434803682;1071.9464026798669;1059.142094903131;1060.2313322840955;1062.2033474893828;1063.6702622187147;1063.9946800266027;785.7446329942792;787.4133770341075;787.7164220880536;788.1173086143499;788.8856115863167;15243.61890952724;17407.564810879703;17428.390006349717;18074.548136296566;18307;13631.727365452734;13738.244396558186;14709.70580588393;14751.77872331916;14850.702985940221;9829.459379734111;11814.822777658343;11890.108241881808;11925.463354149084;12469.875301246962;4608.792604332813;4678.461976872669;4699.2481203007355;4710.717356958594;4716.292556116576;112051;115063;115216;116793;117774.41112794467;10828.296160749684;11189.832152517718;11369.658910232707;11477.655670329903;11577.6526704199;22380.216692416012;22400.88799555992;22403.327900162694;22424.88787556052;22439.775602244095;7926.405519586054;7934.920650793533;8022.1175670676175;8343.499390036617;8371.409432207984;4446.399736035593;4504.887377815516;4553.977230113895;4580.610648094883;4670.439547254283;3549.751517393809;3555.075680323083;3624.8187590620364;3626.075350785533;3630.056185391817;646.7122130651909;650.3269116464531;656.9704363303663;662.8707402056552;664.0935123556408;542.3979382884994;555.1339909740817;560.6047736345866;578.8205656246492;584.9736761845727;10073.899261007442;10173.694789156189;10353.119984801226;10377.533011014522;10381.117605003508;612.2194202391897;636.4272155060482;651.088476133417;656.474820143883;692.3353580562716;4887.828925987574;4976.154053810861;4989.7006179628615;4991.276264941635;4993.875153121201;102592;106262;106574;110027.44986275178;111512.88487115187;54224;69343.65328173326;70890.26542478456;83522.16477835143;94303;78100;78401.60799195968;78806.81789773158;80240;80940.59529702431;11139.83290250663;11286.435678215892;11579.942100289782;11607.36159511235;11679.591214307458;48468;49401.50598494113;52313.47686523086;52520.7373963143;53441.732791335795;64357;64872.026919597185;66241;66782.66434671183;67194.3280567188;13268.800967985295;13360.27965916536;13397.799033014318;13417.865821341662;13534.526291579747;13081.738365232832;14279.785803212751;14984.935647667862;15562.688746224785;15579;14101.506447274296;14231.50189743354;14330.279969002606;14607.780883286972;14617.85382146165;13270.535531256359;13865.376058077209;14340.282985850874;14521.128732276096;14844.183569903327;13432.39554220043;14053.929730351283;14175.858241417867;14189.290535473392;14499.275036248357;9505.239580833655;10109.88352047001;10227.795444091225;10391.532381043022;10447.111995480469;8352.958235208785;9868.85196722064;11658;12257.448414821176;12274.693132671397 08:01:13 INFO - PROCESS | 1639 | __end_tp_report 08:01:13 INFO - PROCESS | 1639 | __start_cc_report 08:01:13 INFO - PROCESS | 1639 | _x_x_mozilla_cycle_collect,2360 08:01:13 INFO - PROCESS | 1639 | __end_cc_report 08:01:13 INFO - PROCESS | 1639 | __startTimestamp1493910073860__endTimestamp 08:01:13 INFO - PROCESS | 1639 | 08:01:13 INFO - PROCESS | 1639 | ------- Summary: start ------- 08:01:13 INFO - PROCESS | 1639 | Number of tests: 6 08:01:13 INFO - PROCESS | 1639 | 08:01:13 INFO - PROCESS | 1639 | [#0] dojo.html Cycles:165 Average:5900.30 Median:6210.60 stddev:667.22 (10.7%) stddev-sans-first:640.78 08:01:13 INFO - PROCESS | 1639 | Values: 3441.6 3446.8 3453.0 3466.7 3475.0 5981.7 6067.2 6071.0 6088.4 6098.4 5679.2 5988.0 6053.4 6058.4 6065.6 5278.6 5289.8 5304.6 5325.4 5433.8 5241.8 5252.2 5323.4 5337.5 5419.5 4442.5 5340.9 5340.9 5345.7 5347.9 5326.5 5335.9 5343.0 5343.8 5347.8 5180.4 5286.9 5302.5 5309.9 5335.4 5992.6 6000.1 6006.7 6008.2 6015.9 6242.6 6248.3 6259.5 6263.7 6267.1 6289.4 6289.8 6329.8 6354.0 6374.6 6033.2 6047.7 6047.8 6076.5 6087.0 6259.8 6300.9 6547.4 6549.9 6579.3 6210.6 6210.7 6257.6 6257.6 6302.7 6403.9 6413.8 6418.6 6420.9 6448.8 6192.2 6331.1 6343.8 6356.2 6360.0 6171.1 6234.1 6248.5 6256.1 6269.5 5015.1 5162.4 5188.2 5194.6 5200.8 4551.3 4567.2 4575.4 4594.4 4603.0 4795.9 6109.0 6184.7 6204.2 6213.8 6219.7 6283.0 6283.0 6309.5 6346.4 6171.1 6186.0 6195.6 6198.6 6205.8 5573.2 5602.3 5631.2 5634.3 5650.9 6297.7 6324.0 6508.9 6621.1 6626.8 6368.7 6376.1 6396.1 6399.5 6400.4 6566.5 6585.4 6594.1 6595.5 6604.4 6213.8 6270.3 6276.0 6288.9 6363.6 6291.9 6298.0 6303.0 6311.9 6313.1 6219.8 6294.2 6301.1 6309.7 6328.4 4977.3 5131.5 6249.2 6326.5 6330.4 6254.3 6279.8 6283.6 6291.3 6291.3 6151.6 6215.1 6255.4 6273.9 6351.7 5947.0 5965.9 6031.5 6222.1 6270.0 08:01:13 INFO - PROCESS | 1639 | 08:01:13 INFO - PROCESS | 1639 | [#1] ext.html Cycles:180 Average:54651.90 Median:29217.13 stddev:111760.18 (382.5%) stddev-sans-first:112000.60 08:01:13 INFO - PROCESS | 1639 | Values: 814.5 823.7 909.4 916.5 918.0 39578.8 40354.6 42863.8 43066.0 43133.6 41979.4 42106.6 42181.6 42193.0 43250.6 7972.7 9659.1 9796.1 9813.6 9817.3 8042.0 11767.5 11884.9 12181.9 12211.3 11965.9 11994.6 12002.7 12003.0 12012.4 11909.2 11934.9 11936.2 11941.2 11948.0 11535.9 11564.5 11589.2 11594.4 11599.5 33664.5 34997.8 38943.0 39007.6 39058.0 3974.4 4029.7 4031.2 4038.7 4066.4 28482.4 29032.0 29981.6 30585.4 30749.8 3291.5 3301.5 3317.3 3451.7 3453.6 322399.4 327922.0 328236.0 328237.0 328326.4 42376.0 43159.9 52108.7 52217.0 52243.7 45208.5 45380.8 45453.8 45524.5 53305.0 15040.8 15407.7 15418.8 15453.8 15475.3 13286.5 13306.9 13327.9 13343.5 13346.0 12089.3 12095.3 12129.0 12140.0 12194.5 4748.8 4825.8 5826.7 5830.8 5845.4 1152.9 1155.6 1156.5 1166.5 1206.3 25882.5 26765.7 26969.3 27121.7 27141.6 1287.1 1289.6 1291.1 1341.0 1348.9 13523.3 13915.2 14097.1 14171.8 14281.6 470657.0 472071.6 472688.0 473079.6 473205.0 55565.7 55751.0 55879.2 56000.0 56007.4 1476.8 1489.5 1500.2 1556.3 1559.0 26069.3 26630.6 27228.2 27256.8 27379.5 37213.4 37224.6 37258.3 37317.6 37327.6 440636.0 441959.0 442285.0 443405.0 472973.6 24786.9 24999.6 25105.1 26516.9 29402.3 30498.5 30872.0 37818.9 38580.2 39109.4 27552.9 27664.7 28096.0 28403.3 28560.6 27562.9 27819.9 28087.3 28389.0 28393.7 23335.0 32661.3 32671.5 32761.8 32773.5 20725.7 28171.7 28200.6 28598.4 28802.9 22334.8 22409.8 22747.5 22760.0 22792.4 08:01:13 INFO - PROCESS | 1639 | 08:01:13 INFO - PROCESS | 1639 | [#2] jquery.html Cycles:180 Average:44751.57 Median:23679.04 stddev:133755.96 (564.9%) stddev-sans-first:134089.63 08:01:13 INFO - PROCESS | 1639 | Values: 352.5 368.6 434.9 437.6 442.8 20963.4 21039.5 22515.3 22518.1 22739.7 22346.1 22682.7 23200.5 23229.1 24129.0 6607.9 6864.9 6880.3 6927.2 6930.6 7313.2 7593.4 7781.4 7782.1 7801.4 7592.9 7641.8 7644.2 7733.5 7767.8 7528.8 7732.2 7791.3 7803.9 7808.3 7644.9 7654.2 7663.3 7670.0 7679.1 27128.9 27572.9 28151.3 28239.0 28512.0 3024.5 3440.4 3450.8 3517.4 3528.7 15191.7 16466.8 16659.4 16712.3 16985.7 2048.9 2099.7 2099.9 2102.1 2104.3 128027.0 154517.2 158552.0 158676.2 160150.0 15052.7 20587.5 20732.6 20917.3 20939.7 32225.8 32576.0 32874.3 32888.0 32908.8 8769.5 10713.5 10894.3 11071.6 11259.2 9192.7 9199.8 9216.3 9381.3 9389.6 9460.3 9520.2 9668.6 9693.6 9721.5 3544.6 3790.5 3836.3 3974.9 3980.5 959.3 968.0 974.4 980.9 991.0 21311.4 21330.0 21342.8 21426.9 21429.0 966.4 967.6 976.9 990.2 990.9 10320.9 10911.7 11019.5 11160.7 11175.7 781763.0 801403.0 808302.0 812433.0 824248.9 146944.3 147216.3 147806.5 152227.2 153469.0 1231.9 1273.1 1327.1 1328.0 1330.4 19265.0 19589.2 19886.0 19893.0 19928.5 60708.0 60745.1 61255.7 62381.4 63433.0 87397.6 87419.0 88210.0 90719.1 90988.1 9788.2 11000.4 11452.5 11682.5 11731.9 8829.5 12744.7 13144.7 13152.8 14046.0 11050.6 11156.5 11350.1 11362.6 11468.8 10369.0 10411.1 10519.2 10687.9 10805.1 11333.4 11527.0 11533.3 11544.0 11915.0 11001.7 11438.2 11447.3 11450.3 11697.9 11064.0 11200.0 11206.9 11264.4 11410.1 08:01:13 INFO - PROCESS | 1639 | 08:01:13 INFO - PROCESS | 1639 | [#3] mootools.html Cycles:180 Average:6937.40 Median:2514.37 stddev:4333.11 (172.3%) stddev-sans-first:4323.90 08:01:13 INFO - PROCESS | 1639 | Values: 1212.7 1389.5 1603.2 1624.3 1626.0 9387.0 9812.7 9829.8 10015.9 10030.6 9787.7 10911.6 11208.7 11210.4 11636.8 2464.7 2511.7 2514.2 2515.3 2516.7 2412.7 2477.7 2481.8 2487.4 2487.5 2083.7 2150.0 2154.9 2160.0 2163.7 2393.6 2498.4 2511.0 2514.5 2518.2 2436.3 2466.4 2491.3 2494.9 2499.7 11150.7 11400.8 11538.5 11542.5 11557.1 5979.2 6158.9 6160.7 6161.0 6179.0 3596.9 3728.1 3741.4 3787.4 3822.9 1266.9 1946.0 1958.0 1995.1 2055.9 15690.0 15912.2 15934.5 15959.2 15994.2 5010.8 5148.5 5181.8 5224.2 5230.0 12214.4 12266.8 12304.0 12309.8 12322.1 6008.4 6040.5 6041.3 6057.3 6073.1 5371.5 5455.8 5490.5 5570.5 5578.2 3968.7 4088.6 4089.9 4133.2 4138.0 1056.1 1063.2 1066.7 1085.8 1086.8 963.0 969.6 975.4 984.8 1013.6 6758.3 6852.0 6900.6 7019.6 7024.1 831.5 999.9 1026.4 1042.5 1047.2 4036.6 4213.4 4275.5 4344.5 4350.5 13918.8 14530.6 14538.0 14548.7 14552.6 14104.3 14330.0 14391.7 14411.9 14426.9 10645.5 10863.3 10865.0 10889.3 10904.3 5316.9 6576.0 6640.0 6692.2 7108.7 12551.5 12810.8 13050.5 13155.1 13163.8 11703.9 12026.3 12054.4 13390.5 13406.1 9016.5 9511.4 9541.2 9559.0 9562.6 10340.6 10498.6 10565.5 10606.7 10632.7 8927.5 8968.7 9024.0 9030.2 9160.2 7881.4 8300.8 8418.6 8471.7 8485.7 8014.3 8027.7 8030.5 8116.5 8133.2 5932.2 5955.4 5958.2 6137.7 6171.5 6015.7 6205.2 6205.6 6252.0 6290.4 08:01:13 INFO - PROCESS | 1639 | 08:01:13 INFO - PROCESS | 1639 | [#4] prototype.html Cycles:180 Average:4386.16 Median:4719.75 stddev:1242.05 (26.3%) stddev-sans-first:1208.48 08:01:13 INFO - PROCESS | 1639 | Values: 373.9 387.9 391.6 392.0 394.1 4731.6 4766.1 4772.2 5116.7 5175.7 4451.7 4534.9 4867.7 4880.6 5103.9 3218.2 3594.4 4034.6 4093.2 4140.5 3324.8 3812.8 4091.3 4133.8 4186.0 3834.5 4109.3 4113.6 4126.8 4171.8 3447.3 3556.8 4029.0 4075.0 4112.3 3305.6 3814.9 3819.4 3835.5 3853.7 4134.9 4406.3 4662.5 4838.9 4896.0 4296.7 4547.8 4708.2 4778.3 4814.4 4555.6 4653.3 4929.6 5019.8 5252.8 3574.4 4101.9 4297.7 4298.5 4348.1 5473.5 5645.7 5646.5 5674.1 5724.6 3577.0 4203.7 4330.3 4350.8 4355.7 3755.9 3974.5 4323.7 4449.6 4527.1 4178.7 4414.9 4524.9 4834.4 4840.3 4741.8 4852.9 5194.5 5226.9 5302.6 1387.7 1392.7 1420.7 1525.9 1548.4 892.9 966.8 1135.1 1146.1 1194.7 5215.0 5229.4 5239.6 5271.6 5308.3 5372.5 5632.3 5639.6 5654.4 5675.9 4775.9 5071.8 5140.2 5191.7 5270.4 2436.3 2560.8 2643.0 2838.4 2861.5 4965.6 5140.2 5646.8 5661.8 5672.9 4435.9 4584.0 5497.1 5518.5 5726.7 4747.6 5409.2 5507.8 5526.1 5719.8 4521.8 4974.7 5343.0 5544.4 5551.5 4532.3 4713.5 4822.5 4836.9 5304.4 4665.8 5426.8 5593.5 5630.9 5671.7 3837.0 4161.9 4271.6 4390.3 4468.6 4536.6 4697.6 5243.7 5479.8 5629.5 4232.1 4405.4 4508.7 5052.9 5294.4 4726.0 4773.1 5295.6 5301.4 5430.8 4110.5 4558.5 5127.6 5264.4 5332.8 4664.2 5051.4 5178.0 5333.6 5490.2 4534.1 4809.9 4883.0 5215.4 5269.5 08:01:13 INFO - PROCESS | 1639 | 08:01:13 INFO - PROCESS | 1639 | [#5] yui.html Cycles:180 Average:20857.62 Median:17417.98 stddev:29723.63 (170.6%) stddev-sans-first:29768.65 08:01:13 INFO - PROCESS | 1639 | Values: 746.7 763.7 766.8 886.4 891.2 15515.8 17438.7 17442.2 17453.6 17460.6 16098.7 16142.9 16313.7 16347.1 16347.7 991.1 991.4 998.2 1014.0 1034.5 1021.7 1023.0 1023.3 1024.1 1024.7 1059.1 1064.1 1066.1 1066.4 1071.9 1059.1 1060.2 1062.2 1063.7 1064.0 785.7 787.4 787.7 788.1 788.9 15243.6 17407.6 17428.4 18074.5 18307.0 13631.7 13738.2 14709.7 14751.8 14850.7 9829.5 11814.8 11890.1 11925.5 12469.9 4608.8 4678.5 4699.2 4710.7 4716.3 112051.0 115063.0 115216.0 116793.0 117774.4 10828.3 11189.8 11369.7 11477.7 11577.7 22380.2 22400.9 22403.3 22424.9 22439.8 7926.4 7934.9 8022.1 8343.5 8371.4 4446.4 4504.9 4554.0 4580.6 4670.4 3549.8 3555.1 3624.8 3626.1 3630.1 646.7 650.3 657.0 662.9 664.1 542.4 555.1 560.6 578.8 585.0 10073.9 10173.7 10353.1 10377.5 10381.1 612.2 636.4 651.1 656.5 692.3 4887.8 4976.2 4989.7 4991.3 4993.9 102592.0 106262.0 106574.0 110027.4 111512.9 54224.0 69343.7 70890.3 83522.2 94303.0 78100.0 78401.6 78806.8 80240.0 80940.6 11139.8 11286.4 11579.9 11607.4 11679.6 48468.0 49401.5 52313.5 52520.7 53441.7 64357.0 64872.0 66241.0 66782.7 67194.3 13268.8 13360.3 13397.8 13417.9 13534.5 13081.7 14279.8 14984.9 15562.7 15579.0 14101.5 14231.5 14330.3 14607.8 14617.9 13270.5 13865.4 14340.3 14521.1 14844.2 13432.4 14053.9 14175.9 14189.3 14499.3 9505.2 10109.9 10227.8 10391.5 10447.1 8353.0 9868.9 11658.0 12257.4 12274.7 08:01:13 INFO - PROCESS | 1639 | -------- Summary: end -------- 08:01:13 INFO - PROCESS | 1639 | 08:01:14 INFO - TEST-INFO | 1639: exit 0 08:01:14 INFO - TEST-OK | dromaeo_css | took 1119497ms 08:01:14 INFO - TEST-START | kraken 08:01:14 INFO - operating with platform_type : mac_ 08:01:14 INFO - Initialising browser for kraken test... 08:01:14 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmpAC7IaL/profile http://localhost:49246/getInfo.html) 08:01:16 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 08:01:16 INFO - PROCESS | 1649 | colorDepth:24 08:01:16 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 08:01:16 INFO - PROCESS | 1649 | __metrics 08:01:16 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:01:16 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:01:17 INFO - TEST-INFO | 1649: exit 0 08:01:17 INFO - Browser initialized. 08:01:17 INFO - Running cycle 1/1 for kraken test... 08:01:17 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/T/tmpAC7IaL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:01:29 INFO - PROCESS | 1651 | RSS: Main: 165371904 08:01:29 INFO - PROCESS | 1651 | 08:01:32 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection) 08:01:33 INFO - PROCESS | 1651 | RSS: Main: 216342528 08:01:33 INFO - PROCESS | 1651 | 08:01:35 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-dft) 08:01:36 INFO - PROCESS | 1651 | RSS: Main: 232517632 08:01:36 INFO - PROCESS | 1651 | 08:01:39 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-fft) 08:01:40 INFO - PROCESS | 1651 | RSS: Main: 328892416 08:01:40 INFO - PROCESS | 1651 | 08:01:42 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator) 08:01:42 INFO - PROCESS | 1651 | RSS: Main: 231272448 08:01:42 INFO - PROCESS | 1651 | 08:01:44 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:01:45 INFO - PROCESS | 1651 | RSS: Main: 232390656 08:01:45 INFO - PROCESS | 1651 | 08:01:48 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom) 08:01:49 INFO - PROCESS | 1651 | RSS: Main: 274186240 08:01:49 INFO - PROCESS | 1651 | 08:01:52 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate) 08:01:52 INFO - PROCESS | 1651 | RSS: Main: 274296832 08:01:52 INFO - PROCESS | 1651 | 08:01:55 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial) 08:01:56 INFO - PROCESS | 1651 | RSS: Main: 270512128 08:01:56 INFO - PROCESS | 1651 | 08:01:57 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:01:58 INFO - PROCESS | 1651 | RSS: Main: 247885824 08:01:58 INFO - PROCESS | 1651 | 08:02:00 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:02:00 INFO - PROCESS | 1651 | RSS: Main: 252194816 08:02:00 INFO - PROCESS | 1651 | 08:02:02 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:02:03 INFO - PROCESS | 1651 | RSS: Main: 256487424 08:02:03 INFO - PROCESS | 1651 | 08:02:06 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:02:07 INFO - PROCESS | 1651 | RSS: Main: 262750208 08:02:07 INFO - PROCESS | 1651 | 08:02:10 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:02:10 INFO - PROCESS | 1651 | RSS: Main: 263766016 08:02:10 INFO - PROCESS | 1651 | 08:02:12 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49246/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49246/tests/kraken/driver.html?testName=ai-astar) 08:02:12 INFO - PROCESS | 1651 | RSS: Main: 308408320 08:02:12 INFO - PROCESS | 1651 | 08:02:12 INFO - PROCESS | 1651 | __start_tp_report 08:02:12 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 08:02:12 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 08:02:12 INFO - PROCESS | 1651 | |i|pagename|runs| 08:02:12 INFO - PROCESS | 1651 | |0;ai-astar;106;116;117;116;117;117;117;117;115;118 08:02:12 INFO - PROCESS | 1651 | |1;audio-beat-detection;143;128;138;176;139;108;108;106;118;107 08:02:12 INFO - PROCESS | 1651 | |2;audio-dft;186;184;185;184;190;187;185;183;186;184 08:02:12 INFO - PROCESS | 1651 | |3;audio-fft;82;61;61;91;81;83;84;70;75;60 08:02:12 INFO - PROCESS | 1651 | |4;audio-oscillator;87;66;85;70;69;68;81;91;98;112 08:02:12 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;88;88;88;89;88;89;88;88;89;88 08:02:12 INFO - PROCESS | 1651 | |6;imaging-darkroom;96;95;96;95;95;95;95;96;96;95 08:02:12 INFO - PROCESS | 1651 | |7;imaging-desaturate;87;85;83;85;84;87;85;82;83;83 08:02:12 INFO - PROCESS | 1651 | |8;json-parse-financial;63;62;60;59;63;63;62;62;63;64 08:02:12 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;62;58;69;63;60;59;58;58;59;59 08:02:12 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;84;81;86;84;84;82;86;88;105;84 08:02:12 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;137;142;136;143;131;133;142;137;148;133 08:02:12 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;163;190;215;185;161;162;162;163;163;158 08:02:12 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;64;65;64;64;65;62;64;62;61;60 08:02:12 INFO - PROCESS | 1651 | __end_tp_report 08:02:12 INFO - PROCESS | 1651 | __start_cc_report 08:02:12 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,2031 08:02:12 INFO - PROCESS | 1651 | __end_cc_report 08:02:12 INFO - PROCESS | 1651 | __startTimestamp1493910132597__endTimestamp 08:02:12 INFO - PROCESS | 1651 | 08:02:12 INFO - PROCESS | 1651 | ------- Summary: start ------- 08:02:12 INFO - PROCESS | 1651 | Number of tests: 14 08:02:12 INFO - PROCESS | 1651 | 08:02:12 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:115.60 Median:117.00 stddev:3.47 (3.0%) stddev-sans-first:0.87 08:02:12 INFO - PROCESS | 1651 | Values: 106.0 116.0 117.0 116.0 117.0 117.0 117.0 117.0 115.0 118.0 08:02:12 INFO - PROCESS | 1651 | 08:02:12 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:127.10 Median:133.00 stddev:22.53 (16.9%) stddev-sans-first:23.15 08:02:12 INFO - PROCESS | 1651 | Values: 143.0 128.0 138.0 176.0 139.0 108.0 108.0 106.0 118.0 107.0 08:02:12 INFO - PROCESS | 1651 | 08:02:12 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:185.40 Median:185.50 stddev:2.01 (1.1%) stddev-sans-first:2.12 08:02:12 INFO - PROCESS | 1651 | Values: 186.0 184.0 185.0 184.0 190.0 187.0 185.0 183.0 186.0 184.0 08:02:12 INFO - PROCESS | 1651 | 08:02:12 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:74.80 Median:81.50 stddev:11.19 (13.7%) stddev-sans-first:11.57 08:02:12 INFO - PROCESS | 1651 | Values: 82.0 61.0 61.0 91.0 81.0 83.0 84.0 70.0 75.0 60.0 08:02:12 INFO - PROCESS | 1651 | 08:02:12 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:82.70 Median:83.00 stddev:15.03 (18.1%) stddev-sans-first:15.86 08:02:12 INFO - PROCESS | 1651 | Values: 87.0 66.0 85.0 70.0 69.0 68.0 81.0 91.0 98.0 112.0 08:02:12 INFO - PROCESS | 1651 | 08:02:12 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:88.30 Median:88.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 08:02:12 INFO - PROCESS | 1651 | Values: 88.0 88.0 88.0 89.0 88.0 89.0 88.0 88.0 89.0 88.0 08:02:12 INFO - PROCESS | 1651 | 08:02:12 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 08:02:12 INFO - PROCESS | 1651 | Values: 96.0 95.0 96.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 08:02:12 INFO - PROCESS | 1651 | 08:02:12 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:85.00 stddev:1.71 (2.0%) stddev-sans-first:1.54 08:02:12 INFO - PROCESS | 1651 | Values: 87.0 85.0 83.0 85.0 84.0 87.0 85.0 82.0 83.0 83.0 08:02:12 INFO - PROCESS | 1651 | 08:02:12 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:62.10 Median:63.00 stddev:1.52 (2.4%) stddev-sans-first:1.58 08:02:12 INFO - PROCESS | 1651 | Values: 63.0 62.0 60.0 59.0 63.0 63.0 62.0 62.0 63.0 64.0 08:02:12 INFO - PROCESS | 1651 | 08:02:12 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:60.50 Median:59.50 stddev:3.44 (5.8%) stddev-sans-first:3.61 08:02:12 INFO - PROCESS | 1651 | Values: 62.0 58.0 69.0 63.0 60.0 59.0 58.0 58.0 59.0 59.0 08:02:12 INFO - PROCESS | 1651 | 08:02:12 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:84.00 stddev:6.83 (8.1%) stddev-sans-first:7.19 08:02:12 INFO - PROCESS | 1651 | Values: 84.0 81.0 86.0 84.0 84.0 82.0 86.0 88.0 105.0 84.0 08:02:12 INFO - PROCESS | 1651 | 08:02:12 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:138.20 Median:139.50 stddev:5.39 (3.9%) stddev-sans-first:5.70 08:02:12 INFO - PROCESS | 1651 | Values: 137.0 142.0 136.0 143.0 131.0 133.0 142.0 137.0 148.0 133.0 08:02:12 INFO - PROCESS | 1651 | 08:02:12 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:172.20 Median:163.00 stddev:18.56 (11.4%) stddev-sans-first:19.39 08:02:12 INFO - PROCESS | 1651 | Values: 163.0 190.0 215.0 185.0 161.0 162.0 162.0 163.0 163.0 158.0 08:02:12 INFO - PROCESS | 1651 | 08:02:12 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:64.00 stddev:1.73 (2.7%) stddev-sans-first:1.80 08:02:12 INFO - PROCESS | 1651 | Values: 64.0 65.0 64.0 64.0 65.0 62.0 64.0 62.0 61.0 60.0 08:02:12 INFO - PROCESS | 1651 | -------- Summary: end -------- 08:02:12 INFO - PROCESS | 1651 | 08:02:13 INFO - TEST-INFO | 1651: exit 0 08:02:13 INFO - TEST-OK | kraken | took 59024ms 08:02:13 INFO - SUITE-END | took 1178s 08:02:13 INFO - Completed test suite (00:19:38) 08:02:13 INFO - javascript benchmark 08:02:13 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7772.6740370510115, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3441.6386279440676, 3446.758726889119, 3453.0, 3466.653334666532, 3475.0443628002304, 5981.671008094553, 6067.180930574382, 6071.015492754991, 6088.421599948009, 6098.359672234413, 5679.204911312419, 5988.0, 6053.364396738345, 6058.39416058395, 6065.636061836281, 5278.604104692145, 5289.841304760864, 5304.6286759926825, 5325.440828712987, 5433.755481003364, 5241.842744717665, 5252.212168174766, 5323.387810401795, 5337.546308563777, 5419.5393391561765, 4442.511323754385, 5340.946590534084, 5340.946590534103, 5345.652532585389, 5347.866303342409, 5326.520613144836, 5335.866603334909, 5343.0, 5343.786248550054, 5347.786088556453, 5180.352455943007, 5286.920696189561, 5302.496262855023, 5309.893802123975, 5335.413104558495, 5992.610480318765, 6000.069989151689, 6006.699665016732, 6008.158857759917, 6015.879682406371, 6242.625442473421, 6248.250209974786, 6259.530535209878, 6263.71813268404, 6267.05994100884, 6289.40250676185, 6289.811305660837, 6329.810105696836, 6353.9682301588655, 6374.649394283312, 6033.245844269466, 6047.697615119227, 6047.848803779897, 6076.453119219247, 6086.965215913306, 6259.812205633838, 6300.936990630126, 6547.443467305237, 6549.901751473732, 6579.342065793382, 6210.596311239755, 6210.658413787285, 6257.561970662101, 6257.624542527463, 6302.747890084345, 6403.903941440882, 6413.807585772434, 6418.614883107029, 6420.935790642127, 6448.806535803933, 6192.195014648067, 6331.113644089831, 6343.841403964845, 6356.237251529846, 6359.96820015897, 6171.13604095427, 6234.064890266405, 6248.50011999039, 6256.092866534327, 6269.46709529686, 5015.14742493777, 5162.380514338229, 5188.169892817131, 5194.636375453758, 5200.817971370984, 4551.340055691972, 4567.177907976529, 4575.359449677047, 4594.425696787902, 4602.953970460319, 4795.928061079087, 6109.0, 6184.690765461799, 6204.193454850841, 6213.813585592439, 6219.689015549205, 6282.968585157045, 6283.0, 6309.526785491106, 6346.428821406003, 6171.13604095427, 6185.969070154621, 6195.628262304276, 6198.566100372931, 6205.751769929243, 5573.247611572467, 5602.327720673546, 5631.18347839561, 5634.295713035871, 5650.85872853182, 6297.716602752978, 6323.9683801580695, 6508.9349106508325, 6621.106150669598, 6626.801195964033, 6368.713407896563, 6376.107344971615, 6396.136521569715, 6399.488040956805, 6400.423961843457, 6566.474682025522, 6585.407313341822, 6594.142761440982, 6595.505337099641, 6604.405603495708, 6213.813585592439, 6270.341614130633, 6276.0, 6288.905666414916, 6363.61818290904, 6291.905621415774, 6298.02380631003, 6302.968485157545, 6311.936880631135, 6313.116163737172, 6219.844503887439, 6294.244690637152, 6301.117843501822, 6309.684515774285, 6328.398802113792, 4977.303177555217, 5131.461196574455, 6249.156363890998, 6326.525510586816, 6330.430261276507, 6254.2807577129215, 6279.811605651837, 6283.5601507895835, 6291.307956124914, 6291.339409362135, 6151.6001459904965, 6215.098810672337, 6255.40573645503, 6273.874522509433, 6351.68241587928, 5947.04847224442, 5965.91051134242, 6031.457168854824, 6222.128901953821, 6270.0], "value": 5858.238359647219, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [814.5112932240654, 823.7487566292281, 909.4316052467208, 916.5325683901212, 918.0360621347584, 39578.80210598947, 40354.596454035454, 42863.785681071626, 43066.0, 43133.568664313345, 41979.37030944531, 42106.57893421065, 42181.578184218146, 42192.99999999992, 43250.56749432505, 7972.681092756283, 9659.13067823894, 9796.118349348557, 9813.558389872438, 9817.263705222102, 8042.0, 11767.529298828036, 11884.881151188507, 12181.939090304537, 12211.32837693931, 11965.940170299136, 11994.580189693363, 12002.699932501713, 12003.0, 12012.399380031007, 11909.166358354918, 11934.880651193507, 11936.224145430519, 11941.223820451729, 11948.044156467462, 11535.884641153565, 11564.53741850325, 11589.188756787029, 11594.362310073027, 11599.536018559247, 33664.49503257453, 34997.825010875036, 38943.0, 39007.6347327845, 39058.0, 3974.4038394240806, 4029.6977726670616, 4031.213913286881, 4038.676905847525, 4066.410370496291, 28482.430351392857, 29032.0, 29981.55027674565, 30585.388292234253, 30749.8462507686, 3291.4569096099117, 3301.4552598821165, 3317.253617935969, 3451.6548345165534, 3453.620101788801, 322399.3880030585, 327922.0, 328236.0, 328237.0, 328326.35836820665, 42376.0, 43159.9210019752, 52108.73945630248, 52217.0, 52243.69390765261, 45208.54791452109, 45380.77309613431, 45453.77273113613, 45524.54475455269, 53305.0, 15040.849591503946, 15407.691846163014, 15418.768718469231, 15453.768193476883, 15475.303611337516, 13286.468541258242, 13306.933465332611, 13327.866721332663, 13343.532976345976, 13346.0, 12089.335086570147, 12095.334756588472, 12129.0, 12139.96810271137, 12194.51221951112, 4748.8337908173735, 4825.758712064383, 5826.659868230331, 5830.766769329264, 5845.357010728816, 1152.948117334722, 1155.589765633205, 1156.462245056053, 1166.5392170092935, 1206.3003457994341, 25882.482350352886, 26765.732342676714, 26969.325766855985, 27121.728782712315, 27141.592876106875, 1287.1118927939692, 1289.5615490733007, 1291.1478424239956, 1340.9731805363838, 1348.9460421583026, 13523.32383380827, 13915.165090094626, 14097.083689560352, 14171.78742318866, 14281.64295892611, 470657.0, 472071.6396417996, 472688.0, 473079.6346018248, 473205.0, 55565.722171389694, 55751.0, 55879.16181257284, 56000.0, 56007.43992560104, 1476.7932489451484, 1489.53079779869, 1500.219885659451, 1556.2763315058553, 1558.9766153507705, 26069.348266293495, 26630.600540992287, 27228.183154505397, 27256.773445194616, 27379.452410952068, 37213.44179837359, 37224.62775372212, 37258.25483490261, 37317.626823731414, 37327.626723732414, 440636.0, 441959.0, 442285.0, 443405.0, 472973.6351318359, 24786.884590193844, 24999.625005624566, 25105.121320753686, 26516.867415662797, 29402.264943376587, 30498.542521861746, 30872.0, 37818.86543403702, 38580.228395432496, 39109.41335880021, 27552.86223568869, 27664.723352766214, 28096.01663941752, 28403.289917752223, 28560.57159142573, 27562.862185688944, 27819.94476345681, 28087.297817554725, 28389.0, 28393.716062839107, 23335.0, 32661.34677306488, 32671.509927351584, 32761.836190818893, 32773.508397374535, 20725.68911466299, 28171.71828281691, 28200.576991345555, 28598.42803143967, 28802.855985719936, 22334.77158756284, 22409.77590224142, 22747.545049098593, 22760.0, 22792.430189244737], "value": 18668.07832577719, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.48361150913905, 368.6276860371026, 434.8564973558725, 437.5602519467934, 442.7520588470457, 20963.37109886702, 21039.47401314968, 22515.324540263777, 22518.09927602898, 22739.658905116416, 22346.10615575379, 22682.659760103612, 23200.535989280248, 23229.070837166535, 24129.0, 6607.933920660792, 6864.931350686504, 6880.2775708550635, 6927.168739751211, 6930.5841649500935, 7313.195548489662, 7593.430492713041, 7781.416393770462, 7782.066152061732, 7801.414893882981, 7592.924070759277, 7641.808954776119, 7644.197359277251, 7733.535987840747, 7767.805804854867, 7528.8117797054965, 7732.226777322251, 7791.259830316139, 7803.921960780376, 7808.297253247179, 7644.885326720104, 7654.196309387546, 7663.271989161077, 7669.961650191769, 7679.078510578766, 27128.86435567829, 27572.862135689393, 28151.296217594518, 28239.01163459269, 28512.0, 3024.5311976643657, 3440.415129428003, 3450.8274586270586, 3517.4196257617464, 3528.6824185823143, 15191.696166076617, 16466.75299870503, 16659.41692040785, 16712.331506739716, 16985.745213821803, 2048.897555122238, 2099.7060411542398, 2099.88450635215, 2102.085592767151, 2104.2740254612136, 128027.0, 154517.22741386332, 158552.0, 158676.20661896616, 160150.0, 15052.698946021019, 20587.4853128673, 20732.58534829295, 20917.267895623885, 20939.68590471144, 32225.838870805495, 32576.02271931846, 32874.342513149604, 32888.0, 32908.83545582257, 8769.517676527852, 10713.517891694737, 10894.346339219672, 11071.5571377144, 11259.155563332619, 9192.724218273463, 9199.804025476646, 9216.308776841764, 9381.29640276982, 9389.577469013911, 9460.337776355727, 9520.152785188247, 9668.564914578861, 9693.6122555097, 9721.46531940736, 3544.61009288978, 3790.469334293201, 3836.3478208704028, 3974.9205015900097, 3980.5024371953505, 959.3332633819429, 967.9854802177832, 974.4056125763278, 980.8528720691953, 990.9653162139291, 21311.36065918025, 21330.0, 21342.78657213408, 21426.892865535574, 21429.0, 966.3622009473854, 967.5791030901439, 976.9413835169912, 990.2078337330252, 990.8910019897805, 10320.948395257976, 10911.745149307773, 11019.504122314514, 11160.665180044612, 11175.664730058112, 781763.0, 801403.0, 808302.0, 812433.0, 824248.8787556024, 146944.26527867292, 147216.26391868186, 147806.52193478143, 152227.23886380496, 153469.0, 1231.9260844349367, 1273.0833799664226, 1327.1307293722627, 1327.9854729763576, 1330.3747238797944, 19265.0, 19589.216431342586, 19886.0, 19893.0, 19928.50178745543, 60708.0, 60745.088823668564, 61255.693721531105, 62381.37618623937, 63433.04850427155, 87397.56301218453, 87419.0, 88210.0, 90719.09280907107, 90988.09011909796, 9788.216942644429, 11000.449977500934, 11452.484638191134, 11682.532698691957, 11731.88268117308, 8829.514376709343, 12744.74510509803, 13144.671383215496, 13152.80270795958, 14046.0, 11050.557977680803, 11156.49795759209, 11350.148738844455, 11362.602308919479, 11468.82796758066, 10369.0, 10411.063004329646, 10519.16254434593, 10687.946560267459, 10805.081568066802, 11333.376664283544, 11527.02317700392, 11533.308001519936, 11543.961043506124, 11914.98722608588, 11001.669949901516, 11438.19932604743, 11447.313161210353, 11450.255733377304, 11697.883021169679, 11064.0, 11200.031792869624, 11206.943965280121, 11264.436778161224, 11410.087193024372], "value": 11895.204528574948, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1212.6786401603572, 1389.4581113365787, 1603.2384617306782, 1624.2528436919024, 1626.0487614745373, 9386.953065234673, 9812.705618831438, 9829.7542561436, 10015.899841001607, 10030.648927287546, 9787.657431989881, 10911.618093366733, 11208.66374008781, 11210.383428911407, 11636.767264654702, 2464.7412021737728, 2511.711153217376, 2514.182890560566, 2515.346010037394, 2516.660250866137, 2412.7225369082603, 2477.715062767778, 2481.8262721609494, 2487.4154573675173, 2487.514934587747, 2083.7395325584303, 2150.021740108247, 2154.859934104286, 2160.0, 2163.675448682702, 2393.5811233034237, 2498.375406148463, 2510.987445062763, 2514.5473814713346, 2518.2319392585255, 2436.281297017384, 2466.3710753757678, 2491.252624212747, 2494.900203991838, 2499.7125330587032, 11150.66548003553, 11400.771984560346, 11538.48076836536, 11542.480588373543, 11557.133215008907, 5979.19280897082, 6158.8768224635705, 6160.722767475474, 6161.0, 6178.969105154445, 3596.9100772480638, 3728.0866187783895, 3741.3639681254253, 3787.4129509926006, 3822.8722526854367, 1266.9104570069733, 1945.9902700486407, 1957.9818494382982, 1995.122146255643, 2055.876647401161, 15690.0, 15912.204389780465, 15934.52196434109, 15959.202039897958, 15994.200289985454, 5010.824621138316, 5148.459411761786, 5181.766820493087, 5224.216367544823, 5230.032443997872, 12214.389280535937, 12266.754664906652, 12304.0, 12309.753804923852, 12322.075844311712, 6008.369121242294, 6040.486558642477, 6041.335453100155, 6057.3336932937345, 6073.119397687311, 5371.543418809445, 5455.8363249102595, 5490.533304669068, 5570.498655121059, 5578.163275508706, 3968.6771734407985, 4088.570700076449, 4089.91820163601, 4133.235351459929, 4138.0, 1056.0759335581367, 1063.1919740996743, 1066.722652110457, 1085.8154113800515, 1086.7772106718103, 962.956666949989, 969.6266937229218, 975.4050029482011, 984.773502094508, 1013.5793645636978, 6758.256591774901, 6851.965740171367, 6900.551464154814, 7019.613921234381, 7024.121984751906, 831.538496134639, 999.9000099989943, 1026.440589878518, 1042.4735508568124, 1047.225053460449, 4036.6367026967714, 4213.367994800805, 4275.508316543637, 4344.500382455994, 4350.499692535335, 13918.791218131737, 14530.564083077525, 14538.0, 14548.709025819637, 14552.563423097325, 14104.294785260696, 14330.0, 14391.712165756626, 14411.855881441052, 14426.927865360816, 10645.467726613639, 10863.293885897392, 10864.96782805648, 10889.346639201673, 10904.291221070605, 5316.920246196233, 6575.961451949911, 6639.966800165968, 6692.163479565054, 7108.715651374094, 12551.497940082294, 12810.807837882252, 13050.477980880658, 13155.144915580457, 13163.802542961672, 11703.941480292544, 12026.338551379758, 12054.397280136134, 13390.531331403354, 13406.061575689608, 9016.504092274725, 9511.381760185566, 9541.188998935168, 9558.95220523893, 9562.61749530011, 10340.638077667245, 10498.632547860789, 10565.471726413802, 10606.734831629272, 10632.681019569425, 8927.464352138892, 8968.730938071869, 9023.962244341723, 9030.187283144549, 9160.175584197454, 7881.369490440866, 8300.792480188044, 8418.621162047844, 8471.745847624581, 8485.703000394957, 8014.278714915686, 8027.678892844221, 8030.518168909651, 8116.472429292077, 8133.227343402367, 5932.199153114447, 5955.40445955401, 5958.225430693982, 6137.723802428991, 6171.506279497719, 6015.699215039318, 6205.162303089206, 6205.565610407228, 6251.9687401562705, 6290.402411770874], "value": 5323.638964422979, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.86540845295707, 387.94956655634763, 391.594699486032, 391.990200244994, 394.08768700458427, 4731.574158325754, 4766.142094423002, 4772.210421092091, 5116.667416617917, 5175.663581867176, 4451.666125040627, 4534.909301813962, 4867.683600565961, 4880.609551235902, 5103.897922041557, 3218.243712727513, 3594.442861356481, 4034.5763694812063, 4093.2222877653153, 4140.50313962325, 3324.7838890472162, 3812.7504772184407, 4091.3453847384426, 4133.813978370966, 4185.9744362631045, 3834.5206849143856, 4109.301418758818, 4113.56807535209, 4126.76197140858, 4171.812268447927, 3447.3105378924065, 3556.826247338385, 4028.992751812047, 4074.9796251018556, 4112.342025275956, 3305.5702758641464, 3814.8664796731982, 3819.350710379242, 3835.5013848199833, 3853.6724378427866, 4134.904250373654, 4406.25093734066, 4662.533746625344, 4838.854834354975, 4895.9510404895855, 4296.679792911824, 4547.795349209294, 4708.223143181371, 4778.307145463888, 4814.398200224972, 4555.612772914306, 4653.325267836179, 4929.580985616227, 5019.824306149304, 5252.763625636855, 3574.392353299945, 4101.85643502479, 4297.72064815786, 4298.506866017702, 4348.086901750637, 5473.480019398151, 5645.661260324353, 5646.54827613794, 5674.120256579338, 5724.570657200685, 3576.98211508946, 4203.747775133502, 4330.328799036154, 4350.760708161081, 4355.695101342939, 3755.887323380303, 3974.463447434617, 4323.675724320626, 4449.621782148489, 4527.117212143667, 4178.707490475637, 4414.867553973386, 4524.891401606562, 4834.444038935568, 4840.273958906192, 4741.799285482286, 4852.878678033077, 5194.506521880416, 5226.895462090737, 5302.602304827154, 1387.653086728318, 1392.6866455047534, 1420.7371636247328, 1525.9323616499705, 1548.3651702801797, 892.8794612727329, 966.8211380894417, 1135.0635725526474, 1146.1174895330716, 1194.665493661776, 5215.044358365613, 5229.424763276036, 5239.629379885648, 5271.575075465253, 5308.283381743492, 5372.549411658831, 5632.324121105494, 5639.6334238274385, 5654.37801841797, 5675.886482270332, 4775.856724298276, 5071.819117779391, 5140.151874940668, 5191.6884986900905, 5270.4188743376835, 2436.2713760588254, 2560.7823335016733, 2642.973570264311, 2838.389746204576, 2861.467601172977, 4965.577925876341, 5140.193918686041, 5646.830595082072, 5661.773529058792, 5672.8865422691315, 4435.866923992286, 4583.983047459107, 5497.059073395714, 5518.503334699896, 5726.707143392566, 4747.64392670558, 5409.161579955114, 5507.834764957058, 5526.06056970316, 5719.828405147852, 4521.84173553924, 4974.701517908937, 5342.973285133549, 5544.362398324083, 5551.500364967173, 4532.252178390529, 4713.505081966344, 4822.493638168082, 4836.879078023077, 5304.443033481429, 4665.836695715634, 5426.8371948841595, 5593.461798005581, 5630.943690563042, 5671.688057156731, 3836.9831994522033, 4161.875143745692, 4271.594198551133, 4390.3414487827085, 4468.603861065679, 4536.57488596121, 4697.624190064855, 5243.68537887728, 5479.821838304783, 5629.4652008059165, 4232.101010807607, 4405.427294451701, 4508.684392092653, 5052.863105801165, 5294.364676238876, 4726.0, 4773.09311230865, 5295.629305948547, 5301.416844147064, 5430.782768689208, 4110.46563946685, 4558.498565157896, 5127.589792816491, 5264.447233040476, 5332.840014799563, 4664.160451118832, 5051.438735691402, 5178.016176926522, 5333.573314134782, 5490.176473529003, 4534.13851368239, 4809.917768502059, 4882.951170488392, 5215.4353693892435, 5269.4730526947], "value": 4031.5248128652083, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [746.7423738810115, 763.6601712238053, 766.76613632842, 886.3573908916037, 891.2290868398835, 15515.844841551596, 17438.651226975453, 17442.215100320485, 17453.563660908483, 17460.56348591286, 16098.678026439464, 16142.919285403586, 16313.673726525461, 16347.100909449975, 16347.673046539063, 991.1327588360167, 991.4299277915192, 998.1715176403604, 1013.9949300253488, 1034.5189486888596, 1021.6781713760179, 1022.9948850255738, 1023.3092662452815, 1024.109025148122, 1024.692592222334, 1059.099765199582, 1064.0742553978012, 1066.1257768629728, 1066.4081434803682, 1071.9464026798669, 1059.142094903131, 1060.2313322840955, 1062.2033474893828, 1063.6702622187147, 1063.9946800266027, 785.7446329942792, 787.4133770341075, 787.7164220880536, 788.1173086143499, 788.8856115863167, 15243.61890952724, 17407.564810879703, 17428.390006349717, 18074.548136296566, 18307.0, 13631.727365452734, 13738.244396558186, 14709.70580588393, 14751.77872331916, 14850.702985940221, 9829.459379734111, 11814.822777658343, 11890.108241881808, 11925.463354149084, 12469.875301246962, 4608.792604332813, 4678.461976872669, 4699.2481203007355, 4710.717356958594, 4716.292556116576, 112051.0, 115063.0, 115216.0, 116793.0, 117774.41112794467, 10828.296160749684, 11189.832152517718, 11369.658910232707, 11477.655670329903, 11577.6526704199, 22380.216692416012, 22400.88799555992, 22403.327900162694, 22424.88787556052, 22439.775602244095, 7926.405519586054, 7934.920650793533, 8022.1175670676175, 8343.499390036617, 8371.409432207984, 4446.399736035593, 4504.887377815516, 4553.977230113895, 4580.610648094883, 4670.439547254283, 3549.751517393809, 3555.075680323083, 3624.8187590620364, 3626.075350785533, 3630.056185391817, 646.7122130651909, 650.3269116464531, 656.9704363303663, 662.8707402056552, 664.0935123556408, 542.3979382884994, 555.1339909740817, 560.6047736345866, 578.8205656246492, 584.9736761845727, 10073.899261007442, 10173.694789156189, 10353.119984801226, 10377.533011014522, 10381.117605003508, 612.2194202391897, 636.4272155060482, 651.088476133417, 656.474820143883, 692.3353580562716, 4887.828925987574, 4976.154053810861, 4989.7006179628615, 4991.276264941635, 4993.875153121201, 102592.0, 106262.0, 106574.0, 110027.44986275178, 111512.88487115187, 54224.0, 69343.65328173326, 70890.26542478456, 83522.16477835143, 94303.0, 78100.0, 78401.60799195968, 78806.81789773158, 80240.0, 80940.59529702431, 11139.83290250663, 11286.435678215892, 11579.942100289782, 11607.36159511235, 11679.591214307458, 48468.0, 49401.50598494113, 52313.47686523086, 52520.7373963143, 53441.732791335795, 64357.0, 64872.026919597185, 66241.0, 66782.66434671183, 67194.3280567188, 13268.800967985295, 13360.27965916536, 13397.799033014318, 13417.865821341662, 13534.526291579747, 13081.738365232832, 14279.785803212751, 14984.935647667862, 15562.688746224785, 15579.0, 14101.506447274296, 14231.50189743354, 14330.279969002606, 14607.780883286972, 14617.85382146165, 13270.535531256359, 13865.376058077209, 14340.282985850874, 14521.128732276096, 14844.183569903327, 13432.39554220043, 14053.929730351283, 14175.858241417867, 14189.290535473392, 14499.275036248357, 9505.239580833655, 10109.88352047001, 10227.795444091225, 10391.532381043022, 10447.111995480469, 8352.958235208785, 9868.85196722064, 11658.0, 12257.448414821176, 12274.693132671397], "value": 7897.02084687571, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1436.2, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 115.0, 118.0], "value": 115.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 128.0, 138.0, 176.0, 139.0, 108.0, 108.0, 106.0, 118.0, 107.0], "value": 127.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 185.0, 184.0, 190.0, 187.0, 185.0, 183.0, 186.0, 184.0], "value": 185.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 61.0, 61.0, 91.0, 81.0, 83.0, 84.0, 70.0, 75.0, 60.0], "value": 74.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 66.0, 85.0, 70.0, 69.0, 68.0, 81.0, 91.0, 98.0, 112.0], "value": 82.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 88.0, 88.0, 89.0, 88.0, 89.0, 88.0, 88.0, 89.0, 88.0], "value": 88.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0], "value": 95.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 83.0, 85.0, 84.0, 87.0, 85.0, 82.0, 83.0, 83.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 60.0, 59.0, 63.0, 63.0, 62.0, 62.0, 63.0, 64.0], "value": 62.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 58.0, 69.0, 63.0, 60.0, 59.0, 58.0, 58.0, 59.0, 59.0], "value": 60.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 86.0, 84.0, 84.0, 82.0, 86.0, 88.0, 105.0, 84.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 142.0, 136.0, 143.0, 131.0, 133.0, 142.0, 137.0, 148.0, 133.0], "value": 138.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 190.0, 215.0, 185.0, 161.0, 162.0, 162.0, 163.0, 163.0, 158.0], "value": 172.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 65.0, 62.0, 64.0, 62.0, 61.0, 60.0], "value": 63.1, "unit": "score"}]}]} 08:02:13 INFO - Return code: 0 08:02:13 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:02:13 INFO - # TBPL SUCCESS # 08:02:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:02:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:02:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:02:13 INFO - 2017-05-04 08:02:13.932 screenresolution[1655:9927] starting screenresolution argv=screenresolution get 08:02:13 INFO - 2017-05-04 08:02:13.934 screenresolution[1655:9927] Display 0: 1600x1200x32@60 08:02:13 INFO - 2017-05-04 08:02:13.941 screenresolution[1656:9930] starting screenresolution argv=screenresolution list 08:02:13 INFO - Available Modes on Display 0 08:02:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:02:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:02:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:02:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:02:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:02:14 INFO - Intel Iris: 08:02:14 INFO - Chipset Model: Intel Iris 08:02:14 INFO - Type: GPU 08:02:14 INFO - Bus: Built-In 08:02:14 INFO - VRAM (Dynamic, Max): 1536 MB 08:02:14 INFO - Vendor: Intel (0x8086) 08:02:14 INFO - Device ID: 0x0a2e 08:02:14 INFO - Revision ID: 0x0009 08:02:14 INFO - Displays: 08:02:14 INFO - Display: 08:02:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:02:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:02:14 INFO - Display Serial Number: 1600x1200 60 08:02:14 INFO - Main Display: Yes 08:02:14 INFO - Mirror: Off 08:02:14 INFO - Online: Yes 08:02:14 INFO - Rotation: Supported 08:02:14 INFO - Return code: 0 08:02:14 INFO - Running post-action listener: _resource_record_post_action 08:02:14 INFO - [mozharness: 2017-05-04 15:02:14.178569Z] Finished run-tests step (success) 08:02:14 INFO - Running post-run listener: _resource_record_post_run 08:02:14 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 38568960; Write bytes: 421067776; Read time: 248; Write time: 1375 08:02:14 INFO - TinderboxPrint: CPU usage
53.8% 08:02:14 INFO - TinderboxPrint: I/O read bytes / time
38,568,960 / 248 08:02:14 INFO - TinderboxPrint: I/O write bytes / time
421,067,776 / 1,375 08:02:14 INFO - TinderboxPrint: CPU idle
2,209.0 (46.2%) 08:02:14 INFO - TinderboxPrint: CPU system
952.2 (19.9%) 08:02:14 INFO - TinderboxPrint: CPU user
1,616.4 (33.8%) 08:02:14 INFO - TinderboxPrint: Swap in / out
160,620,544 / 0 08:02:14 INFO - install - Wall time: 15s; CPU: 53.0%; Read bytes: 117436928; Write bytes: 112881664; Read time: 10909; Write time: 244 08:02:14 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 36602880; Write bytes: 297352192; Read time: 229; Write time: 1100 08:02:14 INFO - Running post-run listener: _upload_blobber_files 08:02:14 INFO - Blob upload gear active. 08:02:14 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:02:14 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 08:02:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:02:15 INFO - (blobuploader) - INFO - Open directory for files ... 08:02:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:02:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:02:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:02:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:02:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:02:16 INFO - (blobuploader) - INFO - Done attempting. 08:02:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:02:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:02:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:02:17 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:02:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:02:17 INFO - (blobuploader) - INFO - Done attempting. 08:02:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:02:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:02:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:02:17 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:02:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:02:17 INFO - (blobuploader) - INFO - Done attempting. 08:02:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:02:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:02:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:02:20 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:02:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:02:20 INFO - (blobuploader) - INFO - Done attempting. 08:02:20 INFO - (blobuploader) - INFO - Iteration through files over. 08:02:20 INFO - Return code: 0 08:02:20 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:02:20 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:02:20 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9fb80186614cee35733882fc0084b8f0dab46223a5f33e6555d925cf093a0551e638017ffca1396658af80dd767e1263b2ae57c30ca4b37f2ebaa45a7dafe078", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b1f72b4e8674146d3baa742e4ade7e8222b9c920dcbb7c4f7b966ec5b11f722b5c43c32e9997281c92f7c56131181b5eab1e1b3b8a62210118489c10f24f76e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4f39faf2bf3e512097945c08fea6ea0116e27ceea91f7f9998d56ee7c173ada1b7f166b5a684c93746713a2f97a0c2e6f6e475b94e5d8abebdac14bdd80fe2a4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/35f7e1cc2704cbf85c03dfd976cf2a8108f335268eeb4d19886cdd8a9e7d69948ab557818fb4b52e3084b86962d62b694128216cf9d81a8dbc9444dfd6ad908d"} 08:02:20 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:02:20 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:02:20 INFO - Contents: 08:02:20 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9fb80186614cee35733882fc0084b8f0dab46223a5f33e6555d925cf093a0551e638017ffca1396658af80dd767e1263b2ae57c30ca4b37f2ebaa45a7dafe078", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b1f72b4e8674146d3baa742e4ade7e8222b9c920dcbb7c4f7b966ec5b11f722b5c43c32e9997281c92f7c56131181b5eab1e1b3b8a62210118489c10f24f76e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4f39faf2bf3e512097945c08fea6ea0116e27ceea91f7f9998d56ee7c173ada1b7f166b5a684c93746713a2f97a0c2e6f6e475b94e5d8abebdac14bdd80fe2a4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/35f7e1cc2704cbf85c03dfd976cf2a8108f335268eeb4d19886cdd8a9e7d69948ab557818fb4b52e3084b86962d62b694128216cf9d81a8dbc9444dfd6ad908d"} 08:02:20 INFO - Running post-run listener: copy_logs_to_upload_dir 08:02:20 INFO - Copying logs to upload dir... 08:02:20 INFO - mkdir: /builds/slave/test/build/upload/logs 08:02:20 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1269.714214 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2017-05-04 08:02:20.532415) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 08:02:20.536744) ========= 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.1rKRTDnjv1/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.hKolWtG6p4/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9fb80186614cee35733882fc0084b8f0dab46223a5f33e6555d925cf093a0551e638017ffca1396658af80dd767e1263b2ae57c30ca4b37f2ebaa45a7dafe078", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b1f72b4e8674146d3baa742e4ade7e8222b9c920dcbb7c4f7b966ec5b11f722b5c43c32e9997281c92f7c56131181b5eab1e1b3b8a62210118489c10f24f76e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4f39faf2bf3e512097945c08fea6ea0116e27ceea91f7f9998d56ee7c173ada1b7f166b5a684c93746713a2f97a0c2e6f6e475b94e5d8abebdac14bdd80fe2a4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/35f7e1cc2704cbf85c03dfd976cf2a8108f335268eeb4d19886cdd8a9e7d69948ab557818fb4b52e3084b86962d62b694128216cf9d81a8dbc9444dfd6ad908d"} build_url:https://queue.taskcluster.net/v1/task/B2IeK8CrRMCSwg9h-5LD2Q/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011298 build_url: 'https://queue.taskcluster.net/v1/task/B2IeK8CrRMCSwg9h-5LD2Q/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9fb80186614cee35733882fc0084b8f0dab46223a5f33e6555d925cf093a0551e638017ffca1396658af80dd767e1263b2ae57c30ca4b37f2ebaa45a7dafe078", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4b1f72b4e8674146d3baa742e4ade7e8222b9c920dcbb7c4f7b966ec5b11f722b5c43c32e9997281c92f7c56131181b5eab1e1b3b8a62210118489c10f24f76e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/4f39faf2bf3e512097945c08fea6ea0116e27ceea91f7f9998d56ee7c173ada1b7f166b5a684c93746713a2f97a0c2e6f6e475b94e5d8abebdac14bdd80fe2a4", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/35f7e1cc2704cbf85c03dfd976cf2a8108f335268eeb4d19886cdd8a9e7d69948ab557818fb4b52e3084b86962d62b694128216cf9d81a8dbc9444dfd6ad908d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 08:02:20.573781) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 08:02:20.574150) ========= 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.1rKRTDnjv1/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.hKolWtG6p4/Listeners TMPDIR=/var/folders/dv/4dymjbqs7kl7kyyl2h4nk6x400000w/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.005163 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 08:02:20.623433) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 08:02:20.623762) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 08:02:20.624148) ========= ========= Total master_lag: 0.19 =========