builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0121 starttime: 1488214584.52 results: success (0) buildid: 20170227072837 builduid: 0142dc885f2f4f1aa1a9df79482af5c5 revision: 106a96755d3bcebe64bbbc3b521d65d262ba9c02 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-27 08:56:24.521479) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-27 08:56:24.521940) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-27 08:56:24.522216) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-27 08:56:24.549727) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 08:56:24.550114) ========= 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.RqMJSPXWcH/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.LCd1eUoh2U/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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-02-27 08:56:24-- 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% 30.2M=0s 2017-02-27 08:56:24 (30.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.138333 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 08:56:24.712678) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 08:56:24.712994) ========= 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.RqMJSPXWcH/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.LCd1eUoh2U/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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.029239 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 08:56:24.764713) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-27 08:56:24.765065) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 106a96755d3bcebe64bbbc3b521d65d262ba9c02 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 106a96755d3bcebe64bbbc3b521d65d262ba9c02 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RqMJSPXWcH/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.LCd1eUoh2U/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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-02-27 08:56:24,907 truncating revision to first 12 chars 2017-02-27 08:56:24,907 Setting DEBUG logging. 2017-02-27 08:56:24,908 attempt 1/10 2017-02-27 08:56:24,908 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/106a96755d3b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-27 08:56:26,514 unpacking tar archive at: mozilla-central-106a96755d3b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.867425 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-27 08:56:26.656544) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-27 08:56:26.656907) ========= script_repo_revision: 106a96755d3bcebe64bbbc3b521d65d262ba9c02 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-27 08:56:26.657327) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-27 08:56:26.657757) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-27 08:56:26.678096) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-02-27 08:56:26.678442) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.RqMJSPXWcH/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.LCd1eUoh2U/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 08:56:26 INFO - MultiFileLogger online at 20170227 08:56:26 in /builds/slave/test 08:56:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 08:56:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:56:26 INFO - {'append_to_log': False, 08:56:26 INFO - 'base_work_dir': '/builds/slave/test', 08:56:26 INFO - 'blob_upload_branch': 'Firefox', 08:56:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:56:26 INFO - 'branch': 'Firefox', 08:56:26 INFO - 'buildbot_json_path': 'buildprops.json', 08:56:26 INFO - 'config_files': ('talos/mac_config.py',), 08:56:26 INFO - 'default_actions': ('clobber', 08:56:26 INFO - 'read-buildbot-config', 08:56:26 INFO - 'download-and-extract', 08:56:26 INFO - 'populate-webroot', 08:56:26 INFO - 'create-virtualenv', 08:56:26 INFO - 'install', 08:56:26 INFO - 'run-tests'), 08:56:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:56:26 INFO - 'download_minidump_stackwalk': True, 08:56:26 INFO - 'download_symbols': 'ondemand', 08:56:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:56:26 INFO - 'tooltool.py': '/tools/tooltool.py', 08:56:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:56:26 INFO - '/tools/misc-python/virtualenv.py')}, 08:56:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:56:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:56:26 INFO - 'gecko_profile': False, 08:56:26 INFO - 'gecko_profile_interval': 0, 08:56:26 INFO - 'installer_path': 'installer.exe', 08:56:26 INFO - 'log_level': 'info', 08:56:26 INFO - 'log_name': 'talos', 08:56:26 INFO - 'log_to_console': True, 08:56:26 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:56:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:56:26 INFO - 'opt_config_files': (), 08:56:26 INFO - 'pip_index': False, 08:56:26 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:56:26 INFO - 'cmd': ('bash', 08:56:26 INFO - '-c', 08:56:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:56:26 INFO - 'enabled': True, 08:56:26 INFO - 'halt_on_failure': False, 08:56:26 INFO - 'name': 'check_screen_resolution'},), 08:56:26 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:56:26 INFO - 'cmd': ('bash', 08:56:26 INFO - '-c', 08:56:26 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:56:26 INFO - 'enabled': True, 08:56:26 INFO - 'halt_on_failure': False, 08:56:26 INFO - 'name': 'check_screen_resolution'},), 08:56:26 INFO - 'run_cmd_checks_enabled': True, 08:56:26 INFO - 'suite': 'dromaeojs', 08:56:26 INFO - 'system_bits': '32', 08:56:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:56:26 INFO - 'title': 't-yosemite-r7-0121', 08:56:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:56:26 INFO - 'use_talos_json': True, 08:56:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:56:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:56:26 INFO - 'work_dir': 'build'} 08:56:26 INFO - [mozharness: 2017-02-27 16:56:26.931277Z] Running clobber step. 08:56:26 INFO - Running pre-action listener: _resource_record_pre_action 08:56:26 INFO - Running main action method: clobber 08:56:26 INFO - rmtree: /builds/slave/test/build 08:56:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:56:29 INFO - Running post-action listener: _resource_record_post_action 08:56:29 INFO - [mozharness: 2017-02-27 16:56:29.460392Z] Finished clobber step (success) 08:56:29 INFO - [mozharness: 2017-02-27 16:56:29.460517Z] Running read-buildbot-config step. 08:56:29 INFO - Running pre-action listener: _resource_record_pre_action 08:56:29 INFO - Running main action method: read_buildbot_config 08:56:29 INFO - Using buildbot properties: 08:56:29 INFO - { 08:56:29 INFO - "project": "", 08:56:29 INFO - "product": "firefox", 08:56:29 INFO - "script_repo_revision": "production", 08:56:29 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:56:29 INFO - "repository": "", 08:56:29 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:56:29 INFO - "buildid": "20170227072837", 08:56:29 INFO - "pgo_build": "False", 08:56:29 INFO - "basedir": "/builds/slave/test", 08:56:29 INFO - "buildnumber": 11, 08:56:29 INFO - "slavename": "t-yosemite-r7-0121", 08:56:29 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 08:56:29 INFO - "platform": "yosemite_r7", 08:56:29 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:56:29 INFO - "branch": "mozilla-central", 08:56:29 INFO - "repo_path": "mozilla-central", 08:56:29 INFO - "revision": "106a96755d3bcebe64bbbc3b521d65d262ba9c02", 08:56:29 INFO - "stage_platform": "macosx64", 08:56:29 INFO - "builduid": "0142dc885f2f4f1aa1a9df79482af5c5", 08:56:29 INFO - "slavebuilddir": "test" 08:56:29 INFO - } 08:56:29 INFO - Found installer url https://queue.taskcluster.net/v1/task/DW0cpsYTQ1i0sUdq36hu4g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 08:56:29 INFO - Running post-action listener: _resource_record_post_action 08:56:29 INFO - [mozharness: 2017-02-27 16:56:29.463996Z] Finished read-buildbot-config step (success) 08:56:29 INFO - [mozharness: 2017-02-27 16:56:29.464087Z] Running download-and-extract step. 08:56:29 INFO - Running pre-action listener: _resource_record_pre_action 08:56:29 INFO - Running main action method: download_and_extract 08:56:29 INFO - mkdir: /builds/slave/test/build/tests 08:56:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:56:29 INFO - trying https://queue.taskcluster.net/v1/task/DW0cpsYTQ1i0sUdq36hu4g/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 08:56:29 INFO - Downloading https://queue.taskcluster.net/v1/task/DW0cpsYTQ1i0sUdq36hu4g/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 08:56:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DW0cpsYTQ1i0sUdq36hu4g/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 08:56:30 INFO - Downloaded 1199 bytes. 08:56:30 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 08:56:30 INFO - Using the following test package requirements: 08:56:30 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 08:56:30 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:56:30 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 08:56:30 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:56:30 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 08:56:30 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:56:30 INFO - u'jsshell-mac.zip'], 08:56:30 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:56:30 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 08:56:30 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 08:56:30 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:56:30 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 08:56:30 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:56:30 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 08:56:30 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:56:30 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 08:56:30 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 08:56:30 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 08:56:30 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:56:30 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DW0cpsYTQ1i0sUdq36hu4g/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 08:56:30 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DW0cpsYTQ1i0sUdq36hu4g/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:56:30 INFO - Fetch https://queue.taskcluster.net/v1/task/DW0cpsYTQ1i0sUdq36hu4g/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 08:56:32 INFO - Expected file size: 51745131 08:56:32 INFO - Obtained file size: 51745131 08:56:48 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 08:56:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DW0cpsYTQ1i0sUdq36hu4g/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 08:56:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DW0cpsYTQ1i0sUdq36hu4g/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:56:48 INFO - Fetch https://queue.taskcluster.net/v1/task/DW0cpsYTQ1i0sUdq36hu4g/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 08:56:50 INFO - Expected file size: 51745131 08:56:50 INFO - Obtained file size: 51745131 08:57:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DW0cpsYTQ1i0sUdq36hu4g/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 08:57:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DW0cpsYTQ1i0sUdq36hu4g/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:57:06 INFO - Fetch https://queue.taskcluster.net/v1/task/DW0cpsYTQ1i0sUdq36hu4g/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 08:57:06 INFO - Expected file size: 14404421 08:57:06 INFO - Obtained file size: 14404421 08:57:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:07 INFO - trying https://queue.taskcluster.net/v1/task/DW0cpsYTQ1i0sUdq36hu4g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 08:57:07 INFO - Downloading https://queue.taskcluster.net/v1/task/DW0cpsYTQ1i0sUdq36hu4g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 08:57:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DW0cpsYTQ1i0sUdq36hu4g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 08:57:09 INFO - Downloaded 74961915 bytes. 08:57:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DW0cpsYTQ1i0sUdq36hu4g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 08:57:09 INFO - mkdir: /builds/slave/test/properties 08:57:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:57:09 INFO - Writing to file /builds/slave/test/properties/build_url 08:57:09 INFO - Contents: 08:57:09 INFO - build_url:https://queue.taskcluster.net/v1/task/DW0cpsYTQ1i0sUdq36hu4g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 08:57:10 INFO - Running post-action listener: _resource_record_post_action 08:57:10 INFO - Running post-action listener: set_extra_try_arguments 08:57:10 INFO - [mozharness: 2017-02-27 16:57:10.074915Z] Finished download-and-extract step (success) 08:57:10 INFO - [mozharness: 2017-02-27 16:57:10.075061Z] Running populate-webroot step. 08:57:10 INFO - Running pre-action listener: _resource_record_pre_action 08:57:10 INFO - Running main action method: populate_webroot 08:57:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:57:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:57:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:57:10 INFO - '--tppagecycles', 08:57:10 INFO - '7'], 08:57:10 INFO - 'tests': ['tsvgm']}}, 08:57:10 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:57:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:57:10 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:57:10 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:57:10 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:57:10 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:57:10 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:57:10 INFO - 'talos_options': ['--disable-e10s'], 08:57:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:57:10 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:57:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:57:10 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:57:10 INFO - 'talos_options': ['--disable-e10s'], 08:57:10 INFO - 'tests': ['damp', 'tps']}, 08:57:10 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:57:10 INFO - 'tests': ['damp', 'tps']}, 08:57:10 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:57:10 INFO - 'tests': ['dromaeo_dom']}, 08:57:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:57:10 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:57:10 INFO - 'tests': ['basic_compositor_video']}, 08:57:10 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:57:10 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:57:10 INFO - 'tests': ['a11yr', 08:57:10 INFO - 'ts_paint', 08:57:10 INFO - 'tpaint', 08:57:10 INFO - 'sessionrestore', 08:57:10 INFO - 'sessionrestore_no_auto_restore', 08:57:10 INFO - 'tabpaint']}, 08:57:10 INFO - 'other-e10s': {'tests': ['a11yr', 08:57:10 INFO - 'ts_paint', 08:57:10 INFO - 'tpaint', 08:57:10 INFO - 'sessionrestore', 08:57:10 INFO - 'sessionrestore_no_auto_restore', 08:57:10 INFO - 'tabpaint']}, 08:57:10 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:57:10 INFO - 'ts_paint', 08:57:10 INFO - 'tpaint', 08:57:10 INFO - 'sessionrestore', 08:57:10 INFO - 'sessionrestore_no_auto_restore', 08:57:10 INFO - 'tabpaint']}, 08:57:10 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:57:10 INFO - 'ts_paint', 08:57:10 INFO - 'tpaint', 08:57:10 INFO - 'sessionrestore', 08:57:10 INFO - 'sessionrestore_no_auto_restore', 08:57:10 INFO - 'tabpaint']}, 08:57:10 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:57:10 INFO - 'tests': ['a11yr', 08:57:10 INFO - 'ts_paint', 08:57:10 INFO - 'tpaint', 08:57:10 INFO - 'sessionrestore', 08:57:10 INFO - 'sessionrestore_no_auto_restore', 08:57:10 INFO - 'tabpaint']}, 08:57:10 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:57:10 INFO - 'tests': ['a11yr', 08:57:10 INFO - 'ts_paint', 08:57:10 INFO - 'tpaint', 08:57:10 INFO - 'sessionrestore', 08:57:10 INFO - 'sessionrestore_no_auto_restore', 08:57:10 INFO - 'tabpaint']}, 08:57:10 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:57:10 INFO - 'tests': ['tsvgx', 08:57:10 INFO - 'tsvgr_opacity', 08:57:10 INFO - 'tart', 08:57:10 INFO - 'tscrollx', 08:57:10 INFO - 'cart', 08:57:10 INFO - 'tsvg_static']}, 08:57:10 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:57:10 INFO - 'tsvgr_opacity', 08:57:10 INFO - 'tart', 08:57:10 INFO - 'tscrollx', 08:57:10 INFO - 'cart', 08:57:10 INFO - 'tsvg_static']}, 08:57:10 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:57:10 INFO - 'talos_options': ['--disable-e10s'], 08:57:10 INFO - 'tests': ['tp5o']}, 08:57:10 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:57:10 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:57:10 INFO - 'talos_options': ['--disable-e10s', 08:57:10 INFO - '--xperf_path', 08:57:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:57:10 INFO - 'tests': ['tp5n']}, 08:57:10 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:57:10 INFO - 'talos_options': ['--xperf_path', 08:57:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:57:10 INFO - 'tests': ['tp5n']}}, 08:57:10 INFO - 'talos.zip': {'path': '', 08:57:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:57:10 INFO - Running post-action listener: _resource_record_post_action 08:57:10 INFO - [mozharness: 2017-02-27 16:57:10.093492Z] Finished populate-webroot step (success) 08:57:10 INFO - [mozharness: 2017-02-27 16:57:10.093633Z] Running create-virtualenv step. 08:57:10 INFO - Running pre-action listener: _resource_record_pre_action 08:57:10 INFO - Running main action method: create_virtualenv 08:57:10 INFO - Creating virtualenv /builds/slave/test/build/venv 08:57:10 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 08:57:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:57:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:57:10 INFO - Using real prefix '/tools/python27' 08:57:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:57:10 INFO - Installing distribute.............................................................................................................................................................................................done. 08:57:13 INFO - Installing pip.................done. 08:57:13 INFO - Return code: 0 08:57:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:57:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:57:14 INFO - Reading from file tmpfile_stdout 08:57:14 INFO - Output received: 08:57:14 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) 08:57:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:57: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')]} 08:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57: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')]} 08:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:14 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 0x101bf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd957e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ced30>, '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 0x1018f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019c3be8>, '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.RqMJSPXWcH/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.LCd1eUoh2U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 08:57:14 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 08:57:14 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 08:57:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RqMJSPXWcH/Render', 08:57:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:14 INFO - 'HOME': '/Users/cltbld', 08:57:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:14 INFO - 'LOGNAME': 'cltbld', 08:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:14 INFO - 'MOZ_NO_REMOTE': '1', 08:57:14 INFO - 'NO_EM_RESTART': '1', 08:57:14 INFO - 'PAGER': '/bin/cat', 08:57:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:14 INFO - 'PWD': '/builds/slave/test', 08:57:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:14 INFO - 'SHELL': '/bin/bash', 08:57:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LCd1eUoh2U/Listeners', 08:57:14 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 08:57:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:14 INFO - 'USER': 'cltbld', 08:57:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:14 INFO - 'XPC_FLAGS': '0x0', 08:57:14 INFO - 'XPC_SERVICE_NAME': '0', 08:57:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:14 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 08:57:14 INFO - Cleaning up... 08:57:14 INFO - Return code: 0 08:57:14 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:57: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')]} 08:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57: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')]} 08:57:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:14 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 0x101bf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd957e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ced30>, '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 0x1018f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019c3be8>, '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.RqMJSPXWcH/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.LCd1eUoh2U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 08:57:14 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 08:57:14 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 08:57:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RqMJSPXWcH/Render', 08:57:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:14 INFO - 'HOME': '/Users/cltbld', 08:57:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:14 INFO - 'LOGNAME': 'cltbld', 08:57:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:14 INFO - 'MOZ_NO_REMOTE': '1', 08:57:14 INFO - 'NO_EM_RESTART': '1', 08:57:14 INFO - 'PAGER': '/bin/cat', 08:57:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:14 INFO - 'PWD': '/builds/slave/test', 08:57:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:14 INFO - 'SHELL': '/bin/bash', 08:57:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LCd1eUoh2U/Listeners', 08:57:14 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 08:57:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:14 INFO - 'USER': 'cltbld', 08:57:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:14 INFO - 'XPC_FLAGS': '0x0', 08:57:14 INFO - 'XPC_SERVICE_NAME': '0', 08:57:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:14 INFO - Downloading/unpacking psutil>=3.1.1 08:57:14 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 08:57:14 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 08:57:14 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 08:57:14 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 08:57:14 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 08:57:14 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 08:57:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:57:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:57:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:57:18 INFO - Installing collected packages: psutil 08:57:18 INFO - Running setup.py install for psutil 08:57:18 INFO - building 'psutil._psutil_osx' extension 08:57:18 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 08:57:18 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 08:57:18 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 08:57:18 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 08:57:18 INFO - building 'psutil._psutil_posix' extension 08:57:18 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 08:57:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:57:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:57:19 INFO - ^ 08:57:19 INFO - 1 warning generated. 08:57:19 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 08:57:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:57:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:57:19 INFO - Successfully installed psutil 08:57:19 INFO - Cleaning up... 08:57:19 INFO - Return code: 0 08:57:19 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:57:19 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')]} 08:57:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:19 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')]} 08:57:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:19 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 0x101bf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd957e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ced30>, '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 0x1018f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019c3be8>, '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.RqMJSPXWcH/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.LCd1eUoh2U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 08:57:19 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 08:57:19 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 08:57:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RqMJSPXWcH/Render', 08:57:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:19 INFO - 'HOME': '/Users/cltbld', 08:57:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:19 INFO - 'LOGNAME': 'cltbld', 08:57:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:19 INFO - 'MOZ_NO_REMOTE': '1', 08:57:19 INFO - 'NO_EM_RESTART': '1', 08:57:19 INFO - 'PAGER': '/bin/cat', 08:57:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:19 INFO - 'PWD': '/builds/slave/test', 08:57:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:19 INFO - 'SHELL': '/bin/bash', 08:57:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LCd1eUoh2U/Listeners', 08:57:19 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 08:57:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:19 INFO - 'USER': 'cltbld', 08:57:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:19 INFO - 'XPC_FLAGS': '0x0', 08:57:19 INFO - 'XPC_SERVICE_NAME': '0', 08:57:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:19 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:57:19 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 08:57:19 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 08:57:19 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 08:57:19 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 08:57:19 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 08:57:19 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 08:57:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:57:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:57:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:57:22 INFO - Installing collected packages: mozsystemmonitor 08:57:22 INFO - Running setup.py install for mozsystemmonitor 08:57:22 INFO - Successfully installed mozsystemmonitor 08:57:22 INFO - Cleaning up... 08:57:22 INFO - Return code: 0 08:57:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:23 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 0x101bf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd957e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ced30>, '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 0x1018f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019c3be8>, '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.RqMJSPXWcH/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.LCd1eUoh2U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 08:57:23 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 08:57:23 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 08:57:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RqMJSPXWcH/Render', 08:57:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:23 INFO - 'HOME': '/Users/cltbld', 08:57:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:23 INFO - 'LOGNAME': 'cltbld', 08:57:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:23 INFO - 'MOZ_NO_REMOTE': '1', 08:57:23 INFO - 'NO_EM_RESTART': '1', 08:57:23 INFO - 'PAGER': '/bin/cat', 08:57:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:23 INFO - 'PWD': '/builds/slave/test', 08:57:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:23 INFO - 'SHELL': '/bin/bash', 08:57:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LCd1eUoh2U/Listeners', 08:57:23 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 08:57:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:23 INFO - 'USER': 'cltbld', 08:57:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:23 INFO - 'XPC_FLAGS': '0x0', 08:57:23 INFO - 'XPC_SERVICE_NAME': '0', 08:57:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:23 INFO - Downloading/unpacking jsonschema==2.5.1 08:57:23 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 08:57:23 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 08:57:23 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 08:57:23 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 08:57:23 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 08:57:23 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 08:57:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:57:26 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:26 INFO - Downloading functools32-3.2.3-2.tar.gz 08:57:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:57:26 INFO - warning: no files found matching '*.txt' 08:57:26 INFO - no previously-included directories found matching 'build' 08:57:26 INFO - no previously-included directories found matching 'dist' 08:57:26 INFO - no previously-included directories found matching '.git*' 08:57:26 INFO - Installing collected packages: jsonschema, functools32 08:57:26 INFO - Running setup.py install for functools32 08:57:27 INFO - warning: no files found matching '*.txt' 08:57:27 INFO - no previously-included directories found matching 'build' 08:57:27 INFO - no previously-included directories found matching 'dist' 08:57:27 INFO - no previously-included directories found matching '.git*' 08:57:27 INFO - Successfully installed jsonschema functools32 08:57:27 INFO - Cleaning up... 08:57:27 INFO - Return code: 0 08:57:27 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101bf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd957e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ced30>, '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 0x1018f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019c3be8>, '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.RqMJSPXWcH/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.LCd1eUoh2U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 08:57:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:57:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:57:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RqMJSPXWcH/Render', 08:57:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:27 INFO - 'HOME': '/Users/cltbld', 08:57:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:27 INFO - 'LOGNAME': 'cltbld', 08:57:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:27 INFO - 'MOZ_NO_REMOTE': '1', 08:57:27 INFO - 'NO_EM_RESTART': '1', 08:57:27 INFO - 'PAGER': '/bin/cat', 08:57:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:27 INFO - 'PWD': '/builds/slave/test', 08:57:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:27 INFO - 'SHELL': '/bin/bash', 08:57:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LCd1eUoh2U/Listeners', 08:57:27 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 08:57:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:27 INFO - 'USER': 'cltbld', 08:57:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:27 INFO - 'XPC_FLAGS': '0x0', 08:57:27 INFO - 'XPC_SERVICE_NAME': '0', 08:57:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:27 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:57:27 INFO - Cleaning up... 08:57:27 INFO - Return code: 0 08:57:27 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101bf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd957e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ced30>, '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 0x1018f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019c3be8>, '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.RqMJSPXWcH/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.LCd1eUoh2U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 08:57:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:57:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:57:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RqMJSPXWcH/Render', 08:57:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:27 INFO - 'HOME': '/Users/cltbld', 08:57:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:27 INFO - 'LOGNAME': 'cltbld', 08:57:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:27 INFO - 'MOZ_NO_REMOTE': '1', 08:57:27 INFO - 'NO_EM_RESTART': '1', 08:57:27 INFO - 'PAGER': '/bin/cat', 08:57:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:27 INFO - 'PWD': '/builds/slave/test', 08:57:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:27 INFO - 'SHELL': '/bin/bash', 08:57:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LCd1eUoh2U/Listeners', 08:57:27 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 08:57:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:27 INFO - 'USER': 'cltbld', 08:57:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:27 INFO - 'XPC_FLAGS': '0x0', 08:57:27 INFO - 'XPC_SERVICE_NAME': '0', 08:57:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:27 INFO - Downloading/unpacking blobuploader==1.2.4 08:57:27 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 08:57:27 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 08:57:27 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 08:57:27 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 08:57:27 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 08:57:27 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 08:57:30 INFO - Downloading blobuploader-1.2.4.tar.gz 08:57:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:57:30 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:57:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:31 INFO - Downloading docopt-0.6.1.tar.gz 08:57:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:57:31 INFO - Installing collected packages: blobuploader, requests, docopt 08:57:31 INFO - Running setup.py install for blobuploader 08:57:31 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:57:31 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:57:31 INFO - Running setup.py install for requests 08:57:32 INFO - Running setup.py install for docopt 08:57:32 INFO - Successfully installed blobuploader requests docopt 08:57:32 INFO - Cleaning up... 08:57:32 INFO - Return code: 0 08:57:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:57:32 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')]} 08:57:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:32 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')]} 08:57:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:32 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 0x101bf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd957e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ced30>, '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 0x1018f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019c3be8>, '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.RqMJSPXWcH/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.LCd1eUoh2U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 08:57:32 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 08:57:32 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 08:57:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RqMJSPXWcH/Render', 08:57:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:32 INFO - 'HOME': '/Users/cltbld', 08:57:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:32 INFO - 'LOGNAME': 'cltbld', 08:57:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:32 INFO - 'MOZ_NO_REMOTE': '1', 08:57:32 INFO - 'NO_EM_RESTART': '1', 08:57:32 INFO - 'PAGER': '/bin/cat', 08:57:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:32 INFO - 'PWD': '/builds/slave/test', 08:57:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:32 INFO - 'SHELL': '/bin/bash', 08:57:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LCd1eUoh2U/Listeners', 08:57:32 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 08:57:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:32 INFO - 'USER': 'cltbld', 08:57:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:32 INFO - 'XPC_FLAGS': '0x0', 08:57:32 INFO - 'XPC_SERVICE_NAME': '0', 08:57:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:57:32 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-6ZC5WJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:57:32 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-aEZeSq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:57:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:57:32 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-NxfjYR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:57:33 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-EIMiKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:57:33 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-y8KbdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:57:33 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-Lx_2Y7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:57:33 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-aSl3V4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:57:33 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-19tHSa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:57:33 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-8nm4Vn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:57:33 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-qkH5CG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:57:33 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-fqGBDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:57:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:57:33 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-dbA5v0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:57:34 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-Qe5Z8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:57:34 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-XA8zX6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:34 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-9oFHi4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:57:34 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-W5hkGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:57:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:57:34 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-ez7Gfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:57:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:57:34 INFO - Running setup.py install for manifestparser 08:57:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:57:34 INFO - Running setup.py install for mozcrash 08:57:34 INFO - Running setup.py install for mozdebug 08:57:34 INFO - Running setup.py install for mozdevice 08:57:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:57:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:57:35 INFO - Running setup.py install for mozfile 08:57:35 INFO - Running setup.py install for mozhttpd 08:57:35 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:57:35 INFO - Running setup.py install for mozinfo 08:57:35 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:57:35 INFO - Running setup.py install for mozInstall 08:57:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:57:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:57:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:57:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:57:35 INFO - Running setup.py install for mozleak 08:57:35 INFO - Running setup.py install for mozlog 08:57:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:57:36 INFO - Running setup.py install for moznetwork 08:57:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:57:36 INFO - Running setup.py install for mozprocess 08:57:36 INFO - Running setup.py install for mozprofile 08:57:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:57:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:57:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:57:36 INFO - Running setup.py install for mozrunner 08:57:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:57:36 INFO - Running setup.py install for mozscreenshot 08:57:36 INFO - Running setup.py install for moztest 08:57:36 INFO - Running setup.py install for mozversion 08:57:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:57:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:57:37 INFO - Cleaning up... 08:57:37 INFO - Return code: 0 08:57:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:37 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 0x101bf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd957e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ced30>, '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 0x1018f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019c3be8>, '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.RqMJSPXWcH/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.LCd1eUoh2U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 08:57:37 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 08:57:37 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 08:57:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RqMJSPXWcH/Render', 08:57:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:37 INFO - 'HOME': '/Users/cltbld', 08:57:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:37 INFO - 'LOGNAME': 'cltbld', 08:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:37 INFO - 'MOZ_NO_REMOTE': '1', 08:57:37 INFO - 'NO_EM_RESTART': '1', 08:57:37 INFO - 'PAGER': '/bin/cat', 08:57:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:37 INFO - 'PWD': '/builds/slave/test', 08:57:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:37 INFO - 'SHELL': '/bin/bash', 08:57:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LCd1eUoh2U/Listeners', 08:57:37 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 08:57:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:37 INFO - 'USER': 'cltbld', 08:57:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:37 INFO - 'XPC_FLAGS': '0x0', 08:57:37 INFO - 'XPC_SERVICE_NAME': '0', 08:57:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:57:37 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-bkpUqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:57:37 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)) 08:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:57:37 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-qA3ecO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:57:37 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)) 08:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:57:37 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-S9pK5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:57:37 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)) 08:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:57:37 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-vAkw5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:57:37 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)) 08:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:57:37 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-NXY2V6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:57:37 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)) 08:57:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:57:37 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-0_C6G_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:57:38 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)) 08:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:57:38 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-lC1tNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:57:38 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)) 08:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:57:38 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-G_QHVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:57:38 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)) 08:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:57:38 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-op7tE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:57:38 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)) 08:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:57:38 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-9XaNnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:57:38 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)) 08:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:57:38 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-3zDkmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:57:38 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)) 08:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:57:38 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-4uyyQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:57:38 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)) 08:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:57:38 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-9yd_wI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:57:38 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)) 08:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:57:38 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-oB5IPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:57:38 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)) 08:57:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:38 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-jE4JMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:57:39 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)) 08:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:57:39 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-DoI6fD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:57:39 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)) 08:57:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:57:39 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-SkvVIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:57:39 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)) 08:57:39 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)) 08:57:39 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)) 08:57:39 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)) 08:57:39 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)) 08:57:39 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)) 08:57:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:57:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:57:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:57:41 INFO - Downloading blessings-1.6.tar.gz 08:57:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:57:42 INFO - Installing collected packages: blessings 08:57:42 INFO - Running setup.py install for blessings 08:57:42 INFO - Successfully installed blessings 08:57:42 INFO - Cleaning up... 08:57:42 INFO - Return code: 0 08:57:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:57:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:57:42 INFO - Reading from file tmpfile_stdout 08:57:42 INFO - Current package versions: 08:57:42 INFO - blessings == 1.6 08:57:42 INFO - blobuploader == 1.2.4 08:57:42 INFO - docopt == 0.6.1 08:57:42 INFO - functools32 == 3.2.3-2 08:57:42 INFO - jsonschema == 2.5.1 08:57:42 INFO - manifestparser == 1.1 08:57:42 INFO - mozInstall == 1.12 08:57:42 INFO - mozcrash == 1.0 08:57:42 INFO - mozdebug == 0.1 08:57:42 INFO - mozdevice == 0.49 08:57:42 INFO - mozfile == 1.2 08:57:42 INFO - mozhttpd == 0.7 08:57:42 INFO - mozinfo == 0.9 08:57:42 INFO - mozleak == 0.1 08:57:42 INFO - mozlog == 3.4 08:57:42 INFO - moznetwork == 0.27 08:57:42 INFO - mozprocess == 0.25 08:57:42 INFO - mozprofile == 0.28 08:57:42 INFO - mozrunner == 6.13 08:57:42 INFO - mozscreenshot == 0.1 08:57:42 INFO - mozsystemmonitor == 0.3 08:57:42 INFO - moztest == 0.8 08:57:42 INFO - mozversion == 1.4 08:57:42 INFO - psutil == 3.1.1 08:57:42 INFO - requests == 1.2.3 08:57:42 INFO - wsgiref == 0.1.2 08:57:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:57:42 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')]} 08:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:42 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')]} 08:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:42 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 0x101bf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd957e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ced30>, '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 0x1018f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019c3be8>, '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.RqMJSPXWcH/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.LCd1eUoh2U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 08:57:42 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 08:57:42 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 08:57:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RqMJSPXWcH/Render', 08:57:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:42 INFO - 'HOME': '/Users/cltbld', 08:57:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:42 INFO - 'LOGNAME': 'cltbld', 08:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:42 INFO - 'MOZ_NO_REMOTE': '1', 08:57:42 INFO - 'NO_EM_RESTART': '1', 08:57:42 INFO - 'PAGER': '/bin/cat', 08:57:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:42 INFO - 'PWD': '/builds/slave/test', 08:57:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:42 INFO - 'SHELL': '/bin/bash', 08:57:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LCd1eUoh2U/Listeners', 08:57:42 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 08:57:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:42 INFO - 'USER': 'cltbld', 08:57:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:42 INFO - 'XPC_FLAGS': '0x0', 08:57:42 INFO - 'XPC_SERVICE_NAME': '0', 08:57:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:42 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)) 08:57:42 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)) 08:57:42 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)) 08:57:42 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)) 08:57:42 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)) 08:57:42 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)) 08:57:42 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)) 08:57:42 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)) 08:57:42 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)) 08:57:42 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)) 08:57:42 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)) 08:57:42 INFO - Cleaning up... 08:57:42 INFO - Return code: 0 08:57:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:57:42 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')]} 08:57:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:57:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:42 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')]} 08:57:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:57:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:57:42 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 0x101bf0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101bf3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f9bd957e5c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1019ced30>, '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 0x1018f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019c3be8>, '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.RqMJSPXWcH/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.LCd1eUoh2U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 08:57:42 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 08:57:42 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 08:57:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RqMJSPXWcH/Render', 08:57:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:57:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:57:42 INFO - 'HOME': '/Users/cltbld', 08:57:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:57:42 INFO - 'LOGNAME': 'cltbld', 08:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:57:42 INFO - 'MOZ_NO_REMOTE': '1', 08:57:42 INFO - 'NO_EM_RESTART': '1', 08:57:42 INFO - 'PAGER': '/bin/cat', 08:57:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:57:42 INFO - 'PWD': '/builds/slave/test', 08:57:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:57:42 INFO - 'SHELL': '/bin/bash', 08:57:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LCd1eUoh2U/Listeners', 08:57:42 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 08:57:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:57:42 INFO - 'USER': 'cltbld', 08:57:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:57:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:57:42 INFO - 'XPC_FLAGS': '0x0', 08:57:42 INFO - 'XPC_SERVICE_NAME': '0', 08:57:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:57:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:57:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:57:43 INFO - Cleaning up... 08:57:43 INFO - Return code: 0 08:57:43 INFO - Running post-action listener: _resource_record_post_action 08:57:43 INFO - Running post-action listener: _start_resource_monitoring 08:57:43 INFO - Starting resource monitoring. 08:57:43 INFO - [mozharness: 2017-02-27 16:57:43.100250Z] Finished create-virtualenv step (success) 08:57:43 INFO - [mozharness: 2017-02-27 16:57:43.101300Z] Running install step. 08:57:43 INFO - Running pre-action listener: _resource_record_pre_action 08:57:43 INFO - Running main action method: install 08:57:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:57:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:57:43 INFO - Reading from file tmpfile_stdout 08:57:43 INFO - Detecting whether we're running mozinstall >=1.0... 08:57:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:57:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:57:43 INFO - Reading from file tmpfile_stdout 08:57:43 INFO - Output received: 08:57:43 INFO - Usage: mozinstall [options] installer 08:57:43 INFO - Options: 08:57:43 INFO - -h, --help show this help message and exit 08:57:43 INFO - -d DEST, --destination=DEST 08:57:43 INFO - Directory to install application into. [default: 08:57:43 INFO - "/builds/slave/test"] 08:57:43 INFO - --app=APP Application being installed. [default: firefox] 08:57:43 INFO - mkdir: /builds/slave/test/build/application 08:57:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:57:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 08:58:03 INFO - Reading from file tmpfile_stdout 08:58:03 INFO - Output received: 08:58:03 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 08:58:03 INFO - Running post-action listener: _resource_record_post_action 08:58:03 INFO - [mozharness: 2017-02-27 16:58:03.612626Z] Finished install step (success) 08:58:03 INFO - [mozharness: 2017-02-27 16:58:03.612792Z] Running run-tests step. 08:58:03 INFO - Running pre-action listener: _resource_record_pre_action 08:58:03 INFO - Running main action method: run_tests 08:58:03 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:58:03 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:58:03 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:58:03 INFO - 2017-02-27 08:58:03.627 screenresolution[1629:7307] starting screenresolution argv=screenresolution get 08:58:03 INFO - 2017-02-27 08:58:03.630 screenresolution[1629:7307] Display 0: 1600x1200x32@60 08:58:03 INFO - 2017-02-27 08:58:03.636 screenresolution[1630:7310] starting screenresolution argv=screenresolution list 08:58:03 INFO - Available Modes on Display 0 08:58:03 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:58:03 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:58:03 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:58:03 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:58:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:58:03 INFO - Intel Iris: 08:58:03 INFO - Chipset Model: Intel Iris 08:58:03 INFO - Type: GPU 08:58:03 INFO - Bus: Built-In 08:58:03 INFO - VRAM (Dynamic, Max): 1536 MB 08:58:03 INFO - Vendor: Intel (0x8086) 08:58:03 INFO - Device ID: 0x0a2e 08:58:03 INFO - Revision ID: 0x0009 08:58:03 INFO - Displays: 08:58:03 INFO - Display: 08:58:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:58:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:58:03 INFO - Display Serial Number: 1600x1200 60 08:58:03 INFO - Main Display: Yes 08:58:03 INFO - Mirror: Off 08:58:03 INFO - Online: Yes 08:58:03 INFO - Rotation: Supported 08:58:03 INFO - Return code: 0 08:58:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:58:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:58:03 INFO - Python 2.7.3 08:58:03 INFO - Return code: 0 08:58:03 INFO - grabbing minidump binary from tooltool 08:58:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:58:03 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 0x1019ced30>, '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 0x1018f5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1019c3be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:58:03 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 08:58:03 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 08:58:03 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 08:58:03 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:58:03 INFO - Return code: 0 08:58:03 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:58:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:58:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:58:03 INFO - ENV: RUST_BACKTRACE is now 1 08:58:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:58:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:58:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DW0cpsYTQ1i0sUdq36hu4g/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0121', '--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 08:58:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DW0cpsYTQ1i0sUdq36hu4g/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0121 --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 08:58:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.RqMJSPXWcH/Render', 08:58:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:58:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:58:03 INFO - 'HOME': '/Users/cltbld', 08:58:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:58:03 INFO - 'LOGNAME': 'cltbld', 08:58:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:58:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:58:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:58:04 INFO - 'MOZ_NO_REMOTE': '1', 08:58:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:58:04 INFO - 'NO_EM_RESTART': '1', 08:58:04 INFO - 'PAGER': '/bin/cat', 08:58:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:58:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:58:04 INFO - 'PWD': '/builds/slave/test', 08:58:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:58:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:58:04 INFO - 'RUST_BACKTRACE': '1', 08:58:04 INFO - 'SHELL': '/bin/bash', 08:58:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.LCd1eUoh2U/Listeners', 08:58:04 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 08:58:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:58:04 INFO - 'USER': 'cltbld', 08:58:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:58:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:58:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:58:04 INFO - 'XPC_FLAGS': '0x0', 08:58:04 INFO - 'XPC_SERVICE_NAME': '0', 08:58:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:58:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DW0cpsYTQ1i0sUdq36hu4g/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0121', '--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 08:58:04 INFO - mozversion application_buildid: 20170227072837 08:58:04 INFO - mozversion application_changeset: 106a96755d3bcebe64bbbc3b521d65d262ba9c02 08:58:04 INFO - mozversion application_display_name: Nightly 08:58:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:58:04 INFO - mozversion application_name: Firefox 08:58:04 INFO - mozversion application_remotingname: firefox 08:58:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:58:04 INFO - mozversion application_vendor: Mozilla 08:58:04 INFO - mozversion application_version: 54.0a1 08:58:04 INFO - mozversion platform_buildid: 20170227072837 08:58:04 INFO - mozversion platform_changeset: 106a96755d3bcebe64bbbc3b521d65d262ba9c02 08:58:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:58:04 INFO - mozversion platform_version: 54.0a1 08:58:04 INFO - using testdate: 1488214684 08:58:04 INFO - actual date: 1488214684 08:58:04 INFO - starting webserver on 'localhost:49243' 08:58:04 INFO - SUITE-START | Running 2 tests 08:58:04 INFO - TEST-START | dromaeo_css 08:58:04 INFO - operating with platform_type : mac_ 08:58:04 INFO - Initialising browser for dromaeo_css test... 08:58:04 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/tmpsMQjME/profile http://localhost:49243/getInfo.html) 08:58:06 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 08:58:06 INFO - PROCESS | 1640 | colorDepth:24 08:58:06 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 08:58:06 INFO - PROCESS | 1640 | __metrics 08:58:06 INFO - PROCESS | 1640 | 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:58:06 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:58:07 INFO - TEST-INFO | 1640: exit 0 08:58:07 INFO - Browser initialized. 08:58:07 INFO - Running cycle 1/1 for dromaeo_css test... 08:58:07 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/tmpsMQjME/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:58:19 INFO - PROCESS | 1642 | RSS: Main: 230846464 08:58:19 INFO - PROCESS | 1642 | 09:01:23 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 09:01:26 INFO - PROCESS | 1642 | RSS: Main: 488787968 09:01:26 INFO - PROCESS | 1642 | 09:03:09 INFO - PROCESS | 1642 | ************************* 09:03:09 INFO - PROCESS | 1642 | A coding exception was thrown and uncaught in a Task. 09:03:09 INFO - PROCESS | 1642 | 09:03:09 ERROR - PROCESS | 1642 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:03:09 INFO - PROCESS | 1642 | Full stack: 09:03:09 INFO - PROCESS | 1642 | ************************* 09:04:30 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 09:04:30 INFO - PROCESS | 1642 | RSS: Main: 365309952 09:04:30 INFO - PROCESS | 1642 | 09:07:33 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 09:07:34 INFO - PROCESS | 1642 | RSS: Main: 348229632 09:07:34 INFO - PROCESS | 1642 | 09:10:36 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 09:10:37 INFO - PROCESS | 1642 | RSS: Main: 339587072 09:10:37 INFO - PROCESS | 1642 | 09:13:40 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 09:13:41 INFO - PROCESS | 1642 | RSS: Main: 343863296 09:13:41 INFO - PROCESS | 1642 | 09:16:44 INFO - PROCESS | 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 09:16:45 INFO - PROCESS | 1642 | RSS: Main: 501874688 09:16:45 INFO - PROCESS | 1642 | 09:16:45 INFO - PROCESS | 1642 | __start_tp_report 09:16:45 INFO - PROCESS | 1642 | _x_x_mozilla_page_load 09:16:45 INFO - PROCESS | 1642 | _x_x_mozilla_page_load_details 09:16:45 INFO - PROCESS | 1642 | |i|pagename|runs| 09:16:45 INFO - PROCESS | 1642 | |0;dojo.html;3219.549263103166;3281.3601347737194;3376.189714468528;3403.6426175251613;3438.3467141243163;4555.20283950309;5664.376918538967;5744.971275143624;5802.883942321157;5831.387704291052;5672.602917795756;5750.223719797826;5793.362730099696;5793.449622285876;5796.913046304298;5188.974055129719;5209.479052094779;5266.394364648077;5286.7885284588765;5300.443453437391;5366.114591092465;5387;5397.028534863723;5413.783448662049;5450.91823622646;5179.2749015137915;5184.585233181374;5197.558207552324;5273.2617433559335;5317.46825317469;4049.5950404959563;4294.26997410441;4581.266997280419;5264.368275806889;5292.364916210041;5160.612954028463;5214.895702085975;5231.136862417697;5234.293370394986;5243.947560524384;4722.456917454502;5670.432956704338;5698.088305871041;5730;5730.627509211888;6202.689865506752;6211.16149319845;6217.533684973645;6219.875602487925;6226.941419958618;6134.08133522331;6143.1434383011665;6193.2877719062435;6209.037599172136;6216.409441103088;5944.197533332988;5950.6132101413705;5967.254093238345;6003.429674180946;6056.303525094582;6298.326586904456;6355.904661430082;6366.458850997625;6376.458001069868;6390.648514331663;6055.061465472859;6058.515318774487;6075.149479072933;6283.465905398092;6286.811395658137;6199.814005579839;6208.099825525273;6229.626222426669;6276.246850377984;6298.842528936813;6310.242770867433;6313.147725057059;6316.9368306317265;6318.778842740574;6338.778142765073;6144.815655530341;6287.622742635456;6313.715882785285;6314.210723659543;6319.399657032666;3581.6776490116013;4225.345071513921;4466.7766611669285;4951.034548263054;5028.5977121830165;4454.398656181439;4500.2799552072165;4561.954380456153;4565.429321334833;4587.08258348325;5807.912881306784;5808.970955145282;5809.7966571170655;5812.157237200582;5817.185594016841;6208.81373558794;6290.716917738713;6302.936970630327;6307.558470906993;6311.842203944938;5743.167240750151;5767.653940763567;5783.334916484574;5827.854303642443;5828.737706803204;4659.324397962277;5435.565154787687;5532.6680399176175;5534.1145416733125;5586.720663966786;6356.2054743157105;6391.712372943229;6402;6404.647744374011;6412.5190610704385;6340.302566717565;6348.841278968062;6350.68246587678;6352.555321127476;6381.138546296191;6253.280872699698;6296.150019747459;6307;6326.051092336186;6327.96836015817;6098.664573448503;6200.3799620037635;6201.007838745779;6204.472619827366;6213.937860621517;5179.19722443022;6255.78104766331;6260.824428395293;6276.058591211355;6336.746530138743;6189.783357582463;6190.350013248724;6213.751449941951;6219.751209951552;6232.937670623236;6134.263888333428;6222;6226.40849119333;6234.407731265523;6234.470070044097;4938.358013458227;5819.185314056121;5850.97607918604;5866.2373891393845;5927.525797936241;6085.361037091218;6086.969565152146;6090.299615544269;6090.817275481742;6102.023676211785;4917.311576379381;5845.298564172326;5854.531637469077;5888.263967004124;5949.196858424058 09:16:45 INFO - PROCESS | 1642 | |1;ext.html;721.7726416178904;771.0631582627109;843.7974886027355;859.9441036332634;861.3970220845409;27193.32016699581;28280.717192828066;38121;38413;38845.41731874024;39893.40159897604;39947;40043;40154.39768403476;40171.59828401715;8982.505962172077;9161;9161.816763664723;9172.31207659425;9173.862392064124;7156.141263048441;7364.410847132217;7369.77890663281;7394.704211831548;7399.3710534604625;10716.41059741714;10933.617323393682;10976.341419514814;11024.889751102466;11050.281731687415;10763.031327180552;10832.566697332097;10848.18638602108;10850.24048316618;10863.782724345549;7121.181064177634;10485.423301718403;10547.419891905942;10555.41945193014;10561.207909406749;26263.73736262632;27264;27281.72718272812;27328.59007114895;37206.44190337147;3638.5269914911155;3664.230511592542;3700.7224458165474;3748.5314335708035;3873.6513713765617;26671;28032.579511307347;28213.15360539187;28366;28674.856625716737;2453.460238747473;3034.317278612317;3038.8936387226563;3111.937761244785;3138.2154461384653;335396;336236;336469;336639;336953;49104.508954909994;49109.50890491121;49194;49294.50705492971;49329.260061099114;50961.725956850634;51001;51024.23463648048;51100.74449627728;51116;13512.459501619825;13648.795268070988;13664.316784160752;13672.52146174879;13675.521356752466;11705.765884682258;11709.531618735326;11709.882901170879;11725.648230553097;11727.237729547553;11514.942425287987;11751.823722644167;11816;11868.406579670982;11909.58316458937;4122.9381559276635;5237.16205407133;5252.737363131828;5285.445028272053;5310.867228319245;918.1002617434951;920.9033051529627;922.0917396364575;965.4448692002127;971.4365667912593;22641.886790565943;24184.339722630495;28083.859580701966;28197.563050714023;28226;984.921206303494;987.9753006174759;1024.8770147582188;1029.4543891737392;1031.3296357367772;14242.43030278798;14319.996422733586;14520.854791452162;14582.781258281135;14639.194844283667;385663;386263;386334;386938;387189;53228.733856331244;53323;53378.73310633422;53399;53537.1969420459;1373.5810577773875;1409.9506517272052;1411.7811739180033;1412.7810189420657;1413.0885578801822;20650.793492065488;27593.17220483389;29225.415491690474;29902.70097298999;30122.01093201931;51252;51310;51390;51468;51473.7426312866;437685;440538;441928;442548;443044;32592.837035814668;33110;33287;33347.49978750369;33420.331593368486;41870;43155.352669709355;43156.56843431525;43227;43402.348964766185;29974.400511990076;33249.50125748164;34566.65433345635;35251.294974100885;35466.64533354736;33958.66041339555;33984.66015339815;35144.418501167;35252.41364138568;35319.646803531636;34413.827930860185;34990.30019399547;35954.4606830903;36010.09974750652;36261.81869090637;25063.199352361466;29814.807407703447;30026;30603.846980764953;30793.69206307908;21536.461588459788;21908.780912191312;22997.88501057484;23101.88449057744;23873.64189537193 09:16:45 INFO - PROCESS | 1642 | |2;jquery.html;359.67449458240293;379.4289594160788;392.1862136067659;405.47339267657276;438.3446747113064;13345.332733363342;13456.932715336421;15744.685106297882;20122.89938550309;21054.473638159052;19751.407457776255;20408.999999999964;20531.486712832186;20641.483962900937;21171.259005934797;6279.27788304344;6362.650054247015;6518.837029074263;6634.5024123190715;6646.60120392778;4084.121913788535;6442.581232219891;6597.4392176664805;6602.60384376939;6609.636469994149;4263.573642635727;4286.464191976003;4340.370646256291;7075.398591119735;7430.517016393944;7380.335769780691;7425.2179476925685;7505.812354691149;7506.887396689054;7536.246375362447;6940.305969403019;7050.259722729091;7168.103987001625;7217.206107328189;7229.5300805448005;21023.8948805255;23021;23154.65268020981;23628.881855590786;25116.869740861523;2373.062640257089;2800.649918760155;2810.5222112240967;2855.072101566999;2858.2568532181576;13070.607881763468;14822.851771482256;15024.699506009818;15240.933134680577;15568.221588920509;1883.915223814918;1946.9513262168418;1947.1237942925598;1960.8137077068454;2026.0983862181336;148848;156755;158807;158988.20505897395;160694.3930560703;14614.481097330401;15425.84574154244;15611.613993172337;15649.29578168985;15654.686906261812;22424.66363004556;22612.86935653211;22645.660315095287;22653.88673056657;22660.433489162904;9131.589078491485;9153.862692059625;9246.491442970566;9340.392874463138;9445.952770236105;8155.184481551797;8165.469244499089;8208.425410221227;8309.83380332402;8317.625706843206;5802.796902108406;6780.559263647847;6866.867661059933;6874.415674667609;6878.518503704692;3600.801955892399;3697;3707.796071216055;3710.276496083238;3717.4423836424753;745.7732030809397;778.0352363069753;862.5385418800911;870.0342619692136;914.3964983111115;19662.623616347006;21151.78848211529;21321.89339053326;21354.35936921895;21406.678899816514;868.4181598329135;871.7123349294718;896.9192772650492;918.2929144558652;918.660095764558;10754.89245107539;11182.38496882663;11193.552257909756;11212.775744485229;11233.32600044;656460;656588;665964;683100;684599;111572.81301073078;136125;141324;146343;153401.23299383654;980.1962390839585;980.4068538534227;1017.3692310767372;1020.6274709731043;1021.1830535571662;18874.33939812155;19513.70729439031;19599.902000489907;19619.313324033592;19627.31304404339;57990;58248.12627810502;58637;58763;59111.40888591059;84373;85705.71441428259;86756.02305734922;88970;89230;10931.726706832393;11563.95924366811;11633.418329083343;11692.94153529227;11702.531898724295;10795.568177273135;12160.513579456723;12486.812697809723;13064.804027939399;13078.084534082524;9998.350107243006;10549.419781912069;10747.140228781522;11105.05607023412;11174.832377514507;10540;10696.518656660624;10792.028717415471;11084.44577771092;11088.833667494833;11069.5572177112;11456.427178640868;11512;11584.652460426201;11647.417629118341;11406.543738250377;11429.314241145557;11699.23954942926;11700.648980530597;11775.293482391084;10920.563177472812;11297.830532541853;11351.829722554334;11373.715657108638;11395.430228488709 09:16:45 INFO - PROCESS | 1642 | |3;mootools.html;1440.7478691229035;1533.2027345780195;1533.5552689719982;1563.7654351847225;1564.3664315952044;10079.24405669575;10626.256162068657;10628.3622982621;10629.04338609525;10631.99999999999;10117.988201179878;10546.209034322437;10558.947205263981;10652.520636571353;10659.040686338229;2321.1991862807304;2362.1614326913955;2363.9881800590974;2365.38499990003;2365.4086478380405;2267.115824828318;2287.8512896661746;2298.7011688480475;2300.2639155470174;2304.1704986204954;2310.341552657493;2313.4332088638225;2325.988370058156;2334.731505876829;2335.988320058397;2258.2209137847335;2274.6815445837597;2291.106468477295;2301.344116926685;2308.90764369425;2301.7813307735737;2315.548468048731;2343.379004563792;2344.5545346384133;2348.729896061958;10552;10656.946715266375;10657.520411581498;10659.467026648714;10662.093722033636;5560.638558493725;5735.254416925814;5735.598508104435;5735.598508104435;5745.683987380692;3269.640339562646;3277.3772983133126;3485.8779942701885;3587.157018100744;3591.44332628443;1117.5138814615668;1152.5908302552557;1197.3294954825326;1224.1308670843712;1232.433080782841;12958.09293349466;13471.191728496224;13497.987650926121;14598;14654.41382344705;4098.7130900836655;4205.852795152155;4206.57934206583;4207.705460617727;4210.32634778434;10722;11026.669199924016;11053.226274160892;11161.609343673095;11222.943885280521;5408.513233808976;5500.50495455411;5501.257330260443;5503.257060296889;5514.834554963358;4904;5079.6698214615935;5217.739113044333;5225.529702326809;5241.9737901310245;3061.3265081681993;3532.346515894568;3680.8527658893345;3720.1443667956523;3739.3643080675806;993.6323560282597;996.0487734213808;996.5615129343066;1010.7372083258406;1011.079917275276;745.7539012125985;867.8871746673018;929.3262384770987;946.9289803264783;962.3311798300114;5276.498732620395;6125.356837532084;6359.141515895388;6387.393197646216;6454.483641308684;958.87332384448;965.4979410706393;965.6234068713208;985.3053597213947;1012.9746756331003;3573.356795776785;3655.7440979131206;3668;3956.584558621361;4080.8571699990357;9998.20014398861;12488.75022499563;12613.684657883627;12618.053645976588;12618.053645976588;10435.739106522398;12539.122261441611;12555.183913045623;12563.93718031404;12580.370981451073;9359.859602105973;9428.62285508572;9540.475273859865;9557.569909354095;9646.372985755903;5978.850528736816;6145.0782382642965;6214.937850621436;6243.188385509855;6327.367263273636;11391.974722275036;11462.770744584896;11491.655250342503;11680.532778689098;11799.410029498662;8232.547209903512;11908.821367679666;11970.640880773592;12002.459889305177;12024.879751202727;7869.409794265339;8410.789730256547;8729.78175545591;8871.891013623297;8978.147076027766;9902.950485247527;10001.099901008944;10102.141317988053;10102.343347682377;10135.037171468699;8556.229939305493;8607.784805379915;8652.567371631267;8670.393072484865;8681.696140635047;8423;8515;8582.356323275904;8627.43921645091;8661.61022753965;7138.286171382821;7479.102507699111;7615.390768738598;7617.961910190414;7632.313091821763;4820.469748327751;5443.727813609383;5496.395396506461;5585.218069470358;5679.6876171810945;5604.103343465026;5713.342965558848;5746.885062298647;5760.510356619734;5790.276215473066 09:16:45 INFO - PROCESS | 1642 | |4;prototype.html;375.27571786452154;375.58122693197095;377.41312259436575;383.42294846256374;383.8867534077445;4907.043126590316;5223.582113430926;5342.786288548454;5369.147644062802;5429.7828086876525;5043.394792624881;5161.458046905077;5231.947680523203;5244.213367994803;5272.894542109156;3432.605250396199;4072.8574499892434;4111.938320925188;4153.979230103845;4173.770442625654;3486.9128271793156;3545.6454354564466;4162.916741665165;4170.249355116078;4188.4136220929095;4009.719319647626;4029.1740193260457;4066.5323487798987;4182.4278068987505;4188.6649068074485;3752;3924.921501569967;4119.352259096356;4150.564190759957;4151.813168407429;3275.623303320101;3448.7241020718534;3676.74262801604;3680.907977300562;3691.9261614767556;3881.6700580450697;4299.978500107511;5076.086304465195;5114.002769459919;5203.297554830087;4035.8587449439424;4190.455240818674;4231.920860180665;4791.94577193017;4818.445878723956;4677.859664210045;4970.0787087178605;5284.656497327662;5614.9157762633595;5635.422081817098;3418.8632454701783;3729.776213427203;4107;4133.46264985553;4242.787860606957;5008;5160.406553246387;5582.567801845227;5780.161876527922;6000.969995149996;4155.709100362946;4806.7836947337455;5035.043341765053;5051.74162665079;5069.771860266297;4889.65772395936;5146.4853514648985;5147.940823670562;5153.2270159476375;5164.992826398891;4455.598996090367;5013.573846223112;5082.593392528589;5239.397469291004;5388.548210564184;4846;4978.908858279531;5567.693776842312;5702.714864256771;5768.94231057684;1551.7517197248385;1649.2083799775935;1688.5525335786026;1703.6711365135213;1704.1649591699977;1165.5920427850185;1243.4777393494753;1280.5070048031575;1286.5368467351745;1349.743548725739;4386.473623165177;5117.667351622133;5136.357955255593;5182.352205974254;5183.974080129575;5020.924686129711;5096.490350964948;5276.498732620395;5450.836474905759;5701.543876489871;4593.379893714373;4718.811247550128;4834.8791280218275;4864.513548645178;5204.330946682579;2789.8796914345244;2933.2813460702264;2936.8707686926805;2957.4233024560003;2971.940561188764;4948.727819969864;4975.751212439363;5249.11298785674;5890.528757699374;5917.497012753878;4945.554900059012;5474.562035037187;5725.656460612293;5844.649321040752;6106.877862442726;6104.231501231294;6157.599756015845;6173.290071641729;6176.69116544171;6208.634100497973;4610.423697037871;5199.194124910645;5612.7754889803955;5960.314563825215;5990.9700451497465;5002.924956125734;5241.344831896013;5495.835124946258;5710.5146062585145;5797.188393624981;5242.5281724644965;5456.47112896303;5487.560995120461;5508.20131080983;5999.370066142992;3973.271626842333;4131.938020929749;4515.7967891444305;4579.610733087725;4731.810727570996;5175.214550979906;5413.24214609947;5447.591430642638;5871.412858714094;5955.731992060454;5294.338207724035;5449.6730196188355;5759.481646651821;5770.884582308414;5803.709814509342;4646.628269738345;5725.2843394575675;5731.713414329183;5757.827265182052;5772.509336706427;4722.819295176206;5126.4360920297995;5303.337082864642;5633.901319306035;5671.432856714296;4390.714603550759;5657.264555607745;5708.857278568069;5720.8283751487525;5725.370209276893;4965.304857319906;5122.871928201825;5139.357580302462;5583.497485226349;5609.186667933045 09:16:45 INFO - PROCESS | 1642 | |5;yui.html;614.3948211012155;698.5319835710073;736.5617457612718;812.3907069697726;853.7012045783977;13303.600891973245;13870;13987.510437134702;14007.649808754773;14014.649633759136;12654.240745555273;12848.48606055759;12888;12953.870461295384;13081.54214602489;931.4318265857821;944.6032666280145;944.8015916657511;946.9526523673824;947.8388673925449;918.9816203675922;940.3464592108487;942.4533770413144;952.1383148250844;961.966331178409;1008.4604736465992;1010.4745532323187;1011.4032720694788;1012.0385633648064;1014.1177175856977;852.663198036772;1006.4866917871865;1007.2898606482412;1008.193445243802;1009.6264382178604;745.5265906149634;746.5408773604248;747.4655621230792;747.5477336211568;747.581354441509;13874.167549946935;14105.2242126683;14136.15183089018;14147.363368648332;14153.363098660586;12216.205946613441;12258.1419300649;12317.507299708;12555.435005424777;12727.227685981086;10621.681349559525;10746;10810.29733067348;10831.945840270828;11127.221094523387;3455.8963231103107;3571.196480791827;3622.9094272643397;3663;3692.9076773080888;69207;71174.93237601388;71222;71778.64110679414;72142.9178562322;9469.66856160031;9720.07659272368;9750.561224744904;9887.060729230712;9912.256580756472;20351.592968140554;20357.880316582436;20387.592248154953;20391.77649341044;20392.184312627625;6983.93016069843;7073.893891591631;7157.7136914522835;7199.172095209014;7279.325755076362;3862.517185351831;3871.864484743077;3895.14306852492;3921.117748506563;3926.6466018058513;3185.792923459968;3200.431788423702;3242.902712918616;3293.967060329414;3294.159989202738;598.6168851934765;605.1678941455499;610.1153327674889;612.7805666723277;619.3125630550086;640.1869625575494;660.1582981698373;661.6890061671007;689.8858343774867;705.4074577355046;9209.677661281823;9218.124278193562;9305.395149315273;9449.574769135406;9544.856827147598;624.6002558362652;631.1952260867339;687.1582311668167;687.6424259385192;696.1924167965136;4529.773511324421;4543.613792827647;4576.222042252825;4590.334401511762;4671;63475.09574712766;68637.3136268641;71496.64251678708;73012.63493682604;73104;41556.75329740113;59476;60989.08516372258;61373.77252454926;62036.14367485672;43253.783731081145;46148.07703845904;50023;50554.988900222525;50764.74617626888;9712.368696034735;9777.21782257432;9787.755306117118;9792.510374481106;9799.853002205115;32088.679113208567;32365.51451728273;33127.17182070467;34095.033369160796;34472;40488.52183650602;40738.79630601828;40781.184376311714;43704.56295437005;44155.55844441515;10001.299909006591;11669.183157178915;11983;12020.879791202326;12046.277223366626;13048.934755326163;13310.267935263653;13406.798898016732;13616.523421680193;13652.658683532594;10539.26225164231;11090.860465346555;12268.32524211177;12416.441260143134;12625.305608191638;10689.144868410664;12253;12389.876101238871;12683.30241836671;12714.300713460478;12068.637940861789;12200.328981906081;12206.267623942593;12210.450529726362;12581.496740130659;9960;10055.095041446013;10310.536025878704;10912.727181820517;11016.724581885197;8326.70856520019;8681.565921703763;9681.128698417177;9931.65239216624;9942.353747006711 09:16:45 INFO - PROCESS | 1642 | __end_tp_report 09:16:45 INFO - PROCESS | 1642 | __start_cc_report 09:16:45 INFO - PROCESS | 1642 | _x_x_mozilla_cycle_collect,3085 09:16:45 INFO - PROCESS | 1642 | __end_cc_report 09:16:45 INFO - PROCESS | 1642 | __startTimestamp1488215805091__endTimestamp 09:16:45 INFO - PROCESS | 1642 | 09:16:45 INFO - PROCESS | 1642 | ------- Summary: start ------- 09:16:45 INFO - PROCESS | 1642 | Number of tests: 6 09:16:45 INFO - PROCESS | 1642 | 09:16:45 INFO - PROCESS | 1642 | [#0] dojo.html Cycles:165 Average:5728.99 Median:5950.61 stddev:717.04 (12.0%) stddev-sans-first:691.69 09:16:45 INFO - PROCESS | 1642 | Values: 3219.5 3281.4 3376.2 3403.6 3438.3 4555.2 5664.4 5745.0 5802.9 5831.4 5672.6 5750.2 5793.4 5793.4 5796.9 5189.0 5209.5 5266.4 5286.8 5300.4 5366.1 5387.0 5397.0 5413.8 5450.9 5179.3 5184.6 5197.6 5273.3 5317.5 4049.6 4294.3 4581.3 5264.4 5292.4 5160.6 5214.9 5231.1 5234.3 5243.9 4722.5 5670.4 5698.1 5730.0 5730.6 6202.7 6211.2 6217.5 6219.9 6226.9 6134.1 6143.1 6193.3 6209.0 6216.4 5944.2 5950.6 5967.3 6003.4 6056.3 6298.3 6355.9 6366.5 6376.5 6390.6 6055.1 6058.5 6075.1 6283.5 6286.8 6199.8 6208.1 6229.6 6276.2 6298.8 6310.2 6313.1 6316.9 6318.8 6338.8 6144.8 6287.6 6313.7 6314.2 6319.4 3581.7 4225.3 4466.8 4951.0 5028.6 4454.4 4500.3 4562.0 4565.4 4587.1 5807.9 5809.0 5809.8 5812.2 5817.2 6208.8 6290.7 6302.9 6307.6 6311.8 5743.2 5767.7 5783.3 5827.9 5828.7 4659.3 5435.6 5532.7 5534.1 5586.7 6356.2 6391.7 6402.0 6404.6 6412.5 6340.3 6348.8 6350.7 6352.6 6381.1 6253.3 6296.2 6307.0 6326.1 6328.0 6098.7 6200.4 6201.0 6204.5 6213.9 5179.2 6255.8 6260.8 6276.1 6336.7 6189.8 6190.4 6213.8 6219.8 6232.9 6134.3 6222.0 6226.4 6234.4 6234.5 4938.4 5819.2 5851.0 5866.2 5927.5 6085.4 6087.0 6090.3 6090.8 6102.0 4917.3 5845.3 5854.5 5888.3 5949.2 09:16:45 INFO - PROCESS | 1642 | 09:16:45 INFO - PROCESS | 1642 | [#1] ext.html Cycles:180 Average:52821.84 Median:33971.66 stddev:103326.05 (304.2%) stddev-sans-first:103541.86 09:16:45 INFO - PROCESS | 1642 | Values: 721.8 771.1 843.8 859.9 861.4 27193.3 28280.7 38121.0 38413.0 38845.4 39893.4 39947.0 40043.0 40154.4 40171.6 8982.5 9161.0 9161.8 9172.3 9173.9 7156.1 7364.4 7369.8 7394.7 7399.4 10716.4 10933.6 10976.3 11024.9 11050.3 10763.0 10832.6 10848.2 10850.2 10863.8 7121.2 10485.4 10547.4 10555.4 10561.2 26263.7 27264.0 27281.7 27328.6 37206.4 3638.5 3664.2 3700.7 3748.5 3873.7 26671.0 28032.6 28213.2 28366.0 28674.9 2453.5 3034.3 3038.9 3111.9 3138.2 335396.0 336236.0 336469.0 336639.0 336953.0 49104.5 49109.5 49194.0 49294.5 49329.3 50961.7 51001.0 51024.2 51100.7 51116.0 13512.5 13648.8 13664.3 13672.5 13675.5 11705.8 11709.5 11709.9 11725.6 11727.2 11514.9 11751.8 11816.0 11868.4 11909.6 4122.9 5237.2 5252.7 5285.4 5310.9 918.1 920.9 922.1 965.4 971.4 22641.9 24184.3 28083.9 28197.6 28226.0 984.9 988.0 1024.9 1029.5 1031.3 14242.4 14320.0 14520.9 14582.8 14639.2 385663.0 386263.0 386334.0 386938.0 387189.0 53228.7 53323.0 53378.7 53399.0 53537.2 1373.6 1410.0 1411.8 1412.8 1413.1 20650.8 27593.2 29225.4 29902.7 30122.0 51252.0 51310.0 51390.0 51468.0 51473.7 437685.0 440538.0 441928.0 442548.0 443044.0 32592.8 33110.0 33287.0 33347.5 33420.3 41870.0 43155.4 43156.6 43227.0 43402.3 29974.4 33249.5 34566.7 35251.3 35466.6 33958.7 33984.7 35144.4 35252.4 35319.6 34413.8 34990.3 35954.5 36010.1 36261.8 25063.2 29814.8 30026.0 30603.8 30793.7 21536.5 21908.8 22997.9 23101.9 23873.6 09:16:45 INFO - PROCESS | 1642 | 09:16:45 INFO - PROCESS | 1642 | [#2] jquery.html Cycles:180 Average:39504.30 Median:22649.77 stddev:112276.50 (495.7%) stddev-sans-first:112552.99 09:16:45 INFO - PROCESS | 1642 | Values: 359.7 379.4 392.2 405.5 438.3 13345.3 13456.9 15744.7 20122.9 21054.5 19751.4 20409.0 20531.5 20641.5 21171.3 6279.3 6362.7 6518.8 6634.5 6646.6 4084.1 6442.6 6597.4 6602.6 6609.6 4263.6 4286.5 4340.4 7075.4 7430.5 7380.3 7425.2 7505.8 7506.9 7536.2 6940.3 7050.3 7168.1 7217.2 7229.5 21023.9 23021.0 23154.7 23628.9 25116.9 2373.1 2800.6 2810.5 2855.1 2858.3 13070.6 14822.9 15024.7 15240.9 15568.2 1883.9 1947.0 1947.1 1960.8 2026.1 148848.0 156755.0 158807.0 158988.2 160694.4 14614.5 15425.8 15611.6 15649.3 15654.7 22424.7 22612.9 22645.7 22653.9 22660.4 9131.6 9153.9 9246.5 9340.4 9446.0 8155.2 8165.5 8208.4 8309.8 8317.6 5802.8 6780.6 6866.9 6874.4 6878.5 3600.8 3697.0 3707.8 3710.3 3717.4 745.8 778.0 862.5 870.0 914.4 19662.6 21151.8 21321.9 21354.4 21406.7 868.4 871.7 896.9 918.3 918.7 10754.9 11182.4 11193.6 11212.8 11233.3 656460.0 656588.0 665964.0 683100.0 684599.0 111572.8 136125.0 141324.0 146343.0 153401.2 980.2 980.4 1017.4 1020.6 1021.2 18874.3 19513.7 19599.9 19619.3 19627.3 57990.0 58248.1 58637.0 58763.0 59111.4 84373.0 85705.7 86756.0 88970.0 89230.0 10931.7 11564.0 11633.4 11692.9 11702.5 10795.6 12160.5 12486.8 13064.8 13078.1 9998.4 10549.4 10747.1 11105.1 11174.8 10540.0 10696.5 10792.0 11084.4 11088.8 11069.6 11456.4 11512.0 11584.7 11647.4 11406.5 11429.3 11699.2 11700.6 11775.3 10920.6 11297.8 11351.8 11373.7 11395.4 09:16:45 INFO - PROCESS | 1642 | 09:16:45 INFO - PROCESS | 1642 | [#3] mootools.html Cycles:180 Average:6339.91 Median:3580.26 stddev:3896.73 (108.8%) stddev-sans-first:3890.28 09:16:45 INFO - PROCESS | 1642 | Values: 1440.7 1533.2 1533.6 1563.8 1564.4 10079.2 10626.3 10628.4 10629.0 10632.0 10118.0 10546.2 10558.9 10652.5 10659.0 2321.2 2362.2 2364.0 2365.4 2365.4 2267.1 2287.9 2298.7 2300.3 2304.2 2310.3 2313.4 2326.0 2334.7 2336.0 2258.2 2274.7 2291.1 2301.3 2308.9 2301.8 2315.5 2343.4 2344.6 2348.7 10552.0 10656.9 10657.5 10659.5 10662.1 5560.6 5735.3 5735.6 5735.6 5745.7 3269.6 3277.4 3485.9 3587.2 3591.4 1117.5 1152.6 1197.3 1224.1 1232.4 12958.1 13471.2 13498.0 14598.0 14654.4 4098.7 4205.9 4206.6 4207.7 4210.3 10722.0 11026.7 11053.2 11161.6 11222.9 5408.5 5500.5 5501.3 5503.3 5514.8 4904.0 5079.7 5217.7 5225.5 5242.0 3061.3 3532.3 3680.9 3720.1 3739.4 993.6 996.0 996.6 1010.7 1011.1 745.8 867.9 929.3 946.9 962.3 5276.5 6125.4 6359.1 6387.4 6454.5 958.9 965.5 965.6 985.3 1013.0 3573.4 3655.7 3668.0 3956.6 4080.9 9998.2 12488.8 12613.7 12618.1 12618.1 10435.7 12539.1 12555.2 12563.9 12580.4 9359.9 9428.6 9540.5 9557.6 9646.4 5978.9 6145.1 6214.9 6243.2 6327.4 11392.0 11462.8 11491.7 11680.5 11799.4 8232.5 11908.8 11970.6 12002.5 12024.9 7869.4 8410.8 8729.8 8871.9 8978.1 9903.0 10001.1 10102.1 10102.3 10135.0 8556.2 8607.8 8652.6 8670.4 8681.7 8423.0 8515.0 8582.4 8627.4 8661.6 7138.3 7479.1 7615.4 7618.0 7632.3 4820.5 5443.7 5496.4 5585.2 5679.7 5604.1 5713.3 5746.9 5760.5 5790.3 09:16:45 INFO - PROCESS | 1642 | 09:16:45 INFO - PROCESS | 1642 | [#4] prototype.html Cycles:180 Average:4618.95 Median:5060.76 stddev:1310.99 (25.9%) stddev-sans-first:1275.39 09:16:45 INFO - PROCESS | 1642 | Values: 375.3 375.6 377.4 383.4 383.9 4907.0 5223.6 5342.8 5369.1 5429.8 5043.4 5161.5 5231.9 5244.2 5272.9 3432.6 4072.9 4111.9 4154.0 4173.8 3486.9 3545.6 4162.9 4170.2 4188.4 4009.7 4029.2 4066.5 4182.4 4188.7 3752.0 3924.9 4119.4 4150.6 4151.8 3275.6 3448.7 3676.7 3680.9 3691.9 3881.7 4300.0 5076.1 5114.0 5203.3 4035.9 4190.5 4231.9 4791.9 4818.4 4677.9 4970.1 5284.7 5614.9 5635.4 3418.9 3729.8 4107.0 4133.5 4242.8 5008.0 5160.4 5582.6 5780.2 6001.0 4155.7 4806.8 5035.0 5051.7 5069.8 4889.7 5146.5 5147.9 5153.2 5165.0 4455.6 5013.6 5082.6 5239.4 5388.5 4846.0 4978.9 5567.7 5702.7 5768.9 1551.8 1649.2 1688.6 1703.7 1704.2 1165.6 1243.5 1280.5 1286.5 1349.7 4386.5 5117.7 5136.4 5182.4 5184.0 5020.9 5096.5 5276.5 5450.8 5701.5 4593.4 4718.8 4834.9 4864.5 5204.3 2789.9 2933.3 2936.9 2957.4 2971.9 4948.7 4975.8 5249.1 5890.5 5917.5 4945.6 5474.6 5725.7 5844.6 6106.9 6104.2 6157.6 6173.3 6176.7 6208.6 4610.4 5199.2 5612.8 5960.3 5991.0 5002.9 5241.3 5495.8 5710.5 5797.2 5242.5 5456.5 5487.6 5508.2 5999.4 3973.3 4131.9 4515.8 4579.6 4731.8 5175.2 5413.2 5447.6 5871.4 5955.7 5294.3 5449.7 5759.5 5770.9 5803.7 4646.6 5725.3 5731.7 5757.8 5772.5 4722.8 5126.4 5303.3 5633.9 5671.4 4390.7 5657.3 5708.9 5720.8 5725.4 4965.3 5122.9 5139.4 5583.5 5609.2 09:16:45 INFO - PROCESS | 1642 | 09:16:45 INFO - PROCESS | 1642 | [#5] yui.html Cycles:180 Average:15151.50 Median:41168.97 stddev:18908.63 (45.9%) stddev-sans-first:18930.16 09:16:45 INFO - PROCESS | 1642 | Values: 614.4 698.5 736.6 812.4 853.7 13303.6 13870.0 13987.5 14007.6 14014.6 12654.2 12848.5 12888.0 12953.9 13081.5 931.4 944.6 944.8 947.0 947.8 919.0 940.3 942.5 952.1 962.0 1008.5 1010.5 1011.4 1012.0 1014.1 852.7 1006.5 1007.3 1008.2 1009.6 745.5 746.5 747.5 747.5 747.6 13874.2 14105.2 14136.2 14147.4 14153.4 12216.2 12258.1 12317.5 12555.4 12727.2 10621.7 10746.0 10810.3 10831.9 11127.2 3455.9 3571.2 3622.9 3663.0 3692.9 69207.0 71174.9 71222.0 71778.6 72142.9 9469.7 9720.1 9750.6 9887.1 9912.3 20351.6 20357.9 20387.6 20391.8 20392.2 6983.9 7073.9 7157.7 7199.2 7279.3 3862.5 3871.9 3895.1 3921.1 3926.6 3185.8 3200.4 3242.9 3294.0 3294.2 598.6 605.2 610.1 612.8 619.3 640.2 660.2 661.7 689.9 705.4 9209.7 9218.1 9305.4 9449.6 9544.9 624.6 631.2 687.2 687.6 696.2 4529.8 4543.6 4576.2 4590.3 4671.0 63475.1 68637.3 71496.6 73012.6 73104.0 41556.8 59476.0 60989.1 61373.8 62036.1 43253.8 46148.1 50023.0 50555.0 50764.7 9712.4 9777.2 9787.8 9792.5 9799.9 32088.7 32365.5 33127.2 34095.0 34472.0 40488.5 40738.8 40781.2 43704.6 44155.6 10001.3 11669.2 11983.0 12020.9 12046.3 13048.9 13310.3 13406.8 13616.5 13652.7 10539.3 11090.9 12268.3 12416.4 12625.3 10689.1 12253.0 12389.9 12683.3 12714.3 12068.6 12200.3 12206.3 12210.5 12581.5 9960.0 10055.1 10310.5 10912.7 11016.7 8326.7 8681.6 9681.1 9931.7 9942.4 09:16:45 INFO - PROCESS | 1642 | -------- Summary: end -------- 09:16:45 INFO - PROCESS | 1642 | 09:16:45 INFO - TEST-INFO | 1642: exit 0 09:16:45 INFO - TEST-OK | dromaeo_css | took 1121541ms 09:16:45 INFO - TEST-START | kraken 09:16:45 INFO - operating with platform_type : mac_ 09:16:45 INFO - Initialising browser for kraken test... 09:16:45 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/tmpPtMDq3/profile http://localhost:49243/getInfo.html) 09:16:48 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 09:16:48 INFO - PROCESS | 1652 | colorDepth:24 09:16:48 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 09:16:48 INFO - PROCESS | 1652 | __metrics 09:16:48 INFO - PROCESS | 1652 | 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" 09:16:48 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:16:49 INFO - TEST-INFO | 1652: exit 0 09:16:49 INFO - Browser initialized. 09:16:49 INFO - Running cycle 1/1 for kraken test... 09:16:49 INFO - TEST-INFO | started process 1653 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/tmpPtMDq3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:17:01 INFO - PROCESS | 1653 | RSS: Main: 231735296 09:17:01 INFO - PROCESS | 1653 | 09:17:04 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 09:17:05 INFO - PROCESS | 1653 | RSS: Main: 282501120 09:17:05 INFO - PROCESS | 1653 | 09:17:08 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 09:17:08 INFO - PROCESS | 1653 | RSS: Main: 285274112 09:17:08 INFO - PROCESS | 1653 | 09:17:11 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 09:17:12 INFO - PROCESS | 1653 | RSS: Main: 376320000 09:17:12 INFO - PROCESS | 1653 | 09:17:14 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 09:17:15 INFO - PROCESS | 1653 | RSS: Main: 278319104 09:17:15 INFO - PROCESS | 1653 | 09:17:17 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:17:17 INFO - PROCESS | 1653 | RSS: Main: 282705920 09:17:17 INFO - PROCESS | 1653 | 09:17:20 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 09:17:21 INFO - PROCESS | 1653 | RSS: Main: 324251648 09:17:21 INFO - PROCESS | 1653 | 09:17:24 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 09:17:25 INFO - PROCESS | 1653 | RSS: Main: 326602752 09:17:25 INFO - PROCESS | 1653 | 09:17:28 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 09:17:29 INFO - PROCESS | 1653 | RSS: Main: 324841472 09:17:29 INFO - PROCESS | 1653 | 09:17:30 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:17:31 INFO - PROCESS | 1653 | RSS: Main: 299843584 09:17:31 INFO - PROCESS | 1653 | 09:17:33 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:17:34 INFO - PROCESS | 1653 | RSS: Main: 303468544 09:17:34 INFO - PROCESS | 1653 | 09:17:36 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:17:37 INFO - PROCESS | 1653 | RSS: Main: 305295360 09:17:37 INFO - PROCESS | 1653 | 09:17:39 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:17:40 INFO - PROCESS | 1653 | RSS: Main: 322883584 09:17:40 INFO - PROCESS | 1653 | 09:17:43 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:17:44 INFO - PROCESS | 1653 | RSS: Main: 317067264 09:17:44 INFO - PROCESS | 1653 | 09:17:46 INFO - PROCESS | 1653 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 09:17:46 INFO - PROCESS | 1653 | RSS: Main: 361840640 09:17:46 INFO - PROCESS | 1653 | 09:17:46 INFO - PROCESS | 1653 | __start_tp_report 09:17:46 INFO - PROCESS | 1653 | _x_x_mozilla_page_load 09:17:46 INFO - PROCESS | 1653 | _x_x_mozilla_page_load_details 09:17:46 INFO - PROCESS | 1653 | |i|pagename|runs| 09:17:46 INFO - PROCESS | 1653 | |0;ai-astar;115;114;115;115;114;116;115;114;114;116 09:17:46 INFO - PROCESS | 1653 | |1;audio-beat-detection;139;122;139;182;114;110;112;111;129;110 09:17:46 INFO - PROCESS | 1653 | |2;audio-dft;183;184;183;182;184;180;180;185;184;184 09:17:46 INFO - PROCESS | 1653 | |3;audio-fft;78;60;61;91;63;64;62;60;76;61 09:17:46 INFO - PROCESS | 1653 | |4;audio-oscillator;89;70;89;70;72;69;86;71;70;85 09:17:46 INFO - PROCESS | 1653 | |5;imaging-gaussian-blur;86;86;87;86;87;86;87;86;87;91 09:17:46 INFO - PROCESS | 1653 | |6;imaging-darkroom;94;94;95;93;123;138;93;114;150;94 09:17:46 INFO - PROCESS | 1653 | |7;imaging-desaturate;86;86;85;88;88;87;87;85;86;88 09:17:46 INFO - PROCESS | 1653 | |8;json-parse-financial;63;60;62;61;63;61;63;61;61;61 09:17:46 INFO - PROCESS | 1653 | |9;json-stringify-tinderbox;57;69;97;96;88;62;60;60;60;61 09:17:46 INFO - PROCESS | 1653 | |10;stanford-crypto-aes;87;91;87;85;74;88;86;104;105;104 09:17:46 INFO - PROCESS | 1653 | |11;stanford-crypto-ccm;145;138;141;147;149;143;141;140;210;158 09:17:46 INFO - PROCESS | 1653 | |12;stanford-crypto-pbkdf2;172;176;176;174;172;172;173;179;209;172 09:17:46 INFO - PROCESS | 1653 | |13;stanford-crypto-sha256-iterative;69;68;68;67;65;67;63;60;61;76 09:17:46 INFO - PROCESS | 1653 | __end_tp_report 09:17:46 INFO - PROCESS | 1653 | __start_cc_report 09:17:46 INFO - PROCESS | 1653 | _x_x_mozilla_cycle_collect,2226 09:17:46 INFO - PROCESS | 1653 | __end_cc_report 09:17:46 INFO - PROCESS | 1653 | __startTimestamp1488215866484__endTimestamp 09:17:46 INFO - PROCESS | 1653 | 09:17:46 INFO - PROCESS | 1653 | ------- Summary: start ------- 09:17:46 INFO - PROCESS | 1653 | Number of tests: 14 09:17:46 INFO - PROCESS | 1653 | 09:17:46 INFO - PROCESS | 1653 | [#0] ai-astar Cycles:10 Average:114.80 Median:115.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 09:17:46 INFO - PROCESS | 1653 | Values: 115.0 114.0 115.0 115.0 114.0 116.0 115.0 114.0 114.0 116.0 09:17:46 INFO - PROCESS | 1653 | 09:17:46 INFO - PROCESS | 1653 | [#1] audio-beat-detection Cycles:10 Average:126.80 Median:125.50 stddev:22.53 (18.0%) stddev-sans-first:23.46 09:17:46 INFO - PROCESS | 1653 | Values: 139.0 122.0 139.0 182.0 114.0 110.0 112.0 111.0 129.0 110.0 09:17:46 INFO - PROCESS | 1653 | 09:17:46 INFO - PROCESS | 1653 | [#2] audio-dft Cycles:10 Average:182.90 Median:184.00 stddev:1.73 (0.9%) stddev-sans-first:1.83 09:17:46 INFO - PROCESS | 1653 | Values: 183.0 184.0 183.0 182.0 184.0 180.0 180.0 185.0 184.0 184.0 09:17:46 INFO - PROCESS | 1653 | 09:17:46 INFO - PROCESS | 1653 | [#3] audio-fft Cycles:10 Average:67.60 Median:63.50 stddev:10.51 (16.6%) stddev-sans-first:10.45 09:17:46 INFO - PROCESS | 1653 | Values: 78.0 60.0 61.0 91.0 63.0 64.0 62.0 60.0 76.0 61.0 09:17:46 INFO - PROCESS | 1653 | 09:17:46 INFO - PROCESS | 1653 | [#4] audio-oscillator Cycles:10 Average:77.10 Median:78.50 stddev:8.85 (11.3%) stddev-sans-first:8.27 09:17:46 INFO - PROCESS | 1653 | Values: 89.0 70.0 89.0 70.0 72.0 69.0 86.0 71.0 70.0 85.0 09:17:46 INFO - PROCESS | 1653 | 09:17:46 INFO - PROCESS | 1653 | [#5] imaging-gaussian-blur Cycles:10 Average:86.90 Median:87.00 stddev:1.52 (1.8%) stddev-sans-first:1.58 09:17:46 INFO - PROCESS | 1653 | Values: 86.0 86.0 87.0 86.0 87.0 86.0 87.0 86.0 87.0 91.0 09:17:46 INFO - PROCESS | 1653 | 09:17:46 INFO - PROCESS | 1653 | [#6] imaging-darkroom Cycles:10 Average:108.80 Median:93.50 stddev:21.41 (22.9%) stddev-sans-first:22.03 09:17:46 INFO - PROCESS | 1653 | Values: 94.0 94.0 95.0 93.0 123.0 138.0 93.0 114.0 150.0 94.0 09:17:46 INFO - PROCESS | 1653 | 09:17:46 INFO - PROCESS | 1653 | [#7] imaging-desaturate Cycles:10 Average:86.60 Median:87.00 stddev:1.17 (1.3%) stddev-sans-first:1.22 09:17:46 INFO - PROCESS | 1653 | Values: 86.0 86.0 85.0 88.0 88.0 87.0 87.0 85.0 86.0 88.0 09:17:46 INFO - PROCESS | 1653 | 09:17:46 INFO - PROCESS | 1653 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:61.50 stddev:1.07 (1.7%) stddev-sans-first:1.01 09:17:46 INFO - PROCESS | 1653 | Values: 63.0 60.0 62.0 61.0 63.0 61.0 63.0 61.0 61.0 61.0 09:17:46 INFO - PROCESS | 1653 | 09:17:46 INFO - PROCESS | 1653 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:65.50 stddev:16.10 (24.6%) stddev-sans-first:16.26 09:17:46 INFO - PROCESS | 1653 | Values: 57.0 69.0 97.0 96.0 88.0 62.0 60.0 60.0 60.0 61.0 09:17:46 INFO - PROCESS | 1653 | 09:17:46 INFO - PROCESS | 1653 | [#10] stanford-crypto-aes Cycles:10 Average:91.10 Median:86.50 stddev:10.14 (11.7%) stddev-sans-first:10.64 09:17:46 INFO - PROCESS | 1653 | Values: 87.0 91.0 87.0 85.0 74.0 88.0 86.0 104.0 105.0 104.0 09:17:46 INFO - PROCESS | 1653 | 09:17:46 INFO - PROCESS | 1653 | [#11] stanford-crypto-ccm Cycles:10 Average:151.20 Median:146.00 stddev:21.45 (14.7%) stddev-sans-first:22.63 09:17:46 INFO - PROCESS | 1653 | Values: 145.0 138.0 141.0 147.0 149.0 143.0 141.0 140.0 210.0 158.0 09:17:46 INFO - PROCESS | 1653 | 09:17:46 INFO - PROCESS | 1653 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.50 Median:175.00 stddev:11.32 (6.5%) stddev-sans-first:11.83 09:17:46 INFO - PROCESS | 1653 | Values: 172.0 176.0 176.0 174.0 172.0 172.0 173.0 179.0 209.0 172.0 09:17:46 INFO - PROCESS | 1653 | 09:17:46 INFO - PROCESS | 1653 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:67.50 stddev:4.58 (6.8%) stddev-sans-first:4.76 09:17:46 INFO - PROCESS | 1653 | Values: 69.0 68.0 68.0 67.0 65.0 67.0 63.0 60.0 61.0 76.0 09:17:46 INFO - PROCESS | 1653 | -------- Summary: end -------- 09:17:46 INFO - PROCESS | 1653 | 09:17:47 INFO - TEST-INFO | 1653: exit 0 09:17:47 INFO - TEST-OK | kraken | took 61715ms 09:17:47 INFO - SUITE-END | took 1183s 09:17:47 INFO - Completed test suite (00:19:43) 09:17:47 INFO - javascript benchmark 09:17:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7310.376611814502, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3219.549263103166, 3281.3601347737194, 3376.189714468528, 3403.6426175251613, 3438.3467141243163, 4555.20283950309, 5664.376918538967, 5744.971275143624, 5802.883942321157, 5831.387704291052, 5672.602917795756, 5750.223719797826, 5793.362730099696, 5793.449622285876, 5796.913046304298, 5188.974055129719, 5209.479052094779, 5266.394364648077, 5286.7885284588765, 5300.443453437391, 5366.114591092465, 5387.0, 5397.028534863723, 5413.783448662049, 5450.91823622646, 5179.2749015137915, 5184.585233181374, 5197.558207552324, 5273.2617433559335, 5317.46825317469, 4049.5950404959563, 4294.26997410441, 4581.266997280419, 5264.368275806889, 5292.364916210041, 5160.612954028463, 5214.895702085975, 5231.136862417697, 5234.293370394986, 5243.947560524384, 4722.456917454502, 5670.432956704338, 5698.088305871041, 5730.0, 5730.627509211888, 6202.689865506752, 6211.16149319845, 6217.533684973645, 6219.875602487925, 6226.941419958618, 6134.08133522331, 6143.1434383011665, 6193.2877719062435, 6209.037599172136, 6216.409441103088, 5944.197533332988, 5950.6132101413705, 5967.254093238345, 6003.429674180946, 6056.303525094582, 6298.326586904456, 6355.904661430082, 6366.458850997625, 6376.458001069868, 6390.648514331663, 6055.061465472859, 6058.515318774487, 6075.149479072933, 6283.465905398092, 6286.811395658137, 6199.814005579839, 6208.099825525273, 6229.626222426669, 6276.246850377984, 6298.842528936813, 6310.242770867433, 6313.147725057059, 6316.9368306317265, 6318.778842740574, 6338.778142765073, 6144.815655530341, 6287.622742635456, 6313.715882785285, 6314.210723659543, 6319.399657032666, 3581.6776490116013, 4225.345071513921, 4466.7766611669285, 4951.034548263054, 5028.5977121830165, 4454.398656181439, 4500.2799552072165, 4561.954380456153, 4565.429321334833, 4587.08258348325, 5807.912881306784, 5808.970955145282, 5809.7966571170655, 5812.157237200582, 5817.185594016841, 6208.81373558794, 6290.716917738713, 6302.936970630327, 6307.558470906993, 6311.842203944938, 5743.167240750151, 5767.653940763567, 5783.334916484574, 5827.854303642443, 5828.737706803204, 4659.324397962277, 5435.565154787687, 5532.6680399176175, 5534.1145416733125, 5586.720663966786, 6356.2054743157105, 6391.712372943229, 6402.0, 6404.647744374011, 6412.5190610704385, 6340.302566717565, 6348.841278968062, 6350.68246587678, 6352.555321127476, 6381.138546296191, 6253.280872699698, 6296.150019747459, 6307.0, 6326.051092336186, 6327.96836015817, 6098.664573448503, 6200.3799620037635, 6201.007838745779, 6204.472619827366, 6213.937860621517, 5179.19722443022, 6255.78104766331, 6260.824428395293, 6276.058591211355, 6336.746530138743, 6189.783357582463, 6190.350013248724, 6213.751449941951, 6219.751209951552, 6232.937670623236, 6134.263888333428, 6222.0, 6226.40849119333, 6234.407731265523, 6234.470070044097, 4938.358013458227, 5819.185314056121, 5850.97607918604, 5866.2373891393845, 5927.525797936241, 6085.361037091218, 6086.969565152146, 6090.299615544269, 6090.817275481742, 6102.023676211785, 4917.311576379381, 5845.298564172326, 5854.531637469077, 5888.263967004124, 5949.196858424058], "value": 5681.349821725499, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [721.7726416178904, 771.0631582627109, 843.7974886027355, 859.9441036332634, 861.3970220845409, 27193.32016699581, 28280.717192828066, 38121.0, 38413.0, 38845.41731874024, 39893.40159897604, 39947.0, 40043.0, 40154.39768403476, 40171.59828401715, 8982.505962172077, 9161.0, 9161.816763664723, 9172.31207659425, 9173.862392064124, 7156.141263048441, 7364.410847132217, 7369.77890663281, 7394.704211831548, 7399.3710534604625, 10716.41059741714, 10933.617323393682, 10976.341419514814, 11024.889751102466, 11050.281731687415, 10763.031327180552, 10832.566697332097, 10848.18638602108, 10850.24048316618, 10863.782724345549, 7121.181064177634, 10485.423301718403, 10547.419891905942, 10555.41945193014, 10561.207909406749, 26263.73736262632, 27264.0, 27281.72718272812, 27328.59007114895, 37206.44190337147, 3638.5269914911155, 3664.230511592542, 3700.7224458165474, 3748.5314335708035, 3873.6513713765617, 26671.0, 28032.579511307347, 28213.15360539187, 28366.0, 28674.856625716737, 2453.460238747473, 3034.317278612317, 3038.8936387226563, 3111.937761244785, 3138.2154461384653, 335396.0, 336236.0, 336469.0, 336639.0, 336953.0, 49104.508954909994, 49109.50890491121, 49194.0, 49294.50705492971, 49329.260061099114, 50961.725956850634, 51001.0, 51024.23463648048, 51100.74449627728, 51116.0, 13512.459501619825, 13648.795268070988, 13664.316784160752, 13672.52146174879, 13675.521356752466, 11705.765884682258, 11709.531618735326, 11709.882901170879, 11725.648230553097, 11727.237729547553, 11514.942425287987, 11751.823722644167, 11816.0, 11868.406579670982, 11909.58316458937, 4122.9381559276635, 5237.16205407133, 5252.737363131828, 5285.445028272053, 5310.867228319245, 918.1002617434951, 920.9033051529627, 922.0917396364575, 965.4448692002127, 971.4365667912593, 22641.886790565943, 24184.339722630495, 28083.859580701966, 28197.563050714023, 28226.0, 984.921206303494, 987.9753006174759, 1024.8770147582188, 1029.4543891737392, 1031.3296357367772, 14242.43030278798, 14319.996422733586, 14520.854791452162, 14582.781258281135, 14639.194844283667, 385663.0, 386263.0, 386334.0, 386938.0, 387189.0, 53228.733856331244, 53323.0, 53378.73310633422, 53399.0, 53537.1969420459, 1373.5810577773875, 1409.9506517272052, 1411.7811739180033, 1412.7810189420657, 1413.0885578801822, 20650.793492065488, 27593.17220483389, 29225.415491690474, 29902.70097298999, 30122.01093201931, 51252.0, 51310.0, 51390.0, 51468.0, 51473.7426312866, 437685.0, 440538.0, 441928.0, 442548.0, 443044.0, 32592.837035814668, 33110.0, 33287.0, 33347.49978750369, 33420.331593368486, 41870.0, 43155.352669709355, 43156.56843431525, 43227.0, 43402.348964766185, 29974.400511990076, 33249.50125748164, 34566.65433345635, 35251.294974100885, 35466.64533354736, 33958.66041339555, 33984.66015339815, 35144.418501167, 35252.41364138568, 35319.646803531636, 34413.827930860185, 34990.30019399547, 35954.4606830903, 36010.09974750652, 36261.81869090637, 25063.199352361466, 29814.807407703447, 30026.0, 30603.846980764953, 30793.69206307908, 21536.461588459788, 21908.780912191312, 22997.88501057484, 23101.88449057744, 23873.64189537193], "value": 18017.623405937895, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.67449458240293, 379.4289594160788, 392.1862136067659, 405.47339267657276, 438.3446747113064, 13345.332733363342, 13456.932715336421, 15744.685106297882, 20122.89938550309, 21054.473638159052, 19751.407457776255, 20408.999999999964, 20531.486712832186, 20641.483962900937, 21171.259005934797, 6279.27788304344, 6362.650054247015, 6518.837029074263, 6634.5024123190715, 6646.60120392778, 4084.121913788535, 6442.581232219891, 6597.4392176664805, 6602.60384376939, 6609.636469994149, 4263.573642635727, 4286.464191976003, 4340.370646256291, 7075.398591119735, 7430.517016393944, 7380.335769780691, 7425.2179476925685, 7505.812354691149, 7506.887396689054, 7536.246375362447, 6940.305969403019, 7050.259722729091, 7168.103987001625, 7217.206107328189, 7229.5300805448005, 21023.8948805255, 23021.0, 23154.65268020981, 23628.881855590786, 25116.869740861523, 2373.062640257089, 2800.649918760155, 2810.5222112240967, 2855.072101566999, 2858.2568532181576, 13070.607881763468, 14822.851771482256, 15024.699506009818, 15240.933134680577, 15568.221588920509, 1883.915223814918, 1946.9513262168418, 1947.1237942925598, 1960.8137077068454, 2026.0983862181336, 148848.0, 156755.0, 158807.0, 158988.20505897395, 160694.3930560703, 14614.481097330401, 15425.84574154244, 15611.613993172337, 15649.29578168985, 15654.686906261812, 22424.66363004556, 22612.86935653211, 22645.660315095287, 22653.88673056657, 22660.433489162904, 9131.589078491485, 9153.862692059625, 9246.491442970566, 9340.392874463138, 9445.952770236105, 8155.184481551797, 8165.469244499089, 8208.425410221227, 8309.83380332402, 8317.625706843206, 5802.796902108406, 6780.559263647847, 6866.867661059933, 6874.415674667609, 6878.518503704692, 3600.801955892399, 3697.0, 3707.796071216055, 3710.276496083238, 3717.4423836424753, 745.7732030809397, 778.0352363069753, 862.5385418800911, 870.0342619692136, 914.3964983111115, 19662.623616347006, 21151.78848211529, 21321.89339053326, 21354.35936921895, 21406.678899816514, 868.4181598329135, 871.7123349294718, 896.9192772650492, 918.2929144558652, 918.660095764558, 10754.89245107539, 11182.38496882663, 11193.552257909756, 11212.775744485229, 11233.32600044, 656460.0, 656588.0, 665964.0, 683100.0, 684599.0, 111572.81301073078, 136125.0, 141324.0, 146343.0, 153401.23299383654, 980.1962390839585, 980.4068538534227, 1017.3692310767372, 1020.6274709731043, 1021.1830535571662, 18874.33939812155, 19513.70729439031, 19599.902000489907, 19619.313324033592, 19627.31304404339, 57990.0, 58248.12627810502, 58637.0, 58763.0, 59111.40888591059, 84373.0, 85705.71441428259, 86756.02305734922, 88970.0, 89230.0, 10931.726706832393, 11563.95924366811, 11633.418329083343, 11692.94153529227, 11702.531898724295, 10795.568177273135, 12160.513579456723, 12486.812697809723, 13064.804027939399, 13078.084534082524, 9998.350107243006, 10549.419781912069, 10747.140228781522, 11105.05607023412, 11174.832377514507, 10540.0, 10696.518656660624, 10792.028717415471, 11084.44577771092, 11088.833667494833, 11069.5572177112, 11456.427178640868, 11512.0, 11584.652460426201, 11647.417629118341, 11406.543738250377, 11429.314241145557, 11699.23954942926, 11700.648980530597, 11775.293482391084, 10920.563177472812, 11297.830532541853, 11351.829722554334, 11373.715657108638, 11395.430228488709], "value": 10701.265702649778, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1440.7478691229035, 1533.2027345780195, 1533.5552689719982, 1563.7654351847225, 1564.3664315952044, 10079.24405669575, 10626.256162068657, 10628.3622982621, 10629.04338609525, 10631.99999999999, 10117.988201179878, 10546.209034322437, 10558.947205263981, 10652.520636571353, 10659.040686338229, 2321.1991862807304, 2362.1614326913955, 2363.9881800590974, 2365.38499990003, 2365.4086478380405, 2267.115824828318, 2287.8512896661746, 2298.7011688480475, 2300.2639155470174, 2304.1704986204954, 2310.341552657493, 2313.4332088638225, 2325.988370058156, 2334.731505876829, 2335.988320058397, 2258.2209137847335, 2274.6815445837597, 2291.106468477295, 2301.344116926685, 2308.90764369425, 2301.7813307735737, 2315.548468048731, 2343.379004563792, 2344.5545346384133, 2348.729896061958, 10552.0, 10656.946715266375, 10657.520411581498, 10659.467026648714, 10662.093722033636, 5560.638558493725, 5735.254416925814, 5735.598508104435, 5735.598508104435, 5745.683987380692, 3269.640339562646, 3277.3772983133126, 3485.8779942701885, 3587.157018100744, 3591.44332628443, 1117.5138814615668, 1152.5908302552557, 1197.3294954825326, 1224.1308670843712, 1232.433080782841, 12958.09293349466, 13471.191728496224, 13497.987650926121, 14598.0, 14654.41382344705, 4098.7130900836655, 4205.852795152155, 4206.57934206583, 4207.705460617727, 4210.32634778434, 10722.0, 11026.669199924016, 11053.226274160892, 11161.609343673095, 11222.943885280521, 5408.513233808976, 5500.50495455411, 5501.257330260443, 5503.257060296889, 5514.834554963358, 4904.0, 5079.6698214615935, 5217.739113044333, 5225.529702326809, 5241.9737901310245, 3061.3265081681993, 3532.346515894568, 3680.8527658893345, 3720.1443667956523, 3739.3643080675806, 993.6323560282597, 996.0487734213808, 996.5615129343066, 1010.7372083258406, 1011.079917275276, 745.7539012125985, 867.8871746673018, 929.3262384770987, 946.9289803264783, 962.3311798300114, 5276.498732620395, 6125.356837532084, 6359.141515895388, 6387.393197646216, 6454.483641308684, 958.87332384448, 965.4979410706393, 965.6234068713208, 985.3053597213947, 1012.9746756331003, 3573.356795776785, 3655.7440979131206, 3668.0, 3956.584558621361, 4080.8571699990357, 9998.20014398861, 12488.75022499563, 12613.684657883627, 12618.053645976588, 12618.053645976588, 10435.739106522398, 12539.122261441611, 12555.183913045623, 12563.93718031404, 12580.370981451073, 9359.859602105973, 9428.62285508572, 9540.475273859865, 9557.569909354095, 9646.372985755903, 5978.850528736816, 6145.0782382642965, 6214.937850621436, 6243.188385509855, 6327.367263273636, 11391.974722275036, 11462.770744584896, 11491.655250342503, 11680.532778689098, 11799.410029498662, 8232.547209903512, 11908.821367679666, 11970.640880773592, 12002.459889305177, 12024.879751202727, 7869.409794265339, 8410.789730256547, 8729.78175545591, 8871.891013623297, 8978.147076027766, 9902.950485247527, 10001.099901008944, 10102.141317988053, 10102.343347682377, 10135.037171468699, 8556.229939305493, 8607.784805379915, 8652.567371631267, 8670.393072484865, 8681.696140635047, 8423.0, 8515.0, 8582.356323275904, 8627.43921645091, 8661.61022753965, 7138.286171382821, 7479.102507699111, 7615.390768738598, 7617.961910190414, 7632.313091821763, 4820.469748327751, 5443.727813609383, 5496.395396506461, 5585.218069470358, 5679.6876171810945, 5604.103343465026, 5713.342965558848, 5746.885062298647, 5760.510356619734, 5790.276215473066], "value": 4877.654984564272, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.27571786452154, 375.58122693197095, 377.41312259436575, 383.42294846256374, 383.8867534077445, 4907.043126590316, 5223.582113430926, 5342.786288548454, 5369.147644062802, 5429.7828086876525, 5043.394792624881, 5161.458046905077, 5231.947680523203, 5244.213367994803, 5272.894542109156, 3432.605250396199, 4072.8574499892434, 4111.938320925188, 4153.979230103845, 4173.770442625654, 3486.9128271793156, 3545.6454354564466, 4162.916741665165, 4170.249355116078, 4188.4136220929095, 4009.719319647626, 4029.1740193260457, 4066.5323487798987, 4182.4278068987505, 4188.6649068074485, 3752.0, 3924.921501569967, 4119.352259096356, 4150.564190759957, 4151.813168407429, 3275.623303320101, 3448.7241020718534, 3676.74262801604, 3680.907977300562, 3691.9261614767556, 3881.6700580450697, 4299.978500107511, 5076.086304465195, 5114.002769459919, 5203.297554830087, 4035.8587449439424, 4190.455240818674, 4231.920860180665, 4791.94577193017, 4818.445878723956, 4677.859664210045, 4970.0787087178605, 5284.656497327662, 5614.9157762633595, 5635.422081817098, 3418.8632454701783, 3729.776213427203, 4107.0, 4133.46264985553, 4242.787860606957, 5008.0, 5160.406553246387, 5582.567801845227, 5780.161876527922, 6000.969995149996, 4155.709100362946, 4806.7836947337455, 5035.043341765053, 5051.74162665079, 5069.771860266297, 4889.65772395936, 5146.4853514648985, 5147.940823670562, 5153.2270159476375, 5164.992826398891, 4455.598996090367, 5013.573846223112, 5082.593392528589, 5239.397469291004, 5388.548210564184, 4846.0, 4978.908858279531, 5567.693776842312, 5702.714864256771, 5768.94231057684, 1551.7517197248385, 1649.2083799775935, 1688.5525335786026, 1703.6711365135213, 1704.1649591699977, 1165.5920427850185, 1243.4777393494753, 1280.5070048031575, 1286.5368467351745, 1349.743548725739, 4386.473623165177, 5117.667351622133, 5136.357955255593, 5182.352205974254, 5183.974080129575, 5020.924686129711, 5096.490350964948, 5276.498732620395, 5450.836474905759, 5701.543876489871, 4593.379893714373, 4718.811247550128, 4834.8791280218275, 4864.513548645178, 5204.330946682579, 2789.8796914345244, 2933.2813460702264, 2936.8707686926805, 2957.4233024560003, 2971.940561188764, 4948.727819969864, 4975.751212439363, 5249.11298785674, 5890.528757699374, 5917.497012753878, 4945.554900059012, 5474.562035037187, 5725.656460612293, 5844.649321040752, 6106.877862442726, 6104.231501231294, 6157.599756015845, 6173.290071641729, 6176.69116544171, 6208.634100497973, 4610.423697037871, 5199.194124910645, 5612.7754889803955, 5960.314563825215, 5990.9700451497465, 5002.924956125734, 5241.344831896013, 5495.835124946258, 5710.5146062585145, 5797.188393624981, 5242.5281724644965, 5456.47112896303, 5487.560995120461, 5508.20131080983, 5999.370066142992, 3973.271626842333, 4131.938020929749, 4515.7967891444305, 4579.610733087725, 4731.810727570996, 5175.214550979906, 5413.24214609947, 5447.591430642638, 5871.412858714094, 5955.731992060454, 5294.338207724035, 5449.6730196188355, 5759.481646651821, 5770.884582308414, 5803.709814509342, 4646.628269738345, 5725.2843394575675, 5731.713414329183, 5757.827265182052, 5772.509336706427, 4722.819295176206, 5126.4360920297995, 5303.337082864642, 5633.901319306035, 5671.432856714296, 4390.714603550759, 5657.264555607745, 5708.857278568069, 5720.8283751487525, 5725.370209276893, 4965.304857319906, 5122.871928201825, 5139.357580302462, 5583.497485226349, 5609.186667933045], "value": 4249.452397395365, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.3948211012155, 698.5319835710073, 736.5617457612718, 812.3907069697726, 853.7012045783977, 13303.600891973245, 13870.0, 13987.510437134702, 14007.649808754773, 14014.649633759136, 12654.240745555273, 12848.48606055759, 12888.0, 12953.870461295384, 13081.54214602489, 931.4318265857821, 944.6032666280145, 944.8015916657511, 946.9526523673824, 947.8388673925449, 918.9816203675922, 940.3464592108487, 942.4533770413144, 952.1383148250844, 961.966331178409, 1008.4604736465992, 1010.4745532323187, 1011.4032720694788, 1012.0385633648064, 1014.1177175856977, 852.663198036772, 1006.4866917871865, 1007.2898606482412, 1008.193445243802, 1009.6264382178604, 745.5265906149634, 746.5408773604248, 747.4655621230792, 747.5477336211568, 747.581354441509, 13874.167549946935, 14105.2242126683, 14136.15183089018, 14147.363368648332, 14153.363098660586, 12216.205946613441, 12258.1419300649, 12317.507299708, 12555.435005424777, 12727.227685981086, 10621.681349559525, 10746.0, 10810.29733067348, 10831.945840270828, 11127.221094523387, 3455.8963231103107, 3571.196480791827, 3622.9094272643397, 3663.0, 3692.9076773080888, 69207.0, 71174.93237601388, 71222.0, 71778.64110679414, 72142.9178562322, 9469.66856160031, 9720.07659272368, 9750.561224744904, 9887.060729230712, 9912.256580756472, 20351.592968140554, 20357.880316582436, 20387.592248154953, 20391.77649341044, 20392.184312627625, 6983.93016069843, 7073.893891591631, 7157.7136914522835, 7199.172095209014, 7279.325755076362, 3862.517185351831, 3871.864484743077, 3895.14306852492, 3921.117748506563, 3926.6466018058513, 3185.792923459968, 3200.431788423702, 3242.902712918616, 3293.967060329414, 3294.159989202738, 598.6168851934765, 605.1678941455499, 610.1153327674889, 612.7805666723277, 619.3125630550086, 640.1869625575494, 660.1582981698373, 661.6890061671007, 689.8858343774867, 705.4074577355046, 9209.677661281823, 9218.124278193562, 9305.395149315273, 9449.574769135406, 9544.856827147598, 624.6002558362652, 631.1952260867339, 687.1582311668167, 687.6424259385192, 696.1924167965136, 4529.773511324421, 4543.613792827647, 4576.222042252825, 4590.334401511762, 4671.0, 63475.09574712766, 68637.3136268641, 71496.64251678708, 73012.63493682604, 73104.0, 41556.75329740113, 59476.0, 60989.08516372258, 61373.77252454926, 62036.14367485672, 43253.783731081145, 46148.07703845904, 50023.0, 50554.988900222525, 50764.74617626888, 9712.368696034735, 9777.21782257432, 9787.755306117118, 9792.510374481106, 9799.853002205115, 32088.679113208567, 32365.51451728273, 33127.17182070467, 34095.033369160796, 34472.0, 40488.52183650602, 40738.79630601828, 40781.184376311714, 43704.56295437005, 44155.55844441515, 10001.299909006591, 11669.183157178915, 11983.0, 12020.879791202326, 12046.277223366626, 13048.934755326163, 13310.267935263653, 13406.798898016732, 13616.523421680193, 13652.658683532594, 10539.26225164231, 11090.860465346555, 12268.32524211177, 12416.441260143134, 12625.305608191638, 10689.144868410664, 12253.0, 12389.876101238871, 12683.30241836671, 12714.300713460478, 12068.637940861789, 12200.328981906081, 12206.267623942593, 12210.450529726362, 12581.496740130659, 9960.0, 10055.095041446013, 10310.536025878704, 10912.727181820517, 11016.724581885197, 8326.70856520019, 8681.565921703763, 9681.128698417177, 9931.65239216624, 9942.353747006711], "value": 6721.554999982532, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1470.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [115.0, 114.0, 115.0, 115.0, 114.0, 116.0, 115.0, 114.0, 114.0, 116.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 122.0, 139.0, 182.0, 114.0, 110.0, 112.0, 111.0, 129.0, 110.0], "value": 126.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 184.0, 183.0, 182.0, 184.0, 180.0, 180.0, 185.0, 184.0, 184.0], "value": 182.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 60.0, 61.0, 91.0, 63.0, 64.0, 62.0, 60.0, 76.0, 61.0], "value": 67.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 70.0, 89.0, 70.0, 72.0, 69.0, 86.0, 71.0, 70.0, 85.0], "value": 77.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 86.0, 87.0, 86.0, 87.0, 86.0, 87.0, 91.0], "value": 86.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 93.0, 123.0, 138.0, 93.0, 114.0, 150.0, 94.0], "value": 108.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 85.0, 88.0, 88.0, 87.0, 87.0, 85.0, 86.0, 88.0], "value": 86.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 60.0, 62.0, 61.0, 63.0, 61.0, 63.0, 61.0, 61.0, 61.0], "value": 61.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 69.0, 97.0, 96.0, 88.0, 62.0, 60.0, 60.0, 60.0, 61.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 91.0, 87.0, 85.0, 74.0, 88.0, 86.0, 104.0, 105.0, 104.0], "value": 91.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 138.0, 141.0, 147.0, 149.0, 143.0, 141.0, 140.0, 210.0, 158.0], "value": 151.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 176.0, 176.0, 174.0, 172.0, 172.0, 173.0, 179.0, 209.0, 172.0], "value": 177.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 68.0, 68.0, 67.0, 65.0, 67.0, 63.0, 60.0, 61.0, 76.0], "value": 66.4, "unit": "score"}]}]} 09:17:47 INFO - Return code: 0 09:17:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:17:47 ERROR - # TBPL SUCCESS # 09:17:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:17:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:17:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:17:47 INFO - 2017-02-27 09:17:47.808 screenresolution[1657:10107] starting screenresolution argv=screenresolution get 09:17:47 INFO - 2017-02-27 09:17:47.811 screenresolution[1657:10107] Display 0: 1600x1200x32@60 09:17:47 INFO - 2017-02-27 09:17:47.817 screenresolution[1658:10110] starting screenresolution argv=screenresolution list 09:17:47 INFO - Available Modes on Display 0 09:17:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:17:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:17:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:17:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:17:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:17:48 INFO - Intel Iris: 09:17:48 INFO - Chipset Model: Intel Iris 09:17:48 INFO - Type: GPU 09:17:48 INFO - Bus: Built-In 09:17:48 INFO - VRAM (Dynamic, Max): 1536 MB 09:17:48 INFO - Vendor: Intel (0x8086) 09:17:48 INFO - Device ID: 0x0a2e 09:17:48 INFO - Revision ID: 0x0009 09:17:48 INFO - Displays: 09:17:48 INFO - Display: 09:17:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:17:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:17:48 INFO - Display Serial Number: 1600x1200 60 09:17:48 INFO - Main Display: Yes 09:17:48 INFO - Mirror: Off 09:17:48 INFO - Online: Yes 09:17:48 INFO - Rotation: Supported 09:17:48 INFO - Return code: 0 09:17:48 INFO - Running post-action listener: _resource_record_post_action 09:17:48 INFO - [mozharness: 2017-02-27 17:17:48.056903Z] Finished run-tests step (success) 09:17:48 INFO - Running post-run listener: _resource_record_post_run 09:17:48 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 38908928; Write bytes: 511370240; Read time: 377; Write time: 1965 09:17:48 INFO - TinderboxPrint: CPU usage
53.7% 09:17:48 INFO - TinderboxPrint: I/O read bytes / time
38,908,928 / 377 09:17:48 INFO - TinderboxPrint: I/O write bytes / time
511,370,240 / 1,965 09:17:48 INFO - TinderboxPrint: CPU idle
2,229.6 (46.3%) 09:17:48 INFO - TinderboxPrint: CPU system
959.0 (19.9%) 09:17:48 INFO - TinderboxPrint: CPU user
1,629.1 (33.8%) 09:17:48 INFO - TinderboxPrint: Swap in / out
249,479,168 / 0 09:17:48 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 206236160; Write bytes: 202995712; Read time: 15702; Write time: 388 09:17:48 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 36914176; Write bytes: 297704448; Read time: 356; Write time: 1543 09:17:48 INFO - Running post-run listener: _upload_blobber_files 09:17:48 INFO - Blob upload gear active. 09:17:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:17:48 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:17:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:17:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:17:48 INFO - (blobuploader) - INFO - Open directory for files ... 09:17:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:17:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:17:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:50 INFO - (blobuploader) - INFO - Done attempting. 09:17:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:17:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:17:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:50 INFO - (blobuploader) - INFO - Done attempting. 09:17:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:17:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:17:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:51 INFO - (blobuploader) - INFO - Done attempting. 09:17:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:17:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:17:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:17:54 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:17:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:17:54 INFO - (blobuploader) - INFO - Done attempting. 09:17:54 INFO - (blobuploader) - INFO - Iteration through files over. 09:17:54 INFO - Return code: 0 09:17:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:17:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:17:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06e2268477c28ddf258812282722deb06b29bdf5ee980236c18c71c27d2192b81fbb4ba7a0b9bbc3b9ea57bf118adcd60d3211a150e57477eef8994f6176d40c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0a5f0f06e03f7ecaa9f38e6d44b0f2214f58589380df7ffaf9d039842c297a6af6fd1abcef1c991b8c74fcd032d9ecabce7c540956c9e80e7715a302219d13c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fef930fc6c1a5780bab57fb4ded0591ca6cf75f2080eab5d9f41a532599fd869e58b903e11bad84eb543f78431c1d76a1698550c5a77a5974c681ec1afec989", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c636c961de3de63151eba67d949b9957d1e6e7b4cb9a783218936fa66f0aa1e63bf9bcdb62cb2bb331fc7fb5ce2d877811fbf917e30920701b63330557ebda8"} 09:17:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:17:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:17:54 INFO - Contents: 09:17:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06e2268477c28ddf258812282722deb06b29bdf5ee980236c18c71c27d2192b81fbb4ba7a0b9bbc3b9ea57bf118adcd60d3211a150e57477eef8994f6176d40c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0a5f0f06e03f7ecaa9f38e6d44b0f2214f58589380df7ffaf9d039842c297a6af6fd1abcef1c991b8c74fcd032d9ecabce7c540956c9e80e7715a302219d13c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fef930fc6c1a5780bab57fb4ded0591ca6cf75f2080eab5d9f41a532599fd869e58b903e11bad84eb543f78431c1d76a1698550c5a77a5974c681ec1afec989", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c636c961de3de63151eba67d949b9957d1e6e7b4cb9a783218936fa66f0aa1e63bf9bcdb62cb2bb331fc7fb5ce2d877811fbf917e30920701b63330557ebda8"} 09:17:54 INFO - Running post-run listener: copy_logs_to_upload_dir 09:17:54 INFO - Copying logs to upload dir... 09:17:54 INFO - mkdir: /builds/slave/test/build/upload/logs 09:17:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.391924 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-02-27 09:17:54.118928) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-27 09:17:54.122856) ========= 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.RqMJSPXWcH/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.LCd1eUoh2U/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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/Firefox/sha512/06e2268477c28ddf258812282722deb06b29bdf5ee980236c18c71c27d2192b81fbb4ba7a0b9bbc3b9ea57bf118adcd60d3211a150e57477eef8994f6176d40c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0a5f0f06e03f7ecaa9f38e6d44b0f2214f58589380df7ffaf9d039842c297a6af6fd1abcef1c991b8c74fcd032d9ecabce7c540956c9e80e7715a302219d13c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fef930fc6c1a5780bab57fb4ded0591ca6cf75f2080eab5d9f41a532599fd869e58b903e11bad84eb543f78431c1d76a1698550c5a77a5974c681ec1afec989", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c636c961de3de63151eba67d949b9957d1e6e7b4cb9a783218936fa66f0aa1e63bf9bcdb62cb2bb331fc7fb5ce2d877811fbf917e30920701b63330557ebda8"} build_url:https://queue.taskcluster.net/v1/task/DW0cpsYTQ1i0sUdq36hu4g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011098 build_url: 'https://queue.taskcluster.net/v1/task/DW0cpsYTQ1i0sUdq36hu4g/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/06e2268477c28ddf258812282722deb06b29bdf5ee980236c18c71c27d2192b81fbb4ba7a0b9bbc3b9ea57bf118adcd60d3211a150e57477eef8994f6176d40c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b0a5f0f06e03f7ecaa9f38e6d44b0f2214f58589380df7ffaf9d039842c297a6af6fd1abcef1c991b8c74fcd032d9ecabce7c540956c9e80e7715a302219d13c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5fef930fc6c1a5780bab57fb4ded0591ca6cf75f2080eab5d9f41a532599fd869e58b903e11bad84eb543f78431c1d76a1698550c5a77a5974c681ec1afec989", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3c636c961de3de63151eba67d949b9957d1e6e7b4cb9a783218936fa66f0aa1e63bf9bcdb62cb2bb331fc7fb5ce2d877811fbf917e30920701b63330557ebda8"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-27 09:17:54.160678) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 09:17:54.161157) ========= 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.RqMJSPXWcH/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.LCd1eUoh2U/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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.005200 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-27 09:17:54.212055) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-27 09:17:54.212601) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-27 09:17:54.213130) ========= ========= Total master_lag: 0.19 =========