builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0327 starttime: 1493908004.13 results: success (0) buildid: 20170504060419 builduid: e64faefe957e4d73ae01e5d0b44fa8b4 revision: a1f55676508b925695b531c28bb37f793a48339f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 07:26:44.134762) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-04 07:26:44.140997) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 07:26:44.141322) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-04 07:26:44.383892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 07:26:44.384344) ========= 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.1eSJ7qSo66/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.Km9oXO8QQJ/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-05-04 07:26:44-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 68.3M=0s 2017-05-04 07:26:44 (68.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.508159 ========= master_lag: 0.08 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 07:26:44.974728) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 07:26:44.975102) ========= 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.1eSJ7qSo66/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.Km9oXO8QQJ/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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.039174 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 07:26:45.054218) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 07:26:45.054631) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a1f55676508b925695b531c28bb37f793a48339f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev a1f55676508b925695b531c28bb37f793a48339f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1eSJ7qSo66/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.Km9oXO8QQJ/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-05-04 07:26:45,159 truncating revision to first 12 chars 2017-05-04 07:26:45,159 Setting DEBUG logging. 2017-05-04 07:26:45,159 attempt 1/10 2017-05-04 07:26:45,159 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/a1f55676508b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-04 07:26:46,120 unpacking tar archive at: mozilla-beta-a1f55676508b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.238357 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-04 07:26:46.320117) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 07:26:46.320910) ========= script_repo_revision: a1f55676508b925695b531c28bb37f793a48339f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-04 07:26:46.321902) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 07:26:46.322621) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-04 07:26:46.345023) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2017-05-04 07:26:46.345811) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.1eSJ7qSo66/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.Km9oXO8QQJ/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 07:26:46 INFO - MultiFileLogger online at 20170504 07:26:46 in /builds/slave/test 07:26:46 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 07:26:46 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:26:46 INFO - {'append_to_log': False, 07:26:46 INFO - 'base_work_dir': '/builds/slave/test', 07:26:46 INFO - 'blob_upload_branch': 'Mozilla-Beta', 07:26:46 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:26:46 INFO - 'branch': 'Mozilla-Beta', 07:26:46 INFO - 'buildbot_json_path': 'buildprops.json', 07:26:46 INFO - 'config_files': ('talos/mac_config.py',), 07:26:46 INFO - 'default_actions': ('clobber', 07:26:46 INFO - 'read-buildbot-config', 07:26:46 INFO - 'download-and-extract', 07:26:46 INFO - 'populate-webroot', 07:26:46 INFO - 'create-virtualenv', 07:26:46 INFO - 'install', 07:26:46 INFO - 'run-tests'), 07:26:46 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:26:46 INFO - 'download_minidump_stackwalk': True, 07:26:46 INFO - 'download_symbols': 'ondemand', 07:26:46 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:26:46 INFO - 'tooltool.py': '/tools/tooltool.py', 07:26:46 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:26:46 INFO - '/tools/misc-python/virtualenv.py')}, 07:26:46 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:26:46 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:26:46 INFO - 'gecko_profile': False, 07:26:46 INFO - 'gecko_profile_interval': 0, 07:26:46 INFO - 'installer_path': 'installer.exe', 07:26:46 INFO - 'log_level': 'info', 07:26:46 INFO - 'log_name': 'talos', 07:26:46 INFO - 'log_to_console': True, 07:26:46 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:26:46 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:26:46 INFO - 'opt_config_files': (), 07:26:46 INFO - 'pip_index': False, 07:26:46 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:26:46 INFO - 'cmd': ('bash', 07:26:46 INFO - '-c', 07:26:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:26:46 INFO - 'enabled': True, 07:26:46 INFO - 'halt_on_failure': False, 07:26:46 INFO - 'name': 'check_screen_resolution'},), 07:26:46 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:26:46 INFO - 'cmd': ('bash', 07:26:46 INFO - '-c', 07:26:46 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:26:46 INFO - 'enabled': True, 07:26:46 INFO - 'halt_on_failure': False, 07:26:46 INFO - 'name': 'check_screen_resolution'},), 07:26:46 INFO - 'run_cmd_checks_enabled': True, 07:26:46 INFO - 'suite': 'dromaeojs', 07:26:46 INFO - 'system_bits': '32', 07:26:46 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:26:46 INFO - 'title': 't-yosemite-r7-0327', 07:26:46 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:26:46 INFO - 'use_talos_json': True, 07:26:46 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:26:46 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:26:46 INFO - 'work_dir': 'build'} 07:26:46 INFO - [mozharness: 2017-05-04 14:26:46.559074Z] Running clobber step. 07:26:46 INFO - Running pre-action listener: _resource_record_pre_action 07:26:46 INFO - Running main action method: clobber 07:26:46 INFO - rmtree: /builds/slave/test/build 07:26:46 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:26:50 INFO - Running post-action listener: _resource_record_post_action 07:26:50 INFO - [mozharness: 2017-05-04 14:26:50.980285Z] Finished clobber step (success) 07:26:50 INFO - [mozharness: 2017-05-04 14:26:50.980362Z] Running read-buildbot-config step. 07:26:50 INFO - Running pre-action listener: _resource_record_pre_action 07:26:50 INFO - Running main action method: read_buildbot_config 07:26:50 INFO - Using buildbot properties: 07:26:50 INFO - { 07:26:50 INFO - "project": "", 07:26:50 INFO - "product": "firefox", 07:26:50 INFO - "script_repo_revision": "production", 07:26:50 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 07:26:50 INFO - "repository": "", 07:26:50 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 07:26:50 INFO - "buildid": "20170504060419", 07:26:50 INFO - "pgo_build": "False", 07:26:50 INFO - "basedir": "/builds/slave/test", 07:26:50 INFO - "buildnumber": 5, 07:26:50 INFO - "slavename": "t-yosemite-r7-0327", 07:26:50 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 07:26:50 INFO - "platform": "yosemite_r7", 07:26:50 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 07:26:50 INFO - "branch": "mozilla-beta", 07:26:50 INFO - "repo_path": "releases/mozilla-beta", 07:26:50 INFO - "revision": "a1f55676508b925695b531c28bb37f793a48339f", 07:26:50 INFO - "stage_platform": "macosx64", 07:26:50 INFO - "builduid": "e64faefe957e4d73ae01e5d0b44fa8b4", 07:26:50 INFO - "slavebuilddir": "test" 07:26:50 INFO - } 07:26:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/LOZxW9d9T3CaQkxhaQ3Ghg/artifacts/public/build/firefox-54.0.en-US.mac.dmg. 07:26:50 INFO - Running post-action listener: _resource_record_post_action 07:26:50 INFO - [mozharness: 2017-05-04 14:26:50.983498Z] Finished read-buildbot-config step (success) 07:26:50 INFO - [mozharness: 2017-05-04 14:26:50.983644Z] Running download-and-extract step. 07:26:50 INFO - Running pre-action listener: _resource_record_pre_action 07:26:50 INFO - Running main action method: download_and_extract 07:26:50 INFO - mkdir: /builds/slave/test/build/tests 07:26:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:26:50 INFO - trying https://queue.taskcluster.net/v1/task/LOZxW9d9T3CaQkxhaQ3Ghg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json 07:26:50 INFO - Downloading https://queue.taskcluster.net/v1/task/LOZxW9d9T3CaQkxhaQ3Ghg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 07:26:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LOZxW9d9T3CaQkxhaQ3Ghg/artifacts/public/build/firefox-54.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json'}, attempt #1 07:26:52 INFO - Downloaded 1287 bytes. 07:26:52 INFO - Reading from file /builds/slave/test/build/firefox-54.0.en-US.mac.test_packages.json 07:26:52 INFO - Using the following test package requirements: 07:26:52 INFO - {u'awsy': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:26:52 INFO - u'firefox-54.0.en-US.mac.awsy.tests.zip'], 07:26:52 INFO - u'common': [u'firefox-54.0.en-US.mac.common.tests.zip'], 07:26:52 INFO - u'cppunittest': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:26:52 INFO - u'firefox-54.0.en-US.mac.cppunittest.tests.zip'], 07:26:52 INFO - u'gtest': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:26:52 INFO - u'firefox-54.0.en-US.mac.gtest.tests.zip'], 07:26:52 INFO - u'jittest': [u'firefox-54.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 07:26:52 INFO - u'mochitest': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:26:52 INFO - u'firefox-54.0.en-US.mac.mochitest.tests.zip'], 07:26:52 INFO - u'mozbase': [u'firefox-54.0.en-US.mac.common.tests.zip'], 07:26:52 INFO - u'reftest': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:26:52 INFO - u'firefox-54.0.en-US.mac.reftest.tests.zip'], 07:26:52 INFO - u'talos': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:26:52 INFO - u'firefox-54.0.en-US.mac.talos.tests.zip'], 07:26:52 INFO - u'web-platform': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:26:52 INFO - u'firefox-54.0.en-US.mac.web-platform.tests.zip'], 07:26:52 INFO - u'xpcshell': [u'firefox-54.0.en-US.mac.common.tests.zip', 07:26:52 INFO - u'firefox-54.0.en-US.mac.xpcshell.tests.zip']} 07:26:52 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip'] for test suite category: common 07:26:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LOZxW9d9T3CaQkxhaQ3Ghg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 07:26:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LOZxW9d9T3CaQkxhaQ3Ghg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 07:26:52 INFO - Fetch https://queue.taskcluster.net/v1/task/LOZxW9d9T3CaQkxhaQ3Ghg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 07:26:53 INFO - Expected file size: 51223910 07:26:53 INFO - Obtained file size: 51223910 07:27:09 INFO - Downloading packages: [u'firefox-54.0.en-US.mac.common.tests.zip', u'firefox-54.0.en-US.mac.talos.tests.zip'] for test suite category: talos 07:27:09 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LOZxW9d9T3CaQkxhaQ3Ghg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip 07:27:09 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LOZxW9d9T3CaQkxhaQ3Ghg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip'}, attempt #1 07:27:09 INFO - Fetch https://queue.taskcluster.net/v1/task/LOZxW9d9T3CaQkxhaQ3Ghg/artifacts/public/build/firefox-54.0.en-US.mac.common.tests.zip into memory 07:27:11 INFO - Expected file size: 51223910 07:27:11 INFO - Obtained file size: 51223910 07:27:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/LOZxW9d9T3CaQkxhaQ3Ghg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip 07:27:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/LOZxW9d9T3CaQkxhaQ3Ghg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip'}, attempt #1 07:27:26 INFO - Fetch https://queue.taskcluster.net/v1/task/LOZxW9d9T3CaQkxhaQ3Ghg/artifacts/public/build/firefox-54.0.en-US.mac.talos.tests.zip into memory 07:27:27 INFO - Expected file size: 14404449 07:27:27 INFO - Obtained file size: 14404449 07:27: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')]} 07:27:27 INFO - trying https://queue.taskcluster.net/v1/task/LOZxW9d9T3CaQkxhaQ3Ghg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 07:27:27 INFO - Downloading https://queue.taskcluster.net/v1/task/LOZxW9d9T3CaQkxhaQ3Ghg/artifacts/public/build/firefox-54.0.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0.en-US.mac.dmg 07:27:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/LOZxW9d9T3CaQkxhaQ3Ghg/artifacts/public/build/firefox-54.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg'}, attempt #1 07:27:29 INFO - Downloaded 59548064 bytes. 07:27:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/LOZxW9d9T3CaQkxhaQ3Ghg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 07:27:29 INFO - mkdir: /builds/slave/test/properties 07:27:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:27:29 INFO - Writing to file /builds/slave/test/properties/build_url 07:27:29 INFO - Contents: 07:27:29 INFO - build_url:https://queue.taskcluster.net/v1/task/LOZxW9d9T3CaQkxhaQ3Ghg/artifacts/public/build/firefox-54.0.en-US.mac.dmg 07:27:30 INFO - Running post-action listener: _resource_record_post_action 07:27:30 INFO - Running post-action listener: set_extra_try_arguments 07:27:30 INFO - [mozharness: 2017-05-04 14:27:30.271591Z] Finished download-and-extract step (success) 07:27:30 INFO - [mozharness: 2017-05-04 14:27:30.271719Z] Running populate-webroot step. 07:27:30 INFO - Running pre-action listener: _resource_record_pre_action 07:27:30 INFO - Running main action method: populate_webroot 07:27:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:27:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:27:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:27:30 INFO - '--tppagecycles', 07:27:30 INFO - '7'], 07:27:30 INFO - 'tests': ['tsvgm']}}, 07:27:30 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:27:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:27:30 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:27:30 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:27:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:27:30 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:27:30 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:27:30 INFO - 'talos_options': ['--disable-e10s'], 07:27:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:27:30 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:27:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:27:30 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:27:30 INFO - 'talos_options': ['--disable-e10s'], 07:27:30 INFO - 'tests': ['damp', 'tps']}, 07:27:30 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:27:30 INFO - 'tests': ['damp', 'tps']}, 07:27:30 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:27:30 INFO - 'tests': ['dromaeo_dom']}, 07:27:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:27:30 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:27:30 INFO - 'tests': ['basic_compositor_video']}, 07:27:30 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:27:30 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:27:30 INFO - 'tests': ['a11yr', 07:27:30 INFO - 'ts_paint', 07:27:30 INFO - 'tpaint', 07:27:30 INFO - 'sessionrestore', 07:27:30 INFO - 'sessionrestore_no_auto_restore', 07:27:30 INFO - 'tabpaint']}, 07:27:30 INFO - 'other-e10s': {'tests': ['a11yr', 07:27:30 INFO - 'ts_paint', 07:27:30 INFO - 'tpaint', 07:27:30 INFO - 'sessionrestore', 07:27:30 INFO - 'sessionrestore_no_auto_restore', 07:27:30 INFO - 'tabpaint']}, 07:27:30 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:27:30 INFO - 'ts_paint', 07:27:30 INFO - 'tpaint', 07:27:30 INFO - 'sessionrestore', 07:27:30 INFO - 'sessionrestore_no_auto_restore', 07:27:30 INFO - 'tabpaint']}, 07:27:30 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:27:30 INFO - 'ts_paint', 07:27:30 INFO - 'tpaint', 07:27:30 INFO - 'sessionrestore', 07:27:30 INFO - 'sessionrestore_no_auto_restore', 07:27:30 INFO - 'tabpaint']}, 07:27:30 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:27:30 INFO - 'tests': ['a11yr', 07:27:30 INFO - 'ts_paint', 07:27:30 INFO - 'tpaint', 07:27:30 INFO - 'sessionrestore', 07:27:30 INFO - 'sessionrestore_no_auto_restore', 07:27:30 INFO - 'tabpaint']}, 07:27:30 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:27:30 INFO - 'tests': ['a11yr', 07:27:30 INFO - 'ts_paint', 07:27:30 INFO - 'tpaint', 07:27:30 INFO - 'sessionrestore', 07:27:30 INFO - 'sessionrestore_no_auto_restore', 07:27:30 INFO - 'tabpaint']}, 07:27:30 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:27:30 INFO - 'tests': ['tsvgx', 07:27:30 INFO - 'tsvgr_opacity', 07:27:30 INFO - 'tart', 07:27:30 INFO - 'tscrollx', 07:27:30 INFO - 'cart', 07:27:30 INFO - 'tsvg_static']}, 07:27:30 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:27:30 INFO - 'tsvgr_opacity', 07:27:30 INFO - 'tart', 07:27:30 INFO - 'tscrollx', 07:27:30 INFO - 'cart', 07:27:30 INFO - 'tsvg_static']}, 07:27:30 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:27:30 INFO - 'talos_options': ['--disable-e10s'], 07:27:30 INFO - 'tests': ['tp5o']}, 07:27:30 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:27:30 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:27:30 INFO - 'talos_options': ['--disable-e10s', 07:27:30 INFO - '--xperf_path', 07:27:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:27:30 INFO - 'tests': ['tp5n']}, 07:27:30 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:27:30 INFO - 'talos_options': ['--xperf_path', 07:27:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:27:30 INFO - 'tests': ['tp5n']}}, 07:27:30 INFO - 'talos.zip': {'path': '', 07:27:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:27:30 INFO - Running post-action listener: _resource_record_post_action 07:27:30 INFO - [mozharness: 2017-05-04 14:27:30.290133Z] Finished populate-webroot step (success) 07:27:30 INFO - [mozharness: 2017-05-04 14:27:30.290276Z] Running create-virtualenv step. 07:27:30 INFO - Running pre-action listener: _resource_record_pre_action 07:27:30 INFO - Running main action method: create_virtualenv 07:27:30 INFO - Creating virtualenv /builds/slave/test/build/venv 07:27: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 07:27:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:27:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:27:30 INFO - Using real prefix '/tools/python27' 07:27:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:27:31 INFO - Installing distribute.............................................................................................................................................................................................done. 07:27:33 INFO - Installing pip.................done. 07:27:33 INFO - Return code: 0 07:27:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:27:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:27:34 INFO - Reading from file tmpfile_stdout 07:27:34 INFO - Output received: 07:27: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) 07:27:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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 0x10c7bab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7bd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8193c8ac80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c598d30>, '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 0x10c4bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c58dbe8>, '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.1eSJ7qSo66/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.Km9oXO8QQJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:27: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 07:27: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 07:27:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1eSJ7qSo66/Render', 07:27:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:27:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:27:34 INFO - 'HOME': '/Users/cltbld', 07:27:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:27:34 INFO - 'LOGNAME': 'cltbld', 07:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:34 INFO - 'MOZ_NO_REMOTE': '1', 07:27:34 INFO - 'NO_EM_RESTART': '1', 07:27:34 INFO - 'PAGER': '/bin/cat', 07:27:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:34 INFO - 'PWD': '/builds/slave/test', 07:27:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:27:34 INFO - 'SHELL': '/bin/bash', 07:27:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Km9oXO8QQJ/Listeners', 07:27:34 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 07:27:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:27:34 INFO - 'USER': 'cltbld', 07:27:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:27:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:34 INFO - 'XPC_FLAGS': '0x0', 07:27:34 INFO - 'XPC_SERVICE_NAME': '0', 07:27:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27: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 07:27:34 INFO - Cleaning up... 07:27:34 INFO - Return code: 0 07:27:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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 0x10c7bab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7bd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8193c8ac80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c598d30>, '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 0x10c4bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c58dbe8>, '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.1eSJ7qSo66/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.Km9oXO8QQJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:27: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 07:27: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 07:27:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1eSJ7qSo66/Render', 07:27:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:27:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:27:34 INFO - 'HOME': '/Users/cltbld', 07:27:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:27:34 INFO - 'LOGNAME': 'cltbld', 07:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:34 INFO - 'MOZ_NO_REMOTE': '1', 07:27:34 INFO - 'NO_EM_RESTART': '1', 07:27:34 INFO - 'PAGER': '/bin/cat', 07:27:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:34 INFO - 'PWD': '/builds/slave/test', 07:27:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:27:34 INFO - 'SHELL': '/bin/bash', 07:27:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Km9oXO8QQJ/Listeners', 07:27:34 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 07:27:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:27:34 INFO - 'USER': 'cltbld', 07:27:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:27:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:34 INFO - 'XPC_FLAGS': '0x0', 07:27:34 INFO - 'XPC_SERVICE_NAME': '0', 07:27:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:34 INFO - Downloading/unpacking psutil>=3.1.1 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:27:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:27:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:27:37 INFO - Installing collected packages: psutil 07:27:37 INFO - Running setup.py install for psutil 07:27:37 INFO - building 'psutil._psutil_osx' extension 07:27:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 07:27:37 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 07:27:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 07:27:38 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 07:27:38 INFO - building 'psutil._psutil_posix' extension 07:27:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 07:27:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:27:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:27:38 INFO - ^ 07:27:38 INFO - 1 warning generated. 07:27:38 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 07:27:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:27:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:27:38 INFO - Successfully installed psutil 07:27:38 INFO - Cleaning up... 07:27:38 INFO - Return code: 0 07:27:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:38 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 0x10c7bab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7bd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8193c8ac80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c598d30>, '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 0x10c4bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c58dbe8>, '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.1eSJ7qSo66/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.Km9oXO8QQJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:27:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:27:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 07:27:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1eSJ7qSo66/Render', 07:27:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:27:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:27:38 INFO - 'HOME': '/Users/cltbld', 07:27:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:27:38 INFO - 'LOGNAME': 'cltbld', 07:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:38 INFO - 'MOZ_NO_REMOTE': '1', 07:27:38 INFO - 'NO_EM_RESTART': '1', 07:27:38 INFO - 'PAGER': '/bin/cat', 07:27:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:38 INFO - 'PWD': '/builds/slave/test', 07:27:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:27:38 INFO - 'SHELL': '/bin/bash', 07:27:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Km9oXO8QQJ/Listeners', 07:27:38 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 07:27:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:27:38 INFO - 'USER': 'cltbld', 07:27:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:27:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:38 INFO - 'XPC_FLAGS': '0x0', 07:27:38 INFO - 'XPC_SERVICE_NAME': '0', 07:27:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:27:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:27:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:27:40 INFO - Installing collected packages: mozsystemmonitor 07:27:40 INFO - Running setup.py install for mozsystemmonitor 07:27:40 INFO - Successfully installed mozsystemmonitor 07:27:40 INFO - Cleaning up... 07:27:40 INFO - Return code: 0 07:27:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:27: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')]} 07:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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')]} 07:27:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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', '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 0x10c7bab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7bd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8193c8ac80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c598d30>, '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 0x10c4bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c58dbe8>, '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.1eSJ7qSo66/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.Km9oXO8QQJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:27: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:27: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 jsonschema==2.5.1 07:27:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1eSJ7qSo66/Render', 07:27:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:27:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:27:40 INFO - 'HOME': '/Users/cltbld', 07:27:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:27:40 INFO - 'LOGNAME': 'cltbld', 07:27:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:40 INFO - 'MOZ_NO_REMOTE': '1', 07:27:40 INFO - 'NO_EM_RESTART': '1', 07:27:40 INFO - 'PAGER': '/bin/cat', 07:27:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:27:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:40 INFO - 'PWD': '/builds/slave/test', 07:27:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:27:40 INFO - 'SHELL': '/bin/bash', 07:27:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Km9oXO8QQJ/Listeners', 07:27:40 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 07:27:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:27:40 INFO - 'USER': 'cltbld', 07:27:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:27:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:27:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:40 INFO - 'XPC_FLAGS': '0x0', 07:27:40 INFO - 'XPC_SERVICE_NAME': '0', 07:27:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:27:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:40 INFO - Downloading/unpacking jsonschema==2.5.1 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27:41 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:27:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:42 INFO - Downloading functools32-3.2.3-2.tar.gz 07:27:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:27:42 INFO - warning: no files found matching '*.txt' 07:27:42 INFO - no previously-included directories found matching 'build' 07:27:42 INFO - no previously-included directories found matching 'dist' 07:27:42 INFO - no previously-included directories found matching '.git*' 07:27:42 INFO - Installing collected packages: jsonschema, functools32 07:27:42 INFO - Running setup.py install for functools32 07:27:42 INFO - warning: no files found matching '*.txt' 07:27:42 INFO - no previously-included directories found matching 'build' 07:27:42 INFO - no previously-included directories found matching 'dist' 07:27:42 INFO - no previously-included directories found matching '.git*' 07:27:42 INFO - Successfully installed jsonschema functools32 07:27:42 INFO - Cleaning up... 07:27:42 INFO - Return code: 0 07:27:42 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c7bab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7bd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8193c8ac80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c598d30>, '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 0x10c4bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c58dbe8>, '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.1eSJ7qSo66/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.Km9oXO8QQJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:27:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 07:27:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 07:27:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1eSJ7qSo66/Render', 07:27:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:27:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:27:42 INFO - 'HOME': '/Users/cltbld', 07:27:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:27:42 INFO - 'LOGNAME': 'cltbld', 07:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:42 INFO - 'MOZ_NO_REMOTE': '1', 07:27:42 INFO - 'NO_EM_RESTART': '1', 07:27:42 INFO - 'PAGER': '/bin/cat', 07:27:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:42 INFO - 'PWD': '/builds/slave/test', 07:27:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:27:42 INFO - 'SHELL': '/bin/bash', 07:27:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Km9oXO8QQJ/Listeners', 07:27:42 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 07:27:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:27:42 INFO - 'USER': 'cltbld', 07:27:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:27:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:42 INFO - 'XPC_FLAGS': '0x0', 07:27:42 INFO - 'XPC_SERVICE_NAME': '0', 07:27:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:27:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:42 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:27:42 INFO - Cleaning up... 07:27:42 INFO - Return code: 0 07:27:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10c7bab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7bd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8193c8ac80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c598d30>, '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 0x10c4bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c58dbe8>, '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.1eSJ7qSo66/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.Km9oXO8QQJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:27:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:27:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:27:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1eSJ7qSo66/Render', 07:27:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:27:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:27:42 INFO - 'HOME': '/Users/cltbld', 07:27:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:27:42 INFO - 'LOGNAME': 'cltbld', 07:27:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:42 INFO - 'MOZ_NO_REMOTE': '1', 07:27:42 INFO - 'NO_EM_RESTART': '1', 07:27:42 INFO - 'PAGER': '/bin/cat', 07:27:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:27:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:42 INFO - 'PWD': '/builds/slave/test', 07:27:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:27:42 INFO - 'SHELL': '/bin/bash', 07:27:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Km9oXO8QQJ/Listeners', 07:27:42 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 07:27:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:27:42 INFO - 'USER': 'cltbld', 07:27:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:27:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:27:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:42 INFO - 'XPC_FLAGS': '0x0', 07:27:42 INFO - 'XPC_SERVICE_NAME': '0', 07:27:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:43 INFO - Downloading/unpacking blobuploader==1.2.4 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27:45 INFO - Downloading blobuploader-1.2.4.tar.gz 07:27:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:27:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:27:46 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27: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 07:27:46 INFO - Downloading docopt-0.6.1.tar.gz 07:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:27:46 INFO - Installing collected packages: blobuploader, requests, docopt 07:27:46 INFO - Running setup.py install for blobuploader 07:27:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:27:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:27:46 INFO - Running setup.py install for requests 07:27:47 INFO - Running setup.py install for docopt 07:27:47 INFO - Successfully installed blobuploader requests docopt 07:27:47 INFO - Cleaning up... 07:27:47 INFO - Return code: 0 07:27:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:27: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')]} 07:27:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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')]} 07:27:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:47 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 0x10c7bab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7bd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8193c8ac80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c598d30>, '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 0x10c4bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c58dbe8>, '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.1eSJ7qSo66/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.Km9oXO8QQJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:27:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:27:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:27:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1eSJ7qSo66/Render', 07:27:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:27:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:27:47 INFO - 'HOME': '/Users/cltbld', 07:27:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:27:47 INFO - 'LOGNAME': 'cltbld', 07:27:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:47 INFO - 'MOZ_NO_REMOTE': '1', 07:27:47 INFO - 'NO_EM_RESTART': '1', 07:27:47 INFO - 'PAGER': '/bin/cat', 07:27:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:27:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:47 INFO - 'PWD': '/builds/slave/test', 07:27:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:27:47 INFO - 'SHELL': '/bin/bash', 07:27:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Km9oXO8QQJ/Listeners', 07:27:47 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 07:27:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:27:47 INFO - 'USER': 'cltbld', 07:27:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:27:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:27:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:47 INFO - 'XPC_FLAGS': '0x0', 07:27:47 INFO - 'XPC_SERVICE_NAME': '0', 07:27:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:27:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:27:47 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-PO0rVD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:27:47 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-JOMoMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:27:47 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-vJQQ1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:27:47 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-3zU3yf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:27:47 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-5tqBGN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:27:48 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-nLxmBu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:27:48 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-VRmyXo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:27:48 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-XS3NT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:27:48 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-8yzSNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:27:48 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-SGXznQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:27:48 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-_NMALN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:27:48 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-v3GOrC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:27:48 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-w0hPnN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:27:48 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-dKbAeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:27:48 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-F3SdWs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:27:49 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-UWrTXZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:27:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:27:49 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-rcymho-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:27:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:27:49 INFO - Running setup.py install for manifestparser 07:27:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:27:49 INFO - Running setup.py install for mozcrash 07:27:49 INFO - Running setup.py install for mozdebug 07:27:49 INFO - Running setup.py install for mozdevice 07:27:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:27:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:27:49 INFO - Running setup.py install for mozfile 07:27:50 INFO - Running setup.py install for mozhttpd 07:27:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:27:50 INFO - Running setup.py install for mozinfo 07:27:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:27:50 INFO - Running setup.py install for mozInstall 07:27:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:27:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:27:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:27:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:27:50 INFO - Running setup.py install for mozleak 07:27:50 INFO - Running setup.py install for mozlog 07:27:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:27:50 INFO - Running setup.py install for moznetwork 07:27:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:27:50 INFO - Running setup.py install for mozprocess 07:27:51 INFO - Running setup.py install for mozprofile 07:27:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:27:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:27:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:27:51 INFO - Running setup.py install for mozrunner 07:27:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:27:51 INFO - Running setup.py install for mozscreenshot 07:27:51 INFO - Running setup.py install for moztest 07:27:51 INFO - Running setup.py install for mozversion 07:27:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:27:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:27:51 INFO - Cleaning up... 07:27:51 INFO - Return code: 0 07:27:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:27:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:51 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 0x10c7bab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7bd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8193c8ac80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c598d30>, '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 0x10c4bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c58dbe8>, '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.1eSJ7qSo66/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.Km9oXO8QQJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:27:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 07:27:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:27:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1eSJ7qSo66/Render', 07:27:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:27:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:27:51 INFO - 'HOME': '/Users/cltbld', 07:27:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:27:51 INFO - 'LOGNAME': 'cltbld', 07:27:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:51 INFO - 'MOZ_NO_REMOTE': '1', 07:27:51 INFO - 'NO_EM_RESTART': '1', 07:27:51 INFO - 'PAGER': '/bin/cat', 07:27:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:27:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:51 INFO - 'PWD': '/builds/slave/test', 07:27:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:27:51 INFO - 'SHELL': '/bin/bash', 07:27:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Km9oXO8QQJ/Listeners', 07:27:51 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 07:27:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:27:51 INFO - 'USER': 'cltbld', 07:27:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:27:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:27:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:51 INFO - 'XPC_FLAGS': '0x0', 07:27:51 INFO - 'XPC_SERVICE_NAME': '0', 07:27:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:27:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:27:52 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-yDkFjK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:27:52 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-zPkUWm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:27:52 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-clqYZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:27:52 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-EBs2ZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:27:52 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-I89mdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:27:52 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-tYLz3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:27:52 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-JR0Lv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:27:52 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-yOeerV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:27:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:27:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:27:52 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-pXgaN7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:27:53 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-zZGKtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:27:53 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-KFV8MK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:27:53 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-HgP1h5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:27:53 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-uxp9O4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 07:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:27:53 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-8OXlZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:27:53 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-rxsTZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:27:53 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-_gCr5K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:27:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:27:53 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-is8hWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 07:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:27:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 07:27:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:27:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:27:56 INFO - Downloading blessings-1.6.tar.gz 07:27:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:27:56 INFO - Installing collected packages: blessings 07:27:56 INFO - Running setup.py install for blessings 07:27:56 INFO - Successfully installed blessings 07:27:56 INFO - Cleaning up... 07:27:56 INFO - Return code: 0 07:27:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:27:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:27:56 INFO - Reading from file tmpfile_stdout 07:27:56 INFO - Current package versions: 07:27:56 INFO - blessings == 1.6 07:27:56 INFO - blobuploader == 1.2.4 07:27:56 INFO - docopt == 0.6.1 07:27:56 INFO - functools32 == 3.2.3-2 07:27:56 INFO - jsonschema == 2.5.1 07:27:56 INFO - manifestparser == 1.1 07:27:56 INFO - mozInstall == 1.12 07:27:56 INFO - mozcrash == 1.0 07:27:56 INFO - mozdebug == 0.1 07:27:56 INFO - mozdevice == 0.49 07:27:56 INFO - mozfile == 1.2 07:27:56 INFO - mozhttpd == 0.7 07:27:56 INFO - mozinfo == 0.9 07:27:56 INFO - mozleak == 0.1 07:27:56 INFO - mozlog == 3.4 07:27:56 INFO - moznetwork == 0.27 07:27:56 INFO - mozprocess == 0.25 07:27:56 INFO - mozprofile == 0.28 07:27:56 INFO - mozrunner == 6.13 07:27:56 INFO - mozscreenshot == 0.1 07:27:56 INFO - mozsystemmonitor == 0.3 07:27:56 INFO - moztest == 0.8 07:27:56 INFO - mozversion == 1.4 07:27:56 INFO - psutil == 3.1.1 07:27:56 INFO - requests == 1.2.3 07:27:56 INFO - wsgiref == 0.1.2 07:27:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:27:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:56 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 0x10c7bab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7bd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8193c8ac80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c598d30>, '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 0x10c4bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c58dbe8>, '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.1eSJ7qSo66/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.Km9oXO8QQJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:27:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 07:27:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 07:27:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1eSJ7qSo66/Render', 07:27:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:27:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:27:56 INFO - 'HOME': '/Users/cltbld', 07:27:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:27:56 INFO - 'LOGNAME': 'cltbld', 07:27:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:56 INFO - 'MOZ_NO_REMOTE': '1', 07:27:56 INFO - 'NO_EM_RESTART': '1', 07:27:56 INFO - 'PAGER': '/bin/cat', 07:27:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:27:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:56 INFO - 'PWD': '/builds/slave/test', 07:27:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:27:56 INFO - 'SHELL': '/bin/bash', 07:27:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Km9oXO8QQJ/Listeners', 07:27:56 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 07:27:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:27:56 INFO - 'USER': 'cltbld', 07:27:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:27:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:27:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:56 INFO - 'XPC_FLAGS': '0x0', 07:27:56 INFO - 'XPC_SERVICE_NAME': '0', 07:27:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 07:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 07:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 07:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 07:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 07:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 07:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 07:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 07:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 07:27:57 INFO - Cleaning up... 07:27:57 INFO - Return code: 0 07:27:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:27: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')]} 07:27:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:27:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27: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')]} 07:27:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:27:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:27:57 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 0x10c7bab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c7bd768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8193c8ac80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10c598d30>, '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 0x10c4bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c58dbe8>, '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.1eSJ7qSo66/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.Km9oXO8QQJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 07:27:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:27:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1eSJ7qSo66/Render', 07:27:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:27:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:27:57 INFO - 'HOME': '/Users/cltbld', 07:27:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:27:57 INFO - 'LOGNAME': 'cltbld', 07:27:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:27:57 INFO - 'MOZ_NO_REMOTE': '1', 07:27:57 INFO - 'NO_EM_RESTART': '1', 07:27:57 INFO - 'PAGER': '/bin/cat', 07:27:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:27:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:27:57 INFO - 'PWD': '/builds/slave/test', 07:27:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:27:57 INFO - 'SHELL': '/bin/bash', 07:27:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Km9oXO8QQJ/Listeners', 07:27:57 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 07:27:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:27:57 INFO - 'USER': 'cltbld', 07:27:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:27:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:27:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:27:57 INFO - 'XPC_FLAGS': '0x0', 07:27:57 INFO - 'XPC_SERVICE_NAME': '0', 07:27:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:27:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:27:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:27:57 INFO - Cleaning up... 07:27:57 INFO - Return code: 0 07:27:57 INFO - Running post-action listener: _resource_record_post_action 07:27:57 INFO - Running post-action listener: _start_resource_monitoring 07:27:57 INFO - Starting resource monitoring. 07:27:57 INFO - [mozharness: 2017-05-04 14:27:57.373378Z] Finished create-virtualenv step (success) 07:27:57 INFO - [mozharness: 2017-05-04 14:27:57.374455Z] Running install step. 07:27:57 INFO - Running pre-action listener: _resource_record_pre_action 07:27:57 INFO - Running main action method: install 07:27:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:27:57 INFO - Reading from file tmpfile_stdout 07:27:57 INFO - Detecting whether we're running mozinstall >=1.0... 07:27:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:27:57 INFO - Reading from file tmpfile_stdout 07:27:57 INFO - Output received: 07:27:57 INFO - Usage: mozinstall [options] installer 07:27:57 INFO - Options: 07:27:57 INFO - -h, --help show this help message and exit 07:27:57 INFO - -d DEST, --destination=DEST 07:27:57 INFO - Directory to install application into. [default: 07:27:57 INFO - "/builds/slave/test"] 07:27:57 INFO - --app=APP Application being installed. [default: firefox] 07:27:57 INFO - mkdir: /builds/slave/test/build/application 07:27:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 07:27:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0.en-US.mac.dmg --destination /builds/slave/test/build/application 07:28:12 INFO - Reading from file tmpfile_stdout 07:28:12 INFO - Output received: 07:28:12 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 07:28:12 INFO - Running post-action listener: _resource_record_post_action 07:28:12 INFO - [mozharness: 2017-05-04 14:28:12.730793Z] Finished install step (success) 07:28:12 INFO - [mozharness: 2017-05-04 14:28:12.730928Z] Running run-tests step. 07:28:12 INFO - Running pre-action listener: _resource_record_pre_action 07:28:12 INFO - Running main action method: run_tests 07:28:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:28:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:28:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:28:12 INFO - 2017-05-04 07:28:12.744 screenresolution[1629:11307] starting screenresolution argv=screenresolution get 07:28:12 INFO - 2017-05-04 07:28:12.747 screenresolution[1629:11307] Display 0: 1600x1200x32@60 07:28:12 INFO - 2017-05-04 07:28:12.753 screenresolution[1630:11309] starting screenresolution argv=screenresolution list 07:28:12 INFO - Available Modes on Display 0 07:28:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:28:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:28:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:28:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:28:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:28:12 INFO - Intel Iris: 07:28:12 INFO - Chipset Model: Intel Iris 07:28:12 INFO - Type: GPU 07:28:12 INFO - Bus: Built-In 07:28:12 INFO - VRAM (Dynamic, Max): 1536 MB 07:28:12 INFO - Vendor: Intel (0x8086) 07:28:12 INFO - Device ID: 0x0a2e 07:28:12 INFO - Revision ID: 0x0009 07:28:12 INFO - Displays: 07:28:12 INFO - Display: 07:28:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:28:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:28:12 INFO - Display Serial Number: 1600x1200 60 07:28:12 INFO - Main Display: Yes 07:28:12 INFO - Mirror: Off 07:28:12 INFO - Online: Yes 07:28:12 INFO - Rotation: Supported 07:28:12 INFO - Return code: 0 07:28:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:28:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:28:12 INFO - Python 2.7.3 07:28:12 INFO - Return code: 0 07:28:12 INFO - grabbing minidump binary from tooltool 07:28:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:28:12 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 0x10c598d30>, '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 0x10c4bfdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10c58dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:28:12 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:28:12 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 07:28:12 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 07:28:13 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:28:13 INFO - Return code: 0 07:28:13 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:28:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:28:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:28:13 INFO - ENV: RUST_BACKTRACE is now 1 07:28:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:28:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:28:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LOZxW9d9T3CaQkxhaQ3Ghg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0327', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:28:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/LOZxW9d9T3CaQkxhaQ3Ghg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0327 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:28:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.1eSJ7qSo66/Render', 07:28:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:28:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:28:13 INFO - 'HOME': '/Users/cltbld', 07:28:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:28:13 INFO - 'LOGNAME': 'cltbld', 07:28:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:28:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:28:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:28:13 INFO - 'MOZ_NO_REMOTE': '1', 07:28:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:28:13 INFO - 'NO_EM_RESTART': '1', 07:28:13 INFO - 'PAGER': '/bin/cat', 07:28:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:28:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:28:13 INFO - 'PWD': '/builds/slave/test', 07:28:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:28:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:28:13 INFO - 'RUST_BACKTRACE': '1', 07:28:13 INFO - 'SHELL': '/bin/bash', 07:28:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Km9oXO8QQJ/Listeners', 07:28:13 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 07:28:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:28:13 INFO - 'USER': 'cltbld', 07:28:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:28:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:28:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:28:13 INFO - 'XPC_FLAGS': '0x0', 07:28:13 INFO - 'XPC_SERVICE_NAME': '0', 07:28:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:28:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/LOZxW9d9T3CaQkxhaQ3Ghg/artifacts/public/build/firefox-54.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0327', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:28:13 INFO - mozversion application_buildid: 20170504060419 07:28:13 INFO - mozversion application_changeset: a1f55676508b925695b531c28bb37f793a48339f 07:28:13 INFO - mozversion application_display_name: Firefox 07:28:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:28:13 INFO - mozversion application_name: Firefox 07:28:13 INFO - mozversion application_remotingname: firefox 07:28:13 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 07:28:13 INFO - mozversion application_vendor: Mozilla 07:28:13 INFO - mozversion application_version: 54.0 07:28:13 INFO - mozversion platform_buildid: 20170504060419 07:28:13 INFO - mozversion platform_changeset: a1f55676508b925695b531c28bb37f793a48339f 07:28:13 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 07:28:13 INFO - mozversion platform_version: 54.0 07:28:13 INFO - using testdate: 1493908093 07:28:13 INFO - actual date: 1493908093 07:28:13 INFO - starting webserver on 'localhost:49239' 07:28:13 INFO - SUITE-START | Running 2 tests 07:28:13 INFO - TEST-START | dromaeo_css 07:28:13 INFO - operating with platform_type : mac_ 07:28:13 INFO - Initialising browser for dromaeo_css test... 07:28:13 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/tmpJdbuYO/profile http://localhost:49239/getInfo.html) 07:28:15 INFO - PROCESS | 1640 | __metrics Screen width/height:1600/1200 07:28:15 INFO - PROCESS | 1640 | colorDepth:24 07:28:15 INFO - PROCESS | 1640 | Browser inner width/height: 1024/689 07:28:15 INFO - PROCESS | 1640 | __metrics 07:28:15 INFO - PROCESS | 1640 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:28:15 INFO - PROCESS | 1640 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:28:16 INFO - TEST-INFO | 1640: exit 0 07:28:16 INFO - Browser initialized. 07:28:16 INFO - Running cycle 1/1 for dromaeo_css test... 07:28:16 INFO - TEST-INFO | started process 1644 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/tmpJdbuYO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:28:28 INFO - PROCESS | 1644 | RSS: Main: 165277696 07:28:28 INFO - PROCESS | 1644 | 07:31:32 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49239/tests/dromaeo/cssquery-ext.html) 07:31:34 INFO - PROCESS | 1644 | RSS: Main: 384729088 07:31:34 INFO - PROCESS | 1644 | 07:34:37 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-ext.html (next: http://localhost:49239/tests/dromaeo/cssquery-jquery.html) 07:34:38 INFO - PROCESS | 1644 | RSS: Main: 304533504 07:34:38 INFO - PROCESS | 1644 | 07:37:40 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49239/tests/dromaeo/cssquery-mootools.html) 07:37:41 INFO - PROCESS | 1644 | RSS: Main: 295960576 07:37:41 INFO - PROCESS | 1644 | 07:40:43 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49239/tests/dromaeo/cssquery-prototype.html) 07:40:44 INFO - PROCESS | 1644 | RSS: Main: 281169920 07:40:44 INFO - PROCESS | 1644 | 07:43:47 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49239/tests/dromaeo/cssquery-yui.html) 07:43:48 INFO - PROCESS | 1644 | RSS: Main: 263020544 07:43:48 INFO - PROCESS | 1644 | 07:46:51 INFO - PROCESS | 1644 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-yui.html (next: http://localhost:49239/tests/dromaeo/cssquery-dojo.html) 07:46:51 INFO - PROCESS | 1644 | RSS: Main: 524537856 07:46:51 INFO - PROCESS | 1644 | 07:46:51 INFO - PROCESS | 1644 | __start_tp_report 07:46:51 INFO - PROCESS | 1644 | _x_x_mozilla_page_load 07:46:51 INFO - PROCESS | 1644 | _x_x_mozilla_page_load_details 07:46:51 INFO - PROCESS | 1644 | |i|pagename|runs| 07:46:51 INFO - PROCESS | 1644 | |0;dojo.html;3116.8285744284067;3559.336401669467;3570.357335679577;3588.8923332300005;3627.9455808162884;6152.323244443113;6218.16054832598;6227.688615569215;6238.282597501288;6238.6256824590555;6201.751929922809;6227.034809604518;6248.562600617958;6280.748770049204;6282.717277722502;5582.49757521823;5596.524295434893;5646.576506761989;5665.490105890469;5736.196932429463;5497.312835895513;5507.366652834915;5518.834434966958;5705.65766054036;5714.114312281603;5585.134304182858;5612.298462692163;5621.353544342412;5625.437456254363;5626.184203290521;5595.720213989304;5604.467575580314;5608.943910560883;5624.437556244384;5632.239647647597;5458.263134476874;5576.721163941827;5579.358373787026;5583.6928968906695;5619.7471113799975;6207.658578778165;6215.968920155416;6227.501799856046;6237.126802247689;6244.812655620339;6403.167588213549;6414.775482858125;6431.970884658479;6432.90350644736;6468.74125034998;6684.064231007663;6712.328767123297;6732.057511948331;6735.8989615155815;6738.494612904003;6275.18422605063;6307.432331090178;6310.053491976194;6338.556301058928;6338.683065846689;6487.870242595121;6523.956167013255;6785.491088168407;6833.658317084225;6835.760748373783;6290.622562646165;6293.087502312139;6322.652254125976;6331.556791024676;6370;6490;6493.967530162414;6498.220213574401;6502.772402965874;6504.05691174777;6263.812085637438;6410.711517981609;6426.2931077581425;6442.35576442352;6450.741970321228;6264.812055638338;6304.243490781044;6419.807405777834;6484.351564843572;6516.315786842408;5334.039872822929;5345.786168553292;5347.331583552056;5348.839534813962;5388.515033646991;3960.980195099006;4349.521552629209;4745.335653008581;4752.263399173134;4752.833650822274;6105.816825495153;6132.306126318567;6163.260408750889;6193.81418557444;6250.0937364082865;6461.289258181596;6492.577982431127;6493.285738568754;6517.576357536745;6565.540412171103;6240.31356550779;6261.373862613702;6261.467775239155;6272.8118156455375;6274.435300822948;5751.424857514216;5808.593398462067;5812.505936995402;5814.3313518945015;5859.53123750099;6543.901841472477;6607.372299631527;6759;6808.319168083152;6831.965840170867;6657.367550082734;6670.466362691071;6689.431398331197;6700.128983232149;6706.429953454011;6804.183497980274;6850.794476165723;6855.383015528427;6857.074294970115;6865.27914568963;6267.717952692049;6311.053341998737;6540.149780528501;6543.0185472179555;6555.901661475177;6426.646534440651;6440.484761219185;6443.516736244706;6451.741930322734;6460.192475940507;6326.3041065483685;6340.048992651139;6354.586951848115;6446.967765161145;6467;5411.78234897145;6415.967920160369;6432.742690292336;6467.256265529524;6468.5472016958365;5964.880702385841;6321.873562528632;6329.145565348803;6332.461740751904;6337.96831015842;6270.905936410866;6303.054541818764;6343;6346.270178929482;6443.96778016107;6173.259208894961;6241.188645476059;6323.08315294289;6363.236411630634;6372.012338087604 07:46:51 INFO - PROCESS | 1644 | |1;ext.html;787.9527228366296;795.5385876191809;902.5532361481067;909.6270529083077;987.2052997337149;39439.0140246494;40066.599334006685;40202.1959560809;42117.7894110529;42301.94245143873;40061.79969100158;40193.59806401935;40314;40350;40380.19239615206;7853.685852565891;7976.322012628933;8214;8347.29048030918;8351.707690230844;11781.587644432446;11962.983146432563;12331.630051098482;12346.876531234662;12368.938155309255;11963.342016189106;12058.397080146002;12068.336241506713;12096.395180240952;12102.878971210263;12018.939905300505;12071.275723456622;12073.637790866289;12098.153129280954;12098.576549820802;11573.305601663842;11624.128190385754;11635.301881887113;11639.127065470038;11642.883571164264;41693.583064169274;41869.95325116866;41921.53274635373;41945.790271048754;41972.37041444381;3964.980175099106;4003.899902502432;4013.7391069580385;4024.2957482440747;4042.6765858731233;28650.570241446396;28745.281367965967;30052.8497357514;30586.847065764752;31101.688983110333;3174.5238214268043;3295.340931813623;3334.583177102862;3359.7144242739396;3386.3565922474895;339572;342259;342510;342993;343242;45381.77309113499;46012.079758404645;53849.461505385225;54000.729996349764;54221;53884.730576347654;53892.461075389525;57727.71136144376;57730.422695772504;57762.422375775706;15690.137042462775;15765.054096754231;15770;15853.207339632972;15909.761353579706;13175.67060823468;13196.076274660682;13200.735985280433;13216.669583260304;13232.867671323163;13493.987950903722;13510.324483775968;13597.456101755819;13690.589282321545;13773.655658608415;5929.258842644669;5951.791687291011;5993.670348130808;5999.370066143079;6001.12983617373;893.6738090596886;900.3292547052357;908.404994728454;937.1986951156799;940.1022023967232;23079.95548879995;28338.433231335257;28368.290792729935;28454.71545284562;29075.127746167647;964.8938616752151;999.9950000250097;1002.4737013068197;1028.7942411517727;1050.9842352364722;14491.130532168103;14871.47949821751;14925.477608283874;15249.6187595311;15265.313060912285;515420;521220;521271;522656;523003;58591.70704146452;58818.70590647105;59008.40991590115;59049.70475147597;59102;1440.8054912587086;1461.736887360264;1483.4659522571865;1489.3744627256578;1489.9851001489847;27286.908523659626;28414.00550980706;28822;28934.42131157407;29095;38928.805355974175;38987.2202555953;39018.6098139015;39099;39108;468197;470088;470458;470810;471061;29757;30664.386712266078;30710.23224419318;30715.692843071283;30726.84636576892;38326.42510362291;39024.80487597544;39192.386091423345;39331.21337573175;39858.800705996284;27510.862445687642;27822.72177278282;27863.442731145667;28144.71855281421;28937.421251575273;26431.603525946743;27693.86153069222;27744.58383124295;28539.143825685263;28693.28266793347;33046.339073218885;33296.00111996547;33316.83341583276;33406.83076092325;33482.33035339231;26137.869310653325;27255.454890901674;28559.28601784972;28736.568951465328;28768.70540825626;22556.436089097246;22723.88638056799;23050.654240186075;23157.88421057884;23199.3040208794 07:46:51 INFO - PROCESS | 1644 | |2;jquery.html;402.99798501007473;412.8410561933655;424.11783490340093;433.15750864568406;444.22704494180124;20299.391018269438;21757.456063598416;22866.771332286673;22977.4255643609;23107.653385199214;22908.656370154462;23923.16268930588;23925.64111538328;24087.277381678578;24370.87814560929;5679.261695979517;6673.432758215557;6934.994425808255;7011;7023.332783385596;6943.340382663664;6994.020837082812;7024.157101147869;7036.753713620024;7085.539439936388;6677.632730199837;6929.203141638701;7001.719931202746;7006.684699188549;7022.332878376546;6756.054152418666;6770.255271920085;6793.694283757242;6839.760608378708;6867.416269617089;6569.441597464222;6872.656367181621;6874.587524748531;6875.449964002868;6876.724931002754;24471.510569788683;25496.23511294664;28156.43687126246;28601.284967875763;29024.41951160986;2929.6923822998706;3019.411214813112;3052.6794686557814;3073.6772638873044;3081;16220.675586488322;16443.753343699853;16693.499195024167;16972.321107155698;17421.39025134127;2057.4547744847628;2143.389134096775;2204.2946257197705;2248.359217622986;2259.062489067035;69900.30099698988;108527.45736271268;158654.68744531684;170173;183581.16418835774;19945.900270498554;20586.970651467367;20769.89615051915;20801.89599051995;20940.685889711665;32178.678213218038;32254.516182257285;32298.192545186557;32308.676913231036;32412.35175296481;9405.388649737744;9492.9083155438;10142.543585538668;10288.794224115476;10957.890421095846;7430.405567554582;9110.316726245557;9125.634974601075;9145.90854091464;9300.11648893354;7922.4850384724805;9493.762655933657;9547.761305967406;9732.734744483172;9739.902600974041;2719.626588572758;3021.3806169735153;3974.6224108709625;3977.7525697981127;4059.6656922269813;1086.6088208245183;1097.023648952433;1102.7463683352873;1104.0174244922025;1155.0759392485977;21809.56380872374;22320.107195712313;22372.776272237395;23852.761472385402;24661.26016219516;935.9157675809209;971.4171497101682;1005.6379703306803;1050.5377633841238;1077.3805062089173;5923.703814809329;6888.242293347727;7249.891251631229;7385.335319821242;7502.287282708134;764609;837952;842949;848259;861781;176437;176846.23153768555;177107.11446442685;178862;181601;1272.4401263444056;1356.9660758481116;1400.2718586335252;1403.6561042544643;1404.0873432269107;12832.679183020125;13128.540501082416;13267.469301227842;13490.392932317873;13599.252041137832;65829.67085164544;66967.99548006881;67352;67992;68730.65634671795;96122;96608;97078.1460926965;99060;99319;11615.012723918562;12022.819657705317;12043;12043.879561204627;12420.689482763004;8782.868256976279;13035.608931732064;13363;13636.318184090955;13802.240876751875;11665.35840528779;11877.821832672344;12142.75714485723;12232.082593805322;12264.509419623115;10737.302075365076;10829.079528240189;10854.40300783433;11014.50434730423;11107.38909359993;11875.881241187823;12107.273563586214;12165.33090680021;12208.511659533518;12223.388830558615;11859.458270425135;11890.227135236182;12012.75974480523;12039.578614748441;12273.938630306791;11839.940800295943;11846.763064738829;11993.220440671328;12076.275423474268;12249 07:46:51 INFO - PROCESS | 1644 | |3;mootools.html;1599.7760313556098;1616.7898173237477;1653.2973486268334;1654.784877965865;1662.2021429713736;10827.971342722438;11480.368579728112;11495.827562586568;11509.136814738886;11512.827307590393;10920.563177472912;11273.943630281838;11422.828657570122;11457.656270311903;11459.025982791472;2409.506051259492;2443.816713746467;2457.496213276274;2459.0901366494422;2459.7909177719916;2367.6922000139957;2430.6111022236446;2452.828302018859;2458.938526536842;2466.5436894174636;2347.5891718949115;2415.239199652104;2421.0315873650507;2425.6846609940685;2428.86641234732;2187.562487502498;2320.8955596998176;2326.336993956714;2377.8335516513853;2421.624648179526;2092.4141240452695;2093.8534302598823;2096.5387614724737;2101.233049936777;2102.810747032759;11303.321800691985;11355.772884542263;11389.943050284779;11393.886061139365;11401.973822355945;5672.205891175238;5897.764089436418;5915.112733090071;6027.668478233695;6108.1143234230785;3126.155937896755;3543.3799085159994;3665.120371110941;3745.2509498100217;3747.2880152770886;1203.8194270859353;1223.9388030598523;1277.2974863824859;1281.9872300882291;1297.9545715899992;13738.244396558186;14230.430782768677;14597.489087881873;15724.44964426251;15885.046897186206;4002.539707933625;4711.128441238382;4722.929312708007;4816.95183048172;4869.074875773592;11984.340861252715;12029.75940481203;12033.278003319829;12044;12046.397680116135;5839.065749480063;5925.555583331267;5952.3154837193415;5955.106733989849;5958.6424814511265;5347.545458635982;5403.4326395727885;5474.178873168977;5479.178123281539;5500.312460942382;3479.2867462170193;3946.723729338976;3956.9909673033194;4027.496562929634;4076.9388459173138;893.2005854759954;1029.8455231715152;1043.3791893823163;1045.2630895218851;1057.7408534908843;978.3982850547005;994.264244459095;1013.1236480444362;1017.730301470111;1029.5727273181546;5052.595792336604;5805.925903707743;5906.173135760997;6072;6703.530752847254;902.8600566912139;936.3679516326453;991.3209451525728;992.8858181309098;998.4508520313943;3128.6402063762503;4034.8991275218355;4064.634182923492;4218.114196018871;4243.130158317537;13481.123726957912;14137.646558835906;14166.645833854236;14170.291485425687;14178.361973711208;14060.929695351459;14079.85920140806;14104.012719109563;14109.435622574982;14115.153090814583;10087;10206.13247873939;10421.062104410488;10451.425171615481;10481.528331225114;5282.630215884851;6169.660668663087;6817.079694241413;6821.727130914708;7009.088818453569;12166.45250963691;12169.2698438094;12315.93842030784;12317.07621928341;12319.50721971147;12202.572909948109;12212.938935305267;12230.266184028987;12348.753024939631;12541;8605.182507661762;8614.61234244448;8714.869276960724;8721.258693010912;8737.956310218407;10276.948615256875;10420.531076101443;10422.374657520573;10530.894691053298;10538.57845686164;8875.334349923653;8942;8995.550222488719;9173.312001599774;9194.35639505255;7645.732399365996;8548.572571371531;8771.07903670131;8812.867806982773;8873.157050080232;8040.758777236692;8179.959100204461;8254.050784159659;8441.873371899304;8455.577221139041;5983.37174596661;5999.160117583455;6013.428724271187;6156.26124865019;6237.438630523275;6033.487153591994;6082.513398928164;6219.844503887439;6253.187085678833;6271.153394291712 07:46:51 INFO - PROCESS | 1644 | |4;prototype.html;336.2132609693317;336.97641165118443;366.9577998530168;383.6662103969547;387.4459522882279;4933.497216975947;5099.413567439741;5310.362756469224;5312.840614781553;5360.597955153359;4306.8277268909205;4984.7756850941705;5098.184290513518;5141.742912854361;5159.007775490216;3478.478228265755;3876.8061596920184;4135.66914646829;4291.763952982585;4294.506131794837;4103.938440923389;4325.87527242916;4337.436133302666;4344.348347747831;4362.672799540047;4041.6564592009713;4214.304639734455;4290;4338.913221735564;4372.3878656988045;3561.5904171020406;4272.6154646081695;4274.636655884254;4313.762743049131;4321.1141715948315;3391.7783851577256;3572.7673952486352;3951.723379363446;3966.702497312684;3995.1622253763303;4761.357331720551;4883.536064073907;5146.639735218536;5189.610779191538;5219;4424.40270563473;4975.676581022258;4983.72589507577;4986.177280748709;5004.472741265674;4886.584640305578;5443.992861320668;5572.219889215513;5579.69311687857;5646.435356464362;4154.210699967027;4186.497620285555;4206.747595144301;4398.780060996937;4464.316938525697;5396.892062158774;5530.695811730353;5655.717214139277;5750.88498230033;5818.6217895836635;3737.4767532545466;4015.5181378234797;4036.59634036594;4526.841560545365;4538.704984176018;4059.715819892638;4314.913701725948;4580.541945805459;4653.2554791233915;4693.577578017995;4233.830646774156;4601;4618.422697162855;4949.430815456197;5012.298278241049;4681.695689780154;4682.307673087988;4954.9009019819405;5061.949380506221;5281.023010742948;1424.287856071964;1549.690061987607;1553.673728517024;1568.443202663061;1575.4013474879703;1034.9741256468499;1076.2520048566328;1177.9175457717877;1178.5091858798626;1201.1891972918245;4989.178949683412;5058.342415486037;5194.818181363634;5214.113600687892;5234.869128271824;5010.949890501049;5075.187969924795;5111.846644600668;5390.622656414092;5741.655500669973;4894.161386395882;5135.485031915594;5207.270982062514;5234.712090834964;5247.317848679723;2572.626969089509;2625.553655878467;2637.406583518693;2858.9142325730263;2982.403519296106;5051.318072060225;5543.390227075019;5782.865251345224;5830.76676932918;5946.851328716817;4871.575968973326;4966.652334336634;5258.3689957204615;5309.973450132802;5836.562257830595;5463.508284254357;5545.77816887328;5925.318588362307;5936.910946335722;5955.79154729591;4750.144973904592;4959.165108909727;5112.74436278192;5751.309842818721;5754.482096611325;4930.383702037246;5344.759485823225;5676.602637815313;5716.685582293014;5751.539876809761;5272.815451459181;5278.20541016041;5453.318335208099;5681.914771278517;5867.32525759526;3802.6007269236334;4045.8846688050626;4492.9775351123035;4562;4591.334256532851;4636.52575264871;5375.871067075958;5507.752151153288;5523.834284971457;5761.769529218785;4745.6678032538775;5232.011835502484;5448.945510544844;5515.283013208257;5533.889322213614;5518.668879867221;5526.171074338881;5534.833954981357;5535.667859928417;5536.861578460571;4410.095930334338;5208;5290.523852853262;5435.266239057834;5496.780128794963;4557.749323787091;4947.628927830499;4996.550310472075;5252.1596544552685;5567;4605.447346318463;5148.9742551287;5457.399686034453;5468.671879687232;5488.560915126701 07:46:51 INFO - PROCESS | 1644 | |5;yui.html;739.1647438394614;758.8102974256433;787.8936343593613;802.7230605441124;833.8749187621858;15845.445409410673;17606.82393176071;17662.470125896212;17680.557986050357;17697.82302176978;16033.679326413465;16116.75824862628;16120.596985075379;16283.918580407082;16285.02289862609;987.323683276954;988.1551273661042;992.4095163377779;1012.7468132966758;1057.006413970865;1023.0536753503017;1033.0547548992663;1038.1746511523356;1038.2420832792066;1039.9168066554657;1071.8820929697727;1072.4476894399352;1072.4905669806858;1073.3452593917705;1074.9946250268738;1064.2497039587072;1064.834950582661;1066.2962444786403;1067.2049323254187;1067.626330784227;792.6195426195401;793.8134538383475;794.047143427883;794.4994653368399;795.4630624328613;16510.917445412815;16907.830921690747;17482.562935926577;17718.202680879393;17753.55616109595;14527.854721452755;14784.704305913929;14954.327055282538;14980.176090315028;15181.16503592302;11918.225315354473;12187.939060304641;12343.814842777365;12401.75196496074;12812.167209131376;3247.269364393016;3855.248226595815;3924.1955399143108;4068.613481719232;4072.857449989236;95923.0407695921;127062.72937270602;130803;131059;134890;11556.422178891022;11575.710607234887;11747.647570572897;11751.529938802523;11966.341851198267;20280.985950702405;22252.664840109646;23129.07483700633;23189.53620927572;23201.071957121865;8137;8176;8384.8742268866;8690.95654521736;8743.650253989768;4556.951901062708;4721.858344249678;4755.500672429414;4770.809167633325;4803.975980120077;3435.587729472479;3459.757816952789;3515.6308587598446;3519;3542.1144713821545;604.4046614085123;607.9665618390942;612.3753771153398;619.4579742725116;625.5183508698277;702.5082442290314;706.8409607838298;732.8973943647893;752.8757754970369;784.811645205158;10755.247132700635;10847.51186196623;10949.83575246372;11194.664160075048;11414.315141091562;733.5232099135604;747.7943565519416;761.5941776821173;765.276813411321;777.249953794591;5017.648764586444;5291.920621190685;5299.973500132474;5300.92048619271;5301.125314323171;111127;113618.43190784159;115791;117553;117991.41004295096;53279.73360133252;60772.530472257706;76305.85541216886;77295.61352193203;87603.9916806654;70876;73241.16897077615;78898;79956;83740.74388884293;10989.175811813986;11276.041536469163;11289.943550282196;11303.378314192798;11701.648950531498;49863.50136498589;50063.748406290135;50875;51488.712782180744;53400;60105.39894600998;63588.68205658942;63699;66200;73780;12919.677008074874;13175.341232938506;13757.140298151178;14257.287135643384;14453;15274;15935.442259520862;16072.437464688679;16137.354505819636;16808.915955420634;14075.155490670593;14329.283535822959;14926.477573285318;15026.17356045428;15372.615684607974;14024.929875350557;14697.632559186106;14822.110673359633;14839.183844888636;15352.692946141238;13835.446582136601;14769.04001239916;14807.33366998466;14810.037347572374;15174.772378414113;10306.92320244492;10724.51739671701;11098.2786118902;11346.60286889988;11449.771004579696;8782.123349682986;10648.040433842229;11227;11678.24091434054;12324.445399956845 07:46:51 INFO - PROCESS | 1644 | __end_tp_report 07:46:51 INFO - PROCESS | 1644 | __start_cc_report 07:46:51 INFO - PROCESS | 1644 | _x_x_mozilla_cycle_collect,2384 07:46:51 INFO - PROCESS | 1644 | __end_cc_report 07:46:51 INFO - PROCESS | 1644 | __startTimestamp1493909211770__endTimestamp 07:46:51 INFO - PROCESS | 1644 | 07:46:51 INFO - PROCESS | 1644 | ------- Summary: start ------- 07:46:51 INFO - PROCESS | 1644 | Number of tests: 6 07:46:51 INFO - PROCESS | 1644 | 07:46:51 INFO - PROCESS | 1644 | [#0] dojo.html Cycles:165 Average:6098.25 Median:6304.24 stddev:673.59 (10.7%) stddev-sans-first:633.76 07:46:51 INFO - PROCESS | 1644 | Values: 3116.8 3559.3 3570.4 3588.9 3627.9 6152.3 6218.2 6227.7 6238.3 6238.6 6201.8 6227.0 6248.6 6280.7 6282.7 5582.5 5596.5 5646.6 5665.5 5736.2 5497.3 5507.4 5518.8 5705.7 5714.1 5585.1 5612.3 5621.4 5625.4 5626.2 5595.7 5604.5 5608.9 5624.4 5632.2 5458.3 5576.7 5579.4 5583.7 5619.7 6207.7 6216.0 6227.5 6237.1 6244.8 6403.2 6414.8 6432.0 6432.9 6468.7 6684.1 6712.3 6732.1 6735.9 6738.5 6275.2 6307.4 6310.1 6338.6 6338.7 6487.9 6524.0 6785.5 6833.7 6835.8 6290.6 6293.1 6322.7 6331.6 6370.0 6490.0 6494.0 6498.2 6502.8 6504.1 6263.8 6410.7 6426.3 6442.4 6450.7 6264.8 6304.2 6419.8 6484.4 6516.3 5334.0 5345.8 5347.3 5348.8 5388.5 3961.0 4349.5 4745.3 4752.3 4752.8 6105.8 6132.3 6163.3 6193.8 6250.1 6461.3 6492.6 6493.3 6517.6 6565.5 6240.3 6261.4 6261.5 6272.8 6274.4 5751.4 5808.6 5812.5 5814.3 5859.5 6543.9 6607.4 6759.0 6808.3 6832.0 6657.4 6670.5 6689.4 6700.1 6706.4 6804.2 6850.8 6855.4 6857.1 6865.3 6267.7 6311.1 6540.1 6543.0 6555.9 6426.6 6440.5 6443.5 6451.7 6460.2 6326.3 6340.0 6354.6 6447.0 6467.0 5411.8 6416.0 6432.7 6467.3 6468.5 5964.9 6321.9 6329.1 6332.5 6338.0 6270.9 6303.1 6343.0 6346.3 6444.0 6173.3 6241.2 6323.1 6363.2 6372.0 07:46:51 INFO - PROCESS | 1644 | 07:46:51 INFO - PROCESS | 1644 | [#1] ext.html Cycles:180 Average:57984.36 Median:33171.17 stddev:119869.98 (361.4%) stddev-sans-first:120129.32 07:46:51 INFO - PROCESS | 1644 | Values: 788.0 795.5 902.6 909.6 987.2 39439.0 40066.6 40202.2 42117.8 42301.9 40061.8 40193.6 40314.0 40350.0 40380.2 7853.7 7976.3 8214.0 8347.3 8351.7 11781.6 11963.0 12331.6 12346.9 12368.9 11963.3 12058.4 12068.3 12096.4 12102.9 12018.9 12071.3 12073.6 12098.2 12098.6 11573.3 11624.1 11635.3 11639.1 11642.9 41693.6 41870.0 41921.5 41945.8 41972.4 3965.0 4003.9 4013.7 4024.3 4042.7 28650.6 28745.3 30052.8 30586.8 31101.7 3174.5 3295.3 3334.6 3359.7 3386.4 339572.0 342259.0 342510.0 342993.0 343242.0 45381.8 46012.1 53849.5 54000.7 54221.0 53884.7 53892.5 57727.7 57730.4 57762.4 15690.1 15765.1 15770.0 15853.2 15909.8 13175.7 13196.1 13200.7 13216.7 13232.9 13494.0 13510.3 13597.5 13690.6 13773.7 5929.3 5951.8 5993.7 5999.4 6001.1 893.7 900.3 908.4 937.2 940.1 23080.0 28338.4 28368.3 28454.7 29075.1 964.9 1000.0 1002.5 1028.8 1051.0 14491.1 14871.5 14925.5 15249.6 15265.3 515420.0 521220.0 521271.0 522656.0 523003.0 58591.7 58818.7 59008.4 59049.7 59102.0 1440.8 1461.7 1483.5 1489.4 1490.0 27286.9 28414.0 28822.0 28934.4 29095.0 38928.8 38987.2 39018.6 39099.0 39108.0 468197.0 470088.0 470458.0 470810.0 471061.0 29757.0 30664.4 30710.2 30715.7 30726.8 38326.4 39024.8 39192.4 39331.2 39858.8 27510.9 27822.7 27863.4 28144.7 28937.4 26431.6 27693.9 27744.6 28539.1 28693.3 33046.3 33296.0 33316.8 33406.8 33482.3 26137.9 27255.5 28559.3 28736.6 28768.7 22556.4 22723.9 23050.7 23157.9 23199.3 07:46:51 INFO - PROCESS | 1644 | 07:46:51 INFO - PROCESS | 1644 | [#2] jquery.html Cycles:180 Average:46034.99 Median:24006.46 stddev:138647.42 (577.5%) stddev-sans-first:138994.02 07:46:51 INFO - PROCESS | 1644 | Values: 403.0 412.8 424.1 433.2 444.2 20299.4 21757.5 22866.8 22977.4 23107.7 22908.7 23923.2 23925.6 24087.3 24370.9 5679.3 6673.4 6935.0 7011.0 7023.3 6943.3 6994.0 7024.2 7036.8 7085.5 6677.6 6929.2 7001.7 7006.7 7022.3 6756.1 6770.3 6793.7 6839.8 6867.4 6569.4 6872.7 6874.6 6875.4 6876.7 24471.5 25496.2 28156.4 28601.3 29024.4 2929.7 3019.4 3052.7 3073.7 3081.0 16220.7 16443.8 16693.5 16972.3 17421.4 2057.5 2143.4 2204.3 2248.4 2259.1 69900.3 108527.5 158654.7 170173.0 183581.2 19945.9 20587.0 20769.9 20801.9 20940.7 32178.7 32254.5 32298.2 32308.7 32412.4 9405.4 9492.9 10142.5 10288.8 10957.9 7430.4 9110.3 9125.6 9145.9 9300.1 7922.5 9493.8 9547.8 9732.7 9739.9 2719.6 3021.4 3974.6 3977.8 4059.7 1086.6 1097.0 1102.7 1104.0 1155.1 21809.6 22320.1 22372.8 23852.8 24661.3 935.9 971.4 1005.6 1050.5 1077.4 5923.7 6888.2 7249.9 7385.3 7502.3 764609.0 837952.0 842949.0 848259.0 861781.0 176437.0 176846.2 177107.1 178862.0 181601.0 1272.4 1357.0 1400.3 1403.7 1404.1 12832.7 13128.5 13267.5 13490.4 13599.3 65829.7 66968.0 67352.0 67992.0 68730.7 96122.0 96608.0 97078.1 99060.0 99319.0 11615.0 12022.8 12043.0 12043.9 12420.7 8782.9 13035.6 13363.0 13636.3 13802.2 11665.4 11877.8 12142.8 12232.1 12264.5 10737.3 10829.1 10854.4 11014.5 11107.4 11875.9 12107.3 12165.3 12208.5 12223.4 11859.5 11890.2 12012.8 12039.6 12273.9 11839.9 11846.8 11993.2 12076.3 12249.0 07:46:51 INFO - PROCESS | 1644 | 07:46:51 INFO - PROCESS | 1644 | [#3] mootools.html Cycles:180 Average:6787.86 Median:2448.32 stddev:4281.01 (174.9%) stddev-sans-first:4275.27 07:46:51 INFO - PROCESS | 1644 | Values: 1599.8 1616.8 1653.3 1654.8 1662.2 10828.0 11480.4 11495.8 11509.1 11512.8 10920.6 11273.9 11422.8 11457.7 11459.0 2409.5 2443.8 2457.5 2459.1 2459.8 2367.7 2430.6 2452.8 2458.9 2466.5 2347.6 2415.2 2421.0 2425.7 2428.9 2187.6 2320.9 2326.3 2377.8 2421.6 2092.4 2093.9 2096.5 2101.2 2102.8 11303.3 11355.8 11389.9 11393.9 11402.0 5672.2 5897.8 5915.1 6027.7 6108.1 3126.2 3543.4 3665.1 3745.3 3747.3 1203.8 1223.9 1277.3 1282.0 1298.0 13738.2 14230.4 14597.5 15724.4 15885.0 4002.5 4711.1 4722.9 4817.0 4869.1 11984.3 12029.8 12033.3 12044.0 12046.4 5839.1 5925.6 5952.3 5955.1 5958.6 5347.5 5403.4 5474.2 5479.2 5500.3 3479.3 3946.7 3957.0 4027.5 4076.9 893.2 1029.8 1043.4 1045.3 1057.7 978.4 994.3 1013.1 1017.7 1029.6 5052.6 5805.9 5906.2 6072.0 6703.5 902.9 936.4 991.3 992.9 998.5 3128.6 4034.9 4064.6 4218.1 4243.1 13481.1 14137.6 14166.6 14170.3 14178.4 14060.9 14079.9 14104.0 14109.4 14115.2 10087.0 10206.1 10421.1 10451.4 10481.5 5282.6 6169.7 6817.1 6821.7 7009.1 12166.5 12169.3 12315.9 12317.1 12319.5 12202.6 12212.9 12230.3 12348.8 12541.0 8605.2 8614.6 8714.9 8721.3 8738.0 10276.9 10420.5 10422.4 10530.9 10538.6 8875.3 8942.0 8995.6 9173.3 9194.4 7645.7 8548.6 8771.1 8812.9 8873.2 8040.8 8180.0 8254.1 8441.9 8455.6 5983.4 5999.2 6013.4 6156.3 6237.4 6033.5 6082.5 6219.8 6253.2 6271.2 07:46:51 INFO - PROCESS | 1644 | 07:46:51 INFO - PROCESS | 1644 | [#4] prototype.html Cycles:180 Average:4563.86 Median:4979.70 stddev:1276.72 (25.6%) stddev-sans-first:1240.24 07:46:51 INFO - PROCESS | 1644 | Values: 336.2 337.0 367.0 383.7 387.4 4933.5 5099.4 5310.4 5312.8 5360.6 4306.8 4984.8 5098.2 5141.7 5159.0 3478.5 3876.8 4135.7 4291.8 4294.5 4103.9 4325.9 4337.4 4344.3 4362.7 4041.7 4214.3 4290.0 4338.9 4372.4 3561.6 4272.6 4274.6 4313.8 4321.1 3391.8 3572.8 3951.7 3966.7 3995.2 4761.4 4883.5 5146.6 5189.6 5219.0 4424.4 4975.7 4983.7 4986.2 5004.5 4886.6 5444.0 5572.2 5579.7 5646.4 4154.2 4186.5 4206.7 4398.8 4464.3 5396.9 5530.7 5655.7 5750.9 5818.6 3737.5 4015.5 4036.6 4526.8 4538.7 4059.7 4314.9 4580.5 4653.3 4693.6 4233.8 4601.0 4618.4 4949.4 5012.3 4681.7 4682.3 4954.9 5061.9 5281.0 1424.3 1549.7 1553.7 1568.4 1575.4 1035.0 1076.3 1177.9 1178.5 1201.2 4989.2 5058.3 5194.8 5214.1 5234.9 5010.9 5075.2 5111.8 5390.6 5741.7 4894.2 5135.5 5207.3 5234.7 5247.3 2572.6 2625.6 2637.4 2858.9 2982.4 5051.3 5543.4 5782.9 5830.8 5946.9 4871.6 4966.7 5258.4 5310.0 5836.6 5463.5 5545.8 5925.3 5936.9 5955.8 4750.1 4959.2 5112.7 5751.3 5754.5 4930.4 5344.8 5676.6 5716.7 5751.5 5272.8 5278.2 5453.3 5681.9 5867.3 3802.6 4045.9 4493.0 4562.0 4591.3 4636.5 5375.9 5507.8 5523.8 5761.8 4745.7 5232.0 5448.9 5515.3 5533.9 5518.7 5526.2 5534.8 5535.7 5536.9 4410.1 5208.0 5290.5 5435.3 5496.8 4557.7 4947.6 4996.6 5252.2 5567.0 4605.4 5149.0 5457.4 5468.7 5488.6 07:46:51 INFO - PROCESS | 1644 | 07:46:51 INFO - PROCESS | 1644 | [#5] yui.html Cycles:180 Average:21334.39 Median:16659.92 stddev:30911.84 (185.5%) stddev-sans-first:30959.87 07:46:51 INFO - PROCESS | 1644 | Values: 739.2 758.8 787.9 802.7 833.9 15845.4 17606.8 17662.5 17680.6 17697.8 16033.7 16116.8 16120.6 16283.9 16285.0 987.3 988.2 992.4 1012.7 1057.0 1023.1 1033.1 1038.2 1038.2 1039.9 1071.9 1072.4 1072.5 1073.3 1075.0 1064.2 1064.8 1066.3 1067.2 1067.6 792.6 793.8 794.0 794.5 795.5 16510.9 16907.8 17482.6 17718.2 17753.6 14527.9 14784.7 14954.3 14980.2 15181.2 11918.2 12187.9 12343.8 12401.8 12812.2 3247.3 3855.2 3924.2 4068.6 4072.9 95923.0 127062.7 130803.0 131059.0 134890.0 11556.4 11575.7 11747.6 11751.5 11966.3 20281.0 22252.7 23129.1 23189.5 23201.1 8137.0 8176.0 8384.9 8691.0 8743.7 4557.0 4721.9 4755.5 4770.8 4804.0 3435.6 3459.8 3515.6 3519.0 3542.1 604.4 608.0 612.4 619.5 625.5 702.5 706.8 732.9 752.9 784.8 10755.2 10847.5 10949.8 11194.7 11414.3 733.5 747.8 761.6 765.3 777.2 5017.6 5291.9 5300.0 5300.9 5301.1 111127.0 113618.4 115791.0 117553.0 117991.4 53279.7 60772.5 76305.9 77295.6 87604.0 70876.0 73241.2 78898.0 79956.0 83740.7 10989.2 11276.0 11289.9 11303.4 11701.6 49863.5 50063.7 50875.0 51488.7 53400.0 60105.4 63588.7 63699.0 66200.0 73780.0 12919.7 13175.3 13757.1 14257.3 14453.0 15274.0 15935.4 16072.4 16137.4 16808.9 14075.2 14329.3 14926.5 15026.2 15372.6 14024.9 14697.6 14822.1 14839.2 15352.7 13835.4 14769.0 14807.3 14810.0 15174.8 10306.9 10724.5 11098.3 11346.6 11449.8 8782.1 10648.0 11227.0 11678.2 12324.4 07:46:51 INFO - PROCESS | 1644 | -------- Summary: end -------- 07:46:51 INFO - PROCESS | 1644 | 07:46:52 INFO - TEST-INFO | 1644: exit 0 07:46:52 INFO - TEST-OK | dromaeo_css | took 1119070ms 07:46:52 INFO - TEST-START | kraken 07:46:52 INFO - operating with platform_type : mac_ 07:46:52 INFO - Initialising browser for kraken test... 07:46:52 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/tmp1HUIsS/profile http://localhost:49239/getInfo.html) 07:46:54 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 07:46:54 INFO - PROCESS | 1652 | colorDepth:24 07:46:54 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 07:46:54 INFO - PROCESS | 1652 | __metrics 07:46:54 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:46:54 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:46:55 INFO - TEST-INFO | 1652: exit 0 07:46:55 INFO - Browser initialized. 07:46:55 INFO - Running cycle 1/1 for kraken test... 07:46:55 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/tmp1HUIsS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:47:07 INFO - PROCESS | 1654 | RSS: Main: 165064704 07:47:07 INFO - PROCESS | 1654 | 07:47:10 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection) 07:47:10 INFO - PROCESS | 1654 | RSS: Main: 215150592 07:47:10 INFO - PROCESS | 1654 | 07:47:13 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-dft) 07:47:14 INFO - PROCESS | 1654 | RSS: Main: 230813696 07:47:14 INFO - PROCESS | 1654 | 07:47:17 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-fft) 07:47:17 INFO - PROCESS | 1654 | RSS: Main: 328482816 07:47:17 INFO - PROCESS | 1654 | 07:47:19 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator) 07:47:20 INFO - PROCESS | 1654 | RSS: Main: 228679680 07:47:20 INFO - PROCESS | 1654 | 07:47:22 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:47:23 INFO - PROCESS | 1654 | RSS: Main: 231448576 07:47:23 INFO - PROCESS | 1654 | 07:47:26 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom) 07:47:26 INFO - PROCESS | 1654 | RSS: Main: 271962112 07:47:26 INFO - PROCESS | 1654 | 07:47:29 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate) 07:47:30 INFO - PROCESS | 1654 | RSS: Main: 271429632 07:47:30 INFO - PROCESS | 1654 | 07:47:33 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial) 07:47:33 INFO - PROCESS | 1654 | RSS: Main: 271593472 07:47:33 INFO - PROCESS | 1654 | 07:47:35 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:47:36 INFO - PROCESS | 1654 | RSS: Main: 247169024 07:47:36 INFO - PROCESS | 1654 | 07:47:37 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:47:38 INFO - PROCESS | 1654 | RSS: Main: 251039744 07:47:38 INFO - PROCESS | 1654 | 07:47:40 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:47:41 INFO - PROCESS | 1654 | RSS: Main: 254689280 07:47:41 INFO - PROCESS | 1654 | 07:47:43 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:47:44 INFO - PROCESS | 1654 | RSS: Main: 271925248 07:47:44 INFO - PROCESS | 1654 | 07:47:47 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:47:48 INFO - PROCESS | 1654 | RSS: Main: 265629696 07:47:48 INFO - PROCESS | 1654 | 07:47:50 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49239/tests/kraken/driver.html?testName=ai-astar) 07:47:50 INFO - PROCESS | 1654 | RSS: Main: 309891072 07:47:50 INFO - PROCESS | 1654 | 07:47:50 INFO - PROCESS | 1654 | __start_tp_report 07:47:50 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 07:47:50 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 07:47:50 INFO - PROCESS | 1654 | |i|pagename|runs| 07:47:50 INFO - PROCESS | 1654 | |0;ai-astar;107;118;116;118;118;118;119;118;118;118 07:47:50 INFO - PROCESS | 1654 | |1;audio-beat-detection;138;106;101;143;108;108;116;134;160;130 07:47:50 INFO - PROCESS | 1654 | |2;audio-dft;185;183;185;183;183;182;184;180;183;183 07:47:50 INFO - PROCESS | 1654 | |3;audio-fft;83;60;58;90;62;60;58;58;72;60 07:47:50 INFO - PROCESS | 1654 | |4;audio-oscillator;86;69;87;70;70;54;80;84;100;113 07:47:50 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;89;89;89;88;89;89;90;89;88;88 07:47:50 INFO - PROCESS | 1654 | |6;imaging-darkroom;95;95;96;96;96;96;96;95;103;95 07:47:50 INFO - PROCESS | 1654 | |7;imaging-desaturate;83;83;83;88;85;84;85;86;86;82 07:47:50 INFO - PROCESS | 1654 | |8;json-parse-financial;62;60;58;59;60;62;61;62;62;62 07:47:50 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;56;66;66;62;59;58;58;59;57;57 07:47:50 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;81;79;80;98;80;80;83;81;84;83 07:47:50 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;132;131;132;132;132;133;138;137;197;156 07:47:50 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;159;163;161;159;159;216;209;160;164;161 07:47:50 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;66;64;65;63;65;66;77;78;77;77 07:47:50 INFO - PROCESS | 1654 | __end_tp_report 07:47:50 INFO - PROCESS | 1654 | __start_cc_report 07:47:50 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,2069 07:47:50 INFO - PROCESS | 1654 | __end_cc_report 07:47:50 INFO - PROCESS | 1654 | __startTimestamp1493909270321__endTimestamp 07:47:50 INFO - PROCESS | 1654 | 07:47:50 INFO - PROCESS | 1654 | ------- Summary: start ------- 07:47:50 INFO - PROCESS | 1654 | Number of tests: 14 07:47:50 INFO - PROCESS | 1654 | 07:47:50 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:116.80 Median:118.00 stddev:3.52 (3.0%) stddev-sans-first:0.78 07:47:50 INFO - PROCESS | 1654 | Values: 107.0 118.0 116.0 118.0 118.0 118.0 119.0 118.0 118.0 118.0 07:47:50 INFO - PROCESS | 1654 | 07:47:50 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:124.40 Median:132.00 stddev:19.48 (14.8%) stddev-sans-first:20.03 07:47:50 INFO - PROCESS | 1654 | Values: 138.0 106.0 101.0 143.0 108.0 108.0 116.0 134.0 160.0 130.0 07:47:50 INFO - PROCESS | 1654 | 07:47:50 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:183.10 Median:183.00 stddev:1.45 (0.8%) stddev-sans-first:1.36 07:47:50 INFO - PROCESS | 1654 | Values: 185.0 183.0 185.0 183.0 183.0 182.0 184.0 180.0 183.0 183.0 07:47:50 INFO - PROCESS | 1654 | 07:47:50 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:66.10 Median:61.00 stddev:11.63 (19.1%) stddev-sans-first:10.60 07:47:50 INFO - PROCESS | 1654 | Values: 83.0 60.0 58.0 90.0 62.0 60.0 58.0 58.0 72.0 60.0 07:47:50 INFO - PROCESS | 1654 | 07:47:50 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:81.30 Median:75.00 stddev:16.90 (22.5%) stddev-sans-first:17.84 07:47:50 INFO - PROCESS | 1654 | Values: 86.0 69.0 87.0 70.0 70.0 54.0 80.0 84.0 100.0 113.0 07:47:50 INFO - PROCESS | 1654 | 07:47:50 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:88.80 Median:89.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 07:47:50 INFO - PROCESS | 1654 | Values: 89.0 89.0 89.0 88.0 89.0 89.0 90.0 89.0 88.0 88.0 07:47:50 INFO - PROCESS | 1654 | 07:47:50 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:96.30 Median:96.00 stddev:2.41 (2.5%) stddev-sans-first:2.51 07:47:50 INFO - PROCESS | 1654 | Values: 95.0 95.0 96.0 96.0 96.0 96.0 96.0 95.0 103.0 95.0 07:47:50 INFO - PROCESS | 1654 | 07:47:50 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:84.50 Median:85.00 stddev:1.84 (2.2%) stddev-sans-first:1.87 07:47:50 INFO - PROCESS | 1654 | Values: 83.0 83.0 83.0 88.0 85.0 84.0 85.0 86.0 86.0 82.0 07:47:50 INFO - PROCESS | 1654 | 07:47:50 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:60.80 Median:62.00 stddev:1.48 (2.4%) stddev-sans-first:1.50 07:47:50 INFO - PROCESS | 1654 | Values: 62.0 60.0 58.0 59.0 60.0 62.0 61.0 62.0 62.0 62.0 07:47:50 INFO - PROCESS | 1654 | 07:47:50 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:59.00 stddev:3.65 (6.2%) stddev-sans-first:3.60 07:47:50 INFO - PROCESS | 1654 | Values: 56.0 66.0 66.0 62.0 59.0 58.0 58.0 59.0 57.0 57.0 07:47:50 INFO - PROCESS | 1654 | 07:47:50 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:82.00 stddev:5.55 (6.8%) stddev-sans-first:5.84 07:47:50 INFO - PROCESS | 1654 | Values: 81.0 79.0 80.0 98.0 80.0 80.0 83.0 81.0 84.0 83.0 07:47:50 INFO - PROCESS | 1654 | 07:47:50 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:135.00 stddev:20.72 (15.3%) stddev-sans-first:21.66 07:47:50 INFO - PROCESS | 1654 | Values: 132.0 131.0 132.0 132.0 132.0 133.0 138.0 137.0 197.0 156.0 07:47:50 INFO - PROCESS | 1654 | 07:47:50 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:162.00 stddev:21.95 (13.5%) stddev-sans-first:22.84 07:47:50 INFO - PROCESS | 1654 | Values: 159.0 163.0 161.0 159.0 159.0 216.0 209.0 160.0 164.0 161.0 07:47:50 INFO - PROCESS | 1654 | 07:47:50 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:71.50 stddev:6.48 (9.1%) stddev-sans-first:6.72 07:47:50 INFO - PROCESS | 1654 | Values: 66.0 64.0 65.0 63.0 65.0 66.0 77.0 78.0 77.0 77.0 07:47:50 INFO - PROCESS | 1654 | -------- Summary: end -------- 07:47:50 INFO - PROCESS | 1654 | 07:47:51 INFO - TEST-INFO | 1654: exit 0 07:47:51 INFO - TEST-OK | kraken | took 58777ms 07:47:51 INFO - SUITE-END | took 1177s 07:47:51 INFO - Completed test suite (00:19:38) 07:47:51 INFO - javascript benchmark 07:47:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7860.676945406712, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3116.8285744284067, 3559.336401669467, 3570.357335679577, 3588.8923332300005, 3627.9455808162884, 6152.323244443113, 6218.16054832598, 6227.688615569215, 6238.282597501288, 6238.6256824590555, 6201.751929922809, 6227.034809604518, 6248.562600617958, 6280.748770049204, 6282.717277722502, 5582.49757521823, 5596.524295434893, 5646.576506761989, 5665.490105890469, 5736.196932429463, 5497.312835895513, 5507.366652834915, 5518.834434966958, 5705.65766054036, 5714.114312281603, 5585.134304182858, 5612.298462692163, 5621.353544342412, 5625.437456254363, 5626.184203290521, 5595.720213989304, 5604.467575580314, 5608.943910560883, 5624.437556244384, 5632.239647647597, 5458.263134476874, 5576.721163941827, 5579.358373787026, 5583.6928968906695, 5619.7471113799975, 6207.658578778165, 6215.968920155416, 6227.501799856046, 6237.126802247689, 6244.812655620339, 6403.167588213549, 6414.775482858125, 6431.970884658479, 6432.90350644736, 6468.74125034998, 6684.064231007663, 6712.328767123297, 6732.057511948331, 6735.8989615155815, 6738.494612904003, 6275.18422605063, 6307.432331090178, 6310.053491976194, 6338.556301058928, 6338.683065846689, 6487.870242595121, 6523.956167013255, 6785.491088168407, 6833.658317084225, 6835.760748373783, 6290.622562646165, 6293.087502312139, 6322.652254125976, 6331.556791024676, 6370.0, 6490.0, 6493.967530162414, 6498.220213574401, 6502.772402965874, 6504.05691174777, 6263.812085637438, 6410.711517981609, 6426.2931077581425, 6442.35576442352, 6450.741970321228, 6264.812055638338, 6304.243490781044, 6419.807405777834, 6484.351564843572, 6516.315786842408, 5334.039872822929, 5345.786168553292, 5347.331583552056, 5348.839534813962, 5388.515033646991, 3960.980195099006, 4349.521552629209, 4745.335653008581, 4752.263399173134, 4752.833650822274, 6105.816825495153, 6132.306126318567, 6163.260408750889, 6193.81418557444, 6250.0937364082865, 6461.289258181596, 6492.577982431127, 6493.285738568754, 6517.576357536745, 6565.540412171103, 6240.31356550779, 6261.373862613702, 6261.467775239155, 6272.8118156455375, 6274.435300822948, 5751.424857514216, 5808.593398462067, 5812.505936995402, 5814.3313518945015, 5859.53123750099, 6543.901841472477, 6607.372299631527, 6759.0, 6808.319168083152, 6831.965840170867, 6657.367550082734, 6670.466362691071, 6689.431398331197, 6700.128983232149, 6706.429953454011, 6804.183497980274, 6850.794476165723, 6855.383015528427, 6857.074294970115, 6865.27914568963, 6267.717952692049, 6311.053341998737, 6540.149780528501, 6543.0185472179555, 6555.901661475177, 6426.646534440651, 6440.484761219185, 6443.516736244706, 6451.741930322734, 6460.192475940507, 6326.3041065483685, 6340.048992651139, 6354.586951848115, 6446.967765161145, 6467.0, 5411.78234897145, 6415.967920160369, 6432.742690292336, 6467.256265529524, 6468.5472016958365, 5964.880702385841, 6321.873562528632, 6329.145565348803, 6332.461740751904, 6337.96831015842, 6270.905936410866, 6303.054541818764, 6343.0, 6346.270178929482, 6443.96778016107, 6173.259208894961, 6241.188645476059, 6323.08315294289, 6363.236411630634, 6372.012338087604], "value": 6054.130188279837, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [787.9527228366296, 795.5385876191809, 902.5532361481067, 909.6270529083077, 987.2052997337149, 39439.0140246494, 40066.599334006685, 40202.1959560809, 42117.7894110529, 42301.94245143873, 40061.79969100158, 40193.59806401935, 40314.0, 40350.0, 40380.19239615206, 7853.685852565891, 7976.322012628933, 8214.0, 8347.29048030918, 8351.707690230844, 11781.587644432446, 11962.983146432563, 12331.630051098482, 12346.876531234662, 12368.938155309255, 11963.342016189106, 12058.397080146002, 12068.336241506713, 12096.395180240952, 12102.878971210263, 12018.939905300505, 12071.275723456622, 12073.637790866289, 12098.153129280954, 12098.576549820802, 11573.305601663842, 11624.128190385754, 11635.301881887113, 11639.127065470038, 11642.883571164264, 41693.583064169274, 41869.95325116866, 41921.53274635373, 41945.790271048754, 41972.37041444381, 3964.980175099106, 4003.899902502432, 4013.7391069580385, 4024.2957482440747, 4042.6765858731233, 28650.570241446396, 28745.281367965967, 30052.8497357514, 30586.847065764752, 31101.688983110333, 3174.5238214268043, 3295.340931813623, 3334.583177102862, 3359.7144242739396, 3386.3565922474895, 339572.0, 342259.0, 342510.0, 342993.0, 343242.0, 45381.77309113499, 46012.079758404645, 53849.461505385225, 54000.729996349764, 54221.0, 53884.730576347654, 53892.461075389525, 57727.71136144376, 57730.422695772504, 57762.422375775706, 15690.137042462775, 15765.054096754231, 15770.0, 15853.207339632972, 15909.761353579706, 13175.67060823468, 13196.076274660682, 13200.735985280433, 13216.669583260304, 13232.867671323163, 13493.987950903722, 13510.324483775968, 13597.456101755819, 13690.589282321545, 13773.655658608415, 5929.258842644669, 5951.791687291011, 5993.670348130808, 5999.370066143079, 6001.12983617373, 893.6738090596886, 900.3292547052357, 908.404994728454, 937.1986951156799, 940.1022023967232, 23079.95548879995, 28338.433231335257, 28368.290792729935, 28454.71545284562, 29075.127746167647, 964.8938616752151, 999.9950000250097, 1002.4737013068197, 1028.7942411517727, 1050.9842352364722, 14491.130532168103, 14871.47949821751, 14925.477608283874, 15249.6187595311, 15265.313060912285, 515420.0, 521220.0, 521271.0, 522656.0, 523003.0, 58591.70704146452, 58818.70590647105, 59008.40991590115, 59049.70475147597, 59102.0, 1440.8054912587086, 1461.736887360264, 1483.4659522571865, 1489.3744627256578, 1489.9851001489847, 27286.908523659626, 28414.00550980706, 28822.0, 28934.42131157407, 29095.0, 38928.805355974175, 38987.2202555953, 39018.6098139015, 39099.0, 39108.0, 468197.0, 470088.0, 470458.0, 470810.0, 471061.0, 29757.0, 30664.386712266078, 30710.23224419318, 30715.692843071283, 30726.84636576892, 38326.42510362291, 39024.80487597544, 39192.386091423345, 39331.21337573175, 39858.800705996284, 27510.862445687642, 27822.72177278282, 27863.442731145667, 28144.71855281421, 28937.421251575273, 26431.603525946743, 27693.86153069222, 27744.58383124295, 28539.143825685263, 28693.28266793347, 33046.339073218885, 33296.00111996547, 33316.83341583276, 33406.83076092325, 33482.33035339231, 26137.869310653325, 27255.454890901674, 28559.28601784972, 28736.568951465328, 28768.70540825626, 22556.436089097246, 22723.88638056799, 23050.654240186075, 23157.88421057884, 23199.3040208794], "value": 19047.527611393256, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [402.99798501007473, 412.8410561933655, 424.11783490340093, 433.15750864568406, 444.22704494180124, 20299.391018269438, 21757.456063598416, 22866.771332286673, 22977.4255643609, 23107.653385199214, 22908.656370154462, 23923.16268930588, 23925.64111538328, 24087.277381678578, 24370.87814560929, 5679.261695979517, 6673.432758215557, 6934.994425808255, 7011.0, 7023.332783385596, 6943.340382663664, 6994.020837082812, 7024.157101147869, 7036.753713620024, 7085.539439936388, 6677.632730199837, 6929.203141638701, 7001.719931202746, 7006.684699188549, 7022.332878376546, 6756.054152418666, 6770.255271920085, 6793.694283757242, 6839.760608378708, 6867.416269617089, 6569.441597464222, 6872.656367181621, 6874.587524748531, 6875.449964002868, 6876.724931002754, 24471.510569788683, 25496.23511294664, 28156.43687126246, 28601.284967875763, 29024.41951160986, 2929.6923822998706, 3019.411214813112, 3052.6794686557814, 3073.6772638873044, 3081.0, 16220.675586488322, 16443.753343699853, 16693.499195024167, 16972.321107155698, 17421.39025134127, 2057.4547744847628, 2143.389134096775, 2204.2946257197705, 2248.359217622986, 2259.062489067035, 69900.30099698988, 108527.45736271268, 158654.68744531684, 170173.0, 183581.16418835774, 19945.900270498554, 20586.970651467367, 20769.89615051915, 20801.89599051995, 20940.685889711665, 32178.678213218038, 32254.516182257285, 32298.192545186557, 32308.676913231036, 32412.35175296481, 9405.388649737744, 9492.9083155438, 10142.543585538668, 10288.794224115476, 10957.890421095846, 7430.405567554582, 9110.316726245557, 9125.634974601075, 9145.90854091464, 9300.11648893354, 7922.4850384724805, 9493.762655933657, 9547.761305967406, 9732.734744483172, 9739.902600974041, 2719.626588572758, 3021.3806169735153, 3974.6224108709625, 3977.7525697981127, 4059.6656922269813, 1086.6088208245183, 1097.023648952433, 1102.7463683352873, 1104.0174244922025, 1155.0759392485977, 21809.56380872374, 22320.107195712313, 22372.776272237395, 23852.761472385402, 24661.26016219516, 935.9157675809209, 971.4171497101682, 1005.6379703306803, 1050.5377633841238, 1077.3805062089173, 5923.703814809329, 6888.242293347727, 7249.891251631229, 7385.335319821242, 7502.287282708134, 764609.0, 837952.0, 842949.0, 848259.0, 861781.0, 176437.0, 176846.23153768555, 177107.11446442685, 178862.0, 181601.0, 1272.4401263444056, 1356.9660758481116, 1400.2718586335252, 1403.6561042544643, 1404.0873432269107, 12832.679183020125, 13128.540501082416, 13267.469301227842, 13490.392932317873, 13599.252041137832, 65829.67085164544, 66967.99548006881, 67352.0, 67992.0, 68730.65634671795, 96122.0, 96608.0, 97078.1460926965, 99060.0, 99319.0, 11615.012723918562, 12022.819657705317, 12043.0, 12043.879561204627, 12420.689482763004, 8782.868256976279, 13035.608931732064, 13363.0, 13636.318184090955, 13802.240876751875, 11665.35840528779, 11877.821832672344, 12142.75714485723, 12232.082593805322, 12264.509419623115, 10737.302075365076, 10829.079528240189, 10854.40300783433, 11014.50434730423, 11107.38909359993, 11875.881241187823, 12107.273563586214, 12165.33090680021, 12208.511659533518, 12223.388830558615, 11859.458270425135, 11890.227135236182, 12012.75974480523, 12039.578614748441, 12273.938630306791, 11839.940800295943, 11846.763064738829, 11993.220440671328, 12076.275423474268, 12249.0], "value": 11717.638352738255, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1599.7760313556098, 1616.7898173237477, 1653.2973486268334, 1654.784877965865, 1662.2021429713736, 10827.971342722438, 11480.368579728112, 11495.827562586568, 11509.136814738886, 11512.827307590393, 10920.563177472912, 11273.943630281838, 11422.828657570122, 11457.656270311903, 11459.025982791472, 2409.506051259492, 2443.816713746467, 2457.496213276274, 2459.0901366494422, 2459.7909177719916, 2367.6922000139957, 2430.6111022236446, 2452.828302018859, 2458.938526536842, 2466.5436894174636, 2347.5891718949115, 2415.239199652104, 2421.0315873650507, 2425.6846609940685, 2428.86641234732, 2187.562487502498, 2320.8955596998176, 2326.336993956714, 2377.8335516513853, 2421.624648179526, 2092.4141240452695, 2093.8534302598823, 2096.5387614724737, 2101.233049936777, 2102.810747032759, 11303.321800691985, 11355.772884542263, 11389.943050284779, 11393.886061139365, 11401.973822355945, 5672.205891175238, 5897.764089436418, 5915.112733090071, 6027.668478233695, 6108.1143234230785, 3126.155937896755, 3543.3799085159994, 3665.120371110941, 3745.2509498100217, 3747.2880152770886, 1203.8194270859353, 1223.9388030598523, 1277.2974863824859, 1281.9872300882291, 1297.9545715899992, 13738.244396558186, 14230.430782768677, 14597.489087881873, 15724.44964426251, 15885.046897186206, 4002.539707933625, 4711.128441238382, 4722.929312708007, 4816.95183048172, 4869.074875773592, 11984.340861252715, 12029.75940481203, 12033.278003319829, 12044.0, 12046.397680116135, 5839.065749480063, 5925.555583331267, 5952.3154837193415, 5955.106733989849, 5958.6424814511265, 5347.545458635982, 5403.4326395727885, 5474.178873168977, 5479.178123281539, 5500.312460942382, 3479.2867462170193, 3946.723729338976, 3956.9909673033194, 4027.496562929634, 4076.9388459173138, 893.2005854759954, 1029.8455231715152, 1043.3791893823163, 1045.2630895218851, 1057.7408534908843, 978.3982850547005, 994.264244459095, 1013.1236480444362, 1017.730301470111, 1029.5727273181546, 5052.595792336604, 5805.925903707743, 5906.173135760997, 6072.0, 6703.530752847254, 902.8600566912139, 936.3679516326453, 991.3209451525728, 992.8858181309098, 998.4508520313943, 3128.6402063762503, 4034.8991275218355, 4064.634182923492, 4218.114196018871, 4243.130158317537, 13481.123726957912, 14137.646558835906, 14166.645833854236, 14170.291485425687, 14178.361973711208, 14060.929695351459, 14079.85920140806, 14104.012719109563, 14109.435622574982, 14115.153090814583, 10087.0, 10206.13247873939, 10421.062104410488, 10451.425171615481, 10481.528331225114, 5282.630215884851, 6169.660668663087, 6817.079694241413, 6821.727130914708, 7009.088818453569, 12166.45250963691, 12169.2698438094, 12315.93842030784, 12317.07621928341, 12319.50721971147, 12202.572909948109, 12212.938935305267, 12230.266184028987, 12348.753024939631, 12541.0, 8605.182507661762, 8614.61234244448, 8714.869276960724, 8721.258693010912, 8737.956310218407, 10276.948615256875, 10420.531076101443, 10422.374657520573, 10530.894691053298, 10538.57845686164, 8875.334349923653, 8942.0, 8995.550222488719, 9173.312001599774, 9194.35639505255, 7645.732399365996, 8548.572571371531, 8771.07903670131, 8812.867806982773, 8873.157050080232, 8040.758777236692, 8179.959100204461, 8254.050784159659, 8441.873371899304, 8455.577221139041, 5983.37174596661, 5999.160117583455, 6013.428724271187, 6156.26124865019, 6237.438630523275, 6033.487153591994, 6082.513398928164, 6219.844503887439, 6253.187085678833, 6271.153394291712], "value": 5160.515005175804, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [336.2132609693317, 336.97641165118443, 366.9577998530168, 383.6662103969547, 387.4459522882279, 4933.497216975947, 5099.413567439741, 5310.362756469224, 5312.840614781553, 5360.597955153359, 4306.8277268909205, 4984.7756850941705, 5098.184290513518, 5141.742912854361, 5159.007775490216, 3478.478228265755, 3876.8061596920184, 4135.66914646829, 4291.763952982585, 4294.506131794837, 4103.938440923389, 4325.87527242916, 4337.436133302666, 4344.348347747831, 4362.672799540047, 4041.6564592009713, 4214.304639734455, 4290.0, 4338.913221735564, 4372.3878656988045, 3561.5904171020406, 4272.6154646081695, 4274.636655884254, 4313.762743049131, 4321.1141715948315, 3391.7783851577256, 3572.7673952486352, 3951.723379363446, 3966.702497312684, 3995.1622253763303, 4761.357331720551, 4883.536064073907, 5146.639735218536, 5189.610779191538, 5219.0, 4424.40270563473, 4975.676581022258, 4983.72589507577, 4986.177280748709, 5004.472741265674, 4886.584640305578, 5443.992861320668, 5572.219889215513, 5579.69311687857, 5646.435356464362, 4154.210699967027, 4186.497620285555, 4206.747595144301, 4398.780060996937, 4464.316938525697, 5396.892062158774, 5530.695811730353, 5655.717214139277, 5750.88498230033, 5818.6217895836635, 3737.4767532545466, 4015.5181378234797, 4036.59634036594, 4526.841560545365, 4538.704984176018, 4059.715819892638, 4314.913701725948, 4580.541945805459, 4653.2554791233915, 4693.577578017995, 4233.830646774156, 4601.0, 4618.422697162855, 4949.430815456197, 5012.298278241049, 4681.695689780154, 4682.307673087988, 4954.9009019819405, 5061.949380506221, 5281.023010742948, 1424.287856071964, 1549.690061987607, 1553.673728517024, 1568.443202663061, 1575.4013474879703, 1034.9741256468499, 1076.2520048566328, 1177.9175457717877, 1178.5091858798626, 1201.1891972918245, 4989.178949683412, 5058.342415486037, 5194.818181363634, 5214.113600687892, 5234.869128271824, 5010.949890501049, 5075.187969924795, 5111.846644600668, 5390.622656414092, 5741.655500669973, 4894.161386395882, 5135.485031915594, 5207.270982062514, 5234.712090834964, 5247.317848679723, 2572.626969089509, 2625.553655878467, 2637.406583518693, 2858.9142325730263, 2982.403519296106, 5051.318072060225, 5543.390227075019, 5782.865251345224, 5830.76676932918, 5946.851328716817, 4871.575968973326, 4966.652334336634, 5258.3689957204615, 5309.973450132802, 5836.562257830595, 5463.508284254357, 5545.77816887328, 5925.318588362307, 5936.910946335722, 5955.79154729591, 4750.144973904592, 4959.165108909727, 5112.74436278192, 5751.309842818721, 5754.482096611325, 4930.383702037246, 5344.759485823225, 5676.602637815313, 5716.685582293014, 5751.539876809761, 5272.815451459181, 5278.20541016041, 5453.318335208099, 5681.914771278517, 5867.32525759526, 3802.6007269236334, 4045.8846688050626, 4492.9775351123035, 4562.0, 4591.334256532851, 4636.52575264871, 5375.871067075958, 5507.752151153288, 5523.834284971457, 5761.769529218785, 4745.6678032538775, 5232.011835502484, 5448.945510544844, 5515.283013208257, 5533.889322213614, 5518.668879867221, 5526.171074338881, 5534.833954981357, 5535.667859928417, 5536.861578460571, 4410.095930334338, 5208.0, 5290.523852853262, 5435.266239057834, 5496.780128794963, 4557.749323787091, 4947.628927830499, 4996.550310472075, 5252.1596544552685, 5567.0, 4605.447346318463, 5148.9742551287, 5457.399686034453, 5468.671879687232, 5488.560915126701], "value": 4187.5486579036715, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [739.1647438394614, 758.8102974256433, 787.8936343593613, 802.7230605441124, 833.8749187621858, 15845.445409410673, 17606.82393176071, 17662.470125896212, 17680.557986050357, 17697.82302176978, 16033.679326413465, 16116.75824862628, 16120.596985075379, 16283.918580407082, 16285.02289862609, 987.323683276954, 988.1551273661042, 992.4095163377779, 1012.7468132966758, 1057.006413970865, 1023.0536753503017, 1033.0547548992663, 1038.1746511523356, 1038.2420832792066, 1039.9168066554657, 1071.8820929697727, 1072.4476894399352, 1072.4905669806858, 1073.3452593917705, 1074.9946250268738, 1064.2497039587072, 1064.834950582661, 1066.2962444786403, 1067.2049323254187, 1067.626330784227, 792.6195426195401, 793.8134538383475, 794.047143427883, 794.4994653368399, 795.4630624328613, 16510.917445412815, 16907.830921690747, 17482.562935926577, 17718.202680879393, 17753.55616109595, 14527.854721452755, 14784.704305913929, 14954.327055282538, 14980.176090315028, 15181.16503592302, 11918.225315354473, 12187.939060304641, 12343.814842777365, 12401.75196496074, 12812.167209131376, 3247.269364393016, 3855.248226595815, 3924.1955399143108, 4068.613481719232, 4072.857449989236, 95923.0407695921, 127062.72937270602, 130803.0, 131059.0, 134890.0, 11556.422178891022, 11575.710607234887, 11747.647570572897, 11751.529938802523, 11966.341851198267, 20280.985950702405, 22252.664840109646, 23129.07483700633, 23189.53620927572, 23201.071957121865, 8137.0, 8176.0, 8384.8742268866, 8690.95654521736, 8743.650253989768, 4556.951901062708, 4721.858344249678, 4755.500672429414, 4770.809167633325, 4803.975980120077, 3435.587729472479, 3459.757816952789, 3515.6308587598446, 3519.0, 3542.1144713821545, 604.4046614085123, 607.9665618390942, 612.3753771153398, 619.4579742725116, 625.5183508698277, 702.5082442290314, 706.8409607838298, 732.8973943647893, 752.8757754970369, 784.811645205158, 10755.247132700635, 10847.51186196623, 10949.83575246372, 11194.664160075048, 11414.315141091562, 733.5232099135604, 747.7943565519416, 761.5941776821173, 765.276813411321, 777.249953794591, 5017.648764586444, 5291.920621190685, 5299.973500132474, 5300.92048619271, 5301.125314323171, 111127.0, 113618.43190784159, 115791.0, 117553.0, 117991.41004295096, 53279.73360133252, 60772.530472257706, 76305.85541216886, 77295.61352193203, 87603.9916806654, 70876.0, 73241.16897077615, 78898.0, 79956.0, 83740.74388884293, 10989.175811813986, 11276.041536469163, 11289.943550282196, 11303.378314192798, 11701.648950531498, 49863.50136498589, 50063.748406290135, 50875.0, 51488.712782180744, 53400.0, 60105.39894600998, 63588.68205658942, 63699.0, 66200.0, 73780.0, 12919.677008074874, 13175.341232938506, 13757.140298151178, 14257.287135643384, 14453.0, 15274.0, 15935.442259520862, 16072.437464688679, 16137.354505819636, 16808.915955420634, 14075.155490670593, 14329.283535822959, 14926.477573285318, 15026.17356045428, 15372.615684607974, 14024.929875350557, 14697.632559186106, 14822.110673359633, 14839.183844888636, 15352.692946141238, 13835.446582136601, 14769.04001239916, 14807.33366998466, 14810.037347572374, 15174.772378414113, 10306.92320244492, 10724.51739671701, 11098.2786118902, 11346.60286889988, 11449.771004579696, 8782.123349682986, 10648.040433842229, 11227.0, 11678.24091434054, 12324.445399956845], "value": 8078.571977262381, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1427.6999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 118.0, 116.0, 118.0, 118.0, 118.0, 119.0, 118.0, 118.0, 118.0], "value": 116.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 106.0, 101.0, 143.0, 108.0, 108.0, 116.0, 134.0, 160.0, 130.0], "value": 124.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 185.0, 183.0, 183.0, 182.0, 184.0, 180.0, 183.0, 183.0], "value": 183.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 60.0, 58.0, 90.0, 62.0, 60.0, 58.0, 58.0, 72.0, 60.0], "value": 66.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 69.0, 87.0, 70.0, 70.0, 54.0, 80.0, 84.0, 100.0, 113.0], "value": 81.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 89.0, 88.0, 89.0, 89.0, 90.0, 89.0, 88.0, 88.0], "value": 88.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 103.0, 95.0], "value": 96.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 83.0, 88.0, 85.0, 84.0, 85.0, 86.0, 86.0, 82.0], "value": 84.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 58.0, 59.0, 60.0, 62.0, 61.0, 62.0, 62.0, 62.0], "value": 60.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 66.0, 66.0, 62.0, 59.0, 58.0, 58.0, 59.0, 57.0, 57.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 79.0, 80.0, 98.0, 80.0, 80.0, 83.0, 81.0, 84.0, 83.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 131.0, 132.0, 132.0, 132.0, 133.0, 138.0, 137.0, 197.0, 156.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 163.0, 161.0, 159.0, 159.0, 216.0, 209.0, 160.0, 164.0, 161.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 65.0, 63.0, 65.0, 66.0, 77.0, 78.0, 77.0, 77.0], "value": 69.8, "unit": "score"}]}]} 07:47:51 INFO - Return code: 0 07:47:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 07:47:51 INFO - # TBPL SUCCESS # 07:47:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:47:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:47:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:47:51 INFO - 2017-05-04 07:47:51.651 screenresolution[1658:13544] starting screenresolution argv=screenresolution get 07:47:51 INFO - 2017-05-04 07:47:51.653 screenresolution[1658:13544] Display 0: 1600x1200x32@60 07:47:51 INFO - 2017-05-04 07:47:51.659 screenresolution[1659:13547] starting screenresolution argv=screenresolution list 07:47:51 INFO - Available Modes on Display 0 07:47:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:47:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:47:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:47:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:47:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:47:51 INFO - Intel Iris: 07:47:51 INFO - Chipset Model: Intel Iris 07:47:51 INFO - Type: GPU 07:47:51 INFO - Bus: Built-In 07:47:51 INFO - VRAM (Dynamic, Max): 1536 MB 07:47:51 INFO - Vendor: Intel (0x8086) 07:47:51 INFO - Device ID: 0x0a2e 07:47:51 INFO - Revision ID: 0x0009 07:47:51 INFO - Displays: 07:47:51 INFO - Display: 07:47:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:47:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:47:51 INFO - Display Serial Number: 1600x1200 60 07:47:51 INFO - Main Display: Yes 07:47:51 INFO - Mirror: Off 07:47:51 INFO - Online: Yes 07:47:51 INFO - Rotation: Supported 07:47:51 INFO - Return code: 0 07:47:51 INFO - Running post-action listener: _resource_record_post_action 07:47:51 INFO - [mozharness: 2017-05-04 14:47:51.894331Z] Finished run-tests step (success) 07:47:51 INFO - Running post-run listener: _resource_record_post_run 07:47:51 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 32660480; Write bytes: 422879232; Read time: 194; Write time: 1385 07:47:51 INFO - TinderboxPrint: CPU usage
53.5% 07:47:51 INFO - TinderboxPrint: I/O read bytes / time
32,660,480 / 194 07:47:51 INFO - TinderboxPrint: I/O write bytes / time
422,879,232 / 1,385 07:47:51 INFO - TinderboxPrint: CPU idle
2,221.3 (46.5%) 07:47:51 INFO - TinderboxPrint: CPU system
948.1 (19.8%) 07:47:51 INFO - TinderboxPrint: CPU user
1,608.3 (33.7%) 07:47:51 INFO - TinderboxPrint: Swap in / out
150,986,752 / 0 07:47:51 INFO - install - Wall time: 15s; CPU: 53.0%; Read bytes: 119550464; Write bytes: 112922624; Read time: 11013; Write time: 246 07:47:51 INFO - run-tests - Wall time: 1179s; CPU: 54.0%; Read bytes: 30583808; Write bytes: 298889216; Read time: 176; Write time: 1106 07:47:52 INFO - Running post-run listener: _upload_blobber_files 07:47:52 INFO - Blob upload gear active. 07:47:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:47:52 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 07:47:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 07:47:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 07:47:52 INFO - (blobuploader) - INFO - Open directory for files ... 07:47:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:47:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:47:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:47:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:47:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:47:53 INFO - (blobuploader) - INFO - Done attempting. 07:47:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:47:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:47:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:47:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:47:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:47:54 INFO - (blobuploader) - INFO - Done attempting. 07:47:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 07:47:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:47:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:47:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 07:47:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:47:55 INFO - (blobuploader) - INFO - Done attempting. 07:47:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 07:47:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:47:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:47:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 07:47:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:47:57 INFO - (blobuploader) - INFO - Done attempting. 07:47:57 INFO - (blobuploader) - INFO - Iteration through files over. 07:47:57 INFO - Return code: 0 07:47:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:47:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:47:57 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b1de77e7751ed1b57343b3f6a8dde520c34105a4fb420c5ab09e177b7b58a7bf81d6fbf8a6cea93078afa8b0d00d4a48c11d452a51240b6031b22ed6209a137", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f28531dcdf61cb32d4b4d8892021ffa182187c967c4f50b2f276654669a8b8d94ef8d8fc82ad53f1032a23a3acadd7db5c042729267bf540a79e1193dbd6fa6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f98c89c2dd2b51008e5aac052b0817e571a25315bcb3d8ac2f9ce3edf545e9dbd4a15f008fe23bd3e8a9ccee6d0ca72a2b17a47fdbb6c7d92549f140937b4cf6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ba26e4e152379b9503de8926b8e3bca23ec70c14147e4037e50e55016c16aaa92af4211fc8a1c4535ee11c54553a35f5b2c83e54c76714571dd8b81878cc3dc"} 07:47:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:47:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:47:57 INFO - Contents: 07:47:57 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b1de77e7751ed1b57343b3f6a8dde520c34105a4fb420c5ab09e177b7b58a7bf81d6fbf8a6cea93078afa8b0d00d4a48c11d452a51240b6031b22ed6209a137", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f28531dcdf61cb32d4b4d8892021ffa182187c967c4f50b2f276654669a8b8d94ef8d8fc82ad53f1032a23a3acadd7db5c042729267bf540a79e1193dbd6fa6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f98c89c2dd2b51008e5aac052b0817e571a25315bcb3d8ac2f9ce3edf545e9dbd4a15f008fe23bd3e8a9ccee6d0ca72a2b17a47fdbb6c7d92549f140937b4cf6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ba26e4e152379b9503de8926b8e3bca23ec70c14147e4037e50e55016c16aaa92af4211fc8a1c4535ee11c54553a35f5b2c83e54c76714571dd8b81878cc3dc"} 07:47:57 INFO - Running post-run listener: copy_logs_to_upload_dir 07:47:57 INFO - Copying logs to upload dir... 07:47:57 INFO - mkdir: /builds/slave/test/build/upload/logs 07:47:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1271.608409 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2017-05-04 07:47:58.003051) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 07:47:58.008567) ========= 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.1eSJ7qSo66/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.Km9oXO8QQJ/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b1de77e7751ed1b57343b3f6a8dde520c34105a4fb420c5ab09e177b7b58a7bf81d6fbf8a6cea93078afa8b0d00d4a48c11d452a51240b6031b22ed6209a137", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f28531dcdf61cb32d4b4d8892021ffa182187c967c4f50b2f276654669a8b8d94ef8d8fc82ad53f1032a23a3acadd7db5c042729267bf540a79e1193dbd6fa6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f98c89c2dd2b51008e5aac052b0817e571a25315bcb3d8ac2f9ce3edf545e9dbd4a15f008fe23bd3e8a9ccee6d0ca72a2b17a47fdbb6c7d92549f140937b4cf6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ba26e4e152379b9503de8926b8e3bca23ec70c14147e4037e50e55016c16aaa92af4211fc8a1c4535ee11c54553a35f5b2c83e54c76714571dd8b81878cc3dc"} build_url:https://queue.taskcluster.net/v1/task/LOZxW9d9T3CaQkxhaQ3Ghg/artifacts/public/build/firefox-54.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011286 build_url: 'https://queue.taskcluster.net/v1/task/LOZxW9d9T3CaQkxhaQ3Ghg/artifacts/public/build/firefox-54.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/1b1de77e7751ed1b57343b3f6a8dde520c34105a4fb420c5ab09e177b7b58a7bf81d6fbf8a6cea93078afa8b0d00d4a48c11d452a51240b6031b22ed6209a137", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f28531dcdf61cb32d4b4d8892021ffa182187c967c4f50b2f276654669a8b8d94ef8d8fc82ad53f1032a23a3acadd7db5c042729267bf540a79e1193dbd6fa6a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f98c89c2dd2b51008e5aac052b0817e571a25315bcb3d8ac2f9ce3edf545e9dbd4a15f008fe23bd3e8a9ccee6d0ca72a2b17a47fdbb6c7d92549f140937b4cf6", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/7ba26e4e152379b9503de8926b8e3bca23ec70c14147e4037e50e55016c16aaa92af4211fc8a1c4535ee11c54553a35f5b2c83e54c76714571dd8b81878cc3dc"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-04 07:47:58.044652) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 07:47:58.045031) ========= 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.1eSJ7qSo66/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.Km9oXO8QQJ/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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.005470 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-04 07:47:58.093981) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 07:47:58.094303) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-04 07:47:58.094648) ========= ========= Total master_lag: 0.27 =========