builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0178 starttime: 1491296142.76 results: success (0) buildid: 20170404004003 builduid: 1e000a41d3274e0a963144b8113a90bf revision: e3ce3282ec26d1cff472f2bed8c65693ea168ff8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 01:55:42.763009) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-04 01:55:42.763486) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 01:55:42.763786) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-04 01:55:43.138680) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 01:55:43.139071) ========= 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.OtB9O85CU0/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.xP9P7WFZm9/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-04 01:55:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 14.1M=0.001s 2017-04-04 01:55:43 (14.1 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.679736 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 01:55:43.845573) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 01:55:43.845913) ========= 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.OtB9O85CU0/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.xP9P7WFZm9/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.035034 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 01:55:43.903549) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-04 01:55:43.903908) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e3ce3282ec26d1cff472f2bed8c65693ea168ff8 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev e3ce3282ec26d1cff472f2bed8c65693ea168ff8 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OtB9O85CU0/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.xP9P7WFZm9/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-04 01:55:44,003 truncating revision to first 12 chars 2017-04-04 01:55:44,003 Setting DEBUG logging. 2017-04-04 01:55:44,003 attempt 1/10 2017-04-04 01:55:44,003 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/e3ce3282ec26?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-04 01:55:44,662 unpacking tar archive at: mozilla-aurora-e3ce3282ec26/testing/mozharness/ program finished with exit code 0 elapsedTime=0.959878 ========= master_lag: 0.12 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-04 01:55:44.979394) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 01:55:44.979679) ========= script_repo_revision: e3ce3282ec26d1cff472f2bed8c65693ea168ff8 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-04 01:55:44.980092) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 01:55:44.980371) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-04 01:55:45.010688) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-04-04 01:55:45.011000) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.OtB9O85CU0/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.xP9P7WFZm9/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 01:55:45 INFO - MultiFileLogger online at 20170404 01:55:45 in /builds/slave/test 01:55:45 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:55:45 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:55:45 INFO - {'append_to_log': False, 01:55:45 INFO - 'base_work_dir': '/builds/slave/test', 01:55:45 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:55:45 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:55:45 INFO - 'branch': 'Mozilla-Aurora', 01:55:45 INFO - 'buildbot_json_path': 'buildprops.json', 01:55:45 INFO - 'config_files': ('talos/mac_config.py',), 01:55:45 INFO - 'default_actions': ('clobber', 01:55:45 INFO - 'read-buildbot-config', 01:55:45 INFO - 'download-and-extract', 01:55:45 INFO - 'populate-webroot', 01:55:45 INFO - 'create-virtualenv', 01:55:45 INFO - 'install', 01:55:45 INFO - 'run-tests'), 01:55:45 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:55:45 INFO - 'download_minidump_stackwalk': True, 01:55:45 INFO - 'download_symbols': 'ondemand', 01:55:45 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:55:45 INFO - 'tooltool.py': '/tools/tooltool.py', 01:55:45 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:55:45 INFO - '/tools/misc-python/virtualenv.py')}, 01:55:45 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:55:45 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:55:45 INFO - 'gecko_profile': False, 01:55:45 INFO - 'gecko_profile_interval': 0, 01:55:45 INFO - 'installer_path': 'installer.exe', 01:55:45 INFO - 'log_level': 'info', 01:55:45 INFO - 'log_name': 'talos', 01:55:45 INFO - 'log_to_console': True, 01:55:45 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:55:45 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:55:45 INFO - 'opt_config_files': (), 01:55:45 INFO - 'pip_index': False, 01:55:45 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:55:45 INFO - 'cmd': ('bash', 01:55:45 INFO - '-c', 01:55:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:55:45 INFO - 'enabled': True, 01:55:45 INFO - 'halt_on_failure': False, 01:55:45 INFO - 'name': 'check_screen_resolution'},), 01:55:45 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:55:45 INFO - 'cmd': ('bash', 01:55:45 INFO - '-c', 01:55:45 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:55:45 INFO - 'enabled': True, 01:55:45 INFO - 'halt_on_failure': False, 01:55:45 INFO - 'name': 'check_screen_resolution'},), 01:55:45 INFO - 'run_cmd_checks_enabled': True, 01:55:45 INFO - 'suite': 'dromaeojs', 01:55:45 INFO - 'system_bits': '32', 01:55:45 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:55:45 INFO - 'title': 't-yosemite-r7-0178', 01:55:45 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:55:45 INFO - 'use_talos_json': True, 01:55:45 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:55:45 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:55:45 INFO - 'work_dir': 'build'} 01:55:45 INFO - [mozharness: 2017-04-04 08:55:45.227513Z] Running clobber step. 01:55:45 INFO - Running pre-action listener: _resource_record_pre_action 01:55:45 INFO - Running main action method: clobber 01:55:45 INFO - rmtree: /builds/slave/test/build 01:55:45 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:55:47 INFO - Running post-action listener: _resource_record_post_action 01:55:47 INFO - [mozharness: 2017-04-04 08:55:47.635873Z] Finished clobber step (success) 01:55:47 INFO - [mozharness: 2017-04-04 08:55:47.636056Z] Running read-buildbot-config step. 01:55:47 INFO - Running pre-action listener: _resource_record_pre_action 01:55:47 INFO - Running main action method: read_buildbot_config 01:55:47 INFO - Using buildbot properties: 01:55:47 INFO - { 01:55:47 INFO - "project": "", 01:55:47 INFO - "product": "firefox", 01:55:47 INFO - "script_repo_revision": "production", 01:55:47 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 01:55:47 INFO - "repository": "", 01:55:47 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 01:55:47 INFO - "buildid": "20170404004003", 01:55:47 INFO - "stage_platform": "macosx64", 01:55:47 INFO - "basedir": "/builds/slave/test", 01:55:47 INFO - "nightly_build": "True", 01:55:47 INFO - "buildnumber": 40, 01:55:47 INFO - "slavename": "t-yosemite-r7-0178", 01:55:47 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 01:55:47 INFO - "platform": "yosemite_r7", 01:55:47 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 01:55:47 INFO - "branch": "mozilla-aurora", 01:55:47 INFO - "repo_path": "releases/mozilla-aurora", 01:55:47 INFO - "revision": "e3ce3282ec26d1cff472f2bed8c65693ea168ff8", 01:55:47 INFO - "pgo_build": "False", 01:55:47 INFO - "builduid": "1e000a41d3274e0a963144b8113a90bf", 01:55:47 INFO - "slavebuilddir": "test" 01:55:47 INFO - } 01:55:47 INFO - Found installer url https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 01:55:47 INFO - Running post-action listener: _resource_record_post_action 01:55:47 INFO - [mozharness: 2017-04-04 08:55:47.639371Z] Finished read-buildbot-config step (success) 01:55:47 INFO - [mozharness: 2017-04-04 08:55:47.639506Z] Running download-and-extract step. 01:55:47 INFO - Running pre-action listener: _resource_record_pre_action 01:55:47 INFO - Running main action method: download_and_extract 01:55:47 INFO - mkdir: /builds/slave/test/build/tests 01:55:47 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')]} 01:55:47 INFO - trying https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 01:55:47 INFO - Downloading https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 01:55:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 01:55:49 INFO - Downloaded 1199 bytes. 01:55:49 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 01:55:49 INFO - Using the following test package requirements: 01:55:49 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 01:55:49 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:55:49 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 01:55:49 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:55:49 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 01:55:49 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:55:49 INFO - u'jsshell-mac.zip'], 01:55:49 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:55:49 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 01:55:49 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 01:55:49 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:55:49 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 01:55:49 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:55:49 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 01:55:49 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:55:49 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 01:55:49 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:55:49 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 01:55:49 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 01:55:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 01:55:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:55:49 INFO - Fetch https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 01:55:52 INFO - Expected file size: 51790454 01:55:52 INFO - Obtained file size: 51790454 01:56:08 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 01:56:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 01:56:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:56:08 INFO - Fetch https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 01:56:10 INFO - Expected file size: 51790454 01:56:10 INFO - Obtained file size: 51790454 01:56:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 01:56:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 01:56:25 INFO - Fetch https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 01:56:27 INFO - Expected file size: 14404438 01:56:27 INFO - Obtained file size: 14404438 01:56: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')]} 01:56:27 INFO - trying https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:56:27 INFO - Downloading https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 01:56:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 01:56:29 INFO - Downloaded 74709766 bytes. 01:56:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:56:29 INFO - mkdir: /builds/slave/test/properties 01:56:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:56:29 INFO - Writing to file /builds/slave/test/properties/build_url 01:56:29 INFO - Contents: 01:56:29 INFO - build_url:https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:56:30 INFO - Running post-action listener: _resource_record_post_action 01:56:30 INFO - Running post-action listener: set_extra_try_arguments 01:56:30 INFO - [mozharness: 2017-04-04 08:56:30.290264Z] Finished download-and-extract step (success) 01:56:30 INFO - [mozharness: 2017-04-04 08:56:30.290419Z] Running populate-webroot step. 01:56:30 INFO - Running pre-action listener: _resource_record_pre_action 01:56:30 INFO - Running main action method: populate_webroot 01:56:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:56:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:56:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:56:30 INFO - '--tppagecycles', 01:56:30 INFO - '7'], 01:56:30 INFO - 'tests': ['tsvgm']}}, 01:56:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:56:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:56:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:56:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:56:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:56:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:56:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:56:30 INFO - 'talos_options': ['--disable-e10s'], 01:56:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:56:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:56:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:56:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:56:30 INFO - 'talos_options': ['--disable-e10s'], 01:56:30 INFO - 'tests': ['damp', 'tps']}, 01:56:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:56:30 INFO - 'tests': ['damp', 'tps']}, 01:56:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:56:30 INFO - 'tests': ['dromaeo_dom']}, 01:56:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:56:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:56:30 INFO - 'tests': ['basic_compositor_video']}, 01:56:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:56:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:56:30 INFO - 'tests': ['a11yr', 01:56:30 INFO - 'ts_paint', 01:56:30 INFO - 'tpaint', 01:56:30 INFO - 'sessionrestore', 01:56:30 INFO - 'sessionrestore_no_auto_restore', 01:56:30 INFO - 'tabpaint']}, 01:56:30 INFO - 'other-e10s': {'tests': ['a11yr', 01:56:30 INFO - 'ts_paint', 01:56:30 INFO - 'tpaint', 01:56:30 INFO - 'sessionrestore', 01:56:30 INFO - 'sessionrestore_no_auto_restore', 01:56:30 INFO - 'tabpaint']}, 01:56:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:56:30 INFO - 'ts_paint', 01:56:30 INFO - 'tpaint', 01:56:30 INFO - 'sessionrestore', 01:56:30 INFO - 'sessionrestore_no_auto_restore', 01:56:30 INFO - 'tabpaint']}, 01:56:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:56:30 INFO - 'ts_paint', 01:56:30 INFO - 'tpaint', 01:56:30 INFO - 'sessionrestore', 01:56:30 INFO - 'sessionrestore_no_auto_restore', 01:56:30 INFO - 'tabpaint']}, 01:56:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:56:30 INFO - 'tests': ['a11yr', 01:56:30 INFO - 'ts_paint', 01:56:30 INFO - 'tpaint', 01:56:30 INFO - 'sessionrestore', 01:56:30 INFO - 'sessionrestore_no_auto_restore', 01:56:30 INFO - 'tabpaint']}, 01:56:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:56:30 INFO - 'tests': ['a11yr', 01:56:30 INFO - 'ts_paint', 01:56:30 INFO - 'tpaint', 01:56:30 INFO - 'sessionrestore', 01:56:30 INFO - 'sessionrestore_no_auto_restore', 01:56:30 INFO - 'tabpaint']}, 01:56:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:56:30 INFO - 'tests': ['tsvgx', 01:56:30 INFO - 'tsvgr_opacity', 01:56:30 INFO - 'tart', 01:56:30 INFO - 'tscrollx', 01:56:30 INFO - 'cart', 01:56:30 INFO - 'tsvg_static']}, 01:56:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:56:30 INFO - 'tsvgr_opacity', 01:56:30 INFO - 'tart', 01:56:30 INFO - 'tscrollx', 01:56:30 INFO - 'cart', 01:56:30 INFO - 'tsvg_static']}, 01:56:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:56:30 INFO - 'talos_options': ['--disable-e10s'], 01:56:30 INFO - 'tests': ['tp5o']}, 01:56:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:56:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:56:30 INFO - 'talos_options': ['--disable-e10s', 01:56:30 INFO - '--xperf_path', 01:56:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:56:30 INFO - 'tests': ['tp5n']}, 01:56:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:56:30 INFO - 'talos_options': ['--xperf_path', 01:56:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:56:30 INFO - 'tests': ['tp5n']}}, 01:56:30 INFO - 'talos.zip': {'path': '', 01:56:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:56:30 INFO - Running post-action listener: _resource_record_post_action 01:56:30 INFO - [mozharness: 2017-04-04 08:56:30.308619Z] Finished populate-webroot step (success) 01:56:30 INFO - [mozharness: 2017-04-04 08:56:30.308730Z] Running create-virtualenv step. 01:56:30 INFO - Running pre-action listener: _resource_record_pre_action 01:56:30 INFO - Running main action method: create_virtualenv 01:56:30 INFO - Creating virtualenv /builds/slave/test/build/venv 01:56:30 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 01:56:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:56:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:56:30 INFO - Using real prefix '/tools/python27' 01:56:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:56:31 INFO - Installing distribute.............................................................................................................................................................................................done. 01:56:34 INFO - Installing pip.................done. 01:56:34 INFO - Return code: 0 01:56:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:56:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:56:34 INFO - Reading from file tmpfile_stdout 01:56:34 INFO - Output received: 01:56:34 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) 01:56:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:56:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88fb482310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f81ad30>, '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 0x10f741db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f80fbe8>, '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.OtB9O85CU0/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.xP9P7WFZm9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 01:56:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:56:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:56:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OtB9O85CU0/Render', 01:56:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:56:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:56:34 INFO - 'HOME': '/Users/cltbld', 01:56:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:56:34 INFO - 'LOGNAME': 'cltbld', 01:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:34 INFO - 'MOZ_NO_REMOTE': '1', 01:56:34 INFO - 'NO_EM_RESTART': '1', 01:56:34 INFO - 'PAGER': '/bin/cat', 01:56:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:34 INFO - 'PWD': '/builds/slave/test', 01:56:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:56:34 INFO - 'SHELL': '/bin/bash', 01:56:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xP9P7WFZm9/Listeners', 01:56:34 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 01:56:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:56:34 INFO - 'USER': 'cltbld', 01:56:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:56:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:34 INFO - 'XPC_FLAGS': '0x0', 01:56:34 INFO - 'XPC_SERVICE_NAME': '0', 01:56:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:34 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 01:56:34 INFO - Cleaning up... 01:56:34 INFO - Return code: 0 01:56:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:56:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:56:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10fa3cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88fb482310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f81ad30>, '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 0x10f741db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f80fbe8>, '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.OtB9O85CU0/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.xP9P7WFZm9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 01:56:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:56:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:56:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OtB9O85CU0/Render', 01:56:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:56:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:56:34 INFO - 'HOME': '/Users/cltbld', 01:56:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:56:34 INFO - 'LOGNAME': 'cltbld', 01:56:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:34 INFO - 'MOZ_NO_REMOTE': '1', 01:56:34 INFO - 'NO_EM_RESTART': '1', 01:56:34 INFO - 'PAGER': '/bin/cat', 01:56:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:56:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:34 INFO - 'PWD': '/builds/slave/test', 01:56:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:56:34 INFO - 'SHELL': '/bin/bash', 01:56:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xP9P7WFZm9/Listeners', 01:56:34 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 01:56:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:56:34 INFO - 'USER': 'cltbld', 01:56:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:56:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:56:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:34 INFO - 'XPC_FLAGS': '0x0', 01:56:34 INFO - 'XPC_SERVICE_NAME': '0', 01:56:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:56:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:34 INFO - Downloading/unpacking psutil>=3.1.1 01:56:34 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 01:56:34 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 01:56:34 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 01:56:34 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 01:56:34 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 01:56:34 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 01:56:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:56:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:56:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:56:38 INFO - Installing collected packages: psutil 01:56:38 INFO - Running setup.py install for psutil 01:56:39 INFO - building 'psutil._psutil_osx' extension 01:56:39 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 01:56:39 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 01:56:39 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 01:56:39 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 01:56:39 INFO - building 'psutil._psutil_posix' extension 01:56:39 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 01:56:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:56:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:56:39 INFO - ^ 01:56:40 INFO - 1 warning generated. 01:56:40 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 01:56:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:56:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:56:40 INFO - Successfully installed psutil 01:56:40 INFO - Cleaning up... 01:56:40 INFO - Return code: 0 01:56:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:56:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:56:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:40 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 0x10fa3cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88fb482310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f81ad30>, '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 0x10f741db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f80fbe8>, '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.OtB9O85CU0/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.xP9P7WFZm9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 01:56:40 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 01:56:40 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 01:56:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OtB9O85CU0/Render', 01:56:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:56:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:56:40 INFO - 'HOME': '/Users/cltbld', 01:56:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:56:40 INFO - 'LOGNAME': 'cltbld', 01:56:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:40 INFO - 'MOZ_NO_REMOTE': '1', 01:56:40 INFO - 'NO_EM_RESTART': '1', 01:56:40 INFO - 'PAGER': '/bin/cat', 01:56:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:56:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:40 INFO - 'PWD': '/builds/slave/test', 01:56:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:56:40 INFO - 'SHELL': '/bin/bash', 01:56:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xP9P7WFZm9/Listeners', 01:56:40 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 01:56:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:56:40 INFO - 'USER': 'cltbld', 01:56:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:56:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:56:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:40 INFO - 'XPC_FLAGS': '0x0', 01:56:40 INFO - 'XPC_SERVICE_NAME': '0', 01:56:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:56:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:56:40 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 01:56:40 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 01:56:40 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 01:56:40 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 01:56:40 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 01:56:40 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 01:56:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:56:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:56:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:56:43 INFO - Installing collected packages: mozsystemmonitor 01:56:43 INFO - Running setup.py install for mozsystemmonitor 01:56:43 INFO - Successfully installed mozsystemmonitor 01:56:43 INFO - Cleaning up... 01:56:43 INFO - Return code: 0 01:56:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:56:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88fb482310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f81ad30>, '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 0x10f741db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f80fbe8>, '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.OtB9O85CU0/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.xP9P7WFZm9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 01:56:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:56:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:56:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OtB9O85CU0/Render', 01:56:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:56:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:56:43 INFO - 'HOME': '/Users/cltbld', 01:56:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:56:43 INFO - 'LOGNAME': 'cltbld', 01:56:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:43 INFO - 'MOZ_NO_REMOTE': '1', 01:56:43 INFO - 'NO_EM_RESTART': '1', 01:56:43 INFO - 'PAGER': '/bin/cat', 01:56:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:56:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:43 INFO - 'PWD': '/builds/slave/test', 01:56:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:56:43 INFO - 'SHELL': '/bin/bash', 01:56:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xP9P7WFZm9/Listeners', 01:56:43 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 01:56:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:56:43 INFO - 'USER': 'cltbld', 01:56:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:56:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:56:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:43 INFO - 'XPC_FLAGS': '0x0', 01:56:43 INFO - 'XPC_SERVICE_NAME': '0', 01:56:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:43 INFO - Downloading/unpacking jsonschema==2.5.1 01:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:56:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:56:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:56:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:56:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:56:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:56:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:46 INFO - Downloading functools32-3.2.3-2.tar.gz 01:56:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:56:46 INFO - warning: no files found matching '*.txt' 01:56:46 INFO - no previously-included directories found matching 'build' 01:56:46 INFO - no previously-included directories found matching 'dist' 01:56:46 INFO - no previously-included directories found matching '.git*' 01:56:46 INFO - Installing collected packages: jsonschema, functools32 01:56:46 INFO - Running setup.py install for functools32 01:56:47 INFO - warning: no files found matching '*.txt' 01:56:47 INFO - no previously-included directories found matching 'build' 01:56:47 INFO - no previously-included directories found matching 'dist' 01:56:47 INFO - no previously-included directories found matching '.git*' 01:56:47 INFO - Successfully installed jsonschema functools32 01:56:47 INFO - Cleaning up... 01:56:47 INFO - Return code: 0 01:56:47 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:56:47 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')]} 01:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:47 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')]} 01:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:47 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 0x10fa3cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88fb482310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f81ad30>, '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 0x10f741db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f80fbe8>, '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.OtB9O85CU0/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.xP9P7WFZm9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 01:56:47 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 01:56:47 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 01:56:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OtB9O85CU0/Render', 01:56:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:56:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:56:47 INFO - 'HOME': '/Users/cltbld', 01:56:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:56:47 INFO - 'LOGNAME': 'cltbld', 01:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:47 INFO - 'MOZ_NO_REMOTE': '1', 01:56:47 INFO - 'NO_EM_RESTART': '1', 01:56:47 INFO - 'PAGER': '/bin/cat', 01:56:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:47 INFO - 'PWD': '/builds/slave/test', 01:56:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:56:47 INFO - 'SHELL': '/bin/bash', 01:56:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xP9P7WFZm9/Listeners', 01:56:47 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 01:56:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:56:47 INFO - 'USER': 'cltbld', 01:56:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:56:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:47 INFO - 'XPC_FLAGS': '0x0', 01:56:47 INFO - 'XPC_SERVICE_NAME': '0', 01:56:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:47 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:56:47 INFO - Cleaning up... 01:56:47 INFO - Return code: 0 01:56:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:56:47 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')]} 01:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:47 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')]} 01:56:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:47 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 0x10fa3cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88fb482310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f81ad30>, '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 0x10f741db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f80fbe8>, '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.OtB9O85CU0/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.xP9P7WFZm9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 01:56:47 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 01:56:47 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 01:56:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OtB9O85CU0/Render', 01:56:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:56:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:56:47 INFO - 'HOME': '/Users/cltbld', 01:56:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:56:47 INFO - 'LOGNAME': 'cltbld', 01:56:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:47 INFO - 'MOZ_NO_REMOTE': '1', 01:56:47 INFO - 'NO_EM_RESTART': '1', 01:56:47 INFO - 'PAGER': '/bin/cat', 01:56:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:56:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:47 INFO - 'PWD': '/builds/slave/test', 01:56:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:56:47 INFO - 'SHELL': '/bin/bash', 01:56:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xP9P7WFZm9/Listeners', 01:56:47 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 01:56:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:56:47 INFO - 'USER': 'cltbld', 01:56:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:56:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:56:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:47 INFO - 'XPC_FLAGS': '0x0', 01:56:47 INFO - 'XPC_SERVICE_NAME': '0', 01:56:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:56:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:47 INFO - Downloading/unpacking blobuploader==1.2.4 01:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:56:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:56:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:56:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:50 INFO - Downloading blobuploader-1.2.4.tar.gz 01:56:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:56:50 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:56:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:56:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:56:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:56:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:56:51 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:56:51 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 01:56:51 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 01:56:51 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 01:56:51 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 01:56:51 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 01:56:51 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 01:56:51 INFO - Downloading docopt-0.6.1.tar.gz 01:56:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:56:51 INFO - Installing collected packages: blobuploader, requests, docopt 01:56:51 INFO - Running setup.py install for blobuploader 01:56:51 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:56:51 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:56:51 INFO - Running setup.py install for requests 01:56:52 INFO - Running setup.py install for docopt 01:56:52 INFO - Successfully installed blobuploader requests docopt 01:56:52 INFO - Cleaning up... 01:56:52 INFO - Return code: 0 01:56:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88fb482310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f81ad30>, '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 0x10f741db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f80fbe8>, '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.OtB9O85CU0/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.xP9P7WFZm9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 01:56:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:56:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:56:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OtB9O85CU0/Render', 01:56:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:56:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:56:52 INFO - 'HOME': '/Users/cltbld', 01:56:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:56:52 INFO - 'LOGNAME': 'cltbld', 01:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:52 INFO - 'MOZ_NO_REMOTE': '1', 01:56:52 INFO - 'NO_EM_RESTART': '1', 01:56:52 INFO - 'PAGER': '/bin/cat', 01:56:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:52 INFO - 'PWD': '/builds/slave/test', 01:56:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:56:52 INFO - 'SHELL': '/bin/bash', 01:56:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xP9P7WFZm9/Listeners', 01:56:52 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 01:56:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:56:52 INFO - 'USER': 'cltbld', 01:56:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:56:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:52 INFO - 'XPC_FLAGS': '0x0', 01:56:52 INFO - 'XPC_SERVICE_NAME': '0', 01:56:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:56:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:56:52 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-mv4edO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:56:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:56:52 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-KpTc84-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:56:53 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-tRmnM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:56:53 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-3ezEno-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:56:53 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-1cYA6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:56:53 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-MGdrDv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:56:53 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-tl4g8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:56:53 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-hCaG8V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:56:53 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-T5Y2Fx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:56:53 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-Maqd__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:56:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:56:53 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-Q_5yys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:56:54 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-Ae2trr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:56:54 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-BaCQE1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:56:54 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-rb5d_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:54 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-1l8WXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:56:54 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-ahKwR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:56:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:56:54 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-MxIOQj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:56:54 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:56:54 INFO - Running setup.py install for manifestparser 01:56:54 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:56:54 INFO - Running setup.py install for mozcrash 01:56:54 INFO - Running setup.py install for mozdebug 01:56:55 INFO - Running setup.py install for mozdevice 01:56:55 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:56:55 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:56:55 INFO - Running setup.py install for mozfile 01:56:55 INFO - Running setup.py install for mozhttpd 01:56:55 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:56:55 INFO - Running setup.py install for mozinfo 01:56:55 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:56:55 INFO - Running setup.py install for mozInstall 01:56:55 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:56:55 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:56:55 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:56:55 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:56:55 INFO - Running setup.py install for mozleak 01:56:55 INFO - Running setup.py install for mozlog 01:56:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:56:56 INFO - Running setup.py install for moznetwork 01:56:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:56:56 INFO - Running setup.py install for mozprocess 01:56:56 INFO - Running setup.py install for mozprofile 01:56:56 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:56:56 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:56:56 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:56:56 INFO - Running setup.py install for mozrunner 01:56:56 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:56:56 INFO - Running setup.py install for mozscreenshot 01:56:56 INFO - Running setup.py install for moztest 01:56:57 INFO - Running setup.py install for mozversion 01:56:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:56:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:56:57 INFO - Cleaning up... 01:56:57 INFO - Return code: 0 01:56:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:56:57 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')]} 01:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:56:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:57 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')]} 01:56:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:56:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:56:57 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 0x10fa3cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88fb482310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f81ad30>, '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 0x10f741db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f80fbe8>, '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.OtB9O85CU0/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.xP9P7WFZm9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 01:56:57 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 01:56:57 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 01:56:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OtB9O85CU0/Render', 01:56:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:56:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:56:57 INFO - 'HOME': '/Users/cltbld', 01:56:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:56:57 INFO - 'LOGNAME': 'cltbld', 01:56:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:57 INFO - 'MOZ_NO_REMOTE': '1', 01:56:57 INFO - 'NO_EM_RESTART': '1', 01:56:57 INFO - 'PAGER': '/bin/cat', 01:56:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:56:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:57 INFO - 'PWD': '/builds/slave/test', 01:56:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:56:57 INFO - 'SHELL': '/bin/bash', 01:56:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xP9P7WFZm9/Listeners', 01:56:57 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 01:56:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:56:57 INFO - 'USER': 'cltbld', 01:56:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:56:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:56:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:57 INFO - 'XPC_FLAGS': '0x0', 01:56:57 INFO - 'XPC_SERVICE_NAME': '0', 01:56:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:56:57 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-wnXdhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:56:57 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-wDysun-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:56:57 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-Pbcg1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:56:57 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-FXFNfY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:56:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:56:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:56:57 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-cRTCcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:56:58 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)) 01:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:56:58 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-ccoza3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:56:58 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)) 01:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:56:58 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-U2wYpI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:56:58 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)) 01:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:56:58 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-jCOEi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:56:58 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)) 01:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:56:58 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-yqyKvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:56:58 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)) 01:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:56:58 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-3yUpaj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:56:58 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-ZelxFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:56:58 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-5fYEmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:56:58 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-z1MP_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:56:58 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:56:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:56:58 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-RnTo5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:56:59 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)) 01:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:59 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-_npO_3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:56:59 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)) 01:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:56:59 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-WSJ12Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:56:59 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)) 01:56:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:56:59 INFO - Running setup.py (path:/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/pip-Xq_3DR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:56:59 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)) 01:56:59 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)) 01:56:59 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)) 01:56:59 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)) 01:56:59 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)) 01:56:59 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)) 01:56:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:56:59 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 01:56:59 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 01:56:59 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 01:56:59 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 01:56:59 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 01:56:59 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 01:57:01 INFO - Downloading blessings-1.6.tar.gz 01:57:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:57:02 INFO - Installing collected packages: blessings 01:57:02 INFO - Running setup.py install for blessings 01:57:02 INFO - Successfully installed blessings 01:57:02 INFO - Cleaning up... 01:57:02 INFO - Return code: 0 01:57:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:57:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:57:02 INFO - Reading from file tmpfile_stdout 01:57:02 INFO - Current package versions: 01:57:02 INFO - blessings == 1.6 01:57:02 INFO - blobuploader == 1.2.4 01:57:02 INFO - docopt == 0.6.1 01:57:02 INFO - functools32 == 3.2.3-2 01:57:02 INFO - jsonschema == 2.5.1 01:57:02 INFO - manifestparser == 1.1 01:57:02 INFO - mozInstall == 1.12 01:57:02 INFO - mozcrash == 1.0 01:57:02 INFO - mozdebug == 0.1 01:57:02 INFO - mozdevice == 0.49 01:57:02 INFO - mozfile == 1.2 01:57:02 INFO - mozhttpd == 0.7 01:57:02 INFO - mozinfo == 0.9 01:57:02 INFO - mozleak == 0.1 01:57:02 INFO - mozlog == 3.4 01:57:02 INFO - moznetwork == 0.27 01:57:02 INFO - mozprocess == 0.25 01:57:02 INFO - mozprofile == 0.28 01:57:02 INFO - mozrunner == 6.13 01:57:02 INFO - mozscreenshot == 0.1 01:57:02 INFO - mozsystemmonitor == 0.3 01:57:02 INFO - moztest == 0.8 01:57:02 INFO - mozversion == 1.4 01:57:02 INFO - psutil == 3.1.1 01:57:02 INFO - requests == 1.2.3 01:57:02 INFO - wsgiref == 0.1.2 01:57:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88fb482310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f81ad30>, '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 0x10f741db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f80fbe8>, '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.OtB9O85CU0/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.xP9P7WFZm9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 01:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:57:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OtB9O85CU0/Render', 01:57:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:57:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:57:02 INFO - 'HOME': '/Users/cltbld', 01:57:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:57:02 INFO - 'LOGNAME': 'cltbld', 01:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:02 INFO - 'MOZ_NO_REMOTE': '1', 01:57:02 INFO - 'NO_EM_RESTART': '1', 01:57:02 INFO - 'PAGER': '/bin/cat', 01:57:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:02 INFO - 'PWD': '/builds/slave/test', 01:57:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:57:02 INFO - 'SHELL': '/bin/bash', 01:57:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xP9P7WFZm9/Listeners', 01:57:02 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 01:57:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:57:02 INFO - 'USER': 'cltbld', 01:57:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:57:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:02 INFO - 'XPC_FLAGS': '0x0', 01:57:02 INFO - 'XPC_SERVICE_NAME': '0', 01:57:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:57:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:57:02 INFO - Cleaning up... 01:57:02 INFO - Return code: 0 01:57:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:57:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3cb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10fa3f768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f88fb482310>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f81ad30>, '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 0x10f741db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f80fbe8>, '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.OtB9O85CU0/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.xP9P7WFZm9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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 01:57:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:57:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:57:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OtB9O85CU0/Render', 01:57:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:57:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:57:02 INFO - 'HOME': '/Users/cltbld', 01:57:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:57:02 INFO - 'LOGNAME': 'cltbld', 01:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:02 INFO - 'MOZ_NO_REMOTE': '1', 01:57:02 INFO - 'NO_EM_RESTART': '1', 01:57:02 INFO - 'PAGER': '/bin/cat', 01:57:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:02 INFO - 'PWD': '/builds/slave/test', 01:57:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:57:02 INFO - 'SHELL': '/bin/bash', 01:57:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xP9P7WFZm9/Listeners', 01:57:02 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 01:57:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:57:02 INFO - 'USER': 'cltbld', 01:57:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:57:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:02 INFO - 'XPC_FLAGS': '0x0', 01:57:02 INFO - 'XPC_SERVICE_NAME': '0', 01:57:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:57:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:57:03 INFO - Cleaning up... 01:57:03 INFO - Return code: 0 01:57:03 INFO - Running post-action listener: _resource_record_post_action 01:57:03 INFO - Running post-action listener: _start_resource_monitoring 01:57:03 INFO - Starting resource monitoring. 01:57:03 INFO - [mozharness: 2017-04-04 08:57:03.197143Z] Finished create-virtualenv step (success) 01:57:03 INFO - [mozharness: 2017-04-04 08:57:03.198103Z] Running install step. 01:57:03 INFO - Running pre-action listener: _resource_record_pre_action 01:57:03 INFO - Running main action method: install 01:57:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:57:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:57:03 INFO - Reading from file tmpfile_stdout 01:57:03 INFO - Detecting whether we're running mozinstall >=1.0... 01:57:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:57:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:57:03 INFO - Reading from file tmpfile_stdout 01:57:03 INFO - Output received: 01:57:03 INFO - Usage: mozinstall [options] installer 01:57:03 INFO - Options: 01:57:03 INFO - -h, --help show this help message and exit 01:57:03 INFO - -d DEST, --destination=DEST 01:57:03 INFO - Directory to install application into. [default: 01:57:03 INFO - "/builds/slave/test"] 01:57:03 INFO - --app=APP Application being installed. [default: firefox] 01:57:03 INFO - mkdir: /builds/slave/test/build/application 01:57:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:57:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 01:57:23 INFO - Reading from file tmpfile_stdout 01:57:23 INFO - Output received: 01:57:23 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 01:57:23 INFO - Running post-action listener: _resource_record_post_action 01:57:23 INFO - [mozharness: 2017-04-04 08:57:23.802340Z] Finished install step (success) 01:57:23 INFO - [mozharness: 2017-04-04 08:57:23.802508Z] Running run-tests step. 01:57:23 INFO - Running pre-action listener: _resource_record_pre_action 01:57:23 INFO - Running main action method: run_tests 01:57:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:57:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:57:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:57:23 INFO - 2017-04-04 01:57:23.817 screenresolution[1636:8928] starting screenresolution argv=screenresolution get 01:57:23 INFO - 2017-04-04 01:57:23.819 screenresolution[1636:8928] Display 0: 1600x1200x32@60 01:57:23 INFO - 2017-04-04 01:57:23.826 screenresolution[1637:8930] starting screenresolution argv=screenresolution list 01:57:23 INFO - Available Modes on Display 0 01:57:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:57:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:57:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:57:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:57:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:57:24 INFO - Intel Iris: 01:57:24 INFO - Chipset Model: Intel Iris 01:57:24 INFO - Type: GPU 01:57:24 INFO - Bus: Built-In 01:57:24 INFO - VRAM (Dynamic, Max): 1536 MB 01:57:24 INFO - Vendor: Intel (0x8086) 01:57:24 INFO - Device ID: 0x0a2e 01:57:24 INFO - Revision ID: 0x0009 01:57:24 INFO - Displays: 01:57:24 INFO - Display: 01:57:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:57:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:57:24 INFO - Display Serial Number: 1600x1200 60 01:57:24 INFO - Main Display: Yes 01:57:24 INFO - Mirror: Off 01:57:24 INFO - Online: Yes 01:57:24 INFO - Rotation: Supported 01:57:24 INFO - Return code: 0 01:57:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:57:24 INFO - Python 2.7.3 01:57:24 INFO - Return code: 0 01:57:24 INFO - grabbing minidump binary from tooltool 01:57:24 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')]} 01:57:24 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 0x10f81ad30>, '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 0x10f741db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f80fbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:57:24 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 01:57:24 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 01:57:24 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 01:57:24 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:57:24 INFO - Return code: 0 01:57:24 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:57:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:57:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:57:24 INFO - ENV: RUST_BACKTRACE is now 1 01:57:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:57:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:57:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0178', '--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 01:57:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0178 --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 01:57:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.OtB9O85CU0/Render', 01:57:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:57:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:57:24 INFO - 'HOME': '/Users/cltbld', 01:57:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:57:24 INFO - 'LOGNAME': 'cltbld', 01:57:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:57:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:57:24 INFO - 'MOZ_NO_REMOTE': '1', 01:57:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:57:24 INFO - 'NO_EM_RESTART': '1', 01:57:24 INFO - 'PAGER': '/bin/cat', 01:57:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:57:24 INFO - 'PWD': '/builds/slave/test', 01:57:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:57:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:57:24 INFO - 'RUST_BACKTRACE': '1', 01:57:24 INFO - 'SHELL': '/bin/bash', 01:57:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.xP9P7WFZm9/Listeners', 01:57:24 INFO - 'TMPDIR': '/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/', 01:57:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:57:24 INFO - 'USER': 'cltbld', 01:57:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:57:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:57:24 INFO - 'XPC_FLAGS': '0x0', 01:57:24 INFO - 'XPC_SERVICE_NAME': '0', 01:57:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:57:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0178', '--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 01:57:24 INFO - mozversion application_buildid: 20170404004003 01:57:24 INFO - mozversion application_changeset: e3ce3282ec26d1cff472f2bed8c65693ea168ff8 01:57:24 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:57:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:57:24 INFO - mozversion application_name: Firefox 01:57:24 INFO - mozversion application_remotingname: firefox-dev 01:57:24 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:57:24 INFO - mozversion application_vendor: Mozilla 01:57:24 INFO - mozversion application_version: 54.0a2 01:57:24 INFO - mozversion platform_buildid: 20170404004003 01:57:24 INFO - mozversion platform_changeset: e3ce3282ec26d1cff472f2bed8c65693ea168ff8 01:57:24 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:57:24 INFO - mozversion platform_version: 54.0a2 01:57:24 INFO - using testdate: 1491296244 01:57:24 INFO - actual date: 1491296244 01:57:24 INFO - starting webserver on 'localhost:49243' 01:57:24 INFO - SUITE-START | Running 2 tests 01:57:24 INFO - TEST-START | dromaeo_css 01:57:24 INFO - operating with platform_type : mac_ 01:57:24 INFO - Initialising browser for dromaeo_css test... 01:57:24 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmp623Vxm/profile http://localhost:49243/getInfo.html) 01:57:26 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 01:57:26 INFO - PROCESS | 1647 | colorDepth:24 01:57:26 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 01:57:26 INFO - PROCESS | 1647 | __metrics 01:57:27 INFO - PROCESS | 1647 | 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" 01:57:27 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:57:27 INFO - TEST-INFO | 1647: exit 0 01:57:27 INFO - Browser initialized. 01:57:27 INFO - Running cycle 1/1 for dromaeo_css test... 01:57:27 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmp623Vxm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:57:39 INFO - PROCESS | 1651 | RSS: Main: 215003136 01:57:39 INFO - PROCESS | 1651 | 02:00:44 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 02:00:46 INFO - PROCESS | 1651 | RSS: Main: 396763136 02:00:46 INFO - PROCESS | 1651 | 02:02:29 INFO - PROCESS | 1651 | ************************* 02:02:29 INFO - PROCESS | 1651 | A coding exception was thrown and uncaught in a Task. 02:02:29 INFO - PROCESS | 1651 | 02:02:29 ERROR - PROCESS | 1651 | Full message: TypeError: NetworkError when attempting to fetch resource. 02:02:29 INFO - PROCESS | 1651 | Full stack: 02:02:29 INFO - PROCESS | 1651 | ************************* 02:03:49 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 02:03:49 INFO - PROCESS | 1651 | RSS: Main: 349818880 02:03:49 INFO - PROCESS | 1651 | 02:06:52 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 02:06:53 INFO - PROCESS | 1651 | RSS: Main: 333746176 02:06:53 INFO - PROCESS | 1651 | 02:09:55 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 02:09:56 INFO - PROCESS | 1651 | RSS: Main: 321728512 02:09:56 INFO - PROCESS | 1651 | 02:12:59 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 02:13:00 INFO - PROCESS | 1651 | RSS: Main: 319488000 02:13:00 INFO - PROCESS | 1651 | 02:16:03 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 02:16:03 INFO - PROCESS | 1651 | RSS: Main: 356610048 02:16:03 INFO - PROCESS | 1651 | 02:16:03 INFO - PROCESS | 1651 | __start_tp_report 02:16:03 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 02:16:03 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 02:16:03 INFO - PROCESS | 1651 | |i|pagename|runs| 02:16:03 INFO - PROCESS | 1651 | |0;dojo.html;3065.1264389648954;3377.969719235634;3418.5043168740535;3425.3834309824238;3432.79403235806;5935.792247271346;5964;5969.1344755010605;5989.730462129204;5997.190379298793;5957.076653118774;6028.065649824284;6031.48732357749;6049.395060493948;6057.09143628456;5370.91943620846;5384.300040994665;5407.648502847322;5422.050537264125;5498.477644623755;5312.389075256337;5318.388385335678;5482.80810171644;5494.313210848644;5548.9722551387185;5352.357717073956;5413.621046526745;5437.537809286216;5467.890642187154;5482.2873026506695;5444.074507333743;5488.121900495901;5494.670319780786;5499.230107784873;5510.834674959738;4485.798139083749;5325.174597937326;5393.703346315951;5404.7838086476495;5432.320959880015;5787.739551720183;5815.563832712522;5816.651000939957;5823.068309070571;5833.212516310286;6196.907046394308;6218.751249949996;6242.313345531988;6249.375062493759;6255.061740738925;6308.810735677937;6364.395382438661;6365.3316401778075;6376.48988080957;6380.776672816429;6062.696865156725;6070.8785824283705;6086.026235802295;6133.693315334215;6136.78521251763;6248.125262463259;6302.401271879165;6421.743130274736;6489.5781774184525;6498.675066246668;6245.781397651061;6263.749450022039;6268.09112678659;6280.2777680566405;6284.308726040132;6357.554971152067;6401.231852177769;6403.743850245938;6423.454006409414;6435.935640643627;6209.875802484015;6227.906581401283;6273.498120150377;6337.683115844189;6348.682565871688;6294.118823364733;6311.147995020705;6321.336259692758;6324.683765811783;6337.2395312562785;4600.6549508786975;4938.234573641092;5120.513551212629;5138.58891288696;5171.043356978971;4370.562943705604;4394.450693663292;4581.335706322565;4596.609288210473;4597.954020459752;5626.099824028218;5978.282606087298;5983.940160598426;6041.942660034477;6052.243469566304;6349.396807303298;6423.839404014843;6424.486041116699;6428;6428.839279018062;5986.970065149733;6011.879762404727;6012.669303188367;6029.939700602938;6032.125341825411;5426.131818908955;5487.725613719298;5538.00315943126;5604.579656525695;5608.439156084359;6567.376099270562;6588.604683718992;6589.80230593083;6591.571547849375;6593.835154121185;6360.077788720702;6411.102445657705;6413.230412350548;6421.133147025092;6425.967870160619;6272.874542509216;6502.707378167899;6586.736530538725;6587.604743715201;6592;6210.937890621036;6266.091416744638;6285.96857015712;6341.651209183539;6342.207224096988;4663.906721865612;5655.688937108499;6235.189425374853;6239.594426362272;6280.152179455898;6116.908246376397;6156.6921653918025;6158.414950579688;6187.319394866471;6189.6286222826775;6210.906836397367;6238.15784869055;6239.532035097477;6241.500679945502;6257;6248.875022499616;6256.593321434092;6262.091996660368;6264.561480696308;6281.780137695341;6118.497354392036;6167.321594624498;6181.53638477125;6193.938060619336;6208.317085120543;6161.983272760123;6180.752769889334;6188.164597779242;6198.2252218472695;6203.131561581473 02:16:03 INFO - PROCESS | 1651 | |1;ext.html;788.6451097006346;806.8063664720466;863.3567991846072;888.9066648001964;890.536920801183;39188.21623567527;40010;40178.19643607126;40238.396424053666;40242;41286.554970576035;41314.58685413145;41315.58684413155;41411.58588414115;41461.96345091374;7216.639168041577;9208.861867071999;9329.72010839676;9359.625614975394;9393;7348.412127029852;10983.231173817836;11162.386068766215;11282.492287847026;11287.604933827317;11151.553937842476;11157.832632510519;11166.441677916113;11175.832362514528;11216.158788090885;7312.890306645405;11047.337159770399;11110.388928608923;11127.888721112766;11174.776504469906;7230.2046774854725;10760.300580462323;10948.671539853738;11095.056920161796;11118.888811111947;38978.220435591415;39153;39190.41214381786;39317.60682393168;39326.0168495787;3798.4682144499793;3801.201747633;3834.750741201841;3850.84596616135;3877.3214687429586;27239.45521089587;27671.58492622612;28428.857855710798;29175.270618234503;29527.261818454495;3098.798578092439;3125.203073216338;3128.9687103128904;3134.0754477428986;3155.842207889619;352602;359026;360215.19892400893;360694.9999999974;361313;43101.137977240905;43489.78255108704;52975;53188.936221275355;53260.93478130493;57469.425305747245;58286.834263315344;58325.12512312319;58353;58429.41570584325;14688.485902993558;14769.63075923089;14786.260686965823;14789.704205916036;14792.556223313102;12694.301813400167;12710;12730.299833509062;12731.61805145847;12734.68163295925;12491.812622810665;12654.620361389174;12674.80987785184;12714.682132946566;12786;5410.3507579090765;5438.83683489496;5452.5463541406525;5462.508374246337;5483.643563168382;830.9447002307036;931.2503434734967;942.4109931292942;984.1142971325864;991.6578780320777;27655.723442765317;28786.424271514872;28989;29296;29488;1036.7356324137447;1045.6549338718205;1046.2519298701313;1054.130342467452;1068.1935138970027;14375.137491750529;14527.346269417902;14940.551783446514;15106.725834841634;15304.693906121815;450368;450949;451055;451103;451754;55829.44170558242;55865.44134558603;55985.600359991324;55989.72005139948;56046;1437.360374633299;1465.2527211122404;1470.6029372069481;1476.2544914818163;1477.1137317609348;26111.216663500127;28232.85883570569;28788.712112879442;28803;28885.988990385235;47460.7626961863;47538;47551.5244847561;47588.04823903433;47633.04733905233;419040;420114;420378;420405;421118;28654.85672571624;32669.346613068083;34711.652883470844;34804.303913922085;35807;38398.040048999;40043.599564003984;40820.97947551335;41159.55941542031;44346;27390.863045684644;28096.85951570229;28394.574081388382;28925.7107428923;29024.564631530968;24518.754812451647;27549.760260787913;28283.717162828932;28461;28564;31861.36277274488;32030.359392811548;32699.673003270615;32720.181995450304;32945.67054329426;27997.580036299063;28090;28162.577561337006;28239.294017648903;29026.419471610872;21707.304961016907;22606.434839129153;22828.7964160582;22948.4262893429;23016 02:16:03 INFO - PROCESS | 1651 | |2;jquery.html;385.90159509325116;397.9383195604681;416.01819705495046;417.6846480906915;431.53825406814707;12834;14601.977861549682;20696.586068278644;20909.895450522727;21207.787922120773;21723.891380543115;22005;22279.888600557017;22457.438564035907;22641.320760377173;6421.967890160543;6467.417932386084;6705.899411508832;6764;6775.932240677604;4178.791060446965;4394.296912494002;4452.0650663360575;6536.869262614745;6687.899681504781;4371.759553224571;4393.05549306899;4440.333949907507;7715.537067775924;7716.614169291541;7618.580978046205;7639.732609358646;7694.076710794712;7714.99705038347;7715.652795624211;7294;7484.251574842527;7493.288137626917;7497.925020749777;7503.587302698349;26454.73545264542;27154.864225678746;27372.726272737218;27462.17613471599;27571.586426203623;2869.583910333011;2895.4932886744737;2899.594056832045;2933.2373582868395;2941.3381989052505;15378;16211.108389038598;16248.268827902655;16509.58726031847;16666.333346666117;1977.9802201978084;2079.189116244666;2086.405374468269;2088.1751708075226;2088.2795435574703;119424.40287798592;123010;145975.54024459832;153145.70281445674;180186;18787.90606046961;20243.291484798257;20475.180992760124;20685.482862928246;20710.068046937922;32454.864079757095;32508.83745581257;32917.835410823274;33122.8343858284;33187.83406082954;10038.598456061822;10133.898661013443;10361.119304859172;10400.063994240554;10420.270581059252;8675.436096653697;8685.131486851391;8741.388102832741;8819.368416842904;8835;9286.767830804283;9350.298727595458;9409.012053734396;9451.385659932082;9507.904920950701;3083.6145481814774;3479.7216222702123;3895.8052097395016;3959.9010024749614;3986.8205930732606;1001.5142655811925;1006.9093781559695;1022.4683164754434;1026.5072765072807;1033.1424917318757;19496.51258718515;20857.582848343252;20898.477538061365;20927.790722092584;21329.573408532055;1012.1245122968579;1025.8563801067855;1039.838824982129;1060.8514807926897;1064.350746044912;7739.458237923404;10245.180385569136;10643.574257029786;10674.412907290174;10752.193585480964;747183;749966;750775.2461237658;760315;766096;86891;159612.20193898957;162243.37756622283;164869;167299.1635041817;1171.9648410547697;1175.506287359311;1213.5631172777794;1237.6905773556612;1237.7276999060193;15715.842841571437;15897.52307430779;17835.375761848274;18677.81322186815;18692;43969.560304396546;47586;60155;60278.7944241104;61650.07524887041;83156.58421707853;88605.55697221731;89000;90911.63632545384;91940.54029730076;10920.617778377718;10975.945120274348;11385.772284554097;11423.942880285545;11430;12823.166494177849;12891.871081289442;13193.472261109831;13239.536616218385;13307.201567905957;10175.185985121025;10360.274780765274;11189.832152517882;11277.548898043986;11497.597584084517;8770;10229.948850255701;10310.381377117097;10341.9482902585;10481.737956550842;11130.666080017612;11167.553297867995;11371.658850234506;11392.886071139183;11459.942700286445;10746.785064298827;11344.752077271329;11453.484593193492;11458.598949036743;11718.472668730099;9193.770155745893;10978.451077445936;11139.3873336964;11342;11348.432578370883 02:16:03 INFO - PROCESS | 1651 | |3;mootools.html;1547.7136729705005;1565.1782814022645;1578.4948816378762;1597.08965889443;1606.2370374072316;10494.737631559216;11052.005319521242;11059.72350691233;11064.834027489595;11075.224734268604;9024.909750902489;10824.350538967667;11121;11142.220044596881;11160.218784685056;2383.8688872111984;2444.5844206484853;2449.0938352809485;2450.15469662966;2457.2382561405934;2290.061074959267;2298.4139044543617;2437.549053425113;2439.0365805506813;2443.3525115844227;2350.118705485443;2420.4432980414517;2421.757824217582;2425.6604075429454;2428.441458464554;2340.8595484270827;2394.95210095798;2403.8437501562344;2414.5170965806733;2415.4202991282054;2376.061455724979;2388.4148383645943;2393.3179043972386;2394.712634483873;2402.8077753779658;10849.891501085045;11061.612843550518;11069.723256918562;11071.833922491169;11112.666620001331;5825.271841019872;5999.220101386792;6000.549958753111;6008.459238668497;6022.337542870281;3616.65641764032;3706.980580340401;3725.5343082114737;3794.8102594870147;3797.1646237827636;1200.7658506591217;1215.7082300247964;1216.7688139253514;1264.3551788587886;1268.2770820632243;13736.793948090786;14128.081674691111;14898.702025959421;15196.924015379964;15593.142377169252;4902.926456103161;5045.672031317952;5075.822346217865;5079.949200508022;5099.133147364957;12986.480540778262;12991.675208119683;13017.544385946636;13022.95816334691;13048.54330098461;5065.670731402447;5249.055170069424;5273.2617433559335;5276.07668657991;5284.815031473957;4797.232442809134;5218.321618189611;5343.65266257692;5355;5369.24830523727;4096.201240758023;4144.647704945113;4219.324908014764;4224.577542245812;4294.892627684333;1153.4290526189423;1161.1697636190165;1164.6040346282136;1178.4049055227056;1185.022356555845;922.6217250927087;931.897491275959;948.2603569216022;953.1183655118987;996.4021587047858;6520.4131628152745;6593.472522198213;6749.93250067493;6816.386525212655;6824.18109826814;980.6959842448864;988.6243227573476;1009.8131845608439;1033.7415646088477;1054.4727636181908;3537.823108844599;4079.551249362568;4163.937540936889;4243.766592837362;4404.185225733249;10599.364038157735;13601.455941762219;13609;13641.386137623831;13641.454341826415;12990.610281691565;13435.529756458476;13452;13462;13560.660983475493;9878.012198780065;10193.949030254802;10204.846927295948;10205.234607404474;10212.438315892698;5499.560035197254;6592.571482853599;6617.205935287796;6629.337066293525;6636;11839.940800295943;12197.878021219674;12204.511819527119;12207.877921220674;12217.450214740536;12078.335691536699;12104.878951210727;12221.205621634565;12340.938295308466;12396.256224626552;9079.863802043106;9144.497052661902;9178;9269.536523173949;9294.209992150472;10062.295639305179;10103.7474063149;10234.539445724811;10251.282410231212;10314;8622.741317760478;8629.611667475105;8656.437331573428;8688.609012594576;8726.040135585208;8295.377846661404;8467.449615774955;8489.06620271782;8541.615627296662;8596.699115530926;7749.922500775146;7882.802929926797;7923.286904178652;7934.722284720007;7944.721934732257;5812.418758124154;5839.124131380327;5929;5967.552433567586;6009.429104235091;5794;5874.559408044499;5995.820125396245;6042.577019608585;6096.786612468542 02:16:03 INFO - PROCESS | 1651 | |4;prototype.html;322.2427295854741;374.1973466913471;381.34218473133865;382.3022983055924;384.7652931711655;5037.345145131137;5045.672031317962;5062.949370506294;5068.619853510988;5113.974430127844;4233.936490952638;4722.527747225276;5007.7496125193775;5025.296458495814;5057.84826455206;3342.4317865962844;3504.5093686883856;3588.533490646219;4052.0087713602225;4140.503139623234;3632.3098611263777;3851.691864650821;4043.9595604043875;4105.876823695294;4133.483314585676;3573.017420209437;3613.9096522586883;3620.330238905811;4098.73358231714;4167.83328666853;3817.2938006468617;3847.576766555677;4040.323265844671;4143.875683729493;4147.983743982713;2998.670146283907;3353.4634458486526;3736.6637002669618;3744.5506539215467;3767.303048935928;4727.621790256771;4779;4807.326974223612;4818.927716084261;4852.331217830179;3904.3557812960826;4005.0788318686864;4238.364245363189;4661.601519544123;4756.714597124149;4638.791254393526;4944.60443164546;5063.721495317756;5226.346706661668;5259.684418934838;3494.4408894576745;3577.982110089433;3652.652997965189;3790.2608991246716;4226.429432026698;5219.321488206547;5241.369667370779;5416.539594134503;5460.996451951411;5467.58993075517;3443.345764304824;3860.6718428933855;4197.055662475979;4299.14017196562;4307.310830267143;4419.712718673276;4437.846159998424;4466.977665111654;4477.350784136282;4478.776061196927;4160.751774467648;4264.253755592821;4569.246074397754;4644.674872758875;4729.4797572267025;4093.9795301023305;4824.984384759526;4929.866130789938;5251.76367063483;5352.277442545284;1332.8400591928837;1377.2149874571398;1439.647286414835;1504.9314986359807;1509.9471518497019;1077.7575045614674;1086.255914698434;1138.599522587206;1141.3266172957829;1163.4996951311018;4223.704340696183;4314.762688052125;4427.512973572904;4890.706557606555;4906.975465122651;4369.880607905164;5103.591712662978;5197;5517.668939863541;5601.862956744236;4137.627613514798;4236.195122926634;4578.624253458482;4862.82980095695;5011.899762004739;2733.9589906151423;2816.169230077132;2847.4732174547776;2863.4559433707527;2871.55490898911;5065.696058236517;5630.915536266959;5637.577181711388;5646.97176514123;5673.3475650299915;5186.559142472856;5431.646942948696;5559.861003474864;5612.576328439649;5715.942840571541;4950.603951683856;5254.448282930313;5472.972635136799;5546.72266386671;5563.916541251965;4836.462250722832;4877.6585639004925;5097.2280512421285;5190.169572868323;5272.736363181749;4877.707337559757;4883.169861123546;5307.946920530745;5312.123499622674;5483.862903427446;5114.181730923035;5132.435432102391;5504.68797610308;5653.378128405954;5696.572757043155;3920.9607903921737;4193.454850869368;4346.543612920598;4348.7390756554705;4370.890727731832;4898.902021959612;4939.629527785359;5152.536271735412;5226.947730522646;5447.700376479173;4563.885902852455;5380.408155103014;5396.949159319433;5397.487238712316;5413.323334583177;4467.7936957020775;5296.470352964673;5330.188914925847;5333.839984800462;5350.919736203882;4544.59098681107;4581.587657110876;4690.835820746394;5079.193576111867;5240.842774716764;5288.8413347599635;5363.249145119765;5364.329458817648;5381.48875856793;5389.407165211902;4427.335899615084;4485.887852803706;4800.423949126127;4823.27650852375;5046.158152274466 02:16:03 INFO - PROCESS | 1651 | |5;yui.html;714.385628359611;730.1019745712773;770.6570576093637;799.5482552357918;818.4311903227258;14975.775363369545;15779.842201577982;15781.921090394546;15823.604409889758;15837.445689400873;14328;14343.995920285584;14358;14393.568192954228;14994.475193368235;921.3366376209135;929.3633860805336;957.4829592020301;960.8222478841402;975.5609975511013;966.4394651102378;967.1344146988441;969.3505351414569;969.8254314223437;970.1898914406479;907.0747837206046;909.6816114359954;911.0206527982413;911.3666002128523;911.9589618467152;905.6513242401656;905.8324210021134;906.0169715858236;907.188066680324;908.0284096017264;668.886289330815;668.8896332105197;669.2036476592839;669.6183175589915;669.6350488983467;15645.374185032584;15924.920375398166;16035.759463608056;16151.192440378052;16416.261268242957;13872.167669939836;13988.72022559543;14051.46880069858;14109.647258818612;14215.289235538181;9800.411975281435;11447.28680247123;11610.36143012134;11787.941060294643;11979.580714674945;3538.6815186633326;3692.372296709566;3700.111973126457;3708.165662725892;3832.156925476391;84973.72539411914;94384.52807735918;111825;114562;116986;10815.621453249256;10849.457527123612;10889.564417423215;11077.279976801483;11152.390472922218;22688.773112268995;22763.317100487013;23095.307140785804;23148.884255578614;23156.88421557915;7407.370373518203;7664.87528186983;7781.8832717509285;7830.334421574116;7836.02049743782;3985.720999530063;4328.523862375137;4331.306990881444;4356.803943822536;4361.5856493633055;3471.6007659119523;3514.4025515662397;3583.3549961006747;3587.959491747416;3608.260306637133;551.2970962023452;630.9211348581428;633.521691123199;640.584308677818;643.9613623182624;656.2813718977711;664.35225654986;682.7269092362995;691.2672567078912;728.6866647341694;9789.657361992297;10132.34139780912;10216.6424175155;10307.793844123076;10412.32319899204;672.9293424190488;690.4510913823523;692.2212510925209;696.1854630082815;709.3509438863485;4809.350737650372;4916.385451818523;4919.3358896549225;4932.679375840559;4933.3586633738105;106087.87824243472;107355;108251.91748082575;108662.3700644491;110937;48704.512954870705;80007.19992800114;85856;89120;95742.52128739451;69275;75014.24985750072;75033.62483187659;76275;76785.99999999888;9394.624215031323;10552.630657926935;11057.557697692002;11313.830292545454;11343.886561134283;46805.36181233641;48356.79108022187;48495.5150448491;48546.51453485561;49321.50678493169;47762;68697.65651171713;69842;72266.55466890738;73905;12369.690757731129;12455.941244994277;12521.56174533887;12536.310502922426;12697.492100315883;12386.876131238572;13965.162090274209;13972.30138493051;14102.506412275521;15214.619634509227;12867.742645146858;13564;13583.117097388638;13747.243901585509;14004.509842155476;12897.290649014394;13540.187588744313;13600.843928265813;13681.31593420305;13956.302184890512;10933;12670.366481675695;13381.66545836362;13492.86507134916;13526.93236533811;9060.48574738346;9339.719808405758;9799.85300220483;9808.117269445784;10319.432431216355;9910.40427824561;9994.60021599157;11093.686993144738;11373.374464404536;11382.772344553228 02:16:03 INFO - PROCESS | 1651 | __end_tp_report 02:16:03 INFO - PROCESS | 1651 | __start_cc_report 02:16:03 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,2140 02:16:03 INFO - PROCESS | 1651 | __end_cc_report 02:16:03 INFO - PROCESS | 1651 | __startTimestamp1491297363902__endTimestamp 02:16:03 INFO - PROCESS | 1651 | 02:16:03 INFO - PROCESS | 1651 | ------- Summary: start ------- 02:16:03 INFO - PROCESS | 1651 | Number of tests: 6 02:16:03 INFO - PROCESS | 1651 | 02:16:03 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5894.12 Median:6167.32 stddev:670.94 (10.9%) stddev-sans-first:635.24 02:16:03 INFO - PROCESS | 1651 | Values: 3065.1 3378.0 3418.5 3425.4 3432.8 5935.8 5964.0 5969.1 5989.7 5997.2 5957.1 6028.1 6031.5 6049.4 6057.1 5370.9 5384.3 5407.6 5422.1 5498.5 5312.4 5318.4 5482.8 5494.3 5549.0 5352.4 5413.6 5437.5 5467.9 5482.3 5444.1 5488.1 5494.7 5499.2 5510.8 4485.8 5325.2 5393.7 5404.8 5432.3 5787.7 5815.6 5816.7 5823.1 5833.2 6196.9 6218.8 6242.3 6249.4 6255.1 6308.8 6364.4 6365.3 6376.5 6380.8 6062.7 6070.9 6086.0 6133.7 6136.8 6248.1 6302.4 6421.7 6489.6 6498.7 6245.8 6263.7 6268.1 6280.3 6284.3 6357.6 6401.2 6403.7 6423.5 6435.9 6209.9 6227.9 6273.5 6337.7 6348.7 6294.1 6311.1 6321.3 6324.7 6337.2 4600.7 4938.2 5120.5 5138.6 5171.0 4370.6 4394.5 4581.3 4596.6 4598.0 5626.1 5978.3 5983.9 6041.9 6052.2 6349.4 6423.8 6424.5 6428.0 6428.8 5987.0 6011.9 6012.7 6029.9 6032.1 5426.1 5487.7 5538.0 5604.6 5608.4 6567.4 6588.6 6589.8 6591.6 6593.8 6360.1 6411.1 6413.2 6421.1 6426.0 6272.9 6502.7 6586.7 6587.6 6592.0 6210.9 6266.1 6286.0 6341.7 6342.2 4663.9 5655.7 6235.2 6239.6 6280.2 6116.9 6156.7 6158.4 6187.3 6189.6 6210.9 6238.2 6239.5 6241.5 6257.0 6248.9 6256.6 6262.1 6264.6 6281.8 6118.5 6167.3 6181.5 6193.9 6208.3 6162.0 6180.8 6188.2 6198.2 6203.1 02:16:03 INFO - PROCESS | 1651 | 02:16:03 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:55086.77 Median:32684.51 stddev:109094.79 (333.8%) stddev-sans-first:109324.66 02:16:03 INFO - PROCESS | 1651 | Values: 788.6 806.8 863.4 888.9 890.5 39188.2 40010.0 40178.2 40238.4 40242.0 41286.6 41314.6 41315.6 41411.6 41462.0 7216.6 9208.9 9329.7 9359.6 9393.0 7348.4 10983.2 11162.4 11282.5 11287.6 11151.6 11157.8 11166.4 11175.8 11216.2 7312.9 11047.3 11110.4 11127.9 11174.8 7230.2 10760.3 10948.7 11095.1 11118.9 38978.2 39153.0 39190.4 39317.6 39326.0 3798.5 3801.2 3834.8 3850.8 3877.3 27239.5 27671.6 28428.9 29175.3 29527.3 3098.8 3125.2 3129.0 3134.1 3155.8 352602.0 359026.0 360215.2 360695.0 361313.0 43101.1 43489.8 52975.0 53188.9 53260.9 57469.4 58286.8 58325.1 58353.0 58429.4 14688.5 14769.6 14786.3 14789.7 14792.6 12694.3 12710.0 12730.3 12731.6 12734.7 12491.8 12654.6 12674.8 12714.7 12786.0 5410.4 5438.8 5452.5 5462.5 5483.6 830.9 931.3 942.4 984.1 991.7 27655.7 28786.4 28989.0 29296.0 29488.0 1036.7 1045.7 1046.3 1054.1 1068.2 14375.1 14527.3 14940.6 15106.7 15304.7 450368.0 450949.0 451055.0 451103.0 451754.0 55829.4 55865.4 55985.6 55989.7 56046.0 1437.4 1465.3 1470.6 1476.3 1477.1 26111.2 28232.9 28788.7 28803.0 28886.0 47460.8 47538.0 47551.5 47588.0 47633.0 419040.0 420114.0 420378.0 420405.0 421118.0 28654.9 32669.3 34711.7 34804.3 35807.0 38398.0 40043.6 40821.0 41159.6 44346.0 27390.9 28096.9 28394.6 28925.7 29024.6 24518.8 27549.8 28283.7 28461.0 28564.0 31861.4 32030.4 32699.7 32720.2 32945.7 27997.6 28090.0 28162.6 28239.3 29026.4 21707.3 22606.4 22828.8 22948.4 23016.0 02:16:03 INFO - PROCESS | 1651 | 02:16:03 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:42439.01 Median:11493.38 stddev:125712.14 (1093.8%) stddev-sans-first:126025.13 02:16:03 INFO - PROCESS | 1651 | Values: 385.9 397.9 416.0 417.7 431.5 12834.0 14602.0 20696.6 20909.9 21207.8 21723.9 22005.0 22279.9 22457.4 22641.3 6422.0 6467.4 6705.9 6764.0 6775.9 4178.8 4394.3 4452.1 6536.9 6687.9 4371.8 4393.1 4440.3 7715.5 7716.6 7618.6 7639.7 7694.1 7715.0 7715.7 7294.0 7484.3 7493.3 7497.9 7503.6 26454.7 27154.9 27372.7 27462.2 27571.6 2869.6 2895.5 2899.6 2933.2 2941.3 15378.0 16211.1 16248.3 16509.6 16666.3 1978.0 2079.2 2086.4 2088.2 2088.3 119424.4 123010.0 145975.5 153145.7 180186.0 18787.9 20243.3 20475.2 20685.5 20710.1 32454.9 32508.8 32917.8 33122.8 33187.8 10038.6 10133.9 10361.1 10400.1 10420.3 8675.4 8685.1 8741.4 8819.4 8835.0 9286.8 9350.3 9409.0 9451.4 9507.9 3083.6 3479.7 3895.8 3959.9 3986.8 1001.5 1006.9 1022.5 1026.5 1033.1 19496.5 20857.6 20898.5 20927.8 21329.6 1012.1 1025.9 1039.8 1060.9 1064.4 7739.5 10245.2 10643.6 10674.4 10752.2 747183.0 749966.0 750775.2 760315.0 766096.0 86891.0 159612.2 162243.4 164869.0 167299.2 1172.0 1175.5 1213.6 1237.7 1237.7 15715.8 15897.5 17835.4 18677.8 18692.0 43969.6 47586.0 60155.0 60278.8 61650.1 83156.6 88605.6 89000.0 90911.6 91940.5 10920.6 10975.9 11385.8 11423.9 11430.0 12823.2 12891.9 13193.5 13239.5 13307.2 10175.2 10360.3 11189.8 11277.5 11497.6 8770.0 10229.9 10310.4 10341.9 10481.7 11130.7 11167.6 11371.7 11392.9 11459.9 10746.8 11344.8 11453.5 11458.6 11718.5 9193.8 10978.5 11139.4 11342.0 11348.4 02:16:03 INFO - PROCESS | 1651 | 02:16:03 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:6724.19 Median:2441.19 stddev:4155.76 (170.2%) stddev-sans-first:4149.21 02:16:03 INFO - PROCESS | 1651 | Values: 1547.7 1565.2 1578.5 1597.1 1606.2 10494.7 11052.0 11059.7 11064.8 11075.2 9024.9 10824.4 11121.0 11142.2 11160.2 2383.9 2444.6 2449.1 2450.2 2457.2 2290.1 2298.4 2437.5 2439.0 2443.4 2350.1 2420.4 2421.8 2425.7 2428.4 2340.9 2395.0 2403.8 2414.5 2415.4 2376.1 2388.4 2393.3 2394.7 2402.8 10849.9 11061.6 11069.7 11071.8 11112.7 5825.3 5999.2 6000.5 6008.5 6022.3 3616.7 3707.0 3725.5 3794.8 3797.2 1200.8 1215.7 1216.8 1264.4 1268.3 13736.8 14128.1 14898.7 15196.9 15593.1 4902.9 5045.7 5075.8 5079.9 5099.1 12986.5 12991.7 13017.5 13023.0 13048.5 5065.7 5249.1 5273.3 5276.1 5284.8 4797.2 5218.3 5343.7 5355.0 5369.2 4096.2 4144.6 4219.3 4224.6 4294.9 1153.4 1161.2 1164.6 1178.4 1185.0 922.6 931.9 948.3 953.1 996.4 6520.4 6593.5 6749.9 6816.4 6824.2 980.7 988.6 1009.8 1033.7 1054.5 3537.8 4079.6 4163.9 4243.8 4404.2 10599.4 13601.5 13609.0 13641.4 13641.5 12990.6 13435.5 13452.0 13462.0 13560.7 9878.0 10193.9 10204.8 10205.2 10212.4 5499.6 6592.6 6617.2 6629.3 6636.0 11839.9 12197.9 12204.5 12207.9 12217.5 12078.3 12104.9 12221.2 12340.9 12396.3 9079.9 9144.5 9178.0 9269.5 9294.2 10062.3 10103.7 10234.5 10251.3 10314.0 8622.7 8629.6 8656.4 8688.6 8726.0 8295.4 8467.4 8489.1 8541.6 8596.7 7749.9 7882.8 7923.3 7934.7 7944.7 5812.4 5839.1 5929.0 5967.6 6009.4 5794.0 5874.6 5995.8 6042.6 6096.8 02:16:03 INFO - PROCESS | 1651 | 02:16:03 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4352.72 Median:4725.07 stddev:1231.64 (26.1%) stddev-sans-first:1197.36 02:16:03 INFO - PROCESS | 1651 | Values: 322.2 374.2 381.3 382.3 384.8 5037.3 5045.7 5062.9 5068.6 5114.0 4233.9 4722.5 5007.7 5025.3 5057.8 3342.4 3504.5 3588.5 4052.0 4140.5 3632.3 3851.7 4044.0 4105.9 4133.5 3573.0 3613.9 3620.3 4098.7 4167.8 3817.3 3847.6 4040.3 4143.9 4148.0 2998.7 3353.5 3736.7 3744.6 3767.3 4727.6 4779.0 4807.3 4818.9 4852.3 3904.4 4005.1 4238.4 4661.6 4756.7 4638.8 4944.6 5063.7 5226.3 5259.7 3494.4 3578.0 3652.7 3790.3 4226.4 5219.3 5241.4 5416.5 5461.0 5467.6 3443.3 3860.7 4197.1 4299.1 4307.3 4419.7 4437.8 4467.0 4477.4 4478.8 4160.8 4264.3 4569.2 4644.7 4729.5 4094.0 4825.0 4929.9 5251.8 5352.3 1332.8 1377.2 1439.6 1504.9 1509.9 1077.8 1086.3 1138.6 1141.3 1163.5 4223.7 4314.8 4427.5 4890.7 4907.0 4369.9 5103.6 5197.0 5517.7 5601.9 4137.6 4236.2 4578.6 4862.8 5011.9 2734.0 2816.2 2847.5 2863.5 2871.6 5065.7 5630.9 5637.6 5647.0 5673.3 5186.6 5431.6 5559.9 5612.6 5715.9 4950.6 5254.4 5473.0 5546.7 5563.9 4836.5 4877.7 5097.2 5190.2 5272.7 4877.7 4883.2 5307.9 5312.1 5483.9 5114.2 5132.4 5504.7 5653.4 5696.6 3921.0 4193.5 4346.5 4348.7 4370.9 4898.9 4939.6 5152.5 5226.9 5447.7 4563.9 5380.4 5396.9 5397.5 5413.3 4467.8 5296.5 5330.2 5333.8 5350.9 4544.6 4581.6 4690.8 5079.2 5240.8 5288.8 5363.2 5364.3 5381.5 5389.4 4427.3 4485.9 4800.4 4823.3 5046.2 02:16:03 INFO - PROCESS | 1651 | 02:16:03 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:20177.06 Median:4329.92 stddev:29110.89 (672.3%) stddev-sans-first:29155.87 02:16:03 INFO - PROCESS | 1651 | Values: 714.4 730.1 770.7 799.5 818.4 14975.8 15779.8 15781.9 15823.6 15837.4 14328.0 14344.0 14358.0 14393.6 14994.5 921.3 929.4 957.5 960.8 975.6 966.4 967.1 969.4 969.8 970.2 907.1 909.7 911.0 911.4 912.0 905.7 905.8 906.0 907.2 908.0 668.9 668.9 669.2 669.6 669.6 15645.4 15924.9 16035.8 16151.2 16416.3 13872.2 13988.7 14051.5 14109.6 14215.3 9800.4 11447.3 11610.4 11787.9 11979.6 3538.7 3692.4 3700.1 3708.2 3832.2 84973.7 94384.5 111825.0 114562.0 116986.0 10815.6 10849.5 10889.6 11077.3 11152.4 22688.8 22763.3 23095.3 23148.9 23156.9 7407.4 7664.9 7781.9 7830.3 7836.0 3985.7 4328.5 4331.3 4356.8 4361.6 3471.6 3514.4 3583.4 3588.0 3608.3 551.3 630.9 633.5 640.6 644.0 656.3 664.4 682.7 691.3 728.7 9789.7 10132.3 10216.6 10307.8 10412.3 672.9 690.5 692.2 696.2 709.4 4809.4 4916.4 4919.3 4932.7 4933.4 106087.9 107355.0 108251.9 108662.4 110937.0 48704.5 80007.2 85856.0 89120.0 95742.5 69275.0 75014.2 75033.6 76275.0 76786.0 9394.6 10552.6 11057.6 11313.8 11343.9 46805.4 48356.8 48495.5 48546.5 49321.5 47762.0 68697.7 69842.0 72266.6 73905.0 12369.7 12455.9 12521.6 12536.3 12697.5 12386.9 13965.2 13972.3 14102.5 15214.6 12867.7 13564.0 13583.1 13747.2 14004.5 12897.3 13540.2 13600.8 13681.3 13956.3 10933.0 12670.4 13381.7 13492.9 13526.9 9060.5 9339.7 9799.9 9808.1 10319.4 9910.4 9994.6 11093.7 11373.4 11382.8 02:16:03 INFO - PROCESS | 1651 | -------- Summary: end -------- 02:16:03 INFO - PROCESS | 1651 | 02:16:04 INFO - TEST-INFO | 1651: exit 0 02:16:04 INFO - TEST-OK | dromaeo_css | took 1120167ms 02:16:04 INFO - TEST-START | kraken 02:16:04 INFO - operating with platform_type : mac_ 02:16:04 INFO - Initialising browser for kraken test... 02:16:04 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpgMFyuz/profile http://localhost:49243/getInfo.html) 02:16:06 INFO - PROCESS | 1657 | __metrics Screen width/height:1600/1200 02:16:06 INFO - PROCESS | 1657 | colorDepth:24 02:16:06 INFO - PROCESS | 1657 | Browser inner width/height: 1024/689 02:16:06 INFO - PROCESS | 1657 | __metrics 02:16:06 INFO - PROCESS | 1657 | 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" 02:16:06 INFO - PROCESS | 1657 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 02:16:07 INFO - TEST-INFO | 1657: exit 0 02:16:07 INFO - Browser initialized. 02:16:07 INFO - Running cycle 1/1 for kraken test... 02:16:07 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/tmpgMFyuz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:16:19 INFO - PROCESS | 1659 | RSS: Main: 214917120 02:16:19 INFO - PROCESS | 1659 | 02:16:22 INFO - PROCESS | 1659 | 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) 02:16:23 INFO - PROCESS | 1659 | RSS: Main: 268374016 02:16:23 INFO - PROCESS | 1659 | 02:16:26 INFO - PROCESS | 1659 | 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) 02:16:27 INFO - PROCESS | 1659 | RSS: Main: 279375872 02:16:27 INFO - PROCESS | 1659 | 02:16:30 INFO - PROCESS | 1659 | 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) 02:16:30 INFO - PROCESS | 1659 | RSS: Main: 376418304 02:16:30 INFO - PROCESS | 1659 | 02:16:33 INFO - PROCESS | 1659 | 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) 02:16:33 INFO - PROCESS | 1659 | RSS: Main: 278249472 02:16:33 INFO - PROCESS | 1659 | 02:16:35 INFO - PROCESS | 1659 | 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) 02:16:36 INFO - PROCESS | 1659 | RSS: Main: 279572480 02:16:36 INFO - PROCESS | 1659 | 02:16:39 INFO - PROCESS | 1659 | 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) 02:16:39 INFO - PROCESS | 1659 | RSS: Main: 319168512 02:16:39 INFO - PROCESS | 1659 | 02:16:42 INFO - PROCESS | 1659 | 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) 02:16:43 INFO - PROCESS | 1659 | RSS: Main: 322199552 02:16:43 INFO - PROCESS | 1659 | 02:16:46 INFO - PROCESS | 1659 | 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) 02:16:47 INFO - PROCESS | 1659 | RSS: Main: 319328256 02:16:47 INFO - PROCESS | 1659 | 02:16:48 INFO - PROCESS | 1659 | 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) 02:16:49 INFO - PROCESS | 1659 | RSS: Main: 295600128 02:16:49 INFO - PROCESS | 1659 | 02:16:51 INFO - PROCESS | 1659 | 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) 02:16:51 INFO - PROCESS | 1659 | RSS: Main: 301096960 02:16:51 INFO - PROCESS | 1659 | 02:16:53 INFO - PROCESS | 1659 | 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) 02:16:54 INFO - PROCESS | 1659 | RSS: Main: 302436352 02:16:54 INFO - PROCESS | 1659 | 02:16:57 INFO - PROCESS | 1659 | 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) 02:16:58 INFO - PROCESS | 1659 | RSS: Main: 318615552 02:16:58 INFO - PROCESS | 1659 | 02:17:01 INFO - PROCESS | 1659 | 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) 02:17:01 INFO - PROCESS | 1659 | RSS: Main: 312045568 02:17:01 INFO - PROCESS | 1659 | 02:17:03 INFO - PROCESS | 1659 | 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) 02:17:03 INFO - PROCESS | 1659 | RSS: Main: 356044800 02:17:03 INFO - PROCESS | 1659 | 02:17:03 INFO - PROCESS | 1659 | __start_tp_report 02:17:03 INFO - PROCESS | 1659 | _x_x_mozilla_page_load 02:17:03 INFO - PROCESS | 1659 | _x_x_mozilla_page_load_details 02:17:03 INFO - PROCESS | 1659 | |i|pagename|runs| 02:17:03 INFO - PROCESS | 1659 | |0;ai-astar;123;172;156;117;165;172;116;115;113;116 02:17:03 INFO - PROCESS | 1659 | |1;audio-beat-detection;136;109;109;141;110;110;109;108;127;109 02:17:03 INFO - PROCESS | 1659 | |2;audio-dft;189;183;198;261;203;187;183;184;186;182 02:17:03 INFO - PROCESS | 1659 | |3;audio-fft;83;61;61;90;56;64;68;80;95;81 02:17:03 INFO - PROCESS | 1659 | |4;audio-oscillator;86;70;86;73;95;97;112;69;68;83 02:17:03 INFO - PROCESS | 1659 | |5;imaging-gaussian-blur;87;88;88;89;88;88;88;87;88;88 02:17:03 INFO - PROCESS | 1659 | |6;imaging-darkroom;95;96;95;98;96;96;96;98;96;95 02:17:03 INFO - PROCESS | 1659 | |7;imaging-desaturate;86;84;85;86;85;83;86;84;86;85 02:17:03 INFO - PROCESS | 1659 | |8;json-parse-financial;63;62;61;68;65;65;65;65;63;64 02:17:03 INFO - PROCESS | 1659 | |9;json-stringify-tinderbox;55;58;71;63;63;61;53;57;58;59 02:17:03 INFO - PROCESS | 1659 | |10;stanford-crypto-aes;85;82;81;90;100;98;82;84;79;85 02:17:03 INFO - PROCESS | 1659 | |11;stanford-crypto-ccm;137;136;135;135;139;152;147;140;177;148 02:17:03 INFO - PROCESS | 1659 | |12;stanford-crypto-pbkdf2;164;162;207;206;165;163;166;164;170;165 02:17:03 INFO - PROCESS | 1659 | |13;stanford-crypto-sha256-iterative;64;66;78;81;80;79;63;64;66;76 02:17:03 INFO - PROCESS | 1659 | __end_tp_report 02:17:03 INFO - PROCESS | 1659 | __start_cc_report 02:17:03 INFO - PROCESS | 1659 | _x_x_mozilla_cycle_collect,2144 02:17:03 INFO - PROCESS | 1659 | __end_cc_report 02:17:03 INFO - PROCESS | 1659 | __startTimestamp1491297423944__endTimestamp 02:17:03 INFO - PROCESS | 1659 | 02:17:03 INFO - PROCESS | 1659 | ------- Summary: start ------- 02:17:03 INFO - PROCESS | 1659 | Number of tests: 14 02:17:03 INFO - PROCESS | 1659 | 02:17:03 INFO - PROCESS | 1659 | [#0] ai-astar Cycles:10 Average:136.50 Median:139.50 stddev:26.10 (18.7%) stddev-sans-first:27.22 02:17:03 INFO - PROCESS | 1659 | Values: 123.0 172.0 156.0 117.0 165.0 172.0 116.0 115.0 113.0 116.0 02:17:03 INFO - PROCESS | 1659 | 02:17:03 INFO - PROCESS | 1659 | [#1] audio-beat-detection Cycles:10 Average:116.80 Median:110.00 stddev:12.79 (11.6%) stddev-sans-first:11.52 02:17:03 INFO - PROCESS | 1659 | Values: 136.0 109.0 109.0 141.0 110.0 110.0 109.0 108.0 127.0 109.0 02:17:03 INFO - PROCESS | 1659 | 02:17:03 INFO - PROCESS | 1659 | [#2] audio-dft Cycles:10 Average:195.60 Median:188.00 stddev:24.00 (12.8%) stddev-sans-first:25.34 02:17:03 INFO - PROCESS | 1659 | Values: 189.0 183.0 198.0 261.0 203.0 187.0 183.0 184.0 186.0 182.0 02:17:03 INFO - PROCESS | 1659 | 02:17:03 INFO - PROCESS | 1659 | [#3] audio-fft Cycles:10 Average:73.90 Median:80.50 stddev:13.58 (16.9%) stddev-sans-first:14.00 02:17:03 INFO - PROCESS | 1659 | Values: 83.0 61.0 61.0 90.0 56.0 64.0 68.0 80.0 95.0 81.0 02:17:03 INFO - PROCESS | 1659 | 02:17:03 INFO - PROCESS | 1659 | [#4] audio-oscillator Cycles:10 Average:83.90 Median:84.50 stddev:14.46 (17.1%) stddev-sans-first:15.31 02:17:03 INFO - PROCESS | 1659 | Values: 86.0 70.0 86.0 73.0 95.0 97.0 112.0 69.0 68.0 83.0 02:17:03 INFO - PROCESS | 1659 | 02:17:03 INFO - PROCESS | 1659 | [#5] imaging-gaussian-blur Cycles:10 Average:87.90 Median:88.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 02:17:03 INFO - PROCESS | 1659 | Values: 87.0 88.0 88.0 89.0 88.0 88.0 88.0 87.0 88.0 88.0 02:17:03 INFO - PROCESS | 1659 | 02:17:03 INFO - PROCESS | 1659 | [#6] imaging-darkroom Cycles:10 Average:96.10 Median:96.00 stddev:1.10 (1.1%) stddev-sans-first:1.09 02:17:03 INFO - PROCESS | 1659 | Values: 95.0 96.0 95.0 98.0 96.0 96.0 96.0 98.0 96.0 95.0 02:17:03 INFO - PROCESS | 1659 | 02:17:03 INFO - PROCESS | 1659 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:85.50 stddev:1.05 (1.2%) stddev-sans-first:1.05 02:17:03 INFO - PROCESS | 1659 | Values: 86.0 84.0 85.0 86.0 85.0 83.0 86.0 84.0 86.0 85.0 02:17:03 INFO - PROCESS | 1659 | 02:17:03 INFO - PROCESS | 1659 | [#8] json-parse-financial Cycles:10 Average:64.10 Median:65.00 stddev:1.97 (3.0%) stddev-sans-first:2.05 02:17:03 INFO - PROCESS | 1659 | Values: 63.0 62.0 61.0 68.0 65.0 65.0 65.0 65.0 63.0 64.0 02:17:03 INFO - PROCESS | 1659 | 02:17:03 INFO - PROCESS | 1659 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:5.07 (8.5%) stddev-sans-first:5.07 02:17:03 INFO - PROCESS | 1659 | Values: 55.0 58.0 71.0 63.0 63.0 61.0 53.0 57.0 58.0 59.0 02:17:03 INFO - PROCESS | 1659 | 02:17:03 INFO - PROCESS | 1659 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:84.50 stddev:7.18 (8.5%) stddev-sans-first:7.60 02:17:03 INFO - PROCESS | 1659 | Values: 85.0 82.0 81.0 90.0 100.0 98.0 82.0 84.0 79.0 85.0 02:17:03 INFO - PROCESS | 1659 | 02:17:03 INFO - PROCESS | 1659 | [#11] stanford-crypto-ccm Cycles:10 Average:144.60 Median:143.50 stddev:12.87 (9.0%) stddev-sans-first:13.35 02:17:03 INFO - PROCESS | 1659 | Values: 137.0 136.0 135.0 135.0 139.0 152.0 147.0 140.0 177.0 148.0 02:17:03 INFO - PROCESS | 1659 | 02:17:03 INFO - PROCESS | 1659 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.20 Median:165.50 stddev:17.68 (10.7%) stddev-sans-first:18.44 02:17:03 INFO - PROCESS | 1659 | Values: 164.0 162.0 207.0 206.0 165.0 163.0 166.0 164.0 170.0 165.0 02:17:03 INFO - PROCESS | 1659 | 02:17:03 INFO - PROCESS | 1659 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.70 Median:77.00 stddev:7.65 (9.9%) stddev-sans-first:7.58 02:17:03 INFO - PROCESS | 1659 | Values: 64.0 66.0 78.0 81.0 80.0 79.0 63.0 64.0 66.0 76.0 02:17:03 INFO - PROCESS | 1659 | -------- Summary: end -------- 02:17:03 INFO - PROCESS | 1659 | 02:17:04 INFO - TEST-INFO | 1659: exit 0 02:17:04 INFO - TEST-OK | kraken | took 60324ms 02:17:04 INFO - SUITE-END | took 1180s 02:17:05 INFO - Completed test suite (00:19:40) 02:17:05 INFO - javascript benchmark 02:17:05 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7593.454044606898, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3065.1264389648954, 3377.969719235634, 3418.5043168740535, 3425.3834309824238, 3432.79403235806, 5935.792247271346, 5964.0, 5969.1344755010605, 5989.730462129204, 5997.190379298793, 5957.076653118774, 6028.065649824284, 6031.48732357749, 6049.395060493948, 6057.09143628456, 5370.91943620846, 5384.300040994665, 5407.648502847322, 5422.050537264125, 5498.477644623755, 5312.389075256337, 5318.388385335678, 5482.80810171644, 5494.313210848644, 5548.9722551387185, 5352.357717073956, 5413.621046526745, 5437.537809286216, 5467.890642187154, 5482.2873026506695, 5444.074507333743, 5488.121900495901, 5494.670319780786, 5499.230107784873, 5510.834674959738, 4485.798139083749, 5325.174597937326, 5393.703346315951, 5404.7838086476495, 5432.320959880015, 5787.739551720183, 5815.563832712522, 5816.651000939957, 5823.068309070571, 5833.212516310286, 6196.907046394308, 6218.751249949996, 6242.313345531988, 6249.375062493759, 6255.061740738925, 6308.810735677937, 6364.395382438661, 6365.3316401778075, 6376.48988080957, 6380.776672816429, 6062.696865156725, 6070.8785824283705, 6086.026235802295, 6133.693315334215, 6136.78521251763, 6248.125262463259, 6302.401271879165, 6421.743130274736, 6489.5781774184525, 6498.675066246668, 6245.781397651061, 6263.749450022039, 6268.09112678659, 6280.2777680566405, 6284.308726040132, 6357.554971152067, 6401.231852177769, 6403.743850245938, 6423.454006409414, 6435.935640643627, 6209.875802484015, 6227.906581401283, 6273.498120150377, 6337.683115844189, 6348.682565871688, 6294.118823364733, 6311.147995020705, 6321.336259692758, 6324.683765811783, 6337.2395312562785, 4600.6549508786975, 4938.234573641092, 5120.513551212629, 5138.58891288696, 5171.043356978971, 4370.562943705604, 4394.450693663292, 4581.335706322565, 4596.609288210473, 4597.954020459752, 5626.099824028218, 5978.282606087298, 5983.940160598426, 6041.942660034477, 6052.243469566304, 6349.396807303298, 6423.839404014843, 6424.486041116699, 6428.0, 6428.839279018062, 5986.970065149733, 6011.879762404727, 6012.669303188367, 6029.939700602938, 6032.125341825411, 5426.131818908955, 5487.725613719298, 5538.00315943126, 5604.579656525695, 5608.439156084359, 6567.376099270562, 6588.604683718992, 6589.80230593083, 6591.571547849375, 6593.835154121185, 6360.077788720702, 6411.102445657705, 6413.230412350548, 6421.133147025092, 6425.967870160619, 6272.874542509216, 6502.707378167899, 6586.736530538725, 6587.604743715201, 6592.0, 6210.937890621036, 6266.091416744638, 6285.96857015712, 6341.651209183539, 6342.207224096988, 4663.906721865612, 5655.688937108499, 6235.189425374853, 6239.594426362272, 6280.152179455898, 6116.908246376397, 6156.6921653918025, 6158.414950579688, 6187.319394866471, 6189.6286222826775, 6210.906836397367, 6238.15784869055, 6239.532035097477, 6241.500679945502, 6257.0, 6248.875022499616, 6256.593321434092, 6262.091996660368, 6264.561480696308, 6281.780137695341, 6118.497354392036, 6167.321594624498, 6181.53638477125, 6193.938060619336, 6208.317085120543, 6161.983272760123, 6180.752769889334, 6188.164597779242, 6198.2252218472695, 6203.131561581473], "value": 5849.873453879364, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [788.6451097006346, 806.8063664720466, 863.3567991846072, 888.9066648001964, 890.536920801183, 39188.21623567527, 40010.0, 40178.19643607126, 40238.396424053666, 40242.0, 41286.554970576035, 41314.58685413145, 41315.58684413155, 41411.58588414115, 41461.96345091374, 7216.639168041577, 9208.861867071999, 9329.72010839676, 9359.625614975394, 9393.0, 7348.412127029852, 10983.231173817836, 11162.386068766215, 11282.492287847026, 11287.604933827317, 11151.553937842476, 11157.832632510519, 11166.441677916113, 11175.832362514528, 11216.158788090885, 7312.890306645405, 11047.337159770399, 11110.388928608923, 11127.888721112766, 11174.776504469906, 7230.2046774854725, 10760.300580462323, 10948.671539853738, 11095.056920161796, 11118.888811111947, 38978.220435591415, 39153.0, 39190.41214381786, 39317.60682393168, 39326.0168495787, 3798.4682144499793, 3801.201747633, 3834.750741201841, 3850.84596616135, 3877.3214687429586, 27239.45521089587, 27671.58492622612, 28428.857855710798, 29175.270618234503, 29527.261818454495, 3098.798578092439, 3125.203073216338, 3128.9687103128904, 3134.0754477428986, 3155.842207889619, 352602.0, 359026.0, 360215.19892400893, 360694.9999999974, 361313.0, 43101.137977240905, 43489.78255108704, 52975.0, 53188.936221275355, 53260.93478130493, 57469.425305747245, 58286.834263315344, 58325.12512312319, 58353.0, 58429.41570584325, 14688.485902993558, 14769.63075923089, 14786.260686965823, 14789.704205916036, 14792.556223313102, 12694.301813400167, 12710.0, 12730.299833509062, 12731.61805145847, 12734.68163295925, 12491.812622810665, 12654.620361389174, 12674.80987785184, 12714.682132946566, 12786.0, 5410.3507579090765, 5438.83683489496, 5452.5463541406525, 5462.508374246337, 5483.643563168382, 830.9447002307036, 931.2503434734967, 942.4109931292942, 984.1142971325864, 991.6578780320777, 27655.723442765317, 28786.424271514872, 28989.0, 29296.0, 29488.0, 1036.7356324137447, 1045.6549338718205, 1046.2519298701313, 1054.130342467452, 1068.1935138970027, 14375.137491750529, 14527.346269417902, 14940.551783446514, 15106.725834841634, 15304.693906121815, 450368.0, 450949.0, 451055.0, 451103.0, 451754.0, 55829.44170558242, 55865.44134558603, 55985.600359991324, 55989.72005139948, 56046.0, 1437.360374633299, 1465.2527211122404, 1470.6029372069481, 1476.2544914818163, 1477.1137317609348, 26111.216663500127, 28232.85883570569, 28788.712112879442, 28803.0, 28885.988990385235, 47460.7626961863, 47538.0, 47551.5244847561, 47588.04823903433, 47633.04733905233, 419040.0, 420114.0, 420378.0, 420405.0, 421118.0, 28654.85672571624, 32669.346613068083, 34711.652883470844, 34804.303913922085, 35807.0, 38398.040048999, 40043.599564003984, 40820.97947551335, 41159.55941542031, 44346.0, 27390.863045684644, 28096.85951570229, 28394.574081388382, 28925.7107428923, 29024.564631530968, 24518.754812451647, 27549.760260787913, 28283.717162828932, 28461.0, 28564.0, 31861.36277274488, 32030.359392811548, 32699.673003270615, 32720.181995450304, 32945.67054329426, 27997.580036299063, 28090.0, 28162.577561337006, 28239.294017648903, 29026.419471610872, 21707.304961016907, 22606.434839129153, 22828.7964160582, 22948.4262893429, 23016.0], "value": 18627.204932223907, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [385.90159509325116, 397.9383195604681, 416.01819705495046, 417.6846480906915, 431.53825406814707, 12834.0, 14601.977861549682, 20696.586068278644, 20909.895450522727, 21207.787922120773, 21723.891380543115, 22005.0, 22279.888600557017, 22457.438564035907, 22641.320760377173, 6421.967890160543, 6467.417932386084, 6705.899411508832, 6764.0, 6775.932240677604, 4178.791060446965, 4394.296912494002, 4452.0650663360575, 6536.869262614745, 6687.899681504781, 4371.759553224571, 4393.05549306899, 4440.333949907507, 7715.537067775924, 7716.614169291541, 7618.580978046205, 7639.732609358646, 7694.076710794712, 7714.99705038347, 7715.652795624211, 7294.0, 7484.251574842527, 7493.288137626917, 7497.925020749777, 7503.587302698349, 26454.73545264542, 27154.864225678746, 27372.726272737218, 27462.17613471599, 27571.586426203623, 2869.583910333011, 2895.4932886744737, 2899.594056832045, 2933.2373582868395, 2941.3381989052505, 15378.0, 16211.108389038598, 16248.268827902655, 16509.58726031847, 16666.333346666117, 1977.9802201978084, 2079.189116244666, 2086.405374468269, 2088.1751708075226, 2088.2795435574703, 119424.40287798592, 123010.0, 145975.54024459832, 153145.70281445674, 180186.0, 18787.90606046961, 20243.291484798257, 20475.180992760124, 20685.482862928246, 20710.068046937922, 32454.864079757095, 32508.83745581257, 32917.835410823274, 33122.8343858284, 33187.83406082954, 10038.598456061822, 10133.898661013443, 10361.119304859172, 10400.063994240554, 10420.270581059252, 8675.436096653697, 8685.131486851391, 8741.388102832741, 8819.368416842904, 8835.0, 9286.767830804283, 9350.298727595458, 9409.012053734396, 9451.385659932082, 9507.904920950701, 3083.6145481814774, 3479.7216222702123, 3895.8052097395016, 3959.9010024749614, 3986.8205930732606, 1001.5142655811925, 1006.9093781559695, 1022.4683164754434, 1026.5072765072807, 1033.1424917318757, 19496.51258718515, 20857.582848343252, 20898.477538061365, 20927.790722092584, 21329.573408532055, 1012.1245122968579, 1025.8563801067855, 1039.838824982129, 1060.8514807926897, 1064.350746044912, 7739.458237923404, 10245.180385569136, 10643.574257029786, 10674.412907290174, 10752.193585480964, 747183.0, 749966.0, 750775.2461237658, 760315.0, 766096.0, 86891.0, 159612.20193898957, 162243.37756622283, 164869.0, 167299.1635041817, 1171.9648410547697, 1175.506287359311, 1213.5631172777794, 1237.6905773556612, 1237.7276999060193, 15715.842841571437, 15897.52307430779, 17835.375761848274, 18677.81322186815, 18692.0, 43969.560304396546, 47586.0, 60155.0, 60278.7944241104, 61650.07524887041, 83156.58421707853, 88605.55697221731, 89000.0, 90911.63632545384, 91940.54029730076, 10920.617778377718, 10975.945120274348, 11385.772284554097, 11423.942880285545, 11430.0, 12823.166494177849, 12891.871081289442, 13193.472261109831, 13239.536616218385, 13307.201567905957, 10175.185985121025, 10360.274780765274, 11189.832152517882, 11277.548898043986, 11497.597584084517, 8770.0, 10229.948850255701, 10310.381377117097, 10341.9482902585, 10481.737956550842, 11130.666080017612, 11167.553297867995, 11371.658850234506, 11392.886071139183, 11459.942700286445, 10746.785064298827, 11344.752077271329, 11453.484593193492, 11458.598949036743, 11718.472668730099, 9193.770155745893, 10978.451077445936, 11139.3873336964, 11342.0, 11348.432578370883], "value": 11304.112121352493, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1547.7136729705005, 1565.1782814022645, 1578.4948816378762, 1597.08965889443, 1606.2370374072316, 10494.737631559216, 11052.005319521242, 11059.72350691233, 11064.834027489595, 11075.224734268604, 9024.909750902489, 10824.350538967667, 11121.0, 11142.220044596881, 11160.218784685056, 2383.8688872111984, 2444.5844206484853, 2449.0938352809485, 2450.15469662966, 2457.2382561405934, 2290.061074959267, 2298.4139044543617, 2437.549053425113, 2439.0365805506813, 2443.3525115844227, 2350.118705485443, 2420.4432980414517, 2421.757824217582, 2425.6604075429454, 2428.441458464554, 2340.8595484270827, 2394.95210095798, 2403.8437501562344, 2414.5170965806733, 2415.4202991282054, 2376.061455724979, 2388.4148383645943, 2393.3179043972386, 2394.712634483873, 2402.8077753779658, 10849.891501085045, 11061.612843550518, 11069.723256918562, 11071.833922491169, 11112.666620001331, 5825.271841019872, 5999.220101386792, 6000.549958753111, 6008.459238668497, 6022.337542870281, 3616.65641764032, 3706.980580340401, 3725.5343082114737, 3794.8102594870147, 3797.1646237827636, 1200.7658506591217, 1215.7082300247964, 1216.7688139253514, 1264.3551788587886, 1268.2770820632243, 13736.793948090786, 14128.081674691111, 14898.702025959421, 15196.924015379964, 15593.142377169252, 4902.926456103161, 5045.672031317952, 5075.822346217865, 5079.949200508022, 5099.133147364957, 12986.480540778262, 12991.675208119683, 13017.544385946636, 13022.95816334691, 13048.54330098461, 5065.670731402447, 5249.055170069424, 5273.2617433559335, 5276.07668657991, 5284.815031473957, 4797.232442809134, 5218.321618189611, 5343.65266257692, 5355.0, 5369.24830523727, 4096.201240758023, 4144.647704945113, 4219.324908014764, 4224.577542245812, 4294.892627684333, 1153.4290526189423, 1161.1697636190165, 1164.6040346282136, 1178.4049055227056, 1185.022356555845, 922.6217250927087, 931.897491275959, 948.2603569216022, 953.1183655118987, 996.4021587047858, 6520.4131628152745, 6593.472522198213, 6749.93250067493, 6816.386525212655, 6824.18109826814, 980.6959842448864, 988.6243227573476, 1009.8131845608439, 1033.7415646088477, 1054.4727636181908, 3537.823108844599, 4079.551249362568, 4163.937540936889, 4243.766592837362, 4404.185225733249, 10599.364038157735, 13601.455941762219, 13609.0, 13641.386137623831, 13641.454341826415, 12990.610281691565, 13435.529756458476, 13452.0, 13462.0, 13560.660983475493, 9878.012198780065, 10193.949030254802, 10204.846927295948, 10205.234607404474, 10212.438315892698, 5499.560035197254, 6592.571482853599, 6617.205935287796, 6629.337066293525, 6636.0, 11839.940800295943, 12197.878021219674, 12204.511819527119, 12207.877921220674, 12217.450214740536, 12078.335691536699, 12104.878951210727, 12221.205621634565, 12340.938295308466, 12396.256224626552, 9079.863802043106, 9144.497052661902, 9178.0, 9269.536523173949, 9294.209992150472, 10062.295639305179, 10103.7474063149, 10234.539445724811, 10251.282410231212, 10314.0, 8622.741317760478, 8629.611667475105, 8656.437331573428, 8688.609012594576, 8726.040135585208, 8295.377846661404, 8467.449615774955, 8489.06620271782, 8541.615627296662, 8596.699115530926, 7749.922500775146, 7882.802929926797, 7923.286904178652, 7934.722284720007, 7944.721934732257, 5812.418758124154, 5839.124131380327, 5929.0, 5967.552433567586, 6009.429104235091, 5794.0, 5874.559408044499, 5995.820125396245, 6042.577019608585, 6096.786612468542], "value": 5171.160644821791, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.2427295854741, 374.1973466913471, 381.34218473133865, 382.3022983055924, 384.7652931711655, 5037.345145131137, 5045.672031317962, 5062.949370506294, 5068.619853510988, 5113.974430127844, 4233.936490952638, 4722.527747225276, 5007.7496125193775, 5025.296458495814, 5057.84826455206, 3342.4317865962844, 3504.5093686883856, 3588.533490646219, 4052.0087713602225, 4140.503139623234, 3632.3098611263777, 3851.691864650821, 4043.9595604043875, 4105.876823695294, 4133.483314585676, 3573.017420209437, 3613.9096522586883, 3620.330238905811, 4098.73358231714, 4167.83328666853, 3817.2938006468617, 3847.576766555677, 4040.323265844671, 4143.875683729493, 4147.983743982713, 2998.670146283907, 3353.4634458486526, 3736.6637002669618, 3744.5506539215467, 3767.303048935928, 4727.621790256771, 4779.0, 4807.326974223612, 4818.927716084261, 4852.331217830179, 3904.3557812960826, 4005.0788318686864, 4238.364245363189, 4661.601519544123, 4756.714597124149, 4638.791254393526, 4944.60443164546, 5063.721495317756, 5226.346706661668, 5259.684418934838, 3494.4408894576745, 3577.982110089433, 3652.652997965189, 3790.2608991246716, 4226.429432026698, 5219.321488206547, 5241.369667370779, 5416.539594134503, 5460.996451951411, 5467.58993075517, 3443.345764304824, 3860.6718428933855, 4197.055662475979, 4299.14017196562, 4307.310830267143, 4419.712718673276, 4437.846159998424, 4466.977665111654, 4477.350784136282, 4478.776061196927, 4160.751774467648, 4264.253755592821, 4569.246074397754, 4644.674872758875, 4729.4797572267025, 4093.9795301023305, 4824.984384759526, 4929.866130789938, 5251.76367063483, 5352.277442545284, 1332.8400591928837, 1377.2149874571398, 1439.647286414835, 1504.9314986359807, 1509.9471518497019, 1077.7575045614674, 1086.255914698434, 1138.599522587206, 1141.3266172957829, 1163.4996951311018, 4223.704340696183, 4314.762688052125, 4427.512973572904, 4890.706557606555, 4906.975465122651, 4369.880607905164, 5103.591712662978, 5197.0, 5517.668939863541, 5601.862956744236, 4137.627613514798, 4236.195122926634, 4578.624253458482, 4862.82980095695, 5011.899762004739, 2733.9589906151423, 2816.169230077132, 2847.4732174547776, 2863.4559433707527, 2871.55490898911, 5065.696058236517, 5630.915536266959, 5637.577181711388, 5646.97176514123, 5673.3475650299915, 5186.559142472856, 5431.646942948696, 5559.861003474864, 5612.576328439649, 5715.942840571541, 4950.603951683856, 5254.448282930313, 5472.972635136799, 5546.72266386671, 5563.916541251965, 4836.462250722832, 4877.6585639004925, 5097.2280512421285, 5190.169572868323, 5272.736363181749, 4877.707337559757, 4883.169861123546, 5307.946920530745, 5312.123499622674, 5483.862903427446, 5114.181730923035, 5132.435432102391, 5504.68797610308, 5653.378128405954, 5696.572757043155, 3920.9607903921737, 4193.454850869368, 4346.543612920598, 4348.7390756554705, 4370.890727731832, 4898.902021959612, 4939.629527785359, 5152.536271735412, 5226.947730522646, 5447.700376479173, 4563.885902852455, 5380.408155103014, 5396.949159319433, 5397.487238712316, 5413.323334583177, 4467.7936957020775, 5296.470352964673, 5330.188914925847, 5333.839984800462, 5350.919736203882, 4544.59098681107, 4581.587657110876, 4690.835820746394, 5079.193576111867, 5240.842774716764, 5288.8413347599635, 5363.249145119765, 5364.329458817648, 5381.48875856793, 5389.407165211902, 4427.335899615084, 4485.887852803706, 4800.423949126127, 4823.27650852375, 5046.158152274466], "value": 3999.5136633038187, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.385628359611, 730.1019745712773, 770.6570576093637, 799.5482552357918, 818.4311903227258, 14975.775363369545, 15779.842201577982, 15781.921090394546, 15823.604409889758, 15837.445689400873, 14328.0, 14343.995920285584, 14358.0, 14393.568192954228, 14994.475193368235, 921.3366376209135, 929.3633860805336, 957.4829592020301, 960.8222478841402, 975.5609975511013, 966.4394651102378, 967.1344146988441, 969.3505351414569, 969.8254314223437, 970.1898914406479, 907.0747837206046, 909.6816114359954, 911.0206527982413, 911.3666002128523, 911.9589618467152, 905.6513242401656, 905.8324210021134, 906.0169715858236, 907.188066680324, 908.0284096017264, 668.886289330815, 668.8896332105197, 669.2036476592839, 669.6183175589915, 669.6350488983467, 15645.374185032584, 15924.920375398166, 16035.759463608056, 16151.192440378052, 16416.261268242957, 13872.167669939836, 13988.72022559543, 14051.46880069858, 14109.647258818612, 14215.289235538181, 9800.411975281435, 11447.28680247123, 11610.36143012134, 11787.941060294643, 11979.580714674945, 3538.6815186633326, 3692.372296709566, 3700.111973126457, 3708.165662725892, 3832.156925476391, 84973.72539411914, 94384.52807735918, 111825.0, 114562.0, 116986.0, 10815.621453249256, 10849.457527123612, 10889.564417423215, 11077.279976801483, 11152.390472922218, 22688.773112268995, 22763.317100487013, 23095.307140785804, 23148.884255578614, 23156.88421557915, 7407.370373518203, 7664.87528186983, 7781.8832717509285, 7830.334421574116, 7836.02049743782, 3985.720999530063, 4328.523862375137, 4331.306990881444, 4356.803943822536, 4361.5856493633055, 3471.6007659119523, 3514.4025515662397, 3583.3549961006747, 3587.959491747416, 3608.260306637133, 551.2970962023452, 630.9211348581428, 633.521691123199, 640.584308677818, 643.9613623182624, 656.2813718977711, 664.35225654986, 682.7269092362995, 691.2672567078912, 728.6866647341694, 9789.657361992297, 10132.34139780912, 10216.6424175155, 10307.793844123076, 10412.32319899204, 672.9293424190488, 690.4510913823523, 692.2212510925209, 696.1854630082815, 709.3509438863485, 4809.350737650372, 4916.385451818523, 4919.3358896549225, 4932.679375840559, 4933.3586633738105, 106087.87824243472, 107355.0, 108251.91748082575, 108662.3700644491, 110937.0, 48704.512954870705, 80007.19992800114, 85856.0, 89120.0, 95742.52128739451, 69275.0, 75014.24985750072, 75033.62483187659, 76275.0, 76785.99999999888, 9394.624215031323, 10552.630657926935, 11057.557697692002, 11313.830292545454, 11343.886561134283, 46805.36181233641, 48356.79108022187, 48495.5150448491, 48546.51453485561, 49321.50678493169, 47762.0, 68697.65651171713, 69842.0, 72266.55466890738, 73905.0, 12369.690757731129, 12455.941244994277, 12521.56174533887, 12536.310502922426, 12697.492100315883, 12386.876131238572, 13965.162090274209, 13972.30138493051, 14102.506412275521, 15214.619634509227, 12867.742645146858, 13564.0, 13583.117097388638, 13747.243901585509, 14004.509842155476, 12897.290649014394, 13540.187588744313, 13600.843928265813, 13681.31593420305, 13956.302184890512, 10933.0, 12670.366481675695, 13381.66545836362, 13492.86507134916, 13526.93236533811, 9060.48574738346, 9339.719808405758, 9799.85300220483, 9808.117269445784, 10319.432431216355, 9910.40427824561, 9994.60021599157, 11093.686993144738, 11373.374464404536, 11382.772344553228], "value": 7524.320504255924, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1475.6999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 172.0, 156.0, 117.0, 165.0, 172.0, 116.0, 115.0, 113.0, 116.0], "value": 136.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 109.0, 109.0, 141.0, 110.0, 110.0, 109.0, 108.0, 127.0, 109.0], "value": 116.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 183.0, 198.0, 261.0, 203.0, 187.0, 183.0, 184.0, 186.0, 182.0], "value": 195.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 61.0, 61.0, 90.0, 56.0, 64.0, 68.0, 80.0, 95.0, 81.0], "value": 73.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 70.0, 86.0, 73.0, 95.0, 97.0, 112.0, 69.0, 68.0, 83.0], "value": 83.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 88.0, 89.0, 88.0, 88.0, 88.0, 87.0, 88.0, 88.0], "value": 87.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 98.0, 96.0, 96.0, 96.0, 98.0, 96.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 86.0, 85.0, 83.0, 86.0, 84.0, 86.0, 85.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 68.0, 65.0, 65.0, 65.0, 65.0, 63.0, 64.0], "value": 64.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 58.0, 71.0, 63.0, 63.0, 61.0, 53.0, 57.0, 58.0, 59.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 81.0, 90.0, 100.0, 98.0, 82.0, 84.0, 79.0, 85.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 136.0, 135.0, 135.0, 139.0, 152.0, 147.0, 140.0, 177.0, 148.0], "value": 144.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 207.0, 206.0, 165.0, 163.0, 166.0, 164.0, 170.0, 165.0], "value": 173.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 78.0, 81.0, 80.0, 79.0, 63.0, 64.0, 66.0, 76.0], "value": 71.7, "unit": "score"}]}]} 02:17:05 INFO - Return code: 0 02:17:05 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 02:17:05 ERROR - # TBPL SUCCESS # 02:17:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:17:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:17:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:17:05 INFO - 2017-04-04 02:17:05.265 screenresolution[1663:11164] starting screenresolution argv=screenresolution get 02:17:05 INFO - 2017-04-04 02:17:05.267 screenresolution[1663:11164] Display 0: 1600x1200x32@60 02:17:05 INFO - 2017-04-04 02:17:05.274 screenresolution[1664:11167] starting screenresolution argv=screenresolution list 02:17:05 INFO - Available Modes on Display 0 02:17:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:17:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:17:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:17:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:17:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:17:05 INFO - Intel Iris: 02:17:05 INFO - Chipset Model: Intel Iris 02:17:05 INFO - Type: GPU 02:17:05 INFO - Bus: Built-In 02:17:05 INFO - VRAM (Dynamic, Max): 1536 MB 02:17:05 INFO - Vendor: Intel (0x8086) 02:17:05 INFO - Device ID: 0x0a2e 02:17:05 INFO - Revision ID: 0x0009 02:17:05 INFO - Displays: 02:17:05 INFO - Display: 02:17:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:17:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:17:05 INFO - Display Serial Number: 1600x1200 60 02:17:05 INFO - Main Display: Yes 02:17:05 INFO - Mirror: Off 02:17:05 INFO - Online: Yes 02:17:05 INFO - Rotation: Supported 02:17:05 INFO - Return code: 0 02:17:05 INFO - Running post-action listener: _resource_record_post_action 02:17:05 INFO - [mozharness: 2017-04-04 09:17:05.520591Z] Finished run-tests step (success) 02:17:05 INFO - Running post-run listener: _resource_record_post_run 02:17:05 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 33897472; Write bytes: 509596672; Read time: 310; Write time: 1696 02:17:05 INFO - TinderboxPrint: CPU usage
53.9% 02:17:05 INFO - TinderboxPrint: I/O read bytes / time
33,897,472 / 310 02:17:05 INFO - TinderboxPrint: I/O write bytes / time
509,596,672 / 1,696 02:17:05 INFO - TinderboxPrint: CPU idle
2,217.1 (46.1%) 02:17:05 INFO - TinderboxPrint: CPU system
953.0 (19.8%) 02:17:05 INFO - TinderboxPrint: CPU user
1,635.5 (34.0%) 02:17:05 INFO - TinderboxPrint: Swap in / out
238,673,920 / 0 02:17:05 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 201810432; Write bytes: 202618880; Read time: 15979; Write time: 528 02:17:05 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 31996928; Write bytes: 296197120; Read time: 289; Write time: 1138 02:17:06 INFO - Running post-run listener: _upload_blobber_files 02:17:06 INFO - Blob upload gear active. 02:17:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:17:06 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 02:17:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 02:17:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 02:17:06 INFO - (blobuploader) - INFO - Open directory for files ... 02:17:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:17:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:17:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:17:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:17:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:17:07 INFO - (blobuploader) - INFO - Done attempting. 02:17:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:17:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:17:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:17:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:17:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:17:11 INFO - (blobuploader) - INFO - Done attempting. 02:17:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 02:17:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:17:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:17:12 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 02:17:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:17:12 INFO - (blobuploader) - INFO - Done attempting. 02:17:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 02:17:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:17:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:17:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 02:17:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:17:14 INFO - (blobuploader) - INFO - Done attempting. 02:17:14 INFO - (blobuploader) - INFO - Iteration through files over. 02:17:14 INFO - Return code: 0 02:17:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:17:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:17:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30b0087ad1e634fea7895745c0a21204c4c65ef7e19f3c128334d786b4c114b88b3e655952b00d7fc7d157f1c0a2cfaa64f6fac577367adf18c15361b6eac431", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16278927f11f8f59f5938465aa4ef9fa788dcb325c687d93c8113285249ecc9e70b7cb851edbfb5232aa7500c461f55452fde2137f9bdefe4f55a94123d4f8a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ad80d0597edde6ecbf4988ebd435ac02800dc2f013fe8ad89f79fb861b5492ba26100f699420dfe3aac88e54fe5793897003e15b61d390859c8596ca197e8aa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/29fec706fe59df55667737d9e01ab5666ce1d19dcaf64799f6107cfdce7642a8193b947114a40b8894dc66ff682cd845ad3e9e18b6a67a3c8e8862b732966985"} 02:17:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:17:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:17:14 INFO - Contents: 02:17:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30b0087ad1e634fea7895745c0a21204c4c65ef7e19f3c128334d786b4c114b88b3e655952b00d7fc7d157f1c0a2cfaa64f6fac577367adf18c15361b6eac431", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16278927f11f8f59f5938465aa4ef9fa788dcb325c687d93c8113285249ecc9e70b7cb851edbfb5232aa7500c461f55452fde2137f9bdefe4f55a94123d4f8a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ad80d0597edde6ecbf4988ebd435ac02800dc2f013fe8ad89f79fb861b5492ba26100f699420dfe3aac88e54fe5793897003e15b61d390859c8596ca197e8aa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/29fec706fe59df55667737d9e01ab5666ce1d19dcaf64799f6107cfdce7642a8193b947114a40b8894dc66ff682cd845ad3e9e18b6a67a3c8e8862b732966985"} 02:17:14 INFO - Running post-run listener: copy_logs_to_upload_dir 02:17:14 INFO - Copying logs to upload dir... 02:17:14 INFO - mkdir: /builds/slave/test/build/upload/logs 02:17:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1289.404162 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 29 secs) (at 2017-04-04 02:17:14.456262) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 02:17:14.459428) ========= 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.OtB9O85CU0/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.xP9P7WFZm9/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30b0087ad1e634fea7895745c0a21204c4c65ef7e19f3c128334d786b4c114b88b3e655952b00d7fc7d157f1c0a2cfaa64f6fac577367adf18c15361b6eac431", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16278927f11f8f59f5938465aa4ef9fa788dcb325c687d93c8113285249ecc9e70b7cb851edbfb5232aa7500c461f55452fde2137f9bdefe4f55a94123d4f8a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ad80d0597edde6ecbf4988ebd435ac02800dc2f013fe8ad89f79fb861b5492ba26100f699420dfe3aac88e54fe5793897003e15b61d390859c8596ca197e8aa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/29fec706fe59df55667737d9e01ab5666ce1d19dcaf64799f6107cfdce7642a8193b947114a40b8894dc66ff682cd845ad3e9e18b6a67a3c8e8862b732966985"} build_url:https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011266 build_url: 'https://queue.taskcluster.net/v1/task/YN55uXbUT4OKzJZ6WNERiw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/30b0087ad1e634fea7895745c0a21204c4c65ef7e19f3c128334d786b4c114b88b3e655952b00d7fc7d157f1c0a2cfaa64f6fac577367adf18c15361b6eac431", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/16278927f11f8f59f5938465aa4ef9fa788dcb325c687d93c8113285249ecc9e70b7cb851edbfb5232aa7500c461f55452fde2137f9bdefe4f55a94123d4f8a3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ad80d0597edde6ecbf4988ebd435ac02800dc2f013fe8ad89f79fb861b5492ba26100f699420dfe3aac88e54fe5793897003e15b61d390859c8596ca197e8aa", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/29fec706fe59df55667737d9e01ab5666ce1d19dcaf64799f6107cfdce7642a8193b947114a40b8894dc66ff682cd845ad3e9e18b6a67a3c8e8862b732966985"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-04 02:17:14.493531) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 02:17:14.493822) ========= 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.OtB9O85CU0/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.xP9P7WFZm9/Listeners TMPDIR=/var/folders/q8/7k0t867j72zfp6m_r1ll249m00000w/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.005675 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-04 02:17:14.545797) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 02:17:14.546702) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-04 02:17:14.547307) ========= ========= Total master_lag: 0.28 =========