builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0257 starttime: 1492948131.13 results: success (0) buildid: 20170423030206 builduid: 1c36ef7c1cb0492aa1fb5c5bd442fc41 revision: 070fc3c2f8400c09f1037f5444c3d33b499e7128 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-23 04:48:51.134768) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-23 04:48:51.135391) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-23 04:48:51.135831) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-23 04:48:51.166301) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-23 04:48:51.166870) ========= 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.p73tS6SYBh/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.arWWIapo87/Listeners TMPDIR=/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-04-23 04:48:51-- 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% 19.2M=0.001s 2017-04-23 04:48:51 (19.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.614159 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-23 04:48:51.847466) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-23 04:48:51.847749) ========= 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.p73tS6SYBh/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.arWWIapo87/Listeners TMPDIR=/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/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.027743 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-23 04:48:51.901572) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-23 04:48:51.901893) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 070fc3c2f8400c09f1037f5444c3d33b499e7128 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 070fc3c2f8400c09f1037f5444c3d33b499e7128 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.p73tS6SYBh/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.arWWIapo87/Listeners TMPDIR=/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-04-23 04:48:52,146 truncating revision to first 12 chars 2017-04-23 04:48:52,146 Setting DEBUG logging. 2017-04-23 04:48:52,146 attempt 1/10 2017-04-23 04:48:52,146 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/070fc3c2f840?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-23 04:48:53,921 unpacking tar archive at: mozilla-central-070fc3c2f840/testing/mozharness/ program finished with exit code 0 elapsedTime=2.059941 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-23 04:48:53.985647) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-23 04:48:53.985949) ========= script_repo_revision: 070fc3c2f8400c09f1037f5444c3d33b499e7128 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-23 04:48:53.986372) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-23 04:48:53.986645) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-23 04:48:54.006816) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-23 04:48:54.007142) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.p73tS6SYBh/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.arWWIapo87/Listeners TMPDIR=/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/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 04:48:54 INFO - MultiFileLogger online at 20170423 04:48:54 in /builds/slave/test 04:48:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:48:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:48:54 INFO - {'append_to_log': False, 04:48:54 INFO - 'base_work_dir': '/builds/slave/test', 04:48:54 INFO - 'blob_upload_branch': 'Firefox', 04:48:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:48:54 INFO - 'branch': 'Firefox', 04:48:54 INFO - 'buildbot_json_path': 'buildprops.json', 04:48:54 INFO - 'config_files': ('talos/mac_config.py',), 04:48:54 INFO - 'default_actions': ('clobber', 04:48:54 INFO - 'read-buildbot-config', 04:48:54 INFO - 'download-and-extract', 04:48:54 INFO - 'populate-webroot', 04:48:54 INFO - 'create-virtualenv', 04:48:54 INFO - 'install', 04:48:54 INFO - 'run-tests'), 04:48:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:48:54 INFO - 'download_minidump_stackwalk': True, 04:48:54 INFO - 'download_symbols': 'ondemand', 04:48:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:48:54 INFO - 'tooltool.py': '/tools/tooltool.py', 04:48:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:48:54 INFO - '/tools/misc-python/virtualenv.py')}, 04:48:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:48:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:48:54 INFO - 'gecko_profile': False, 04:48:54 INFO - 'gecko_profile_interval': 0, 04:48:54 INFO - 'installer_path': 'installer.exe', 04:48:54 INFO - 'log_level': 'info', 04:48:54 INFO - 'log_name': 'talos', 04:48:54 INFO - 'log_to_console': True, 04:48:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:48:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:48:54 INFO - 'opt_config_files': (), 04:48:54 INFO - 'pip_index': False, 04:48:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:48:54 INFO - 'cmd': ('bash', 04:48:54 INFO - '-c', 04:48:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:48:54 INFO - 'enabled': True, 04:48:54 INFO - 'halt_on_failure': False, 04:48:54 INFO - 'name': 'check_screen_resolution'},), 04:48:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:48:54 INFO - 'cmd': ('bash', 04:48:54 INFO - '-c', 04:48:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:48:54 INFO - 'enabled': True, 04:48:54 INFO - 'halt_on_failure': False, 04:48:54 INFO - 'name': 'check_screen_resolution'},), 04:48:54 INFO - 'run_cmd_checks_enabled': True, 04:48:54 INFO - 'suite': 'dromaeojs', 04:48:54 INFO - 'system_bits': '32', 04:48:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:48:54 INFO - 'title': 't-yosemite-r7-0257', 04:48:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:48:54 INFO - 'use_talos_json': True, 04:48:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:48:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:48:54 INFO - 'work_dir': 'build'} 04:48:54 INFO - [mozharness: 2017-04-23 11:48:54.360006Z] Running clobber step. 04:48:54 INFO - Running pre-action listener: _resource_record_pre_action 04:48:54 INFO - Running main action method: clobber 04:48:54 INFO - rmtree: /builds/slave/test/build 04:48:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:48:57 INFO - Running post-action listener: _resource_record_post_action 04:48:57 INFO - [mozharness: 2017-04-23 11:48:57.051350Z] Finished clobber step (success) 04:48:57 INFO - [mozharness: 2017-04-23 11:48:57.051520Z] Running read-buildbot-config step. 04:48:57 INFO - Running pre-action listener: _resource_record_pre_action 04:48:57 INFO - Running main action method: read_buildbot_config 04:48:57 INFO - Using buildbot properties: 04:48:57 INFO - { 04:48:57 INFO - "project": "", 04:48:57 INFO - "product": "firefox", 04:48:57 INFO - "script_repo_revision": "production", 04:48:57 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:48:57 INFO - "repository": "", 04:48:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:48:57 INFO - "buildid": "20170423030206", 04:48:57 INFO - "stage_platform": "macosx64", 04:48:57 INFO - "basedir": "/builds/slave/test", 04:48:57 INFO - "nightly_build": "True", 04:48:57 INFO - "buildnumber": 33, 04:48:57 INFO - "slavename": "t-yosemite-r7-0257", 04:48:57 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:48:57 INFO - "platform": "yosemite_r7", 04:48:57 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:48:57 INFO - "branch": "mozilla-central", 04:48:57 INFO - "repo_path": "mozilla-central", 04:48:57 INFO - "revision": "070fc3c2f8400c09f1037f5444c3d33b499e7128", 04:48:57 INFO - "pgo_build": "False", 04:48:57 INFO - "builduid": "1c36ef7c1cb0492aa1fb5c5bd442fc41", 04:48:57 INFO - "slavebuilddir": "test" 04:48:57 INFO - } 04:48:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:48:57 INFO - Running post-action listener: _resource_record_post_action 04:48:57 INFO - [mozharness: 2017-04-23 11:48:57.055188Z] Finished read-buildbot-config step (success) 04:48:57 INFO - [mozharness: 2017-04-23 11:48:57.055304Z] Running download-and-extract step. 04:48:57 INFO - Running pre-action listener: _resource_record_pre_action 04:48:57 INFO - Running main action method: download_and_extract 04:48:57 INFO - mkdir: /builds/slave/test/build/tests 04:48: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')]} 04:48:57 INFO - trying https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:48:57 INFO - Downloading https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:48:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:48:58 INFO - Downloaded 1325 bytes. 04:48:58 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:48:58 INFO - Using the following test package requirements: 04:48:58 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:58 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:48:58 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:48:58 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:58 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:48:58 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:58 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:48:58 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:58 INFO - u'jsshell-mac.zip'], 04:48:58 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:58 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:48:58 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:48:58 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:58 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:48:58 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:58 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:48:58 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:58 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:48:58 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:48:58 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:48:58 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:48:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:48:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:48:58 INFO - Fetch https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:48:59 INFO - Content-Length response header: 52523695 04:48:59 INFO - Bytes received: 52523695 04:49:15 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:49:15 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:49:15 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:49:15 INFO - Fetch https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:49:17 INFO - Content-Length response header: 52523695 04:49:17 INFO - Bytes received: 52523695 04:49:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:49:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:49:33 INFO - Fetch https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:49:34 INFO - Content-Length response header: 14408811 04:49:34 INFO - Bytes received: 14408811 04:49: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')]} 04:49:34 INFO - trying https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:49:34 INFO - Downloading https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:49:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:49:37 INFO - Downloaded 71119849 bytes. 04:49:37 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:49:37 INFO - mkdir: /builds/slave/test/properties 04:49:37 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:49:37 INFO - Writing to file /builds/slave/test/properties/build_url 04:49:37 INFO - Contents: 04:49:37 INFO - build_url:https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:49:37 INFO - Running post-action listener: _resource_record_post_action 04:49:37 INFO - Running post-action listener: set_extra_try_arguments 04:49:37 INFO - [mozharness: 2017-04-23 11:49:37.955048Z] Finished download-and-extract step (success) 04:49:37 INFO - [mozharness: 2017-04-23 11:49:37.955185Z] Running populate-webroot step. 04:49:37 INFO - Running pre-action listener: _resource_record_pre_action 04:49:37 INFO - Running main action method: populate_webroot 04:49:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:49:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:49:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:49:37 INFO - '--tppagecycles', 04:49:37 INFO - '7'], 04:49:37 INFO - 'tests': ['tsvgm']}}, 04:49:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:49:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:49:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:49:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:49:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:49:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:49:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:49:37 INFO - 'talos_options': ['--disable-e10s'], 04:49:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:49:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:49:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:49:37 INFO - 'talos_options': ['--disable-e10s'], 04:49:37 INFO - 'tests': ['damp', 'tps']}, 04:49:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:49:37 INFO - 'tests': ['damp', 'tps']}, 04:49:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:49:37 INFO - 'tests': ['dromaeo_dom']}, 04:49:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:49:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:49:37 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:49:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:49:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:49:37 INFO - 'tests': ['a11yr', 04:49:37 INFO - 'ts_paint', 04:49:37 INFO - 'tpaint', 04:49:37 INFO - 'sessionrestore', 04:49:37 INFO - 'sessionrestore_no_auto_restore', 04:49:37 INFO - 'tabpaint']}, 04:49:37 INFO - 'other-e10s': {'tests': ['a11yr', 04:49:37 INFO - 'ts_paint', 04:49:37 INFO - 'tpaint', 04:49:37 INFO - 'sessionrestore', 04:49:37 INFO - 'sessionrestore_no_auto_restore', 04:49:37 INFO - 'tabpaint']}, 04:49:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:49:37 INFO - 'ts_paint', 04:49:37 INFO - 'tpaint', 04:49:37 INFO - 'sessionrestore', 04:49:37 INFO - 'sessionrestore_no_auto_restore', 04:49:37 INFO - 'tabpaint']}, 04:49:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:49:37 INFO - 'ts_paint', 04:49:37 INFO - 'tpaint', 04:49:37 INFO - 'sessionrestore', 04:49:37 INFO - 'sessionrestore_no_auto_restore', 04:49:37 INFO - 'tabpaint']}, 04:49:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:49:37 INFO - 'tests': ['a11yr', 04:49:37 INFO - 'ts_paint', 04:49:37 INFO - 'tpaint', 04:49:37 INFO - 'sessionrestore', 04:49:37 INFO - 'sessionrestore_no_auto_restore', 04:49:37 INFO - 'tabpaint']}, 04:49:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:49:37 INFO - 'tests': ['a11yr', 04:49:37 INFO - 'ts_paint', 04:49:37 INFO - 'tpaint', 04:49:37 INFO - 'sessionrestore', 04:49:37 INFO - 'sessionrestore_no_auto_restore', 04:49:37 INFO - 'tabpaint']}, 04:49:37 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:49:37 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:49:37 INFO - 'bloom_basic_ref']}, 04:49:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:49:37 INFO - 'tests': ['tsvgx', 04:49:37 INFO - 'tsvgr_opacity', 04:49:37 INFO - 'tart', 04:49:37 INFO - 'tscrollx', 04:49:37 INFO - 'cart', 04:49:37 INFO - 'tsvg_static']}, 04:49:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:49:37 INFO - 'tsvgr_opacity', 04:49:37 INFO - 'tart', 04:49:37 INFO - 'tscrollx', 04:49:37 INFO - 'cart', 04:49:37 INFO - 'tsvg_static']}, 04:49:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:49:37 INFO - 'talos_options': ['--disable-e10s'], 04:49:37 INFO - 'tests': ['tp5o']}, 04:49:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:49:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:49:37 INFO - 'talos_options': ['--disable-e10s', 04:49:37 INFO - '--xperf_path', 04:49:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:37 INFO - 'tests': ['tp5n']}, 04:49:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:49:37 INFO - 'talos_options': ['--xperf_path', 04:49:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:49:37 INFO - 'tests': ['tp5n']}}, 04:49:37 INFO - 'talos.zip': {'path': '', 04:49:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:49:37 INFO - Running post-action listener: _resource_record_post_action 04:49:37 INFO - [mozharness: 2017-04-23 11:49:37.974512Z] Finished populate-webroot step (success) 04:49:37 INFO - [mozharness: 2017-04-23 11:49:37.974623Z] Running create-virtualenv step. 04:49:37 INFO - Running pre-action listener: _resource_record_pre_action 04:49:37 INFO - Running main action method: create_virtualenv 04:49:37 INFO - Creating virtualenv /builds/slave/test/build/venv 04:49:37 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 04:49:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:49:38 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:49:38 INFO - Using real prefix '/tools/python27' 04:49:38 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:49:38 INFO - Installing distribute.............................................................................................................................................................................................done. 04:49:41 INFO - Installing pip.................done. 04:49:41 INFO - Return code: 0 04:49:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:49:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:49:41 INFO - Reading from file tmpfile_stdout 04:49:41 INFO - Output received: 04:49:41 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) 04:49:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:49:41 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')]} 04:49:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:41 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')]} 04:49:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:41 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 0x10b168b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b16b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f04cd780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af46d30>, '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 0x10ae6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af3bbe8>, '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.p73tS6SYBh/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.arWWIapo87/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/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 04:49:41 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 04:49:41 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 04:49:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p73tS6SYBh/Render', 04:49:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:41 INFO - 'HOME': '/Users/cltbld', 04:49:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:41 INFO - 'LOGNAME': 'cltbld', 04:49:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:41 INFO - 'MOZ_NO_REMOTE': '1', 04:49:41 INFO - 'NO_EM_RESTART': '1', 04:49:41 INFO - 'PAGER': '/bin/cat', 04:49:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:41 INFO - 'PWD': '/builds/slave/test', 04:49:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:41 INFO - 'SHELL': '/bin/bash', 04:49:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.arWWIapo87/Listeners', 04:49:41 INFO - 'TMPDIR': '/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/', 04:49:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:41 INFO - 'USER': 'cltbld', 04:49:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:41 INFO - 'XPC_FLAGS': '0x0', 04:49:41 INFO - 'XPC_SERVICE_NAME': '0', 04:49:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:42 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 04:49:42 INFO - Cleaning up... 04:49:42 INFO - Return code: 0 04:49:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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', '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 0x10b168b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b16b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f04cd780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af46d30>, '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 0x10ae6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af3bbe8>, '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.p73tS6SYBh/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.arWWIapo87/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/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 04:49: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', 'psutil>=3.1.1'] in /builds/slave/test/build 04:49: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 psutil>=3.1.1 04:49:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p73tS6SYBh/Render', 04:49:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:42 INFO - 'HOME': '/Users/cltbld', 04:49:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:42 INFO - 'LOGNAME': 'cltbld', 04:49:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:42 INFO - 'MOZ_NO_REMOTE': '1', 04:49:42 INFO - 'NO_EM_RESTART': '1', 04:49:42 INFO - 'PAGER': '/bin/cat', 04:49:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:42 INFO - 'PWD': '/builds/slave/test', 04:49:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:42 INFO - 'SHELL': '/bin/bash', 04:49:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.arWWIapo87/Listeners', 04:49:42 INFO - 'TMPDIR': '/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/', 04:49:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:42 INFO - 'USER': 'cltbld', 04:49:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:42 INFO - 'XPC_FLAGS': '0x0', 04:49:42 INFO - 'XPC_SERVICE_NAME': '0', 04:49:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:42 INFO - Downloading/unpacking psutil>=3.1.1 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:49:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:46 INFO - Installing collected packages: psutil 04:49:46 INFO - Running setup.py install for psutil 04:49:46 INFO - building 'psutil._psutil_osx' extension 04:49:46 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 04:49:47 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 04:49:47 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 04:49:47 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 04:49:47 INFO - building 'psutil._psutil_posix' extension 04:49:47 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 04:49:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:49:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:49:47 INFO - ^ 04:49:47 INFO - 1 warning generated. 04:49:47 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 04:49:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:49:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:49:47 INFO - Successfully installed psutil 04:49:47 INFO - Cleaning up... 04:49:47 INFO - Return code: 0 04:49:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b168b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b16b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f04cd780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af46d30>, '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 0x10ae6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af3bbe8>, '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.p73tS6SYBh/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.arWWIapo87/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/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 04:49:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:49:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:49:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p73tS6SYBh/Render', 04:49:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:47 INFO - 'HOME': '/Users/cltbld', 04:49:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:47 INFO - 'LOGNAME': 'cltbld', 04:49:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:47 INFO - 'MOZ_NO_REMOTE': '1', 04:49:47 INFO - 'NO_EM_RESTART': '1', 04:49:47 INFO - 'PAGER': '/bin/cat', 04:49:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:47 INFO - 'PWD': '/builds/slave/test', 04:49:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:47 INFO - 'SHELL': '/bin/bash', 04:49:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.arWWIapo87/Listeners', 04:49:47 INFO - 'TMPDIR': '/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/', 04:49:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:47 INFO - 'USER': 'cltbld', 04:49:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:47 INFO - 'XPC_FLAGS': '0x0', 04:49:47 INFO - 'XPC_SERVICE_NAME': '0', 04:49:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:49:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:49:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:49:50 INFO - Installing collected packages: mozsystemmonitor 04:49:50 INFO - Running setup.py install for mozsystemmonitor 04:49:50 INFO - Successfully installed mozsystemmonitor 04:49:50 INFO - Cleaning up... 04:49:50 INFO - Return code: 0 04:49:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:49: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')]} 04:49:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49: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')]} 04:49:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b168b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b16b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f04cd780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af46d30>, '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 0x10ae6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af3bbe8>, '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.p73tS6SYBh/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.arWWIapo87/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/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 04:49:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:49:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:49:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p73tS6SYBh/Render', 04:49:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:50 INFO - 'HOME': '/Users/cltbld', 04:49:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:50 INFO - 'LOGNAME': 'cltbld', 04:49:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:50 INFO - 'MOZ_NO_REMOTE': '1', 04:49:50 INFO - 'NO_EM_RESTART': '1', 04:49:50 INFO - 'PAGER': '/bin/cat', 04:49:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:50 INFO - 'PWD': '/builds/slave/test', 04:49:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:50 INFO - 'SHELL': '/bin/bash', 04:49:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.arWWIapo87/Listeners', 04:49:50 INFO - 'TMPDIR': '/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/', 04:49:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:50 INFO - 'USER': 'cltbld', 04:49:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:50 INFO - 'XPC_FLAGS': '0x0', 04:49:50 INFO - 'XPC_SERVICE_NAME': '0', 04:49:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:51 INFO - Downloading/unpacking jsonschema==2.5.1 04:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:49:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49: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 04:49:54 INFO - Downloading functools32-3.2.3-2.tar.gz 04:49:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:49:54 INFO - warning: no files found matching '*.txt' 04:49:54 INFO - no previously-included directories found matching 'build' 04:49:54 INFO - no previously-included directories found matching 'dist' 04:49:54 INFO - no previously-included directories found matching '.git*' 04:49:54 INFO - Installing collected packages: jsonschema, functools32 04:49:54 INFO - Running setup.py install for functools32 04:49:54 INFO - warning: no files found matching '*.txt' 04:49:54 INFO - no previously-included directories found matching 'build' 04:49:54 INFO - no previously-included directories found matching 'dist' 04:49:54 INFO - no previously-included directories found matching '.git*' 04:49:54 INFO - Successfully installed jsonschema functools32 04:49:54 INFO - Cleaning up... 04:49:54 INFO - Return code: 0 04:49:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:49:54 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')]} 04:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:54 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')]} 04:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:54 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 0x10b168b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b16b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f04cd780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af46d30>, '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 0x10ae6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af3bbe8>, '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.p73tS6SYBh/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.arWWIapo87/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/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 04:49:54 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 04:49:54 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 04:49:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p73tS6SYBh/Render', 04:49:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:54 INFO - 'HOME': '/Users/cltbld', 04:49:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:54 INFO - 'LOGNAME': 'cltbld', 04:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:54 INFO - 'MOZ_NO_REMOTE': '1', 04:49:54 INFO - 'NO_EM_RESTART': '1', 04:49:54 INFO - 'PAGER': '/bin/cat', 04:49:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:54 INFO - 'PWD': '/builds/slave/test', 04:49:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:54 INFO - 'SHELL': '/bin/bash', 04:49:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.arWWIapo87/Listeners', 04:49:54 INFO - 'TMPDIR': '/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/', 04:49:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:54 INFO - 'USER': 'cltbld', 04:49:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:54 INFO - 'XPC_FLAGS': '0x0', 04:49:54 INFO - 'XPC_SERVICE_NAME': '0', 04:49:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:49:54 INFO - Cleaning up... 04:49:54 INFO - Return code: 0 04:49:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:49:54 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')]} 04:49:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:54 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')]} 04:49:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:54 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 0x10b168b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b16b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f04cd780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af46d30>, '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 0x10ae6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af3bbe8>, '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.p73tS6SYBh/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.arWWIapo87/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/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 04:49:54 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 04:49:54 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 04:49:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p73tS6SYBh/Render', 04:49:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:54 INFO - 'HOME': '/Users/cltbld', 04:49:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:54 INFO - 'LOGNAME': 'cltbld', 04:49:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:54 INFO - 'MOZ_NO_REMOTE': '1', 04:49:54 INFO - 'NO_EM_RESTART': '1', 04:49:54 INFO - 'PAGER': '/bin/cat', 04:49:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:54 INFO - 'PWD': '/builds/slave/test', 04:49:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:54 INFO - 'SHELL': '/bin/bash', 04:49:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.arWWIapo87/Listeners', 04:49:54 INFO - 'TMPDIR': '/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/', 04:49:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:54 INFO - 'USER': 'cltbld', 04:49:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:54 INFO - 'XPC_FLAGS': '0x0', 04:49:54 INFO - 'XPC_SERVICE_NAME': '0', 04:49:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:49:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:49:55 INFO - Downloading/unpacking blobuploader==1.2.4 04:49:55 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 04:49:55 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 04:49:55 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 04:49:55 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 04:49:55 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 04:49:55 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 04:49:57 INFO - Downloading blobuploader-1.2.4.tar.gz 04:49:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:49:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:49:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:49:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:49:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:49:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:49:58 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 04:49:58 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 04:49:58 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 04:49:58 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 04:49:58 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 04:49:58 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 04:49:58 INFO - Downloading docopt-0.6.1.tar.gz 04:49:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:49:58 INFO - Installing collected packages: blobuploader, requests, docopt 04:49:58 INFO - Running setup.py install for blobuploader 04:49:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:49:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:49:59 INFO - Running setup.py install for requests 04:49:59 INFO - Running setup.py install for docopt 04:49:59 INFO - Successfully installed blobuploader requests docopt 04:49:59 INFO - Cleaning up... 04:49:59 INFO - Return code: 0 04:49:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:49:59 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')]} 04:49:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:49:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:59 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')]} 04:49:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:49:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:49:59 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 0x10b168b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b16b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f04cd780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af46d30>, '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 0x10ae6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af3bbe8>, '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.p73tS6SYBh/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.arWWIapo87/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/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 04:49:59 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 04:49:59 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 04:49:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p73tS6SYBh/Render', 04:49:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:49:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:49:59 INFO - 'HOME': '/Users/cltbld', 04:49:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:49:59 INFO - 'LOGNAME': 'cltbld', 04:49:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:49:59 INFO - 'MOZ_NO_REMOTE': '1', 04:49:59 INFO - 'NO_EM_RESTART': '1', 04:49:59 INFO - 'PAGER': '/bin/cat', 04:49:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:49:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:49:59 INFO - 'PWD': '/builds/slave/test', 04:49:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:49:59 INFO - 'SHELL': '/bin/bash', 04:49:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.arWWIapo87/Listeners', 04:49:59 INFO - 'TMPDIR': '/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/', 04:49:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:49:59 INFO - 'USER': 'cltbld', 04:49:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:49:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:49:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:49:59 INFO - 'XPC_FLAGS': '0x0', 04:49:59 INFO - 'XPC_SERVICE_NAME': '0', 04:49:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:50:00 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-TrRz7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:50:00 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-Ye4lr0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:50:00 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-wVtXP5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:50:00 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-7lVv2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:50:00 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-EjvIlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:50:00 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-Qzt41e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:50:00 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-tqXhip-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:50:00 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-Cja4No-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:50:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:50:00 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-pEC0pP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:50:01 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-Tuy8AN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:50:01 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-yd0oTu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:50:01 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-ngVd3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:50:01 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-4WqJHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:50:01 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-sWv3N9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:01 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-FvRmM1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:50:01 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-mSDOsP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:50:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:50:01 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-coKo3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:50:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:50:01 INFO - Running setup.py install for manifestparser 04:50:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:50:02 INFO - Running setup.py install for mozcrash 04:50:02 INFO - Running setup.py install for mozdebug 04:50:02 INFO - Running setup.py install for mozdevice 04:50:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:50:02 INFO - Running setup.py install for mozfile 04:50:02 INFO - Running setup.py install for mozhttpd 04:50:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:50:02 INFO - Running setup.py install for mozinfo 04:50:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:50:02 INFO - Running setup.py install for mozInstall 04:50:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:50:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:50:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:50:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:50:03 INFO - Running setup.py install for mozleak 04:50:03 INFO - Running setup.py install for mozlog 04:50:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:50:03 INFO - Running setup.py install for moznetwork 04:50:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:50:03 INFO - Running setup.py install for mozprocess 04:50:03 INFO - Running setup.py install for mozprofile 04:50:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:50:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:50:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:50:03 INFO - Running setup.py install for mozrunner 04:50:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:50:03 INFO - Running setup.py install for mozscreenshot 04:50:04 INFO - Running setup.py install for moztest 04:50:04 INFO - Running setup.py install for mozversion 04:50:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:50:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:50:04 INFO - Cleaning up... 04:50:04 INFO - Return code: 0 04:50:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:04 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 0x10b168b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b16b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f04cd780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af46d30>, '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 0x10ae6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af3bbe8>, '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.p73tS6SYBh/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.arWWIapo87/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/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 04:50:04 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 04:50:04 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 04:50:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p73tS6SYBh/Render', 04:50:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:04 INFO - 'HOME': '/Users/cltbld', 04:50:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:04 INFO - 'LOGNAME': 'cltbld', 04:50:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:04 INFO - 'MOZ_NO_REMOTE': '1', 04:50:04 INFO - 'NO_EM_RESTART': '1', 04:50:04 INFO - 'PAGER': '/bin/cat', 04:50:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:04 INFO - 'PWD': '/builds/slave/test', 04:50:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:04 INFO - 'SHELL': '/bin/bash', 04:50:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.arWWIapo87/Listeners', 04:50:04 INFO - 'TMPDIR': '/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/', 04:50:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:04 INFO - 'USER': 'cltbld', 04:50:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:04 INFO - 'XPC_FLAGS': '0x0', 04:50:04 INFO - 'XPC_SERVICE_NAME': '0', 04:50:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:50:04 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-z5wXyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:50:04 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)) 04:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:50:04 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-RW1cOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:50:04 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)) 04:50:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:50:04 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-wwAabk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:50:05 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)) 04:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:50:05 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-CdO4RL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:50:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:50:05 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-aDRFEb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:50:05 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)) 04:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:50:05 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-fKB9gz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:50:05 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)) 04:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:50:05 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-Oxhd0p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:50:05 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)) 04:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:50:05 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-wfP0Y6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:50:05 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)) 04:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:50:05 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-4zdSqg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:50:05 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)) 04:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:50:05 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-263VkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:50:05 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)) 04:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:50:05 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-ywg4dA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:50:05 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)) 04:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:50:05 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-5BKywI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:50:05 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)) 04:50:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:50:05 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-jJxo08-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:50:06 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)) 04:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:50:06 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-rHLNZ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:50:06 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)) 04:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:06 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-XpUNk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:50:06 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)) 04:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:50:06 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-U04RQl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:50:06 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)) 04:50:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:50:06 INFO - Running setup.py (path:/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/pip-RenfHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:50:06 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)) 04:50:06 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)) 04:50:06 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)) 04:50:06 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)) 04:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:50:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:50:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:50:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:50:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:50:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:50:09 INFO - Downloading blessings-1.6.tar.gz 04:50:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:50:09 INFO - Installing collected packages: blessings 04:50:09 INFO - Running setup.py install for blessings 04:50:09 INFO - Successfully installed blessings 04:50:09 INFO - Cleaning up... 04:50:09 INFO - Return code: 0 04:50:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:50:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:50:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:50:09 INFO - Reading from file tmpfile_stdout 04:50:09 INFO - Current package versions: 04:50:09 INFO - blessings == 1.6 04:50:09 INFO - blobuploader == 1.2.4 04:50:09 INFO - docopt == 0.6.1 04:50:09 INFO - functools32 == 3.2.3-2 04:50:09 INFO - jsonschema == 2.5.1 04:50:09 INFO - manifestparser == 1.1 04:50:09 INFO - mozInstall == 1.12 04:50:09 INFO - mozcrash == 1.0 04:50:09 INFO - mozdebug == 0.1 04:50:09 INFO - mozdevice == 0.50 04:50:09 INFO - mozfile == 1.2 04:50:09 INFO - mozhttpd == 0.7 04:50:09 INFO - mozinfo == 0.9 04:50:09 INFO - mozleak == 0.1 04:50:09 INFO - mozlog == 3.4 04:50:09 INFO - moznetwork == 0.27 04:50:09 INFO - mozprocess == 0.25 04:50:09 INFO - mozprofile == 0.28 04:50:09 INFO - mozrunner == 6.13 04:50:09 INFO - mozscreenshot == 0.1 04:50:09 INFO - mozsystemmonitor == 0.3 04:50:09 INFO - moztest == 0.8 04:50:09 INFO - mozversion == 1.4 04:50:09 INFO - psutil == 3.1.1 04:50:09 INFO - requests == 1.2.3 04:50:09 INFO - wsgiref == 0.1.2 04:50:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:50:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:09 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 0x10b168b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b16b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f04cd780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af46d30>, '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 0x10ae6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af3bbe8>, '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.p73tS6SYBh/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.arWWIapo87/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/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 04:50:09 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 04:50:09 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 04:50:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p73tS6SYBh/Render', 04:50:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:09 INFO - 'HOME': '/Users/cltbld', 04:50:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:09 INFO - 'LOGNAME': 'cltbld', 04:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:09 INFO - 'MOZ_NO_REMOTE': '1', 04:50:09 INFO - 'NO_EM_RESTART': '1', 04:50:09 INFO - 'PAGER': '/bin/cat', 04:50:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:09 INFO - 'PWD': '/builds/slave/test', 04:50:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:09 INFO - 'SHELL': '/bin/bash', 04:50:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.arWWIapo87/Listeners', 04:50:09 INFO - 'TMPDIR': '/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/', 04:50:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:09 INFO - 'USER': 'cltbld', 04:50:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:09 INFO - 'XPC_FLAGS': '0x0', 04:50:09 INFO - 'XPC_SERVICE_NAME': '0', 04:50:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:09 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)) 04:50:09 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)) 04:50:09 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)) 04:50:09 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)) 04:50:09 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)) 04:50:09 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)) 04:50:09 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)) 04:50:09 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)) 04:50:09 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)) 04:50:09 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)) 04:50:09 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)) 04:50:09 INFO - Cleaning up... 04:50:09 INFO - Return code: 0 04:50:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:50:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:50:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:50:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:50:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:50:09 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 0x10b168b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b16b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f84f04cd780>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af46d30>, '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 0x10ae6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af3bbe8>, '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.p73tS6SYBh/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.arWWIapo87/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/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 04:50:09 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 04:50:09 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 04:50:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p73tS6SYBh/Render', 04:50:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:09 INFO - 'HOME': '/Users/cltbld', 04:50:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:09 INFO - 'LOGNAME': 'cltbld', 04:50:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:09 INFO - 'MOZ_NO_REMOTE': '1', 04:50:09 INFO - 'NO_EM_RESTART': '1', 04:50:09 INFO - 'PAGER': '/bin/cat', 04:50:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:09 INFO - 'PWD': '/builds/slave/test', 04:50:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:09 INFO - 'SHELL': '/bin/bash', 04:50:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.arWWIapo87/Listeners', 04:50:09 INFO - 'TMPDIR': '/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/', 04:50:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:09 INFO - 'USER': 'cltbld', 04:50:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:09 INFO - 'XPC_FLAGS': '0x0', 04:50:09 INFO - 'XPC_SERVICE_NAME': '0', 04:50:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:50:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:50:10 INFO - Cleaning up... 04:50:10 INFO - Return code: 0 04:50:10 INFO - Running post-action listener: _resource_record_post_action 04:50:10 INFO - Running post-action listener: _start_resource_monitoring 04:50:10 INFO - Starting resource monitoring. 04:50:10 INFO - [mozharness: 2017-04-23 11:50:10.256687Z] Finished create-virtualenv step (success) 04:50:10 INFO - [mozharness: 2017-04-23 11:50:10.257668Z] Running install step. 04:50:10 INFO - Running pre-action listener: _resource_record_pre_action 04:50:10 INFO - Running main action method: install 04:50:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:50:10 INFO - Reading from file tmpfile_stdout 04:50:10 INFO - Detecting whether we're running mozinstall >=1.0... 04:50:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:50:10 INFO - Reading from file tmpfile_stdout 04:50:10 INFO - Output received: 04:50:10 INFO - Usage: mozinstall [options] installer 04:50:10 INFO - Options: 04:50:10 INFO - -h, --help show this help message and exit 04:50:10 INFO - -d DEST, --destination=DEST 04:50:10 INFO - Directory to install application into. [default: 04:50:10 INFO - "/builds/slave/test"] 04:50:10 INFO - --app=APP Application being installed. [default: firefox] 04:50:10 INFO - mkdir: /builds/slave/test/build/application 04:50:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:50:30 INFO - Reading from file tmpfile_stdout 04:50:30 INFO - Output received: 04:50:30 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:50:30 INFO - Running post-action listener: _resource_record_post_action 04:50:30 INFO - [mozharness: 2017-04-23 11:50:30.471997Z] Finished install step (success) 04:50:30 INFO - [mozharness: 2017-04-23 11:50:30.472121Z] Running run-tests step. 04:50:30 INFO - Running pre-action listener: _resource_record_pre_action 04:50:30 INFO - Running main action method: run_tests 04:50:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:50:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:50:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:50:30 INFO - 2017-04-23 04:50:30.486 screenresolution[1670:11514] starting screenresolution argv=screenresolution get 04:50:30 INFO - 2017-04-23 04:50:30.489 screenresolution[1670:11514] Display 0: 1600x1200x32@60 04:50:30 INFO - 2017-04-23 04:50:30.494 screenresolution[1671:11517] starting screenresolution argv=screenresolution list 04:50:30 INFO - Available Modes on Display 0 04:50:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:50:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:50:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:50:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:50:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:50:30 INFO - Intel Iris: 04:50:30 INFO - Chipset Model: Intel Iris 04:50:30 INFO - Type: GPU 04:50:30 INFO - Bus: Built-In 04:50:30 INFO - VRAM (Dynamic, Max): 1536 MB 04:50:30 INFO - Vendor: Intel (0x8086) 04:50:30 INFO - Device ID: 0x0a2e 04:50:30 INFO - Revision ID: 0x0009 04:50:30 INFO - Displays: 04:50:30 INFO - Display: 04:50:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:50:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:50:30 INFO - Display Serial Number: 1600x1200 60 04:50:30 INFO - Main Display: Yes 04:50:30 INFO - Mirror: Off 04:50:30 INFO - Online: Yes 04:50:30 INFO - Rotation: Supported 04:50:30 INFO - Return code: 0 04:50:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:50:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:50:30 INFO - Python 2.7.3 04:50:30 INFO - Return code: 0 04:50:30 INFO - grabbing minidump binary from tooltool 04:50:30 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')]} 04:50:30 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 0x10af46d30>, '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 0x10ae6cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10af3bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:50:30 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 04:50:30 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 04:50:30 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 04:50:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:50:30 INFO - Return code: 0 04:50:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:50:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:50:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:50:30 INFO - ENV: RUST_BACKTRACE is now 1 04:50:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:50:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:50:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0257', '--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 04:50:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0257 --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 04:50:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.p73tS6SYBh/Render', 04:50:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:50:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:50:30 INFO - 'HOME': '/Users/cltbld', 04:50:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:50:30 INFO - 'LOGNAME': 'cltbld', 04:50:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:50:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:50:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:50:30 INFO - 'MOZ_NO_REMOTE': '1', 04:50:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:50:30 INFO - 'NO_EM_RESTART': '1', 04:50:30 INFO - 'PAGER': '/bin/cat', 04:50:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:50:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:50:30 INFO - 'PWD': '/builds/slave/test', 04:50:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:50:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:50:30 INFO - 'RUST_BACKTRACE': '1', 04:50:30 INFO - 'SHELL': '/bin/bash', 04:50:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.arWWIapo87/Listeners', 04:50:30 INFO - 'TMPDIR': '/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/', 04:50:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:50:30 INFO - 'USER': 'cltbld', 04:50:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:50:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:50:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:50:30 INFO - 'XPC_FLAGS': '0x0', 04:50:30 INFO - 'XPC_SERVICE_NAME': '0', 04:50:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:50:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0257', '--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 04:50:31 INFO - mozversion application_buildid: 20170423030206 04:50:31 INFO - mozversion application_changeset: 070fc3c2f8400c09f1037f5444c3d33b499e7128 04:50:31 INFO - mozversion application_display_name: Nightly 04:50:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:50:31 INFO - mozversion application_name: Firefox 04:50:31 INFO - mozversion application_remotingname: firefox 04:50:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:50:31 INFO - mozversion application_vendor: Mozilla 04:50:31 INFO - mozversion application_version: 55.0a1 04:50:31 INFO - mozversion platform_buildid: 20170423030206 04:50:31 INFO - mozversion platform_changeset: 070fc3c2f8400c09f1037f5444c3d33b499e7128 04:50:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:50:31 INFO - mozversion platform_version: 55.0a1 04:50:31 INFO - using testdate: 1492948231 04:50:31 INFO - actual date: 1492948231 04:50:31 INFO - starting webserver on 'localhost:49250' 04:50:31 INFO - SUITE-START | Running 2 tests 04:50:31 INFO - TEST-START | dromaeo_css 04:50:31 INFO - operating with platform_type : mac_ 04:50:31 INFO - Initialising browser for dromaeo_css test... 04:50:31 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/tmps1Qjmz/profile http://localhost:49250/getInfo.html) 04:50:33 INFO - PID 1681 | __metrics Screen width/height:1600/1200 04:50:33 INFO - PID 1681 | colorDepth:24 04:50:33 INFO - PID 1681 | Browser inner width/height: 1024/689 04:50:33 INFO - PID 1681 | __metrics 04:50:33 INFO - PID 1681 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:50:33 INFO - PID 1681 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:50:35 INFO - TEST-INFO | 1681: exit 0 04:50:35 INFO - Browser initialized. 04:50:35 INFO - Running cycle 1/1 for dromaeo_css test... 04:50:35 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/tmps1Qjmz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:50:47 INFO - PID 1685 | RSS: Main: 240783360 04:50:47 INFO - PID 1685 | 04:53:52 INFO - PID 1685 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49250/tests/dromaeo/cssquery-ext.html) 04:53:54 INFO - PID 1685 | RSS: Main: 407855104 04:53:54 INFO - PID 1685 | 04:55:36 INFO - PID 1685 | ************************* 04:55:36 INFO - PID 1685 | A coding exception was thrown and uncaught in a Task. 04:55:36 INFO - PID 1685 | 04:55:36 ERROR - PID 1685 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:55:36 INFO - PID 1685 | Full stack: 04:55:36 INFO - PID 1685 | ************************* 04:55:36 INFO - PID 1685 | ************************* 04:55:36 INFO - PID 1685 | A coding exception was thrown and uncaught in a Task. 04:55:36 INFO - PID 1685 | 04:55:36 ERROR - PID 1685 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:55:36 INFO - PID 1685 | Full stack: 04:55:36 INFO - PID 1685 | ************************* 04:55:36 INFO - PID 1685 | ************************* 04:55:36 INFO - PID 1685 | A coding exception was thrown and uncaught in a Task. 04:55:36 INFO - PID 1685 | 04:55:36 ERROR - PID 1685 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:55:36 INFO - PID 1685 | Full stack: 04:55:36 INFO - PID 1685 | ************************* 04:55:36 INFO - PID 1685 | ************************* 04:55:36 INFO - PID 1685 | A coding exception was thrown and uncaught in a Task. 04:55:36 INFO - PID 1685 | 04:55:36 ERROR - PID 1685 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:55:36 INFO - PID 1685 | Full stack: 04:55:36 INFO - PID 1685 | ************************* 04:56:56 INFO - PID 1685 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-ext.html (next: http://localhost:49250/tests/dromaeo/cssquery-jquery.html) 04:56:57 INFO - PID 1685 | RSS: Main: 373481472 04:56:57 INFO - PID 1685 | 04:59:59 INFO - PID 1685 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49250/tests/dromaeo/cssquery-mootools.html) 05:00:00 INFO - PID 1685 | RSS: Main: 334053376 05:00:00 INFO - PID 1685 | 05:03:02 INFO - PID 1685 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49250/tests/dromaeo/cssquery-prototype.html) 05:03:03 INFO - PID 1685 | RSS: Main: 332132352 05:03:03 INFO - PID 1685 | 05:06:07 INFO - PID 1685 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49250/tests/dromaeo/cssquery-yui.html) 05:06:07 INFO - PID 1685 | RSS: Main: 338149376 05:06:07 INFO - PID 1685 | 05:09:10 INFO - PID 1685 | Cycle 1(1): loaded http://localhost:49250/tests/dromaeo/cssquery-yui.html (next: http://localhost:49250/tests/dromaeo/cssquery-dojo.html) 05:09:10 INFO - PID 1685 | RSS: Main: 381763584 05:09:10 INFO - PID 1685 | 05:09:10 INFO - PID 1685 | __start_tp_report 05:09:10 INFO - PID 1685 | _x_x_mozilla_page_load 05:09:10 INFO - PID 1685 | _x_x_mozilla_page_load_details 05:09:10 INFO - PID 1685 | |i|pagename|runs| 05:09:10 INFO - PID 1685 | |0;dojo.html;3154.2745168611204;3455.9308813823723;3543.9114022149442;3562.0204443777957;3571;5937.524998000161;6067.423594758502;6196.349383314755;6207.565470417073;6216.875662486747;6051.364606716297;6111.7249723762425;6120.234970628671;6132.110843927628;6136.938630613692;5242.659227150223;5247.1866860636665;5259.184826351902;5267.683938963655;5383.057964856134;5372.0330340538685;5374.650647707906;5377.946220537803;5378.327709036371;5383.542398896079;5370.382406023318;5372.355317361922;5375.032494151052;5376.8118115865955;5378.085725426687;5361.383440904287;5373.59698022646;5381.650192737459;5384.7846086156505;5387.811426600069;5242.397124330712;5328.3605967284175;5329.920051199235;5330.466953304677;5333.173358129496;6221.533384996098;6251.156093927352;6275.6548389838545;6277.7175027123885;6278.183836101323;6007.639541627516;6359.17330747;6501.869962600769;6527.543071984963;6550.541462097655;4863.8784030399165;5422.186671999192;6426;6468.676566171673;6605.207375114969;5243.895122097537;6250.843728906768;6326.114343991845;6329.145565348711;6329.9872020476505;6695.096162018162;6755.324467553205;6768.018637297663;6768.357006084414;6776.796696099125;6316.557840951089;6398.488120950313;6406.167198264289;6414.390632889868;6436.517261205428;6496.935030649633;6527.412532871969;6543.607383557001;6585.111010013587;6594.86810263792;6408.327125651833;6476.838079048061;6484.708188131545;6489.967550162219;6504.739810407531;6301.7164227609865;6484.578502397423;6509.804705858832;6529.7714579990425;6534.281229064799;5176.715280659525;5193.68837869729;5217.895642087137;5237;5293.867653308621;4693.530646935279;4697.95302046982;4700.529947005272;4731;4750.477447480775;6208.192934918432;6242.219722534684;6252.3122456529745;6252.937470625327;6253.78111766086;6380.170577824853;6441.3880681335195;6457.1282876811965;6514.543981921315;6654.70053847578;6175.62946223228;6215.12988181655;6240.095186197976;6242.719077641517;6256.249250089927;5749.8275051748515;5769.509591684754;5771.30744310677;5771.509421699203;5813.912791308134;6461.2892581816905;6541.803745887631;6694.83262918431;6819.454443644596;6837;6430.871382572416;6433.742650294123;6452.032195170762;6460.580062295936;6533.477321814148;6754.054432379373;6820.761273355409;6824.965875170592;6825.522213445011;6843.076184715;6478.838029049311;6491.993740970157;6493.935060649522;6508.381703738138;6513.674316284261;6376.489880809431;6428.067930150009;6431.228252609717;6605.834854128685;6616.239132499824;6341.112244285711;6380.680965951591;6393.8721225576155;6405.167328247298;6405.615663060231;6283.622982620875;6288.119663247057;6351.587146835441;6354.364563543609;6395.360463953567;5064.037832811754;6316.399942005502;6337;6356.809295721136;6361.809145725636;6428.774992875227;6438.420542151229;6440.259370172303;6442.8389290268115;6458.580192287486;6200.162977997912;6260.342664020212;6271.717772700148;6283.403076707706;6304.306526282014 05:09:10 INFO - PID 1685 | |1;ext.html;737.402703809914;783.7570353190512;801.1427772283657;1115.8103122469179;1125.9774804503916;28312.433751324963;37353.06617334564;37526.62473375269;37619.05952351186;37688.62311376885;40461;40647.79676101615;40649.79675101628;40725.79637101818;40812.59187408125;6107.938920610782;8427.789305267355;8660.13398660132;8664.0902705216;8670.653173873037;5188.92216616751;8558.828823423528;8713.215810577047;8739.781505462352;8753.693620723276;8780.912190878105;8813.07462716412;8826.117388261187;8827.735167944971;8891.777705557348;8742.256908162783;8790.340724445692;8792.692255771017;8797.384183107186;8832.425892317044;8509.48943063412;8566.957165214197;8579.442336248187;8585.699500517514;8596.527191004492;38192;38266.23467530634;38442.61557384418;38444.42333365002;38468;3572;3593.7843729376323;3593.964060359389;3595.6044835068124;3598.802065886375;31144.377112457623;31200;31200.37599248025;31215.687843121734;31301.686983130105;3154.2902846859274;3180.984095079533;3210.8876189333496;3218.0185043561705;3226.790258633181;291572;297928.510357449;298121.99999999785;298200;298213;50672.74663626732;50726.49273507218;50733.23900141501;50802;50915.49084509107;53073.46926530763;53307;53334;53411;53463.93072138535;13893.305334733424;14001.089929154572;14011.229382384066;14024.298785060706;14025.265073310811;9809.313348065709;11322.037626801814;11342.149338799623;11375;11383.715407114889;11410.600628978113;11487.655370338904;12870.742585148244;12906.161099528501;13102.672433189056;5174.586033117342;5195;5211.296474975829;5221.765020574083;5222.843314700565;949.5726922884729;1012.3520946594185;1017.6082208349691;1052.9157667386744;1075.1936047964027;19493.31773387953;22789.430264243525;24534;24625.63061554078;24766.628500572508;1099.3349023840622;1111.9777604448027;1145.478807142748;1145.6563031090639;1155.364549497773;12537.93731031339;12546.560870369492;12563.811542826865;12596.685082873002;12703.93648031754;298732;298995;299653;299672;299761.0023899777;44165.77917110458;54172;54201.72899135558;54246.45753542493;54413.91172176534;1459.3943513442016;1463.6633574277976;1518.4533567915541;1530.6632540840997;1535.4702627593463;20011.299604513773;24279;24489.877550612135;24528.01887924463;24596.139135130186;39329.016774580865;39417.60582394254;39448.40827387649;39490;39569.80215098906;271767;272467;273026;275037.62481187464;280444;35408.82295588506;35617.82191089028;35743.821280893426;35755.927322180374;35798.28403431969;45740.8564785883;46746.53253467422;46914.29628555506;46943.530564695284;46993.29510057283;25465.363365916;29013.56479652849;31688.841555792074;31968.36063278768;32116.518252225767;30571.694283057775;30977.760889564164;31693.683063169072;31871.521927171576;31955.881544145843;38634.6136538631;38669;38682;38724;38763.80618096892;27026.594601080607;31391.529127063568;31556.106633602056;32266;32650.51024234686;21830.89084554567;22182.556348873255;23778.881105594362;24462.021519139034;25115 05:09:10 INFO - PID 1685 | |2;jquery.html;374.1544110310697;382.9655331020208;389.8596505258108;420.96421804146644;431.98488052918157;13904.791428128587;18893.905530472362;20837.47906302343;21537.46156346092;21860.797656128907;21652.458688532755;22360;23071.653925191134;23090;23421.531569368603;4957.934044180501;6090.299615544225;6275.811725648238;6302.590331628452;6332.588381755171;6112.51099912006;6262.405071518198;6272.623642581437;6279.623222606635;6287.937120628804;5123.872747995435;5272.655472854417;6229.906551401733;6248.625082495042;6281.152044474006;6153.7230824613;6263.780767673133;6314.62112273265;6316.30520642729;6325.272593651743;5527.419620939783;5606.439356064361;5625.662460252398;5641.633293835887;5642.887142257173;26322.341941451425;26590.73409265902;27087.729122708915;27157;27574.034908778096;2174.826013918883;2236.0720301075035;2242.7420846602686;2242.8990695418584;2243.5176437065948;17430;17455.301787928594;17898.463046108638;17929.282828686835;18091.72862407065;1959.9412017639493;2050.8564400491823;2091.435312465641;2123.9150433982622;2138.8609740366983;109662;129885;151098.24450877676;158929.8481568332;161792;11102.888971110347;11135.387553684624;11257.380844053656;12431.37843107841;12507;15369.231538423033;15430.5370838875;16257.105859177858;16749.748753768705;16783;7736.342410895137;8679.218870301704;8799.868001979976;8859.778505537284;9007.504587247633;8271.8345633087;8272.805247475168;8306.584670766437;8451.873221901677;8540.957295213608;7642.5032372895585;7777.444511097803;7818.843623127505;7829.64766585505;7837.725679601187;2187.7921597448217;2194;2194.9451263718533;2196.4728465168246;2324.5467133908724;930.3812964378612;931.8602209668468;957.9952100239454;971.3055165556661;986.9654562090292;19123.90438047801;19776.40670779879;21555.67666485004;21690.34928952134;21757.041866232114;981.1758123176566;987.1313244344931;1007.4761124215366;1011.6863772230632;1017.3692310767372;10818;10932.726681833017;10970.067544258827;10978.615748448767;10992;551958;556689;560230;562316.4641127014;564868;127316;132982;133050.33474832564;134192;138452.30773846267;1180.6635108993896;1185.2532904270427;1213.8664746877837;1221.8228356888378;1228.5700004998357;21038.789612103683;21650.67523987173;21718.131274748834;21718.45703857416;21731.891340543196;54740;55999.88000239891;56099.71950140223;56183.43816561782;56635.43364566466;76604.61697691475;77619.61190194012;79123;79710;81464.59267703624;8690.869636955324;8702.521361325187;8821.426607270507;8963.731088067369;9021.864672030057;11717.179797414099;11944.223625464318;12650.30423326726;13947.37236824325;14132.364043617856;10956.233063685466;11835.585754498552;11928.343941083323;12091.39543022863;12264.264144151379;11343.602973895873;11351.262167959056;11455;11684.824727629262;11723.179377443497;11703.707407314885;11875.584354547549;12137.453814578541;12213.877861221274;12288.324142172267;8623.482591044558;8659.6103175356;8697.652093916426;9038.728838134866;9162.450252984841;10026.749331266778;11739.589114380955;12047;12110.515579376726;12111.515539378326 05:09:10 INFO - PID 1685 | |3;mootools.html;1328.594778592529;1411.3578321863547;1429.8856091512673;1452.9927350363246;1456;11264.493097810599;11706.707332316686;11728.589499367525;11744.295342279469;11748.76502469951;11367.658970230907;11703.941480292586;11717.894757889166;11735;11773.823392649096;2512.7612876776675;2547.694276686791;2550.744925507453;2552.693676758782;2556.3992461771563;2090.1221486975505;2396.532676128156;2517.5216708825355;2525.02786427225;2525.6085306777386;2141.8286537076997;2163.653815389538;2164.4588852786806;2165.631842586764;2167.219800871685;2444.0956845967016;2514.509670614231;2518.508890766301;2518.8110891683195;2523.823332366726;2394.8580695871765;2415.6738840256517;2422.685050943384;2432.7202371727126;2465.790407815338;11631.360275184861;11762.000459921834;11762.764744705059;11774.823377649342;11796.823047654292;6539.280679125292;6782.186137663462;6793.796186114425;6797.354251346114;6798.116244888133;4000.739951903146;4343.413639158736;4403.3174857897075;4420.646348292161;4445.377647129404;1216.4404373987977;1228.1955319265894;1293.6313150752085;1297.9935100324533;1303.67408147963;16577.91711041449;16656.250468728937;16705.498835034967;16720.331186752515;16720.83279167205;5170.819021334235;5249.42256351801;5442.183672449164;5648.322201335866;5716.542676585863;12290;12300;12323.815142772866;12324.952379047882;12361.07291953089;5693.9430605693415;6360.014197799349;6485.6108633482145;6612.603243805387;6623.437007854386;6091.878162436727;6115.877682446326;6135.141080248769;6221.4089661482085;6229.4082062204925;3808.3423175949;4101.646456669292;4299.9785001075425;4310.50429200646;4333.285007973649;1251.4806355362605;1274.1842873904834;1294.8187253784479;1297.780794840814;1299.753046921082;780.480980148195;794.9960250198827;800.3677095094927;816.5753808019797;824.5135370131651;5647.29408823897;6150.7847225346895;6152.077188421683;6259.7496100156395;6348.492120630339;580.4833698008775;587.0870795912311;606.372404561277;609.0468416927495;617.9258488981351;3831.8695984684587;3835.6356146166067;3841.822484385115;3943.7633741975;3985.501812273466;14329.713405732036;14876.553703388916;15050.473233436996;15089.773653395208;15105.169215693242;14357.095932952392;14721.484748033767;14728.55814325572;14979.40082396692;15198;8404.621792019374;8488.702895398756;8666.306695464347;8674.56627168639;8791.252743516745;6897.448204143556;6941.895871561829;7123.394511466583;7168.605726684874;7244.963775181091;13391.799123012968;13444.596662100153;13501.864981350061;13583.932080339535;13880.097793643381;13884.791728124288;13885.166889986633;13895.513657021957;14062.859371406155;14103.717925641224;9568.282378821477;9688.224942004763;9739.561719722771;9755.170810481188;9758.365706229357;10725.08836748885;10984.780304393707;11089.611863584736;11143.721406964567;11177.217594768288;9116.179543841086;9124.49815260167;9128.634854605742;9146.496942668216;9358.204552612831;8925.598348074222;8973.192412682889;9062.320325975446;9075.636974520945;9089.409188402733;6823.965880170567;6887.758928437681;8162.918370816215;8169.428140030141;8273.958630206811;5624.818788054555;5942.168096466412;6115.357887421935;6125.1424800527075;6130.570860039755;6054.455099041107;6143;6143.631382117087;6149.200603921461;6258.561900667091 05:09:10 INFO - PID 1685 | |4;prototype.html;390.91399892023753;396.379665822987;398.4043854437616;403.34255164082543;403.491600583265;5091.592672586194;5845.357010728816;5872.530197584194;5879.265091863523;5882.705804722965;5213.765380557875;5224.764885580148;5539.473749993755;5753.769849206027;5811.418858114197;3866.2460820140086;4462.219111655463;4463.263561512346;4485.237509623372;4506.616937560295;4387.68369489152;4400.493943196525;4495.797689103982;4504.617107545862;4551.7724113794175;3535.4166562517153;3714.944275835851;4436.645068394537;4480.843170489034;4496.965697889487;4063.1061166543313;4204.894877628069;4400.647948164139;4431.40176076232;4451.9777401113115;3926.450296958428;3932.643238082857;3950.38768990804;3950.723449358546;3975.926499845026;5342.118550439173;5557.277244054356;5644.322681278273;5652.886942261173;5666.291713535808;5096.668716533413;5320.228566857822;5360.195970604441;5360.249565060894;5396.91904621431;5527.407185329528;5734.853029394096;5824.53403727705;6111.938880611181;6201;3790.8862734117743;3995.5604883462797;4183.811728472226;4246.384274280212;4517.977410112929;6238.2825975013;6416.550841441054;6416.839579010515;6504.869902601921;6605.9669701651665;4182.853600123981;4251.553586873334;4254.7021708480725;4279;4284.250256205214;4330.566943305645;4348.804303806336;4350.260455722535;4355.15074560464;4370.541093185233;4578.2903649934315;4779.856604301876;4897.608191344684;5040.799092576167;5041.344625198701;6106.328303886569;6174.845628859224;6219.937800621936;6223.96888015557;6226.346233645492;1397.9650508737363;1459.7664373700156;1478.209158100411;1482.9777553336494;1488.2558720639681;966.183574879226;991.2516050381915;1002.8367094170727;1004.9598016079422;1009.647072922273;5106.923396149061;5566.805161819317;5879.412058794172;5886.440788125121;5906.40935906406;5391.892162156735;6101.786437474667;6422.74309027643;6427.485801135898;6436.259830119502;5425.294711687534;5567.972160139173;5652.9152062719095;5799.2460980073165;5934.792282270186;2824.717528247159;3123.422166899131;3314.502824576333;3321.5183798349585;3359.546461227752;6265.718042687999;6518.315576864456;6638.83402914931;6650.70071846768;6720.1599800025;6218.409251121137;6551.477681092813;6577.901331480031;6605.86788264232;6618.7021584028835;6233.189685341058;6615.180825273088;6660.467162626978;6663.4669226461765;6663.966680166665;6092.634441933498;6103;6368.267649220399;6496.382843629847;6512.153420055362;6316.084167795736;6337.6197428154455;6345.333739957238;6357.650329231937;6359.841003974938;6281.026440901667;6307.432331090224;6363.840903977252;6457.4188323049275;6519.771807986698;4235.724677895927;4236.957630423656;4269.225003747589;4272.209641216385;4277.144571085733;5358.812441564683;6101.481374083252;6407.231132264158;6421.8073457796345;6476.870462590816;5926.703664816656;6240.375962403723;6245.720996476886;6249.031400132987;6254.810816214471;4831.492693267297;6065.363136870565;6183.567150299616;6235.875282494416;6330.778422755181;5246.081935661167;5714.742836572281;5783.884322313615;6096.9390306096375;6142.262928448615;5446.509814116748;5684.204211410323;5765.962126817046;6255.812325630239;6259.687015649109;5827.912581311369;5858.443447872445;6027.367126451835;6117;6139.631622102688 05:09:10 INFO - PID 1685 | |5;yui.html;703.9859202815946;849.2484151525898;856.2892798976847;857.609787546666;864.0927026622047;12670.936645316771;18115.54711132221;18140;18716.25134994602;18787.15457804399;16025.198740063008;16939;17193.484195474157;17218.741718874197;17273.222704978274;776.9184235655259;924;928.8931772846108;930.999175885922;931.7624005878525;657.4214691071874;670.9429698475635;961.5817119552981;983.233078199006;990.8216521026212;999.8150342186682;1000.3997601439152;1000.5347513406265;1003.4731765822964;1028.1980055556678;998.5955687946393;998.9001099890025;999.8700168977987;1000.1498726082808;1027.5530144387178;738.0405472885228;738.2912404092025;741.7922981565171;745.02401853572;761.2311565319068;13275.734485310337;15896.602584935354;16052.75920861188;16294.755578666329;16683.749743753855;16178;16360.509184724477;16449.42427015061;16712.91643541787;16732.498025059267;13492.865071349259;13667.316634168352;13679.110857794212;13844.515441959584;13886.93056534721;3376.2234686022107;3383.154211447138;3393.8472768725464;3398.3882901077795;3400.5579274694132;87286.5635671824;109253;111073;111174;111707;8869.467831930106;11130.610428634958;11741.88258117425;11853.111016673784;11879.70300742471;18530.16614252362;23341.299761007198;24102.517949640907;24209.878950605133;24245.878770606036;7637.274458926393;7831.295183433518;7856.489328193649;7856.842863142705;7865.488743231672;3725.6088110748524;3750.587435382106;3762.811859407019;3804.8668296609485;3816.637419445148;4165.541790403053;4267.8292868284925;4275.187714334266;4275.209086319041;4280;818.300353198019;823.1151512124491;827.4084029918516;833.2667252817603;833.9374546909006;623.4077626255075;645.1355184053391;647.5467172978933;652.083822229768;676.4317972902785;9839.277146969494;10092.899071009197;11530.59642912494;11647.6505704829;11927.582534611247;620.8545234043183;653.7581094994882;656.2682608891052;664.9135612370361;689.4966674327769;4534.047849951481;5281.102212623863;5405.459454054641;5501.021376845835;5531.640443371168;94375.52812236032;94815;95444.52277738567;99479;99658.501707491;83143;86672;90604.18791624131;90805;91256.5246085237;78569.93038423457;79071.60464197642;79415.60292198502;80058.19941800625;81578;10914.56341746353;11245.831312530156;11563.826542602035;12589.74820503603;12949.935250324064;37315.253694925406;37990.01104884058;38148;39162.80418597889;39302.6069739299;64958.350416497124;65288.67355663191;70233;72232.27767722255;72637;16190.67618647644;16325.265363058928;16984.15079246008;16988.150592470574;17023.829761702225;15021.948463607443;18310;18318.90840545842;18394.72407913909;18578.81421185771;16702.331906723593;16969.321227150776;17084.145792710067;17131.91434042822;17266.482005539852;13952.720945581235;16017.199140042718;16745.162741863103;16843.91578042102;17057.402990895258;15914.60213494672;16683.582910427336;16939.32242710278;16940.237689304256;17014.149292535076;11655.708607284885;11660.12549058807;12194.878051219373;12283.503868230597;12296.938515307365;12424.813627795409;13219.40512676951;13548;13814.585562433143;13937 05:09:10 INFO - PID 1685 | __end_tp_report 05:09:10 INFO - PID 1685 | __start_cc_report 05:09:10 INFO - PID 1685 | _x_x_mozilla_cycle_collect,1779 05:09:10 INFO - PID 1685 | __end_cc_report 05:09:10 INFO - PID 1685 | __startTimestamp1492949350515__endTimestamp 05:09:10 INFO - PID 1685 | 05:09:10 INFO - PID 1685 | ------- Summary: start ------- 05:09:10 INFO - PID 1685 | Number of tests: 6 05:09:10 INFO - PID 1685 | 05:09:10 INFO - PID 1685 | [#0] dojo.html Cycles:165 Average:6026.68 Median:6301.72 stddev:707.02 (11.2%) stddev-sans-first:672.32 05:09:10 INFO - PID 1685 | Values: 3154.3 3455.9 3543.9 3562.0 3571.0 5937.5 6067.4 6196.3 6207.6 6216.9 6051.4 6111.7 6120.2 6132.1 6136.9 5242.7 5247.2 5259.2 5267.7 5383.1 5372.0 5374.7 5377.9 5378.3 5383.5 5370.4 5372.4 5375.0 5376.8 5378.1 5361.4 5373.6 5381.7 5384.8 5387.8 5242.4 5328.4 5329.9 5330.5 5333.2 6221.5 6251.2 6275.7 6277.7 6278.2 6007.6 6359.2 6501.9 6527.5 6550.5 4863.9 5422.2 6426.0 6468.7 6605.2 5243.9 6250.8 6326.1 6329.1 6330.0 6695.1 6755.3 6768.0 6768.4 6776.8 6316.6 6398.5 6406.2 6414.4 6436.5 6496.9 6527.4 6543.6 6585.1 6594.9 6408.3 6476.8 6484.7 6490.0 6504.7 6301.7 6484.6 6509.8 6529.8 6534.3 5176.7 5193.7 5217.9 5237.0 5293.9 4693.5 4698.0 4700.5 4731.0 4750.5 6208.2 6242.2 6252.3 6252.9 6253.8 6380.2 6441.4 6457.1 6514.5 6654.7 6175.6 6215.1 6240.1 6242.7 6256.2 5749.8 5769.5 5771.3 5771.5 5813.9 6461.3 6541.8 6694.8 6819.5 6837.0 6430.9 6433.7 6452.0 6460.6 6533.5 6754.1 6820.8 6825.0 6825.5 6843.1 6478.8 6492.0 6493.9 6508.4 6513.7 6376.5 6428.1 6431.2 6605.8 6616.2 6341.1 6380.7 6393.9 6405.2 6405.6 6283.6 6288.1 6351.6 6354.4 6395.4 5064.0 6316.4 6337.0 6356.8 6361.8 6428.8 6438.4 6440.3 6442.8 6458.6 6200.2 6260.3 6271.7 6283.4 6304.3 05:09:10 INFO - PID 1685 | 05:09:10 INFO - PID 1685 | [#1] ext.html Cycles:180 Average:44584.05 Median:34029.67 stddev:76071.05 (223.5%) stddev-sans-first:76213.22 05:09:10 INFO - PID 1685 | Values: 737.4 783.8 801.1 1115.8 1126.0 28312.4 37353.1 37526.6 37619.1 37688.6 40461.0 40647.8 40649.8 40725.8 40812.6 6107.9 8427.8 8660.1 8664.1 8670.7 5188.9 8558.8 8713.2 8739.8 8753.7 8780.9 8813.1 8826.1 8827.7 8891.8 8742.3 8790.3 8792.7 8797.4 8832.4 8509.5 8567.0 8579.4 8585.7 8596.5 38192.0 38266.2 38442.6 38444.4 38468.0 3572.0 3593.8 3594.0 3595.6 3598.8 31144.4 31200.0 31200.4 31215.7 31301.7 3154.3 3181.0 3210.9 3218.0 3226.8 291572.0 297928.5 298122.0 298200.0 298213.0 50672.7 50726.5 50733.2 50802.0 50915.5 53073.5 53307.0 53334.0 53411.0 53463.9 13893.3 14001.1 14011.2 14024.3 14025.3 9809.3 11322.0 11342.1 11375.0 11383.7 11410.6 11487.7 12870.7 12906.2 13102.7 5174.6 5195.0 5211.3 5221.8 5222.8 949.6 1012.4 1017.6 1052.9 1075.2 19493.3 22789.4 24534.0 24625.6 24766.6 1099.3 1112.0 1145.5 1145.7 1155.4 12537.9 12546.6 12563.8 12596.7 12703.9 298732.0 298995.0 299653.0 299672.0 299761.0 44165.8 54172.0 54201.7 54246.5 54413.9 1459.4 1463.7 1518.5 1530.7 1535.5 20011.3 24279.0 24489.9 24528.0 24596.1 39329.0 39417.6 39448.4 39490.0 39569.8 271767.0 272467.0 273026.0 275037.6 280444.0 35408.8 35617.8 35743.8 35755.9 35798.3 45740.9 46746.5 46914.3 46943.5 46993.3 25465.4 29013.6 31688.8 31968.4 32116.5 30571.7 30977.8 31693.7 31871.5 31955.9 38634.6 38669.0 38682.0 38724.0 38763.8 27026.6 31391.5 31556.1 32266.0 32650.5 21830.9 22182.6 23778.9 24462.0 25115.0 05:09:10 INFO - PID 1685 | 05:09:10 INFO - PID 1685 | [#2] jquery.html Cycles:180 Average:35549.47 Median:12301.37 stddev:94488.55 (768.1%) stddev-sans-first:94716.71 05:09:10 INFO - PID 1685 | Values: 374.2 383.0 389.9 421.0 432.0 13904.8 18893.9 20837.5 21537.5 21860.8 21652.5 22360.0 23071.7 23090.0 23421.5 4957.9 6090.3 6275.8 6302.6 6332.6 6112.5 6262.4 6272.6 6279.6 6287.9 5123.9 5272.7 6229.9 6248.6 6281.2 6153.7 6263.8 6314.6 6316.3 6325.3 5527.4 5606.4 5625.7 5641.6 5642.9 26322.3 26590.7 27087.7 27157.0 27574.0 2174.8 2236.1 2242.7 2242.9 2243.5 17430.0 17455.3 17898.5 17929.3 18091.7 1959.9 2050.9 2091.4 2123.9 2138.9 109662.0 129885.0 151098.2 158929.8 161792.0 11102.9 11135.4 11257.4 12431.4 12507.0 15369.2 15430.5 16257.1 16749.7 16783.0 7736.3 8679.2 8799.9 8859.8 9007.5 8271.8 8272.8 8306.6 8451.9 8541.0 7642.5 7777.4 7818.8 7829.6 7837.7 2187.8 2194.0 2194.9 2196.5 2324.5 930.4 931.9 958.0 971.3 987.0 19123.9 19776.4 21555.7 21690.3 21757.0 981.2 987.1 1007.5 1011.7 1017.4 10818.0 10932.7 10970.1 10978.6 10992.0 551958.0 556689.0 560230.0 562316.5 564868.0 127316.0 132982.0 133050.3 134192.0 138452.3 1180.7 1185.3 1213.9 1221.8 1228.6 21038.8 21650.7 21718.1 21718.5 21731.9 54740.0 55999.9 56099.7 56183.4 56635.4 76604.6 77619.6 79123.0 79710.0 81464.6 8690.9 8702.5 8821.4 8963.7 9021.9 11717.2 11944.2 12650.3 13947.4 14132.4 10956.2 11835.6 11928.3 12091.4 12264.3 11343.6 11351.3 11455.0 11684.8 11723.2 11703.7 11875.6 12137.5 12213.9 12288.3 8623.5 8659.6 8697.7 9038.7 9162.5 10026.7 11739.6 12047.0 12110.5 12111.5 05:09:10 INFO - PID 1685 | 05:09:10 INFO - PID 1685 | [#3] mootools.html Cycles:180 Average:7118.68 Median:3820.11 stddev:4579.69 (119.9%) stddev-sans-first:4571.87 05:09:10 INFO - PID 1685 | Values: 1328.6 1411.4 1429.9 1453.0 1456.0 11264.5 11706.7 11728.6 11744.3 11748.8 11367.7 11703.9 11717.9 11735.0 11773.8 2512.8 2547.7 2550.7 2552.7 2556.4 2090.1 2396.5 2517.5 2525.0 2525.6 2141.8 2163.7 2164.5 2165.6 2167.2 2444.1 2514.5 2518.5 2518.8 2523.8 2394.9 2415.7 2422.7 2432.7 2465.8 11631.4 11762.0 11762.8 11774.8 11796.8 6539.3 6782.2 6793.8 6797.4 6798.1 4000.7 4343.4 4403.3 4420.6 4445.4 1216.4 1228.2 1293.6 1298.0 1303.7 16577.9 16656.3 16705.5 16720.3 16720.8 5170.8 5249.4 5442.2 5648.3 5716.5 12290.0 12300.0 12323.8 12325.0 12361.1 5693.9 6360.0 6485.6 6612.6 6623.4 6091.9 6115.9 6135.1 6221.4 6229.4 3808.3 4101.6 4300.0 4310.5 4333.3 1251.5 1274.2 1294.8 1297.8 1299.8 780.5 795.0 800.4 816.6 824.5 5647.3 6150.8 6152.1 6259.7 6348.5 580.5 587.1 606.4 609.0 617.9 3831.9 3835.6 3841.8 3943.8 3985.5 14329.7 14876.6 15050.5 15089.8 15105.2 14357.1 14721.5 14728.6 14979.4 15198.0 8404.6 8488.7 8666.3 8674.6 8791.3 6897.4 6941.9 7123.4 7168.6 7245.0 13391.8 13444.6 13501.9 13583.9 13880.1 13884.8 13885.2 13895.5 14062.9 14103.7 9568.3 9688.2 9739.6 9755.2 9758.4 10725.1 10984.8 11089.6 11143.7 11177.2 9116.2 9124.5 9128.6 9146.5 9358.2 8925.6 8973.2 9062.3 9075.6 9089.4 6824.0 6887.8 8162.9 8169.4 8274.0 5624.8 5942.2 6115.4 6125.1 6130.6 6054.5 6143.0 6143.6 6149.2 6258.6 05:09:10 INFO - PID 1685 | 05:09:10 INFO - PID 1685 | [#4] prototype.html Cycles:180 Average:5051.87 Median:5652.90 stddev:1552.97 (27.5%) stddev-sans-first:1517.41 05:09:10 INFO - PID 1685 | Values: 390.9 396.4 398.4 403.3 403.5 5091.6 5845.4 5872.5 5879.3 5882.7 5213.8 5224.8 5539.5 5753.8 5811.4 3866.2 4462.2 4463.3 4485.2 4506.6 4387.7 4400.5 4495.8 4504.6 4551.8 3535.4 3714.9 4436.6 4480.8 4497.0 4063.1 4204.9 4400.6 4431.4 4452.0 3926.5 3932.6 3950.4 3950.7 3975.9 5342.1 5557.3 5644.3 5652.9 5666.3 5096.7 5320.2 5360.2 5360.2 5396.9 5527.4 5734.9 5824.5 6111.9 6201.0 3790.9 3995.6 4183.8 4246.4 4518.0 6238.3 6416.6 6416.8 6504.9 6606.0 4182.9 4251.6 4254.7 4279.0 4284.3 4330.6 4348.8 4350.3 4355.2 4370.5 4578.3 4779.9 4897.6 5040.8 5041.3 6106.3 6174.8 6219.9 6224.0 6226.3 1398.0 1459.8 1478.2 1483.0 1488.3 966.2 991.3 1002.8 1005.0 1009.6 5106.9 5566.8 5879.4 5886.4 5906.4 5391.9 6101.8 6422.7 6427.5 6436.3 5425.3 5568.0 5652.9 5799.2 5934.8 2824.7 3123.4 3314.5 3321.5 3359.5 6265.7 6518.3 6638.8 6650.7 6720.2 6218.4 6551.5 6577.9 6605.9 6618.7 6233.2 6615.2 6660.5 6663.5 6664.0 6092.6 6103.0 6368.3 6496.4 6512.2 6316.1 6337.6 6345.3 6357.7 6359.8 6281.0 6307.4 6363.8 6457.4 6519.8 4235.7 4237.0 4269.2 4272.2 4277.1 5358.8 6101.5 6407.2 6421.8 6476.9 5926.7 6240.4 6245.7 6249.0 6254.8 4831.5 6065.4 6183.6 6235.9 6330.8 5246.1 5714.7 5783.9 6096.9 6142.3 5446.5 5684.2 5766.0 6255.8 6259.7 5827.9 5858.4 6027.4 6117.0 6139.6 05:09:10 INFO - PID 1685 | 05:09:10 INFO - PID 1685 | [#5] yui.html Cycles:180 Average:21029.71 Median:3396.12 stddev:28632.66 (843.1%) stddev-sans-first:28672.31 05:09:10 INFO - PID 1685 | Values: 704.0 849.2 856.3 857.6 864.1 12670.9 18115.5 18140.0 18716.3 18787.2 16025.2 16939.0 17193.5 17218.7 17273.2 776.9 924.0 928.9 931.0 931.8 657.4 670.9 961.6 983.2 990.8 999.8 1000.4 1000.5 1003.5 1028.2 998.6 998.9 999.9 1000.1 1027.6 738.0 738.3 741.8 745.0 761.2 13275.7 15896.6 16052.8 16294.8 16683.7 16178.0 16360.5 16449.4 16712.9 16732.5 13492.9 13667.3 13679.1 13844.5 13886.9 3376.2 3383.2 3393.8 3398.4 3400.6 87286.6 109253.0 111073.0 111174.0 111707.0 8869.5 11130.6 11741.9 11853.1 11879.7 18530.2 23341.3 24102.5 24209.9 24245.9 7637.3 7831.3 7856.5 7856.8 7865.5 3725.6 3750.6 3762.8 3804.9 3816.6 4165.5 4267.8 4275.2 4275.2 4280.0 818.3 823.1 827.4 833.3 833.9 623.4 645.1 647.5 652.1 676.4 9839.3 10092.9 11530.6 11647.7 11927.6 620.9 653.8 656.3 664.9 689.5 4534.0 5281.1 5405.5 5501.0 5531.6 94375.5 94815.0 95444.5 99479.0 99658.5 83143.0 86672.0 90604.2 90805.0 91256.5 78569.9 79071.6 79415.6 80058.2 81578.0 10914.6 11245.8 11563.8 12589.7 12949.9 37315.3 37990.0 38148.0 39162.8 39302.6 64958.4 65288.7 70233.0 72232.3 72637.0 16190.7 16325.3 16984.2 16988.2 17023.8 15021.9 18310.0 18318.9 18394.7 18578.8 16702.3 16969.3 17084.1 17131.9 17266.5 13952.7 16017.2 16745.2 16843.9 17057.4 15914.6 16683.6 16939.3 16940.2 17014.1 11655.7 11660.1 12194.9 12283.5 12296.9 12424.8 13219.4 13548.0 13814.6 13937.0 05:09:10 INFO - PID 1685 | -------- Summary: end -------- 05:09:10 INFO - PID 1685 | 05:09:11 INFO - TEST-INFO | 1685: exit 0 05:09:11 INFO - TEST-OK | dromaeo_css | took 1120113ms 05:09:11 INFO - TEST-START | kraken 05:09:11 INFO - operating with platform_type : mac_ 05:09:11 INFO - Initialising browser for kraken test... 05:09:11 INFO - TEST-INFO | started process 1691 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/tmpxzxa2e/profile http://localhost:49250/getInfo.html) 05:09:13 INFO - PID 1691 | __metrics Screen width/height:1600/1200 05:09:13 INFO - PID 1691 | colorDepth:24 05:09:13 INFO - PID 1691 | Browser inner width/height: 1024/689 05:09:13 INFO - PID 1691 | __metrics 05:09:13 INFO - PID 1691 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:09:13 INFO - PID 1691 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:09:14 INFO - TEST-INFO | 1691: exit 0 05:09:14 INFO - Browser initialized. 05:09:14 INFO - Running cycle 1/1 for kraken test... 05:09:14 INFO - TEST-INFO | started process 1693 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/tmpxzxa2e/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:09:26 INFO - PID 1693 | RSS: Main: 241860608 05:09:26 INFO - PID 1693 | 05:09:29 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection) 05:09:30 INFO - PID 1693 | RSS: Main: 313040896 05:09:30 INFO - PID 1693 | 05:09:33 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-dft) 05:09:33 INFO - PID 1693 | RSS: Main: 295387136 05:09:33 INFO - PID 1693 | 05:09:37 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-fft) 05:09:37 INFO - PID 1693 | RSS: Main: 389128192 05:09:37 INFO - PID 1693 | 05:09:39 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator) 05:09:40 INFO - PID 1693 | RSS: Main: 290627584 05:09:40 INFO - PID 1693 | 05:09:42 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:09:43 INFO - PID 1693 | RSS: Main: 291602432 05:09:43 INFO - PID 1693 | 05:09:45 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom) 05:09:46 INFO - PID 1693 | RSS: Main: 357691392 05:09:46 INFO - PID 1693 | 05:09:49 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate) 05:09:49 INFO - PID 1693 | RSS: Main: 381091840 05:09:49 INFO - PID 1693 | 05:09:52 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial) 05:09:53 INFO - PID 1693 | RSS: Main: 396587008 05:09:53 INFO - PID 1693 | 05:09:55 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:09:55 INFO - PID 1693 | RSS: Main: 333029376 05:09:55 INFO - PID 1693 | 05:09:57 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:09:58 INFO - PID 1693 | RSS: Main: 335904768 05:09:58 INFO - PID 1693 | 05:10:00 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:10:00 INFO - PID 1693 | RSS: Main: 336293888 05:10:00 INFO - PID 1693 | 05:10:03 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:10:04 INFO - PID 1693 | RSS: Main: 334352384 05:10:04 INFO - PID 1693 | 05:10:07 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:10:08 INFO - PID 1693 | RSS: Main: 343826432 05:10:08 INFO - PID 1693 | 05:10:10 INFO - PID 1693 | Cycle 1(1): loaded http://localhost:49250/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49250/tests/kraken/driver.html?testName=ai-astar) 05:10:10 INFO - PID 1693 | RSS: Main: 387457024 05:10:10 INFO - PID 1693 | 05:10:10 INFO - PID 1693 | __start_tp_report 05:10:10 INFO - PID 1693 | _x_x_mozilla_page_load 05:10:10 INFO - PID 1693 | _x_x_mozilla_page_load_details 05:10:10 INFO - PID 1693 | |i|pagename|runs| 05:10:10 INFO - PID 1693 | |0;ai-astar;113;159;167;112;111;111;111;112;112;110 05:10:10 INFO - PID 1693 | |1;audio-beat-detection;143;108;107;145;108;105;108;108;141;134 05:10:10 INFO - PID 1693 | |2;audio-dft;188;183;182;186;185;186;181;188;185;185 05:10:10 INFO - PID 1693 | |3;audio-fft;80;56;56;85;57;58;87;59;76;74 05:10:10 INFO - PID 1693 | |4;audio-oscillator;91;68;88;69;68;67;91;68;68;90 05:10:10 INFO - PID 1693 | |5;imaging-gaussian-blur;89;89;89;90;89;88;90;88;89;88 05:10:10 INFO - PID 1693 | |6;imaging-darkroom;95;96;97;96;95;96;98;96;95;95 05:10:10 INFO - PID 1693 | |7;imaging-desaturate;84;86;84;100;91;85;88;126;130;84 05:10:10 INFO - PID 1693 | |8;json-parse-financial;48;46;47;46;47;48;49;47;47;48 05:10:10 INFO - PID 1693 | |9;json-stringify-tinderbox;53;59;66;61;58;59;57;57;54;57 05:10:10 INFO - PID 1693 | |10;stanford-crypto-aes;82;83;84;83;84;83;82;81;84;83 05:10:10 INFO - PID 1693 | |11;stanford-crypto-ccm;142;135;135;135;137;129;146;153;199;161 05:10:10 INFO - PID 1693 | |12;stanford-crypto-pbkdf2;191;202;185;186;186;186;182;185;189;185 05:10:10 INFO - PID 1693 | |13;stanford-crypto-sha256-iterative;67;68;69;67;67;68;68;66;65;67 05:10:10 INFO - PID 1693 | __end_tp_report 05:10:10 INFO - PID 1693 | __start_cc_report 05:10:10 INFO - PID 1693 | _x_x_mozilla_cycle_collect,2181 05:10:10 INFO - PID 1693 | __end_cc_report 05:10:10 INFO - PID 1693 | __startTimestamp1492949410309__endTimestamp 05:10:10 INFO - PID 1693 | 05:10:10 INFO - PID 1693 | ------- Summary: start ------- 05:10:10 INFO - PID 1693 | Number of tests: 14 05:10:10 INFO - PID 1693 | 05:10:10 INFO - PID 1693 | [#0] ai-astar Cycles:10 Average:121.80 Median:112.00 stddev:21.81 (19.5%) stddev-sans-first:22.90 05:10:10 INFO - PID 1693 | Values: 113.0 159.0 167.0 112.0 111.0 111.0 111.0 112.0 112.0 110.0 05:10:10 INFO - PID 1693 | 05:10:10 INFO - PID 1693 | [#1] audio-beat-detection Cycles:10 Average:120.70 Median:121.00 stddev:17.50 (14.5%) stddev-sans-first:16.60 05:10:10 INFO - PID 1693 | Values: 143.0 108.0 107.0 145.0 108.0 105.0 108.0 108.0 141.0 134.0 05:10:10 INFO - PID 1693 | 05:10:10 INFO - PID 1693 | [#2] audio-dft Cycles:10 Average:184.90 Median:185.50 stddev:2.33 (1.3%) stddev-sans-first:2.19 05:10:10 INFO - PID 1693 | Values: 188.0 183.0 182.0 186.0 185.0 186.0 181.0 188.0 185.0 185.0 05:10:10 INFO - PID 1693 | 05:10:10 INFO - PID 1693 | [#3] audio-fft Cycles:10 Average:68.80 Median:75.00 stddev:12.81 (17.1%) stddev-sans-first:12.93 05:10:10 INFO - PID 1693 | Values: 80.0 56.0 56.0 85.0 57.0 58.0 87.0 59.0 76.0 74.0 05:10:10 INFO - PID 1693 | 05:10:10 INFO - PID 1693 | [#4] audio-oscillator Cycles:10 Average:76.80 Median:78.50 stddev:11.40 (14.5%) stddev-sans-first:10.87 05:10:10 INFO - PID 1693 | Values: 91.0 68.0 88.0 69.0 68.0 67.0 91.0 68.0 68.0 90.0 05:10:10 INFO - PID 1693 | 05:10:10 INFO - PID 1693 | [#5] imaging-gaussian-blur Cycles:10 Average:88.90 Median:89.00 stddev:0.74 (0.8%) stddev-sans-first:0.78 05:10:10 INFO - PID 1693 | Values: 89.0 89.0 89.0 90.0 89.0 88.0 90.0 88.0 89.0 88.0 05:10:10 INFO - PID 1693 | 05:10:10 INFO - PID 1693 | [#6] imaging-darkroom Cycles:10 Average:95.90 Median:96.00 stddev:0.99 (1.0%) stddev-sans-first:1.00 05:10:10 INFO - PID 1693 | Values: 95.0 96.0 97.0 96.0 95.0 96.0 98.0 96.0 95.0 95.0 05:10:10 INFO - PID 1693 | 05:10:10 INFO - PID 1693 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:84.50 stddev:17.68 (20.9%) stddev-sans-first:18.23 05:10:10 INFO - PID 1693 | Values: 84.0 86.0 84.0 100.0 91.0 85.0 88.0 126.0 130.0 84.0 05:10:10 INFO - PID 1693 | 05:10:10 INFO - PID 1693 | [#8] json-parse-financial Cycles:10 Average:47.30 Median:47.50 stddev:0.95 (2.0%) stddev-sans-first:0.97 05:10:10 INFO - PID 1693 | Values: 48.0 46.0 47.0 46.0 47.0 48.0 49.0 47.0 47.0 48.0 05:10:10 INFO - PID 1693 | 05:10:10 INFO - PID 1693 | [#9] json-stringify-tinderbox Cycles:10 Average:58.10 Median:58.50 stddev:3.63 (6.2%) stddev-sans-first:3.35 05:10:10 INFO - PID 1693 | Values: 53.0 59.0 66.0 61.0 58.0 59.0 57.0 57.0 54.0 57.0 05:10:10 INFO - PID 1693 | 05:10:10 INFO - PID 1693 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:0.99 (1.2%) stddev-sans-first:1.00 05:10:10 INFO - PID 1693 | Values: 82.0 83.0 84.0 83.0 84.0 83.0 82.0 81.0 84.0 83.0 05:10:10 INFO - PID 1693 | 05:10:10 INFO - PID 1693 | [#11] stanford-crypto-ccm Cycles:10 Average:147.20 Median:144.00 stddev:20.60 (14.3%) stddev-sans-first:21.76 05:10:10 INFO - PID 1693 | Values: 142.0 135.0 135.0 135.0 137.0 129.0 146.0 153.0 199.0 161.0 05:10:10 INFO - PID 1693 | 05:10:10 INFO - PID 1693 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:187.70 Median:186.00 stddev:5.58 (3.0%) stddev-sans-first:5.79 05:10:10 INFO - PID 1693 | Values: 191.0 202.0 185.0 186.0 186.0 186.0 182.0 185.0 189.0 185.0 05:10:10 INFO - PID 1693 | 05:10:10 INFO - PID 1693 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.50 stddev:1.14 (1.7%) stddev-sans-first:1.20 05:10:10 INFO - PID 1693 | Values: 67.0 68.0 69.0 67.0 67.0 68.0 68.0 66.0 65.0 67.0 05:10:10 INFO - PID 1693 | -------- Summary: end -------- 05:10:10 INFO - PID 1693 | 05:10:11 INFO - TEST-INFO | 1693: exit 0 05:10:11 INFO - TEST-OK | kraken | took 60273ms 05:10:11 INFO - SUITE-END | took 1180s 05:10:11 INFO - Completed test suite (00:19:40) 05:10:11 INFO - javascript benchmark 05:10:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7728.2198659112555, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3154.2745168611204, 3455.9308813823723, 3543.9114022149442, 3562.0204443777957, 3571.0, 5937.524998000161, 6067.423594758502, 6196.349383314755, 6207.565470417073, 6216.875662486747, 6051.364606716297, 6111.7249723762425, 6120.234970628671, 6132.110843927628, 6136.938630613692, 5242.659227150223, 5247.1866860636665, 5259.184826351902, 5267.683938963655, 5383.057964856134, 5372.0330340538685, 5374.650647707906, 5377.946220537803, 5378.327709036371, 5383.542398896079, 5370.382406023318, 5372.355317361922, 5375.032494151052, 5376.8118115865955, 5378.085725426687, 5361.383440904287, 5373.59698022646, 5381.650192737459, 5384.7846086156505, 5387.811426600069, 5242.397124330712, 5328.3605967284175, 5329.920051199235, 5330.466953304677, 5333.173358129496, 6221.533384996098, 6251.156093927352, 6275.6548389838545, 6277.7175027123885, 6278.183836101323, 6007.639541627516, 6359.17330747, 6501.869962600769, 6527.543071984963, 6550.541462097655, 4863.8784030399165, 5422.186671999192, 6426.0, 6468.676566171673, 6605.207375114969, 5243.895122097537, 6250.843728906768, 6326.114343991845, 6329.145565348711, 6329.9872020476505, 6695.096162018162, 6755.324467553205, 6768.018637297663, 6768.357006084414, 6776.796696099125, 6316.557840951089, 6398.488120950313, 6406.167198264289, 6414.390632889868, 6436.517261205428, 6496.935030649633, 6527.412532871969, 6543.607383557001, 6585.111010013587, 6594.86810263792, 6408.327125651833, 6476.838079048061, 6484.708188131545, 6489.967550162219, 6504.739810407531, 6301.7164227609865, 6484.578502397423, 6509.804705858832, 6529.7714579990425, 6534.281229064799, 5176.715280659525, 5193.68837869729, 5217.895642087137, 5237.0, 5293.867653308621, 4693.530646935279, 4697.95302046982, 4700.529947005272, 4731.0, 4750.477447480775, 6208.192934918432, 6242.219722534684, 6252.3122456529745, 6252.937470625327, 6253.78111766086, 6380.170577824853, 6441.3880681335195, 6457.1282876811965, 6514.543981921315, 6654.70053847578, 6175.62946223228, 6215.12988181655, 6240.095186197976, 6242.719077641517, 6256.249250089927, 5749.8275051748515, 5769.509591684754, 5771.30744310677, 5771.509421699203, 5813.912791308134, 6461.2892581816905, 6541.803745887631, 6694.83262918431, 6819.454443644596, 6837.0, 6430.871382572416, 6433.742650294123, 6452.032195170762, 6460.580062295936, 6533.477321814148, 6754.054432379373, 6820.761273355409, 6824.965875170592, 6825.522213445011, 6843.076184715, 6478.838029049311, 6491.993740970157, 6493.935060649522, 6508.381703738138, 6513.674316284261, 6376.489880809431, 6428.067930150009, 6431.228252609717, 6605.834854128685, 6616.239132499824, 6341.112244285711, 6380.680965951591, 6393.8721225576155, 6405.167328247298, 6405.615663060231, 6283.622982620875, 6288.119663247057, 6351.587146835441, 6354.364563543609, 6395.360463953567, 5064.037832811754, 6316.399942005502, 6337.0, 6356.809295721136, 6361.809145725636, 6428.774992875227, 6438.420542151229, 6440.259370172303, 6442.8389290268115, 6458.580192287486, 6200.162977997912, 6260.342664020212, 6271.717772700148, 6283.403076707706, 6304.306526282014], "value": 5980.44463031747, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.402703809914, 783.7570353190512, 801.1427772283657, 1115.8103122469179, 1125.9774804503916, 28312.433751324963, 37353.06617334564, 37526.62473375269, 37619.05952351186, 37688.62311376885, 40461.0, 40647.79676101615, 40649.79675101628, 40725.79637101818, 40812.59187408125, 6107.938920610782, 8427.789305267355, 8660.13398660132, 8664.0902705216, 8670.653173873037, 5188.92216616751, 8558.828823423528, 8713.215810577047, 8739.781505462352, 8753.693620723276, 8780.912190878105, 8813.07462716412, 8826.117388261187, 8827.735167944971, 8891.777705557348, 8742.256908162783, 8790.340724445692, 8792.692255771017, 8797.384183107186, 8832.425892317044, 8509.48943063412, 8566.957165214197, 8579.442336248187, 8585.699500517514, 8596.527191004492, 38192.0, 38266.23467530634, 38442.61557384418, 38444.42333365002, 38468.0, 3572.0, 3593.7843729376323, 3593.964060359389, 3595.6044835068124, 3598.802065886375, 31144.377112457623, 31200.0, 31200.37599248025, 31215.687843121734, 31301.686983130105, 3154.2902846859274, 3180.984095079533, 3210.8876189333496, 3218.0185043561705, 3226.790258633181, 291572.0, 297928.510357449, 298121.99999999785, 298200.0, 298213.0, 50672.74663626732, 50726.49273507218, 50733.23900141501, 50802.0, 50915.49084509107, 53073.46926530763, 53307.0, 53334.0, 53411.0, 53463.93072138535, 13893.305334733424, 14001.089929154572, 14011.229382384066, 14024.298785060706, 14025.265073310811, 9809.313348065709, 11322.037626801814, 11342.149338799623, 11375.0, 11383.715407114889, 11410.600628978113, 11487.655370338904, 12870.742585148244, 12906.161099528501, 13102.672433189056, 5174.586033117342, 5195.0, 5211.296474975829, 5221.765020574083, 5222.843314700565, 949.5726922884729, 1012.3520946594185, 1017.6082208349691, 1052.9157667386744, 1075.1936047964027, 19493.31773387953, 22789.430264243525, 24534.0, 24625.63061554078, 24766.628500572508, 1099.3349023840622, 1111.9777604448027, 1145.478807142748, 1145.6563031090639, 1155.364549497773, 12537.93731031339, 12546.560870369492, 12563.811542826865, 12596.685082873002, 12703.93648031754, 298732.0, 298995.0, 299653.0, 299672.0, 299761.0023899777, 44165.77917110458, 54172.0, 54201.72899135558, 54246.45753542493, 54413.91172176534, 1459.3943513442016, 1463.6633574277976, 1518.4533567915541, 1530.6632540840997, 1535.4702627593463, 20011.299604513773, 24279.0, 24489.877550612135, 24528.01887924463, 24596.139135130186, 39329.016774580865, 39417.60582394254, 39448.40827387649, 39490.0, 39569.80215098906, 271767.0, 272467.0, 273026.0, 275037.62481187464, 280444.0, 35408.82295588506, 35617.82191089028, 35743.821280893426, 35755.927322180374, 35798.28403431969, 45740.8564785883, 46746.53253467422, 46914.29628555506, 46943.530564695284, 46993.29510057283, 25465.363365916, 29013.56479652849, 31688.841555792074, 31968.36063278768, 32116.518252225767, 30571.694283057775, 30977.760889564164, 31693.683063169072, 31871.521927171576, 31955.881544145843, 38634.6136538631, 38669.0, 38682.0, 38724.0, 38763.80618096892, 27026.594601080607, 31391.529127063568, 31556.106633602056, 32266.0, 32650.51024234686, 21830.89084554567, 22182.556348873255, 23778.881105594362, 24462.021519139034, 25115.0], "value": 17502.254352361742, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.1544110310697, 382.9655331020208, 389.8596505258108, 420.96421804146644, 431.98488052918157, 13904.791428128587, 18893.905530472362, 20837.47906302343, 21537.46156346092, 21860.797656128907, 21652.458688532755, 22360.0, 23071.653925191134, 23090.0, 23421.531569368603, 4957.934044180501, 6090.299615544225, 6275.811725648238, 6302.590331628452, 6332.588381755171, 6112.51099912006, 6262.405071518198, 6272.623642581437, 6279.623222606635, 6287.937120628804, 5123.872747995435, 5272.655472854417, 6229.906551401733, 6248.625082495042, 6281.152044474006, 6153.7230824613, 6263.780767673133, 6314.62112273265, 6316.30520642729, 6325.272593651743, 5527.419620939783, 5606.439356064361, 5625.662460252398, 5641.633293835887, 5642.887142257173, 26322.341941451425, 26590.73409265902, 27087.729122708915, 27157.0, 27574.034908778096, 2174.826013918883, 2236.0720301075035, 2242.7420846602686, 2242.8990695418584, 2243.5176437065948, 17430.0, 17455.301787928594, 17898.463046108638, 17929.282828686835, 18091.72862407065, 1959.9412017639493, 2050.8564400491823, 2091.435312465641, 2123.9150433982622, 2138.8609740366983, 109662.0, 129885.0, 151098.24450877676, 158929.8481568332, 161792.0, 11102.888971110347, 11135.387553684624, 11257.380844053656, 12431.37843107841, 12507.0, 15369.231538423033, 15430.5370838875, 16257.105859177858, 16749.748753768705, 16783.0, 7736.342410895137, 8679.218870301704, 8799.868001979976, 8859.778505537284, 9007.504587247633, 8271.8345633087, 8272.805247475168, 8306.584670766437, 8451.873221901677, 8540.957295213608, 7642.5032372895585, 7777.444511097803, 7818.843623127505, 7829.64766585505, 7837.725679601187, 2187.7921597448217, 2194.0, 2194.9451263718533, 2196.4728465168246, 2324.5467133908724, 930.3812964378612, 931.8602209668468, 957.9952100239454, 971.3055165556661, 986.9654562090292, 19123.90438047801, 19776.40670779879, 21555.67666485004, 21690.34928952134, 21757.041866232114, 981.1758123176566, 987.1313244344931, 1007.4761124215366, 1011.6863772230632, 1017.3692310767372, 10818.0, 10932.726681833017, 10970.067544258827, 10978.615748448767, 10992.0, 551958.0, 556689.0, 560230.0, 562316.4641127014, 564868.0, 127316.0, 132982.0, 133050.33474832564, 134192.0, 138452.30773846267, 1180.6635108993896, 1185.2532904270427, 1213.8664746877837, 1221.8228356888378, 1228.5700004998357, 21038.789612103683, 21650.67523987173, 21718.131274748834, 21718.45703857416, 21731.891340543196, 54740.0, 55999.88000239891, 56099.71950140223, 56183.43816561782, 56635.43364566466, 76604.61697691475, 77619.61190194012, 79123.0, 79710.0, 81464.59267703624, 8690.869636955324, 8702.521361325187, 8821.426607270507, 8963.731088067369, 9021.864672030057, 11717.179797414099, 11944.223625464318, 12650.30423326726, 13947.37236824325, 14132.364043617856, 10956.233063685466, 11835.585754498552, 11928.343941083323, 12091.39543022863, 12264.264144151379, 11343.602973895873, 11351.262167959056, 11455.0, 11684.824727629262, 11723.179377443497, 11703.707407314885, 11875.584354547549, 12137.453814578541, 12213.877861221274, 12288.324142172267, 8623.482591044558, 8659.6103175356, 8697.652093916426, 9038.728838134866, 9162.450252984841, 10026.749331266778, 11739.589114380955, 12047.0, 12110.515579376726, 12111.515539378326], "value": 10360.063553533066, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1328.594778592529, 1411.3578321863547, 1429.8856091512673, 1452.9927350363246, 1456.0, 11264.493097810599, 11706.707332316686, 11728.589499367525, 11744.295342279469, 11748.76502469951, 11367.658970230907, 11703.941480292586, 11717.894757889166, 11735.0, 11773.823392649096, 2512.7612876776675, 2547.694276686791, 2550.744925507453, 2552.693676758782, 2556.3992461771563, 2090.1221486975505, 2396.532676128156, 2517.5216708825355, 2525.02786427225, 2525.6085306777386, 2141.8286537076997, 2163.653815389538, 2164.4588852786806, 2165.631842586764, 2167.219800871685, 2444.0956845967016, 2514.509670614231, 2518.508890766301, 2518.8110891683195, 2523.823332366726, 2394.8580695871765, 2415.6738840256517, 2422.685050943384, 2432.7202371727126, 2465.790407815338, 11631.360275184861, 11762.000459921834, 11762.764744705059, 11774.823377649342, 11796.823047654292, 6539.280679125292, 6782.186137663462, 6793.796186114425, 6797.354251346114, 6798.116244888133, 4000.739951903146, 4343.413639158736, 4403.3174857897075, 4420.646348292161, 4445.377647129404, 1216.4404373987977, 1228.1955319265894, 1293.6313150752085, 1297.9935100324533, 1303.67408147963, 16577.91711041449, 16656.250468728937, 16705.498835034967, 16720.331186752515, 16720.83279167205, 5170.819021334235, 5249.42256351801, 5442.183672449164, 5648.322201335866, 5716.542676585863, 12290.0, 12300.0, 12323.815142772866, 12324.952379047882, 12361.07291953089, 5693.9430605693415, 6360.014197799349, 6485.6108633482145, 6612.603243805387, 6623.437007854386, 6091.878162436727, 6115.877682446326, 6135.141080248769, 6221.4089661482085, 6229.4082062204925, 3808.3423175949, 4101.646456669292, 4299.9785001075425, 4310.50429200646, 4333.285007973649, 1251.4806355362605, 1274.1842873904834, 1294.8187253784479, 1297.780794840814, 1299.753046921082, 780.480980148195, 794.9960250198827, 800.3677095094927, 816.5753808019797, 824.5135370131651, 5647.29408823897, 6150.7847225346895, 6152.077188421683, 6259.7496100156395, 6348.492120630339, 580.4833698008775, 587.0870795912311, 606.372404561277, 609.0468416927495, 617.9258488981351, 3831.8695984684587, 3835.6356146166067, 3841.822484385115, 3943.7633741975, 3985.501812273466, 14329.713405732036, 14876.553703388916, 15050.473233436996, 15089.773653395208, 15105.169215693242, 14357.095932952392, 14721.484748033767, 14728.55814325572, 14979.40082396692, 15198.0, 8404.621792019374, 8488.702895398756, 8666.306695464347, 8674.56627168639, 8791.252743516745, 6897.448204143556, 6941.895871561829, 7123.394511466583, 7168.605726684874, 7244.963775181091, 13391.799123012968, 13444.596662100153, 13501.864981350061, 13583.932080339535, 13880.097793643381, 13884.791728124288, 13885.166889986633, 13895.513657021957, 14062.859371406155, 14103.717925641224, 9568.282378821477, 9688.224942004763, 9739.561719722771, 9755.170810481188, 9758.365706229357, 10725.08836748885, 10984.780304393707, 11089.611863584736, 11143.721406964567, 11177.217594768288, 9116.179543841086, 9124.49815260167, 9128.634854605742, 9146.496942668216, 9358.204552612831, 8925.598348074222, 8973.192412682889, 9062.320325975446, 9075.636974520945, 9089.409188402733, 6823.965880170567, 6887.758928437681, 8162.918370816215, 8169.428140030141, 8273.958630206811, 5624.818788054555, 5942.168096466412, 6115.357887421935, 6125.1424800527075, 6130.570860039755, 6054.455099041107, 6143.0, 6143.631382117087, 6149.200603921461, 6258.561900667091], "value": 5295.427754227581, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.91399892023753, 396.379665822987, 398.4043854437616, 403.34255164082543, 403.491600583265, 5091.592672586194, 5845.357010728816, 5872.530197584194, 5879.265091863523, 5882.705804722965, 5213.765380557875, 5224.764885580148, 5539.473749993755, 5753.769849206027, 5811.418858114197, 3866.2460820140086, 4462.219111655463, 4463.263561512346, 4485.237509623372, 4506.616937560295, 4387.68369489152, 4400.493943196525, 4495.797689103982, 4504.617107545862, 4551.7724113794175, 3535.4166562517153, 3714.944275835851, 4436.645068394537, 4480.843170489034, 4496.965697889487, 4063.1061166543313, 4204.894877628069, 4400.647948164139, 4431.40176076232, 4451.9777401113115, 3926.450296958428, 3932.643238082857, 3950.38768990804, 3950.723449358546, 3975.926499845026, 5342.118550439173, 5557.277244054356, 5644.322681278273, 5652.886942261173, 5666.291713535808, 5096.668716533413, 5320.228566857822, 5360.195970604441, 5360.249565060894, 5396.91904621431, 5527.407185329528, 5734.853029394096, 5824.53403727705, 6111.938880611181, 6201.0, 3790.8862734117743, 3995.5604883462797, 4183.811728472226, 4246.384274280212, 4517.977410112929, 6238.2825975013, 6416.550841441054, 6416.839579010515, 6504.869902601921, 6605.9669701651665, 4182.853600123981, 4251.553586873334, 4254.7021708480725, 4279.0, 4284.250256205214, 4330.566943305645, 4348.804303806336, 4350.260455722535, 4355.15074560464, 4370.541093185233, 4578.2903649934315, 4779.856604301876, 4897.608191344684, 5040.799092576167, 5041.344625198701, 6106.328303886569, 6174.845628859224, 6219.937800621936, 6223.96888015557, 6226.346233645492, 1397.9650508737363, 1459.7664373700156, 1478.209158100411, 1482.9777553336494, 1488.2558720639681, 966.183574879226, 991.2516050381915, 1002.8367094170727, 1004.9598016079422, 1009.647072922273, 5106.923396149061, 5566.805161819317, 5879.412058794172, 5886.440788125121, 5906.40935906406, 5391.892162156735, 6101.786437474667, 6422.74309027643, 6427.485801135898, 6436.259830119502, 5425.294711687534, 5567.972160139173, 5652.9152062719095, 5799.2460980073165, 5934.792282270186, 2824.717528247159, 3123.422166899131, 3314.502824576333, 3321.5183798349585, 3359.546461227752, 6265.718042687999, 6518.315576864456, 6638.83402914931, 6650.70071846768, 6720.1599800025, 6218.409251121137, 6551.477681092813, 6577.901331480031, 6605.86788264232, 6618.7021584028835, 6233.189685341058, 6615.180825273088, 6660.467162626978, 6663.4669226461765, 6663.966680166665, 6092.634441933498, 6103.0, 6368.267649220399, 6496.382843629847, 6512.153420055362, 6316.084167795736, 6337.6197428154455, 6345.333739957238, 6357.650329231937, 6359.841003974938, 6281.026440901667, 6307.432331090224, 6363.840903977252, 6457.4188323049275, 6519.771807986698, 4235.724677895927, 4236.957630423656, 4269.225003747589, 4272.209641216385, 4277.144571085733, 5358.812441564683, 6101.481374083252, 6407.231132264158, 6421.8073457796345, 6476.870462590816, 5926.703664816656, 6240.375962403723, 6245.720996476886, 6249.031400132987, 6254.810816214471, 4831.492693267297, 6065.363136870565, 6183.567150299616, 6235.875282494416, 6330.778422755181, 5246.081935661167, 5714.742836572281, 5783.884322313615, 6096.9390306096375, 6142.262928448615, 5446.509814116748, 5684.204211410323, 5765.962126817046, 6255.812325630239, 6259.687015649109, 5827.912581311369, 5858.443447872445, 6027.367126451835, 6117.0, 6139.631622102688], "value": 4571.087913842905, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [703.9859202815946, 849.2484151525898, 856.2892798976847, 857.609787546666, 864.0927026622047, 12670.936645316771, 18115.54711132221, 18140.0, 18716.25134994602, 18787.15457804399, 16025.198740063008, 16939.0, 17193.484195474157, 17218.741718874197, 17273.222704978274, 776.9184235655259, 924.0, 928.8931772846108, 930.999175885922, 931.7624005878525, 657.4214691071874, 670.9429698475635, 961.5817119552981, 983.233078199006, 990.8216521026212, 999.8150342186682, 1000.3997601439152, 1000.5347513406265, 1003.4731765822964, 1028.1980055556678, 998.5955687946393, 998.9001099890025, 999.8700168977987, 1000.1498726082808, 1027.5530144387178, 738.0405472885228, 738.2912404092025, 741.7922981565171, 745.02401853572, 761.2311565319068, 13275.734485310337, 15896.602584935354, 16052.75920861188, 16294.755578666329, 16683.749743753855, 16178.0, 16360.509184724477, 16449.42427015061, 16712.91643541787, 16732.498025059267, 13492.865071349259, 13667.316634168352, 13679.110857794212, 13844.515441959584, 13886.93056534721, 3376.2234686022107, 3383.154211447138, 3393.8472768725464, 3398.3882901077795, 3400.5579274694132, 87286.5635671824, 109253.0, 111073.0, 111174.0, 111707.0, 8869.467831930106, 11130.610428634958, 11741.88258117425, 11853.111016673784, 11879.70300742471, 18530.16614252362, 23341.299761007198, 24102.517949640907, 24209.878950605133, 24245.878770606036, 7637.274458926393, 7831.295183433518, 7856.489328193649, 7856.842863142705, 7865.488743231672, 3725.6088110748524, 3750.587435382106, 3762.811859407019, 3804.8668296609485, 3816.637419445148, 4165.541790403053, 4267.8292868284925, 4275.187714334266, 4275.209086319041, 4280.0, 818.300353198019, 823.1151512124491, 827.4084029918516, 833.2667252817603, 833.9374546909006, 623.4077626255075, 645.1355184053391, 647.5467172978933, 652.083822229768, 676.4317972902785, 9839.277146969494, 10092.899071009197, 11530.59642912494, 11647.6505704829, 11927.582534611247, 620.8545234043183, 653.7581094994882, 656.2682608891052, 664.9135612370361, 689.4966674327769, 4534.047849951481, 5281.102212623863, 5405.459454054641, 5501.021376845835, 5531.640443371168, 94375.52812236032, 94815.0, 95444.52277738567, 99479.0, 99658.501707491, 83143.0, 86672.0, 90604.18791624131, 90805.0, 91256.5246085237, 78569.93038423457, 79071.60464197642, 79415.60292198502, 80058.19941800625, 81578.0, 10914.56341746353, 11245.831312530156, 11563.826542602035, 12589.74820503603, 12949.935250324064, 37315.253694925406, 37990.01104884058, 38148.0, 39162.80418597889, 39302.6069739299, 64958.350416497124, 65288.67355663191, 70233.0, 72232.27767722255, 72637.0, 16190.67618647644, 16325.265363058928, 16984.15079246008, 16988.150592470574, 17023.829761702225, 15021.948463607443, 18310.0, 18318.90840545842, 18394.72407913909, 18578.81421185771, 16702.331906723593, 16969.321227150776, 17084.145792710067, 17131.91434042822, 17266.482005539852, 13952.720945581235, 16017.199140042718, 16745.162741863103, 16843.91578042102, 17057.402990895258, 15914.60213494672, 16683.582910427336, 16939.32242710278, 16940.237689304256, 17014.149292535076, 11655.708607284885, 11660.12549058807, 12194.878051219373, 12283.503868230597, 12296.938515307365, 12424.813627795409, 13219.40512676951, 13548.0, 13814.585562433143, 13937.0], "value": 8115.842426727278, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1444.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 159.0, 167.0, 112.0, 111.0, 111.0, 111.0, 112.0, 112.0, 110.0], "value": 121.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 108.0, 107.0, 145.0, 108.0, 105.0, 108.0, 108.0, 141.0, 134.0], "value": 120.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 183.0, 182.0, 186.0, 185.0, 186.0, 181.0, 188.0, 185.0, 185.0], "value": 184.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 56.0, 56.0, 85.0, 57.0, 58.0, 87.0, 59.0, 76.0, 74.0], "value": 68.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 68.0, 88.0, 69.0, 68.0, 67.0, 91.0, 68.0, 68.0, 90.0], "value": 76.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 89.0, 90.0, 89.0, 88.0, 90.0, 88.0, 89.0, 88.0], "value": 88.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 96.0, 95.0, 96.0, 98.0, 96.0, 95.0, 95.0], "value": 95.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 84.0, 100.0, 91.0, 85.0, 88.0, 126.0, 130.0, 84.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 46.0, 47.0, 46.0, 47.0, 48.0, 49.0, 47.0, 47.0, 48.0], "value": 47.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 59.0, 66.0, 61.0, 58.0, 59.0, 57.0, 57.0, 54.0, 57.0], "value": 58.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 84.0, 83.0, 84.0, 83.0, 82.0, 81.0, 84.0, 83.0], "value": 82.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 135.0, 135.0, 135.0, 137.0, 129.0, 146.0, 153.0, 199.0, 161.0], "value": 147.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [191.0, 202.0, 185.0, 186.0, 186.0, 186.0, 182.0, 185.0, 189.0, 185.0], "value": 187.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 69.0, 67.0, 67.0, 68.0, 68.0, 66.0, 65.0, 67.0], "value": 67.2, "unit": "score"}]}]} 05:10:12 INFO - Return code: 0 05:10:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:10:12 ERROR - # TBPL SUCCESS # 05:10:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:10:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:10:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:10:12 INFO - 2017-04-23 05:10:12.119 screenresolution[1697:13728] starting screenresolution argv=screenresolution get 05:10:12 INFO - 2017-04-23 05:10:12.122 screenresolution[1697:13728] Display 0: 1600x1200x32@60 05:10:12 INFO - 2017-04-23 05:10:12.128 screenresolution[1698:13732] starting screenresolution argv=screenresolution list 05:10:12 INFO - Available Modes on Display 0 05:10:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:10:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:10:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:10:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:10:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:10:12 INFO - Intel Iris: 05:10:12 INFO - Chipset Model: Intel Iris 05:10:12 INFO - Type: GPU 05:10:12 INFO - Bus: Built-In 05:10:12 INFO - VRAM (Dynamic, Max): 1536 MB 05:10:12 INFO - Vendor: Intel (0x8086) 05:10:12 INFO - Device ID: 0x0a2e 05:10:12 INFO - Revision ID: 0x0009 05:10:12 INFO - Displays: 05:10:12 INFO - Display: 05:10:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:10:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:10:12 INFO - Display Serial Number: 1600x1200 60 05:10:12 INFO - Main Display: Yes 05:10:12 INFO - Mirror: Off 05:10:12 INFO - Online: Yes 05:10:12 INFO - Rotation: Supported 05:10:12 INFO - Return code: 0 05:10:12 INFO - Running post-action listener: _resource_record_post_action 05:10:12 INFO - [mozharness: 2017-04-23 12:10:12.363077Z] Finished run-tests step (success) 05:10:12 INFO - Running post-run listener: _resource_record_post_run 05:10:12 INFO - Total resource usage - Wall time: 1201s; CPU: 53.0%; Read bytes: 31529984; Write bytes: 517681664; Read time: 197; Write time: 1583 05:10:12 INFO - TinderboxPrint: CPU usage
53.4% 05:10:12 INFO - TinderboxPrint: I/O read bytes / time
31,529,984 / 197 05:10:12 INFO - TinderboxPrint: I/O write bytes / time
517,681,664 / 1,583 05:10:12 INFO - TinderboxPrint: CPU idle
2,237.3 (46.6%) 05:10:12 INFO - TinderboxPrint: CPU system
959.7 (20.0%) 05:10:12 INFO - TinderboxPrint: CPU user
1,608.7 (33.5%) 05:10:12 INFO - TinderboxPrint: Swap in / out
234,872,832 / 0 05:10:12 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207710720; Write bytes: 203177984; Read time: 15966; Write time: 412 05:10:12 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 29432832; Write bytes: 307323392; Read time: 176; Write time: 1143 05:10:12 INFO - Running post-run listener: _upload_blobber_files 05:10:12 INFO - Blob upload gear active. 05:10:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:10:12 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 05:10:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:10:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:10:13 INFO - (blobuploader) - INFO - Open directory for files ... 05:10:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:10:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:10:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:14 INFO - (blobuploader) - INFO - Done attempting. 05:10:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:10:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:10:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:15 INFO - (blobuploader) - INFO - Done attempting. 05:10:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:10:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:16 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:10:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:16 INFO - (blobuploader) - INFO - Done attempting. 05:10:16 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:10:16 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:10:16 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:10:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:10:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:10:18 INFO - (blobuploader) - INFO - Done attempting. 05:10:18 INFO - (blobuploader) - INFO - Iteration through files over. 05:10:18 INFO - Return code: 0 05:10:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:10:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:10:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d217f911e9ece78300421d75f241921e0e17bafe65a69c98b83d3ed180262cf5d1c7d2be686ecc152f2efbd740cf8a74d20c64c5c828b7ee56f630bad3358c18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be499fc91e31919cd6f4d6e8e6b006d55eda97f88c1ef7780d4d1efc1fbadef581ce86033dba90ada366686928663c768e0e56c0a9aa21a0e16c69a1300a8b5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c417c8e964a18347a86b8b86b6b5e80b89427ba4b30d312d7027372cddf65de766952cb9cfde812658baf1063ff0b7d1e36dbec5a16c0d977963a3409d21d2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62bb25de1457c3c49fd02d366f7129ff8f42309afcb49ce5d10952106bd29f8e3479a63c161f6f165f5a684df14d4b52b616d78daffc4df741f03db562fdc881"} 05:10:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:10:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:10:18 INFO - Contents: 05:10:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d217f911e9ece78300421d75f241921e0e17bafe65a69c98b83d3ed180262cf5d1c7d2be686ecc152f2efbd740cf8a74d20c64c5c828b7ee56f630bad3358c18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be499fc91e31919cd6f4d6e8e6b006d55eda97f88c1ef7780d4d1efc1fbadef581ce86033dba90ada366686928663c768e0e56c0a9aa21a0e16c69a1300a8b5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c417c8e964a18347a86b8b86b6b5e80b89427ba4b30d312d7027372cddf65de766952cb9cfde812658baf1063ff0b7d1e36dbec5a16c0d977963a3409d21d2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62bb25de1457c3c49fd02d366f7129ff8f42309afcb49ce5d10952106bd29f8e3479a63c161f6f165f5a684df14d4b52b616d78daffc4df741f03db562fdc881"} 05:10:18 INFO - Running post-run listener: copy_logs_to_upload_dir 05:10:18 INFO - Copying logs to upload dir... 05:10:18 INFO - mkdir: /builds/slave/test/build/upload/logs 05:10:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.022453 ========= master_lag: 0.34 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-04-23 05:10:18.367027) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-23 05:10:18.370595) ========= 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.p73tS6SYBh/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.arWWIapo87/Listeners TMPDIR=/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d217f911e9ece78300421d75f241921e0e17bafe65a69c98b83d3ed180262cf5d1c7d2be686ecc152f2efbd740cf8a74d20c64c5c828b7ee56f630bad3358c18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be499fc91e31919cd6f4d6e8e6b006d55eda97f88c1ef7780d4d1efc1fbadef581ce86033dba90ada366686928663c768e0e56c0a9aa21a0e16c69a1300a8b5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c417c8e964a18347a86b8b86b6b5e80b89427ba4b30d312d7027372cddf65de766952cb9cfde812658baf1063ff0b7d1e36dbec5a16c0d977963a3409d21d2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62bb25de1457c3c49fd02d366f7129ff8f42309afcb49ce5d10952106bd29f8e3479a63c161f6f165f5a684df14d4b52b616d78daffc4df741f03db562fdc881"} build_url:https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011091 build_url: 'https://queue.taskcluster.net/v1/task/MIY67_u2SsuXyDNfv0abQg/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d217f911e9ece78300421d75f241921e0e17bafe65a69c98b83d3ed180262cf5d1c7d2be686ecc152f2efbd740cf8a74d20c64c5c828b7ee56f630bad3358c18", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/be499fc91e31919cd6f4d6e8e6b006d55eda97f88c1ef7780d4d1efc1fbadef581ce86033dba90ada366686928663c768e0e56c0a9aa21a0e16c69a1300a8b5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4c417c8e964a18347a86b8b86b6b5e80b89427ba4b30d312d7027372cddf65de766952cb9cfde812658baf1063ff0b7d1e36dbec5a16c0d977963a3409d21d2f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/62bb25de1457c3c49fd02d366f7129ff8f42309afcb49ce5d10952106bd29f8e3479a63c161f6f165f5a684df14d4b52b616d78daffc4df741f03db562fdc881"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-23 05:10:18.405273) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-23 05:10:18.405601) ========= 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.p73tS6SYBh/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.arWWIapo87/Listeners TMPDIR=/var/folders/w4/wtzn5y_127z_rwtpxmdvh92000000w/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.005039 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-23 05:10:18.454031) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-23 05:10:18.454352) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-23 05:10:18.454672) ========= ========= Total master_lag: 0.52 =========