builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0001 starttime: 1491219829.05 results: success (0) buildid: 20170403031423 builduid: af923ef774b54073bed7e085d6e2c657 revision: aaa0cd3bd620daf6be29c72625f6e63fd0bc1d46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 04:43:49.050186) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-03 04:43:49.050606) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 04:43:49.050891) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-03 04:43:49.076044) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 04:43:49.076657) ========= 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.iAFWc1iQ7N/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.mNRIAksYXe/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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-03 04:43:49-- 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% 168M=0s 2017-04-03 04:43:49 (168 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.197656 ========= master_lag: 0.19 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 04:43:49.463757) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 04:43:49.464098) ========= 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.iAFWc1iQ7N/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.mNRIAksYXe/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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.030150 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 04:43:49.519522) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-03 04:43:49.519837) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev aaa0cd3bd620daf6be29c72625f6e63fd0bc1d46 --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 aaa0cd3bd620daf6be29c72625f6e63fd0bc1d46 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iAFWc1iQ7N/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.mNRIAksYXe/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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-03 04:43:49,660 truncating revision to first 12 chars 2017-04-03 04:43:49,660 Setting DEBUG logging. 2017-04-03 04:43:49,660 attempt 1/10 2017-04-03 04:43:49,660 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/aaa0cd3bd620?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-03 04:43:50,951 unpacking tar archive at: mozilla-central-aaa0cd3bd620/testing/mozharness/ program finished with exit code 0 elapsedTime=1.556764 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-03 04:43:51.104692) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 04:43:51.105491) ========= script_repo_revision: aaa0cd3bd620daf6be29c72625f6e63fd0bc1d46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-03 04:43:51.106611) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 04:43:51.107266) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-03 04:43:51.129129) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2017-04-03 04:43:51.129923) ========= /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.iAFWc1iQ7N/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.mNRIAksYXe/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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:43:51 INFO - MultiFileLogger online at 20170403 04:43:51 in /builds/slave/test 04:43:51 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:43:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:43:51 INFO - {'append_to_log': False, 04:43:51 INFO - 'base_work_dir': '/builds/slave/test', 04:43:51 INFO - 'blob_upload_branch': 'Firefox', 04:43:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:43:51 INFO - 'branch': 'Firefox', 04:43:51 INFO - 'buildbot_json_path': 'buildprops.json', 04:43:51 INFO - 'config_files': ('talos/mac_config.py',), 04:43:51 INFO - 'default_actions': ('clobber', 04:43:51 INFO - 'read-buildbot-config', 04:43:51 INFO - 'download-and-extract', 04:43:51 INFO - 'populate-webroot', 04:43:51 INFO - 'create-virtualenv', 04:43:51 INFO - 'install', 04:43:51 INFO - 'run-tests'), 04:43:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:43:51 INFO - 'download_minidump_stackwalk': True, 04:43:51 INFO - 'download_symbols': 'ondemand', 04:43:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:43:51 INFO - 'tooltool.py': '/tools/tooltool.py', 04:43:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:43:51 INFO - '/tools/misc-python/virtualenv.py')}, 04:43:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:43:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:43:51 INFO - 'gecko_profile': False, 04:43:51 INFO - 'gecko_profile_interval': 0, 04:43:51 INFO - 'installer_path': 'installer.exe', 04:43:51 INFO - 'log_level': 'info', 04:43:51 INFO - 'log_name': 'talos', 04:43:51 INFO - 'log_to_console': True, 04:43:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:43:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:43:51 INFO - 'opt_config_files': (), 04:43:51 INFO - 'pip_index': False, 04:43:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:43:51 INFO - 'cmd': ('bash', 04:43:51 INFO - '-c', 04:43:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:43:51 INFO - 'enabled': True, 04:43:51 INFO - 'halt_on_failure': False, 04:43:51 INFO - 'name': 'check_screen_resolution'},), 04:43:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:43:51 INFO - 'cmd': ('bash', 04:43:51 INFO - '-c', 04:43:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:43:51 INFO - 'enabled': True, 04:43:51 INFO - 'halt_on_failure': False, 04:43:51 INFO - 'name': 'check_screen_resolution'},), 04:43:51 INFO - 'run_cmd_checks_enabled': True, 04:43:51 INFO - 'suite': 'dromaeojs', 04:43:51 INFO - 'system_bits': '32', 04:43:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:43:51 INFO - 'title': 't-yosemite-r7-0001', 04:43:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:43:51 INFO - 'use_talos_json': True, 04:43:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:43:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:43:51 INFO - 'work_dir': 'build'} 04:43:51 INFO - [mozharness: 2017-04-03 11:43:51.384034Z] Running clobber step. 04:43:51 INFO - Running pre-action listener: _resource_record_pre_action 04:43:51 INFO - Running main action method: clobber 04:43:51 INFO - rmtree: /builds/slave/test/build 04:43:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:43:54 INFO - Running post-action listener: _resource_record_post_action 04:43:54 INFO - [mozharness: 2017-04-03 11:43:54.002596Z] Finished clobber step (success) 04:43:54 INFO - [mozharness: 2017-04-03 11:43:54.002739Z] Running read-buildbot-config step. 04:43:54 INFO - Running pre-action listener: _resource_record_pre_action 04:43:54 INFO - Running main action method: read_buildbot_config 04:43:54 INFO - Using buildbot properties: 04:43:54 INFO - { 04:43:54 INFO - "project": "", 04:43:54 INFO - "product": "firefox", 04:43:54 INFO - "script_repo_revision": "production", 04:43:54 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:43:54 INFO - "repository": "", 04:43:54 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:43:54 INFO - "buildid": "20170403031423", 04:43:54 INFO - "pgo_build": "False", 04:43:54 INFO - "basedir": "/builds/slave/test", 04:43:54 INFO - "buildnumber": 91, 04:43:54 INFO - "slavename": "t-yosemite-r7-0001", 04:43:54 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:43:54 INFO - "platform": "yosemite_r7", 04:43:54 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:43:54 INFO - "branch": "mozilla-central", 04:43:54 INFO - "repo_path": "mozilla-central", 04:43:54 INFO - "revision": "aaa0cd3bd620daf6be29c72625f6e63fd0bc1d46", 04:43:54 INFO - "stage_platform": "macosx64", 04:43:54 INFO - "builduid": "af923ef774b54073bed7e085d6e2c657", 04:43:54 INFO - "slavebuilddir": "test" 04:43:54 INFO - } 04:43:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:43:54 INFO - Running post-action listener: _resource_record_post_action 04:43:54 INFO - [mozharness: 2017-04-03 11:43:54.006054Z] Finished read-buildbot-config step (success) 04:43:54 INFO - [mozharness: 2017-04-03 11:43:54.006158Z] Running download-and-extract step. 04:43:54 INFO - Running pre-action listener: _resource_record_pre_action 04:43:54 INFO - Running main action method: download_and_extract 04:43:54 INFO - mkdir: /builds/slave/test/build/tests 04:43: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:43:54 INFO - trying https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:43:54 INFO - Downloading https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/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:43:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/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:43:55 INFO - Downloaded 1325 bytes. 04:43:55 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:43:55 INFO - Using the following test package requirements: 04:43:55 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:55 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:43:55 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:43:55 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:55 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:43:55 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:55 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:43:55 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:55 INFO - u'jsshell-mac.zip'], 04:43:55 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:55 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:43:55 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:43:55 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:55 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:43:55 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:55 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:43:55 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:55 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:43:55 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:43:55 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:43:55 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:43:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:43:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:43:55 INFO - Fetch https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:43:56 INFO - Expected file size: 52519377 04:43:56 INFO - Obtained file size: 52519377 04:44:13 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:44:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:44:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:44:13 INFO - Fetch https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:44:15 INFO - Expected file size: 52519377 04:44:15 INFO - Obtained file size: 52519377 04:44:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:44:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:44:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:44:33 INFO - Expected file size: 14404152 04:44:33 INFO - Obtained file size: 14404152 04:44:33 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:44:33 INFO - trying https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:44:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:44:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/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:44:36 INFO - Downloaded 75570606 bytes. 04:44:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:44:36 INFO - mkdir: /builds/slave/test/properties 04:44:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:44:36 INFO - Writing to file /builds/slave/test/properties/build_url 04:44:36 INFO - Contents: 04:44:36 INFO - build_url:https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:44:37 INFO - Running post-action listener: _resource_record_post_action 04:44:37 INFO - Running post-action listener: set_extra_try_arguments 04:44:37 INFO - [mozharness: 2017-04-03 11:44:37.036254Z] Finished download-and-extract step (success) 04:44:37 INFO - [mozharness: 2017-04-03 11:44:37.036403Z] Running populate-webroot step. 04:44:37 INFO - Running pre-action listener: _resource_record_pre_action 04:44:37 INFO - Running main action method: populate_webroot 04:44:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:44:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:44:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:44:37 INFO - '--tppagecycles', 04:44:37 INFO - '7'], 04:44:37 INFO - 'tests': ['tsvgm']}}, 04:44:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:44:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:44:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:44:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:44:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:44:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:44:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:44:37 INFO - 'talos_options': ['--disable-e10s'], 04:44:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:44:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:44:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:44:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:44:37 INFO - 'talos_options': ['--disable-e10s'], 04:44:37 INFO - 'tests': ['damp', 'tps']}, 04:44:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:44:37 INFO - 'tests': ['damp', 'tps']}, 04:44:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:44:37 INFO - 'tests': ['dromaeo_dom']}, 04:44:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:44:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:44:37 INFO - 'tests': ['basic_compositor_video']}, 04:44:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:44:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:44:37 INFO - 'tests': ['a11yr', 04:44:37 INFO - 'ts_paint', 04:44:37 INFO - 'tpaint', 04:44:37 INFO - 'sessionrestore', 04:44:37 INFO - 'sessionrestore_no_auto_restore', 04:44:37 INFO - 'tabpaint']}, 04:44:37 INFO - 'other-e10s': {'tests': ['a11yr', 04:44:37 INFO - 'ts_paint', 04:44:37 INFO - 'tpaint', 04:44:37 INFO - 'sessionrestore', 04:44:37 INFO - 'sessionrestore_no_auto_restore', 04:44:37 INFO - 'tabpaint']}, 04:44:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:44:37 INFO - 'ts_paint', 04:44:37 INFO - 'tpaint', 04:44:37 INFO - 'sessionrestore', 04:44:37 INFO - 'sessionrestore_no_auto_restore', 04:44:37 INFO - 'tabpaint']}, 04:44:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:44:37 INFO - 'ts_paint', 04:44:37 INFO - 'tpaint', 04:44:37 INFO - 'sessionrestore', 04:44:37 INFO - 'sessionrestore_no_auto_restore', 04:44:37 INFO - 'tabpaint']}, 04:44:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:44:37 INFO - 'tests': ['a11yr', 04:44:37 INFO - 'ts_paint', 04:44:37 INFO - 'tpaint', 04:44:37 INFO - 'sessionrestore', 04:44:37 INFO - 'sessionrestore_no_auto_restore', 04:44:37 INFO - 'tabpaint']}, 04:44:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:44:37 INFO - 'tests': ['a11yr', 04:44:37 INFO - 'ts_paint', 04:44:37 INFO - 'tpaint', 04:44:37 INFO - 'sessionrestore', 04:44:37 INFO - 'sessionrestore_no_auto_restore', 04:44:37 INFO - 'tabpaint']}, 04:44:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:44:37 INFO - 'tests': ['tsvgx', 04:44:37 INFO - 'tsvgr_opacity', 04:44:37 INFO - 'tart', 04:44:37 INFO - 'tscrollx', 04:44:37 INFO - 'cart', 04:44:37 INFO - 'tsvg_static']}, 04:44:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:44:37 INFO - 'tsvgr_opacity', 04:44:37 INFO - 'tart', 04:44:37 INFO - 'tscrollx', 04:44:37 INFO - 'cart', 04:44:37 INFO - 'tsvg_static']}, 04:44:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:44:37 INFO - 'talos_options': ['--disable-e10s'], 04:44:37 INFO - 'tests': ['tp5o']}, 04:44:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:44:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:44:37 INFO - 'talos_options': ['--disable-e10s', 04:44:37 INFO - '--xperf_path', 04:44:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:44:37 INFO - 'tests': ['tp5n']}, 04:44:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:44:37 INFO - 'talos_options': ['--xperf_path', 04:44:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:44:37 INFO - 'tests': ['tp5n']}}, 04:44:37 INFO - 'talos.zip': {'path': '', 04:44:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:44:37 INFO - Running post-action listener: _resource_record_post_action 04:44:37 INFO - [mozharness: 2017-04-03 11:44:37.054668Z] Finished populate-webroot step (success) 04:44:37 INFO - [mozharness: 2017-04-03 11:44:37.054793Z] Running create-virtualenv step. 04:44:37 INFO - Running pre-action listener: _resource_record_pre_action 04:44:37 INFO - Running main action method: create_virtualenv 04:44:37 INFO - Creating virtualenv /builds/slave/test/build/venv 04:44: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:44:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:44:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:44:37 INFO - Using real prefix '/tools/python27' 04:44:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:44:37 INFO - Installing distribute.............................................................................................................................................................................................done. 04:44:40 INFO - Installing pip.................done. 04:44:40 INFO - Return code: 0 04:44:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:44:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:44:41 INFO - Reading from file tmpfile_stdout 04:44:41 INFO - Output received: 04:44: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:44:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:44: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:44:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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:44:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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 0x10810ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4db5d6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ee8d30>, '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 0x107e0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107eddbe8>, '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.iAFWc1iQ7N/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.mNRIAksYXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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:44: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:44: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:44:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAFWc1iQ7N/Render', 04:44:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:41 INFO - 'HOME': '/Users/cltbld', 04:44:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:41 INFO - 'LOGNAME': 'cltbld', 04:44:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:41 INFO - 'MOZ_NO_REMOTE': '1', 04:44:41 INFO - 'NO_EM_RESTART': '1', 04:44:41 INFO - 'PAGER': '/bin/cat', 04:44:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:41 INFO - 'PWD': '/builds/slave/test', 04:44:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:41 INFO - 'SHELL': '/bin/bash', 04:44:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mNRIAksYXe/Listeners', 04:44:41 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:44:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:41 INFO - 'USER': 'cltbld', 04:44:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:41 INFO - 'XPC_FLAGS': '0x0', 04:44:41 INFO - 'XPC_SERVICE_NAME': '0', 04:44:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:41 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:44:41 INFO - Cleaning up... 04:44:42 INFO - Return code: 0 04:44:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:44: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:44:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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:44:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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 0x10810ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4db5d6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ee8d30>, '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 0x107e0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107eddbe8>, '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.iAFWc1iQ7N/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.mNRIAksYXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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:44: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:44: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:44:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAFWc1iQ7N/Render', 04:44:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:42 INFO - 'HOME': '/Users/cltbld', 04:44:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:42 INFO - 'LOGNAME': 'cltbld', 04:44:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:42 INFO - 'MOZ_NO_REMOTE': '1', 04:44:42 INFO - 'NO_EM_RESTART': '1', 04:44:42 INFO - 'PAGER': '/bin/cat', 04:44:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:42 INFO - 'PWD': '/builds/slave/test', 04:44:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:42 INFO - 'SHELL': '/bin/bash', 04:44:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mNRIAksYXe/Listeners', 04:44:42 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:44:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:42 INFO - 'USER': 'cltbld', 04:44:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:42 INFO - 'XPC_FLAGS': '0x0', 04:44:42 INFO - 'XPC_SERVICE_NAME': '0', 04:44:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:42 INFO - Downloading/unpacking psutil>=3.1.1 04:44: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:44: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:44: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:44: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:44: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:44: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:44:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:44:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:44:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:44:46 INFO - Installing collected packages: psutil 04:44:46 INFO - Running setup.py install for psutil 04:44:46 INFO - building 'psutil._psutil_osx' extension 04:44: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:44: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:44: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:44: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:44:47 INFO - building 'psutil._psutil_posix' extension 04:44: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:44:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:44:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:44:47 INFO - ^ 04:44:47 INFO - 1 warning generated. 04:44: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:44:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:44:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:44:47 INFO - Successfully installed psutil 04:44:47 INFO - Cleaning up... 04:44:47 INFO - Return code: 0 04:44:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:44: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:44:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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:44:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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 0x10810ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4db5d6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ee8d30>, '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 0x107e0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107eddbe8>, '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.iAFWc1iQ7N/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.mNRIAksYXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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:44: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:44: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:44:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAFWc1iQ7N/Render', 04:44:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:47 INFO - 'HOME': '/Users/cltbld', 04:44:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:47 INFO - 'LOGNAME': 'cltbld', 04:44:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:47 INFO - 'MOZ_NO_REMOTE': '1', 04:44:47 INFO - 'NO_EM_RESTART': '1', 04:44:47 INFO - 'PAGER': '/bin/cat', 04:44:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:47 INFO - 'PWD': '/builds/slave/test', 04:44:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:47 INFO - 'SHELL': '/bin/bash', 04:44:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mNRIAksYXe/Listeners', 04:44:47 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:44:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:47 INFO - 'USER': 'cltbld', 04:44:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:47 INFO - 'XPC_FLAGS': '0x0', 04:44:47 INFO - 'XPC_SERVICE_NAME': '0', 04:44:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:48 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:44:48 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:44:48 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:44:48 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:44:48 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:44:48 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:44:48 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:44:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:44:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:44: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:44:50 INFO - Installing collected packages: mozsystemmonitor 04:44:50 INFO - Running setup.py install for mozsystemmonitor 04:44:50 INFO - Successfully installed mozsystemmonitor 04:44:50 INFO - Cleaning up... 04:44:50 INFO - Return code: 0 04:44:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:44: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:44:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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:44:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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 0x10810ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4db5d6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ee8d30>, '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 0x107e0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107eddbe8>, '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.iAFWc1iQ7N/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.mNRIAksYXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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:44: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:44: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:44:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAFWc1iQ7N/Render', 04:44:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:50 INFO - 'HOME': '/Users/cltbld', 04:44:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:50 INFO - 'LOGNAME': 'cltbld', 04:44:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:50 INFO - 'MOZ_NO_REMOTE': '1', 04:44:50 INFO - 'NO_EM_RESTART': '1', 04:44:50 INFO - 'PAGER': '/bin/cat', 04:44:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:50 INFO - 'PWD': '/builds/slave/test', 04:44:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:50 INFO - 'SHELL': '/bin/bash', 04:44:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mNRIAksYXe/Listeners', 04:44:50 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:44:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:50 INFO - 'USER': 'cltbld', 04:44:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:50 INFO - 'XPC_FLAGS': '0x0', 04:44:50 INFO - 'XPC_SERVICE_NAME': '0', 04:44:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:51 INFO - Downloading/unpacking jsonschema==2.5.1 04:44: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:44: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:44: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:44: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:44: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:44: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:44:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:44:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:44: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:44: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:44: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:44: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:44: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:44: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:44:54 INFO - Downloading functools32-3.2.3-2.tar.gz 04:44:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:44:54 INFO - warning: no files found matching '*.txt' 04:44:54 INFO - no previously-included directories found matching 'build' 04:44:54 INFO - no previously-included directories found matching 'dist' 04:44:54 INFO - no previously-included directories found matching '.git*' 04:44:54 INFO - Installing collected packages: jsonschema, functools32 04:44:54 INFO - Running setup.py install for functools32 04:44:54 INFO - warning: no files found matching '*.txt' 04:44:54 INFO - no previously-included directories found matching 'build' 04:44:54 INFO - no previously-included directories found matching 'dist' 04:44:54 INFO - no previously-included directories found matching '.git*' 04:44:54 INFO - Successfully installed jsonschema functools32 04:44:54 INFO - Cleaning up... 04:44:54 INFO - Return code: 0 04:44:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:44: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:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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:44:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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 0x10810ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4db5d6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ee8d30>, '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 0x107e0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107eddbe8>, '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.iAFWc1iQ7N/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.mNRIAksYXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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:44: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:44: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:44:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAFWc1iQ7N/Render', 04:44:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:54 INFO - 'HOME': '/Users/cltbld', 04:44:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:54 INFO - 'LOGNAME': 'cltbld', 04:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:54 INFO - 'MOZ_NO_REMOTE': '1', 04:44:54 INFO - 'NO_EM_RESTART': '1', 04:44:54 INFO - 'PAGER': '/bin/cat', 04:44:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:54 INFO - 'PWD': '/builds/slave/test', 04:44:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:54 INFO - 'SHELL': '/bin/bash', 04:44:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mNRIAksYXe/Listeners', 04:44:54 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:44:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:54 INFO - 'USER': 'cltbld', 04:44:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:54 INFO - 'XPC_FLAGS': '0x0', 04:44:54 INFO - 'XPC_SERVICE_NAME': '0', 04:44:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:44:54 INFO - Cleaning up... 04:44:54 INFO - Return code: 0 04:44:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:44: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:44:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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:44:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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 0x10810ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4db5d6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ee8d30>, '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 0x107e0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107eddbe8>, '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.iAFWc1iQ7N/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.mNRIAksYXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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:44: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:44: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:44:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAFWc1iQ7N/Render', 04:44:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:54 INFO - 'HOME': '/Users/cltbld', 04:44:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:54 INFO - 'LOGNAME': 'cltbld', 04:44:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:54 INFO - 'MOZ_NO_REMOTE': '1', 04:44:54 INFO - 'NO_EM_RESTART': '1', 04:44:54 INFO - 'PAGER': '/bin/cat', 04:44:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:54 INFO - 'PWD': '/builds/slave/test', 04:44:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:54 INFO - 'SHELL': '/bin/bash', 04:44:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mNRIAksYXe/Listeners', 04:44:54 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:44:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:54 INFO - 'USER': 'cltbld', 04:44:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:54 INFO - 'XPC_FLAGS': '0x0', 04:44:54 INFO - 'XPC_SERVICE_NAME': '0', 04:44:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:44:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:44:55 INFO - Downloading/unpacking blobuploader==1.2.4 04:44: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:44: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:44: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:44: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:44: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:44: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:44:57 INFO - Downloading blobuploader-1.2.4.tar.gz 04:44:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:44:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:44: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:44: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:44: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:44: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:44: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:44: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:44:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:44:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:44: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:44: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:44: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:44: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:44: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:44: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:44:58 INFO - Downloading docopt-0.6.1.tar.gz 04:44:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:44:59 INFO - Installing collected packages: blobuploader, requests, docopt 04:44:59 INFO - Running setup.py install for blobuploader 04:44:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:44:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:44:59 INFO - Running setup.py install for requests 04:44:59 INFO - Running setup.py install for docopt 04:44:59 INFO - Successfully installed blobuploader requests docopt 04:44:59 INFO - Cleaning up... 04:44:59 INFO - Return code: 0 04:44:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:44: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:44:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:44:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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:44:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:44:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:44: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 0x10810ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4db5d6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ee8d30>, '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 0x107e0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107eddbe8>, '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.iAFWc1iQ7N/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.mNRIAksYXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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:44: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:44: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:44:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAFWc1iQ7N/Render', 04:44:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:44:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:44:59 INFO - 'HOME': '/Users/cltbld', 04:44:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:44:59 INFO - 'LOGNAME': 'cltbld', 04:44:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:44:59 INFO - 'MOZ_NO_REMOTE': '1', 04:44:59 INFO - 'NO_EM_RESTART': '1', 04:44:59 INFO - 'PAGER': '/bin/cat', 04:44:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:44:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:44:59 INFO - 'PWD': '/builds/slave/test', 04:44:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:44:59 INFO - 'SHELL': '/bin/bash', 04:44:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mNRIAksYXe/Listeners', 04:44:59 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:44:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:44:59 INFO - 'USER': 'cltbld', 04:44:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:44:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:44:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:44:59 INFO - 'XPC_FLAGS': '0x0', 04:44:59 INFO - 'XPC_SERVICE_NAME': '0', 04:44:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:45:00 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-BPgZnh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:45:00 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-mMLk9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:45:00 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-GhVFGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:45:00 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-8WAN9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:45:00 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-tvOPym-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:45:00 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-tx3ii7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:45:00 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-2j8Prn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:45:00 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-JrScUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:45:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:45:00 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-X9oeRb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:45:01 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-wcFc3q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:45:01 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-MCReJr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:45:01 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-KWWNMi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:45:01 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-EO1UFt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:45:01 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-Fcj6gT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:01 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-uXrhUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:45:01 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-kVnle9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:45:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:45:01 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-416Mlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:45:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:45:01 INFO - Running setup.py install for manifestparser 04:45:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:45:02 INFO - Running setup.py install for mozcrash 04:45:02 INFO - Running setup.py install for mozdebug 04:45:02 INFO - Running setup.py install for mozdevice 04:45:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:45:02 INFO - Running setup.py install for mozfile 04:45:02 INFO - Running setup.py install for mozhttpd 04:45:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:45:02 INFO - Running setup.py install for mozinfo 04:45:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:45:02 INFO - Running setup.py install for mozInstall 04:45:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:45:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:45:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:45:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:45:03 INFO - Running setup.py install for mozleak 04:45:03 INFO - Running setup.py install for mozlog 04:45:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:45:03 INFO - Running setup.py install for moznetwork 04:45:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:45:03 INFO - Running setup.py install for mozprocess 04:45:03 INFO - Running setup.py install for mozprofile 04:45:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:45:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:45:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:45:03 INFO - Running setup.py install for mozrunner 04:45:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:45:04 INFO - Running setup.py install for mozscreenshot 04:45:04 INFO - Running setup.py install for moztest 04:45:04 INFO - Running setup.py install for mozversion 04:45:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:45:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:45:04 INFO - Cleaning up... 04:45:04 INFO - Return code: 0 04:45:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45: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:45:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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:45:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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 0x10810ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4db5d6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ee8d30>, '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 0x107e0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107eddbe8>, '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.iAFWc1iQ7N/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.mNRIAksYXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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:45: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:45: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:45:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAFWc1iQ7N/Render', 04:45:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:04 INFO - 'HOME': '/Users/cltbld', 04:45:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:04 INFO - 'LOGNAME': 'cltbld', 04:45:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:04 INFO - 'MOZ_NO_REMOTE': '1', 04:45:04 INFO - 'NO_EM_RESTART': '1', 04:45:04 INFO - 'PAGER': '/bin/cat', 04:45:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:04 INFO - 'PWD': '/builds/slave/test', 04:45:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:04 INFO - 'SHELL': '/bin/bash', 04:45:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mNRIAksYXe/Listeners', 04:45:04 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:45:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:04 INFO - 'USER': 'cltbld', 04:45:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:04 INFO - 'XPC_FLAGS': '0x0', 04:45:04 INFO - 'XPC_SERVICE_NAME': '0', 04:45:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:45:04 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-dXcaF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:45: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:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:45:04 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-S_4XbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:45: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:45:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:45:04 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-ocmeyP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:45: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:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:45:05 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-r3ouhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:45:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:45:05 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-n_nCbC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:45: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:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:45:05 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-yaivPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:45: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:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:45:05 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-UlNU7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:45: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:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:45:05 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-UV38mf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:45: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:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:45:05 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-Yeo50h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:45: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:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:45:05 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-_VOUiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:45: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:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:45:05 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-glYVZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:45: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:45:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:45:05 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-4oETIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:45:06 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:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:45:06 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-fHqEup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:45: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:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:45:06 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-3nLxPi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:45: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:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:45:06 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-CYDof7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:45: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:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:45:06 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-eE2nYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:45: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:45:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:45:06 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-zNoiz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:45: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:45: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:45: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:45: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:45: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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:45: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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:45:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:45: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:45: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:45: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:45: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:45: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:45: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:45:09 INFO - Downloading blessings-1.6.tar.gz 04:45:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:45:09 INFO - Installing collected packages: blessings 04:45:09 INFO - Running setup.py install for blessings 04:45:09 INFO - Successfully installed blessings 04:45:09 INFO - Cleaning up... 04:45:09 INFO - Return code: 0 04:45:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:45:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:09 INFO - Reading from file tmpfile_stdout 04:45:09 INFO - Current package versions: 04:45:09 INFO - blessings == 1.6 04:45:09 INFO - blobuploader == 1.2.4 04:45:09 INFO - docopt == 0.6.1 04:45:09 INFO - functools32 == 3.2.3-2 04:45:09 INFO - jsonschema == 2.5.1 04:45:09 INFO - manifestparser == 1.1 04:45:09 INFO - mozInstall == 1.12 04:45:09 INFO - mozcrash == 1.0 04:45:09 INFO - mozdebug == 0.1 04:45:09 INFO - mozdevice == 0.49 04:45:09 INFO - mozfile == 1.2 04:45:09 INFO - mozhttpd == 0.7 04:45:09 INFO - mozinfo == 0.9 04:45:09 INFO - mozleak == 0.1 04:45:09 INFO - mozlog == 3.4 04:45:09 INFO - moznetwork == 0.27 04:45:09 INFO - mozprocess == 0.25 04:45:09 INFO - mozprofile == 0.28 04:45:09 INFO - mozrunner == 6.13 04:45:09 INFO - mozscreenshot == 0.1 04:45:09 INFO - mozsystemmonitor == 0.3 04:45:09 INFO - moztest == 0.8 04:45:09 INFO - mozversion == 1.4 04:45:09 INFO - psutil == 3.1.1 04:45:09 INFO - requests == 1.2.3 04:45:09 INFO - wsgiref == 0.1.2 04:45:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:45: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:45:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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:45:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45: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 0x10810ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4db5d6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ee8d30>, '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 0x107e0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107eddbe8>, '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.iAFWc1iQ7N/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.mNRIAksYXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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:45: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:45: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:45:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAFWc1iQ7N/Render', 04:45:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:09 INFO - 'HOME': '/Users/cltbld', 04:45:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:09 INFO - 'LOGNAME': 'cltbld', 04:45:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:09 INFO - 'MOZ_NO_REMOTE': '1', 04:45:09 INFO - 'NO_EM_RESTART': '1', 04:45:09 INFO - 'PAGER': '/bin/cat', 04:45:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:09 INFO - 'PWD': '/builds/slave/test', 04:45:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:09 INFO - 'SHELL': '/bin/bash', 04:45:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mNRIAksYXe/Listeners', 04:45:09 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:45:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:09 INFO - 'USER': 'cltbld', 04:45:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:09 INFO - 'XPC_FLAGS': '0x0', 04:45:09 INFO - 'XPC_SERVICE_NAME': '0', 04:45:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:10 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:45:10 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:45:10 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:45:10 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:45:10 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:45:10 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:45:10 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:45:10 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:45:10 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:45:10 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:45:10 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:45:10 INFO - Cleaning up... 04:45:10 INFO - Return code: 0 04:45:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:45:10 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:45:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:45:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:10 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:45:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:45:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:45:10 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 0x10810ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10810d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd4db5d6860>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x107ee8d30>, '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 0x107e0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107eddbe8>, '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.iAFWc1iQ7N/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.mNRIAksYXe/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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:45:10 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:45:10 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:45:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAFWc1iQ7N/Render', 04:45:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:10 INFO - 'HOME': '/Users/cltbld', 04:45:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:10 INFO - 'LOGNAME': 'cltbld', 04:45:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:10 INFO - 'MOZ_NO_REMOTE': '1', 04:45:10 INFO - 'NO_EM_RESTART': '1', 04:45:10 INFO - 'PAGER': '/bin/cat', 04:45:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:10 INFO - 'PWD': '/builds/slave/test', 04:45:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:10 INFO - 'SHELL': '/bin/bash', 04:45:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mNRIAksYXe/Listeners', 04:45:10 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:45:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:10 INFO - 'USER': 'cltbld', 04:45:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:10 INFO - 'XPC_FLAGS': '0x0', 04:45:10 INFO - 'XPC_SERVICE_NAME': '0', 04:45:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:45:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:45:10 INFO - Cleaning up... 04:45:10 INFO - Return code: 0 04:45:10 INFO - Running post-action listener: _resource_record_post_action 04:45:10 INFO - Running post-action listener: _start_resource_monitoring 04:45:10 INFO - Starting resource monitoring. 04:45:10 INFO - [mozharness: 2017-04-03 11:45:10.460566Z] Finished create-virtualenv step (success) 04:45:10 INFO - [mozharness: 2017-04-03 11:45:10.461482Z] Running install step. 04:45:10 INFO - Running pre-action listener: _resource_record_pre_action 04:45:10 INFO - Running main action method: install 04:45:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:45:10 INFO - Reading from file tmpfile_stdout 04:45:10 INFO - Detecting whether we're running mozinstall >=1.0... 04:45:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:45:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:45:10 INFO - Reading from file tmpfile_stdout 04:45:10 INFO - Output received: 04:45:10 INFO - Usage: mozinstall [options] installer 04:45:10 INFO - Options: 04:45:10 INFO - -h, --help show this help message and exit 04:45:10 INFO - -d DEST, --destination=DEST 04:45:10 INFO - Directory to install application into. [default: 04:45:10 INFO - "/builds/slave/test"] 04:45:10 INFO - --app=APP Application being installed. [default: firefox] 04:45:10 INFO - mkdir: /builds/slave/test/build/application 04:45: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:45: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:45:31 INFO - Reading from file tmpfile_stdout 04:45:31 INFO - Output received: 04:45:31 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:45:31 INFO - Running post-action listener: _resource_record_post_action 04:45:31 INFO - [mozharness: 2017-04-03 11:45:31.305184Z] Finished install step (success) 04:45:31 INFO - [mozharness: 2017-04-03 11:45:31.305310Z] Running run-tests step. 04:45:31 INFO - Running pre-action listener: _resource_record_pre_action 04:45:31 INFO - Running main action method: run_tests 04:45:31 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:45:31 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:45:31 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:45:31 INFO - 2017-04-03 04:45:31.319 screenresolution[1626:7509] starting screenresolution argv=screenresolution get 04:45:31 INFO - 2017-04-03 04:45:31.322 screenresolution[1626:7509] Display 0: 1600x1200x32@60 04:45:31 INFO - 2017-04-03 04:45:31.328 screenresolution[1627:7512] starting screenresolution argv=screenresolution list 04:45:31 INFO - Available Modes on Display 0 04:45:31 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:45:31 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:45:31 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:45:31 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:45:31 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:45:31 INFO - Intel Iris: 04:45:31 INFO - Chipset Model: Intel Iris 04:45:31 INFO - Type: GPU 04:45:31 INFO - Bus: Built-In 04:45:31 INFO - VRAM (Dynamic, Max): 1536 MB 04:45:31 INFO - Vendor: Intel (0x8086) 04:45:31 INFO - Device ID: 0x0a2e 04:45:31 INFO - Revision ID: 0x0009 04:45:31 INFO - Displays: 04:45:31 INFO - Display: 04:45:31 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:45:31 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:45:31 INFO - Display Serial Number: 1600x1200 60 04:45:31 INFO - Main Display: Yes 04:45:31 INFO - Mirror: Off 04:45:31 INFO - Online: Yes 04:45:31 INFO - Rotation: Supported 04:45:31 INFO - Return code: 0 04:45:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:45:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:45:31 INFO - Python 2.7.3 04:45:31 INFO - Return code: 0 04:45:31 INFO - grabbing minidump binary from tooltool 04:45:31 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:45:31 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 0x107ee8d30>, '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 0x107e0fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x107eddbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:45:31 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:45:31 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:45:31 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:45:31 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:45:31 INFO - Return code: 0 04:45:31 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:45:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:45:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:45:31 INFO - ENV: RUST_BACKTRACE is now 1 04:45:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:45:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:45:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0001', '--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:45:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0001 --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:45:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iAFWc1iQ7N/Render', 04:45:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:45:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:45:31 INFO - 'HOME': '/Users/cltbld', 04:45:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:45:31 INFO - 'LOGNAME': 'cltbld', 04:45:31 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:45:31 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:45:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:45:31 INFO - 'MOZ_NO_REMOTE': '1', 04:45:31 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:45:31 INFO - 'NO_EM_RESTART': '1', 04:45:31 INFO - 'PAGER': '/bin/cat', 04:45:31 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:45:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:45:31 INFO - 'PWD': '/builds/slave/test', 04:45:31 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:45:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:45:31 INFO - 'RUST_BACKTRACE': '1', 04:45:31 INFO - 'SHELL': '/bin/bash', 04:45:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.mNRIAksYXe/Listeners', 04:45:31 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 04:45:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:45:31 INFO - 'USER': 'cltbld', 04:45:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:45:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:45:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:45:31 INFO - 'XPC_FLAGS': '0x0', 04:45:31 INFO - 'XPC_SERVICE_NAME': '0', 04:45:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:45:31 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0001', '--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:45:31 INFO - mozversion application_buildid: 20170403031423 04:45:31 INFO - mozversion application_changeset: aaa0cd3bd620daf6be29c72625f6e63fd0bc1d46 04:45:31 INFO - mozversion application_display_name: Nightly 04:45:31 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:45:31 INFO - mozversion application_name: Firefox 04:45:31 INFO - mozversion application_remotingname: firefox 04:45:31 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:45:31 INFO - mozversion application_vendor: Mozilla 04:45:31 INFO - mozversion application_version: 55.0a1 04:45:31 INFO - mozversion platform_buildid: 20170403031423 04:45:31 INFO - mozversion platform_changeset: aaa0cd3bd620daf6be29c72625f6e63fd0bc1d46 04:45:31 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:45:31 INFO - mozversion platform_version: 55.0a1 04:45:31 INFO - using testdate: 1491219931 04:45:31 INFO - actual date: 1491219931 04:45:31 INFO - starting webserver on 'localhost:49241' 04:45:31 INFO - SUITE-START | Running 2 tests 04:45:31 INFO - TEST-START | dromaeo_css 04:45:31 INFO - operating with platform_type : mac_ 04:45:31 INFO - Initialising browser for dromaeo_css test... 04:45:31 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmppvlaCF/profile http://localhost:49241/getInfo.html) 04:45:34 INFO - PID 1637 | __metrics Screen width/height:1600/1200 04:45:34 INFO - PID 1637 | colorDepth:24 04:45:34 INFO - PID 1637 | Browser inner width/height: 1024/689 04:45:34 INFO - PID 1637 | __metrics 04:45:34 INFO - PID 1637 | 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:45:34 INFO - PID 1637 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:45:35 INFO - TEST-INFO | 1637: exit 0 04:45:35 INFO - Browser initialized. 04:45:35 INFO - Running cycle 1/1 for dromaeo_css test... 04:45:35 INFO - TEST-INFO | started process 1639 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmppvlaCF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:45:47 INFO - PID 1639 | RSS: Main: 232595456 04:45:47 INFO - PID 1639 | 04:48:51 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 04:48:54 INFO - PID 1639 | RSS: Main: 469745664 04:48:54 INFO - PID 1639 | 04:50:37 INFO - PID 1639 | ************************* 04:50:37 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 04:50:37 INFO - PID 1639 | 04:50:37 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:50:37 INFO - PID 1639 | Full stack: 04:50:37 INFO - PID 1639 | ************************* 04:50:37 INFO - PID 1639 | ************************* 04:50:37 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 04:50:37 INFO - PID 1639 | 04:50:37 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:50:37 INFO - PID 1639 | Full stack: 04:50:37 INFO - PID 1639 | ************************* 04:50:37 INFO - PID 1639 | ************************* 04:50:37 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 04:50:37 INFO - PID 1639 | 04:50:37 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:50:37 INFO - PID 1639 | Full stack: 04:50:37 INFO - PID 1639 | ************************* 04:50:37 INFO - PID 1639 | ************************* 04:50:37 INFO - PID 1639 | A coding exception was thrown and uncaught in a Task. 04:50:37 INFO - PID 1639 | 04:50:37 ERROR - PID 1639 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:50:37 INFO - PID 1639 | Full stack: 04:50:37 INFO - PID 1639 | ************************* 04:51:57 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 04:51:58 INFO - PID 1639 | RSS: Main: 374427648 04:51:58 INFO - PID 1639 | 04:55:00 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 04:55:01 INFO - PID 1639 | RSS: Main: 360067072 04:55:01 INFO - PID 1639 | 04:58:03 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 04:58:04 INFO - PID 1639 | RSS: Main: 334086144 04:58:04 INFO - PID 1639 | 05:01:07 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 05:01:08 INFO - PID 1639 | RSS: Main: 340856832 05:01:08 INFO - PID 1639 | 05:04:12 INFO - PID 1639 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 05:04:12 INFO - PID 1639 | RSS: Main: 389443584 05:04:12 INFO - PID 1639 | 05:04:12 INFO - PID 1639 | __start_tp_report 05:04:12 INFO - PID 1639 | _x_x_mozilla_page_load 05:04:12 INFO - PID 1639 | _x_x_mozilla_page_load_details 05:04:12 INFO - PID 1639 | |i|pagename|runs| 05:04:12 INFO - PID 1639 | |0;dojo.html;3274.1814546363407;3513.7540372173958;3527.2769082338114;3532.311199316134;3569.196930690595;6035.72839222235;6148.446639802417;6253.24961004679;6279.215098112736;6285.717142728571;6173.351798061206;6207.565470417073;6271.655058971754;6273.811785646438;6283.465905398047;5206.635535512497;5326.6537675050995;5383.380911195204;5384.326959130109;5516.806911758089;5462.754176062087;5502;5503.449655034505;5512.255845460852;5518.034343989786;5284.867878303035;5344.171653393731;5351;5364.222187782789;5448.4006759256645;4418.977905110454;5374.220737993008;5399.541039011689;5439.048166570834;5485.01269771441;5366.409694933554;5366.570674346043;5378.354597448292;5381.0852155133725;5412.431694672042;5771.740271687784;6003.759849606011;6114.023656277648;6211.919007132616;6274;6336.936630633681;6510.023496475519;6592.571482853599;6595.835104122388;6596.670166491656;6641.435477984377;6663;6676.232233293184;6715.630640314781;6739.932600673979;6303.36966303366;6349.52378571609;6354.809355719336;6360.268569114611;6370.299267080617;6570.080188773575;6641.236257830315;6663.800085997428;6665.400113989765;6899.275576064541;6316.431521163117;6326.588771729823;6354.078658594478;6371.52213583983;6414;6663.833404164838;6695.363940425652;6712.83217919556;6719.529632925746;6733.192016957898;6589.703463344161;6601.834954126185;6608.306127856602;6617.305182955816;6629.303923088007;6311.747530098836;6639.933600664028;6644.103046088716;6651.66741662915;6656;5230.34620672416;5241.68549887008;5245.7114858683135;5245.921311180336;5248.76380562868;4621.838235661736;4624.44506659203;4744.288356746516;4757.215059515142;4759.143354196209;6186.659733714599;6187.133801267826;6188.690565471708;6207.441330280297;6222.968885155546;6117.296510901214;6646.767363142363;6648.7340506379205;6648.933510664928;6651.600903945779;6214.285357183981;6280.748770049238;6323.683815809191;6331.176946996953;6344.429001389897;4646.907061858744;5575.609707320448;5804.361520232771;5827.941720582825;5829.242198514166;6339.461145802658;6488.740450381932;6503.642299673564;6601.76893808724;6630.535862489773;5648.5763567731765;6523.836904077436;6605.570637908713;6663.100481435138;6672.766453174116;6555.672216389257;6851.07510486078;6869.690863911236;6882.242953275036;6882.552634078769;6270.905936411049;6333;6346.7461301549265;6468.450181734605;6505.41451269388;6600.669966501559;6610.768623098361;6638.867222655616;6653.73385064592;6684.4318232950745;6414.294427612866;6437.388448097423;6446.742130314735;6449.193850768654;6455.064015717789;6199.5970261934635;6280.371962803866;6296.590721603081;6397.680115994089;6457.128287681103;5483.2323474712775;6268.937310626835;6288.779892703734;6296.024116261987;6309.179806625109;6230.096635987847;6295.244570651551;6300.21247344082;6303.275123360872;6305.779297724557;5232.8168514103345;6252.437280644764;6303.117563541016;6313.1477250572425;6321.841953951004 05:04:12 INFO - PID 1639 | |1;ext.html;794.833085052139;808.6401551309666;1133.9943300283496;1151.4933429291116;1155.9075273978083;31253;38216.853494395145;39129.630462933805;39155;39310.60689393105;40945.59054409455;41353.37969930446;41367.58632413675;41375.99999999993;41441.96395090124;6104.755809767604;8645.049044605104;8758.605862736193;8773.692920747775;8805.119488051208;6206.627602343874;6296.811095667137;6306.653134077624;6307.936920630781;8507.659693612248;8746.994095678983;8830;8834.983976842648;8841.823163536757;8860.069692682273;8732.825343493127;8775.034746177947;8799.164079412509;8805.955970220171;8824.514651694155;8566.871496927488;8627.827443451095;8639.697610583662;8641.827163456759;8643.308535317223;38704.03239919025;38887.41668874969;38887.611123888964;38913.41629875554;38926.41610375846;2966.9554956675665;3004.4141392428487;3020.154356780105;3042.893498727556;3064.6782087880897;27551.724482755115;27556.44887102247;27666.723332766614;27686.030988915492;28714.282142946595;2803.579463080534;2825.6891741908375;2836.957445638317;2856.7857410694073;2866.928326791826;308944.4552777244;308979;310449.8955010466;310752.4462377696;310785;41080.962188318525;41947.790261048496;50079.499205008215;50255.49233523;50280;43418.78290608527;52214.73892630589;52702.73648631732;52902.470975289754;52963.205551916755;12546.435410406553;12737.490500379881;14681.265936703123;14791.926040369945;14796.926015369854;10336.966303369603;10340.586376545005;10364.740881477872;11664.416779161009;11802.055835533136;11901.940490297493;13885;13899.235542045284;14033.947453940791;14039.649008774863;5939.109133629903;5952.809438112395;5990.101484777319;6002.639841609517;6029.969850150721;987.4026214140341;1003.9397636141855;1006.7231511334442;1010.8534262531891;1045.9790804183874;21806;22517.774822251897;24416.145434909693;30003.69996300009;30532.08403747891;1065.1691680489075;1065.7815147894662;1092.3773449133917;1096.3750662122673;1112.6828853776635;11410.573678290213;11621.6513504595;12633.431495582721;12918.224906505451;12965.092443528862;449090;453373;454203;454235;454378;57543;57880;57976;58023.709881450326;59337.703311483165;1354.5326862232514;1414.0384538513908;1506.683596444759;1511.9773203402178;1529.4799768078906;20694.482637934172;20993.89503052475;23325.41686457852;24345.513089737753;24367.51264974655;40535;40922;41008;41023.7948810254;41028.58971410367;467555;467994;468690;469716.65141674073;470389.18443261884;26545.60181597239;26851.462970740868;27399.86300068487;27482.312942176606;33854.64581416716;41690;43019.924501887705;43042.13915721731;43134.78432607817;43175;28455;29284;29866.954656586917;29944.700552995062;30273.69726302797;28992.710072899;29546.783991201177;29559.85220073886;29894.701052989192;30077.398452031273;31323.68676313208;35096;36159.63840361563;36164;36195;29061.418771624027;29356.853215733783;30101;30147.849260753555;30364.089077327717;19142.425727228205;20288.289909853083;20619.4845128867;23803.45277556953;24522.264332070066 05:04:12 INFO - PID 1639 | |2;jquery.html;364.28418158318897;392.8291193330903;419.4945091165146;436.20828196822765;448.0613115522978;13614;15478.458253961113;21040.158393664235;22007.669884951738;22078.558428831435;21477.355679329605;21611.243606473778;22120.668189977165;22323.330300090984;22601.773982260172;5976.312724036748;6069.969650151743;6292.622442653433;6350.682465876711;6355;3518.47222916562;3738.7943663098517;6267.43593076623;6326.14597029402;6337.493000559967;3842.4236364545263;6330.746770129213;6331.936680633204;6332.588381755194;6356.586821856565;5503.587230957694;6093.939060609426;6324.146240257575;6336.017917222838;6365.681715914186;5383.81156659515;5589.245451863987;5602.159676048625;5611.8877622447735;5613;26456;26734.46531069387;27052.10635255533;27690.030848920393;28428.857855710798;2001.6196922584809;2022.4438279473115;2063.2572273981355;2075.6990236415786;2137.326742076257;15564.61088472786;16681.83318166815;16709.331626734915;16872.072036038015;17061.48815535536;1879.1731638079339;1882.4634979031048;1891.7162425636127;1893.9810601893942;1922.1152179833196;156995;165382.17308913378;166697;168508;169660;10933.945330273456;11321.603743868925;12197.268163910194;12364.44360003802;12575.748485030248;16496.34014639401;16516.84382093266;16527.752083718755;16537.255823487732;16692.24884880183;8715.074096943536;9008.954955225314;9059.59231834569;9171.63313467454;9188.40275382098;8623;8643.30853531716;8658.48049117055;8841.336899732545;8858.29133669305;7661.042369703787;7791.220877912164;7835.177306382861;7838.686452541834;7858.017747781528;1808.4303444414968;2083.874967501955;2200.6478963366103;2208.5693289808655;2380.1312520930082;915.6932427636816;920.406337912043;931.6552875436132;937.6023177132431;945.976350591227;17553.912230438767;19745.801856570124;20942.267020654202;20958.580828383347;21379.78620213778;851.4891065360735;935.9064093590587;960.9135177834029;965.9565319560637;979.1921664626569;10363.481825908675;10698.358098514114;10821;10884.782304353868;10889;686616;687245;688540;690024.5498772574;705240;158937;160260;160670;162180;162726;1138.6128716236353;1168.894799468052;1192.1476144556684;1192.1952681939829;1196.0610920427423;13447.46210151583;17447.82552174513;18364.72452913234;18440.446786596425;18861;64761.35238647742;65621.67189164023;65765;65779;65879.67060164668;85967;86464;87982.56008720171;94821;96310;8757.299416046573;8763.474191548528;8969.730908072768;8971.416857904216;9066.637334506546;11454.140939429743;13765;13821.239831809347;14040.1575905446;14270.429182832571;10956.835647465135;11628.825567616661;11904.880951190376;11958.940205298917;12044.410451752916;10924.453777310944;11141.94151555601;11159.721006974565;11247.212695111264;11603.187776855539;10227.795444091225;11780.70548236301;11853.466594003117;11956.10329225329;12310.076744244396;8608.354373422144;8813.42712723671;8829.2495137914;8838.425502342327;9171.63313467454;11737.823932641188;11807.996320312526;12005.81991270149;12097.2136811107;12188.512459501875 05:04:12 INFO - PID 1639 | |3;mootools.html;1370.8697673720997;1424.64383904024;1441.6972435788484;1445.349592683292;1455.2360010994223;10623.84064239036;11088.168387370939;11094.3343399396;11104;11108.111351091913;10580.470976451166;10975.451227438636;11042.282251653636;11061.391623460706;11075.224734268604;2431.2463136427677;2478.479519300949;2482.5779617465073;2483.1060818105466;2483.987580062097;2060.402483279847;2350.3771500552366;2417.395651087228;2450.889709963056;2457.594496908008;2121.7666056733747;2343.742188359279;2444.291155564884;2445.6576079348906;2451.901923923041;2431.598786200275;2445.42532504863;2448;2450.509898020403;2451.166603354859;2390.0559279084664;2429.4290841652196;2433.85396876188;2434.403571125068;2437.098273638765;10885.619003334845;11118.110551155889;11131.833022504668;11145.16411269158;11154.665360039131;6103.42017508336;6358.42774150324;6358.936410635881;6366.458850997671;6371.044343348489;3760.2479504099015;3858.3633700439395;4113.732607380541;4114.506259248879;4125.773082480462;1142.5829572206085;1154.8498695169574;1182.4974385885964;1220.231254309788;1241.88823005929;15079.623009424742;15116.39534418622;15178.848211517965;15196.924015379964;15210.315535800915;4887.657863949489;5198.740062996835;5286.418493965661;5409.486098820606;5441.945580544223;11519.30884146954;11524.59663911759;11525.711857203469;11538.365389903469;11547.133964952662;6292.276388215414;6295.464885484785;6296.212973378328;6308.053791931247;6313.779017734358;5707.343655479673;5736.741846616912;5892.322382925932;5977.372375900555;5992.161097446361;3365.3942290387963;3967.305721498726;4104.343305071234;4155.252054630196;4186.769727665008;1046.340805292676;1227.5081584383538;1234.2532767675427;1236.4621389695512;1246.1526162209602;584.1646445582772;743.6170372258291;761.3490465651788;769.7844603511026;795.7891158842912;6475.219314688404;6546.607203567801;6699.330066993261;6814.965925170342;6829.112215411965;883.8276536075404;909.9545022748836;915.8717779510873;916.1845957098188;957.3681370295571;3981.22366138606;4099.221147981874;4128.772917489507;4147.562108543829;4277.850275240352;12054.97532709712;13758.380872860746;13769.31153442324;13776.448942042407;13797.517086902111;13381.397837097355;13511.324433778469;13659.521916732867;13660.795088073686;13678.31608419575;9809.166220871306;10028.699139025695;10125.594976201017;10142.239332049978;10158.593656253815;6241.407066328691;6367.586106903036;6437.774677886251;6444.420002199825;6559.573627714183;8938.329625278;12151.270923744603;12303.876961230273;12462.252264864137;12471.314077725812;10463.587415699089;12339.93830030844;12501.312427816558;12639;12693.936530317289;8819.955900220459;8907.821843562962;8962.507062111647;9009.279257659502;9018.323625728228;9773.267004974514;9966.40201587878;10105.090541851268;10111.292209545556;10257;8678.566071696516;8693.869591956252;8720.651173953225;8728.519931403835;8770.91229087701;7923.6830526778285;8351.958240209004;8532.274756645755;8551.444156129832;8625.353098517511;7397.926020739939;7428.814279643052;7503.5497870127965;7515.323620874147;7527.435442341737;5601.80393686219;5636.210930469655;5703.344115426613;5782.0630088919;5796.275465566804;5502.257195278747;5875.20684707559;5985.880282394415;6069.666168360783;6262 05:04:12 INFO - PID 1639 | |4;prototype.html;389;391.7551530293567;399.56846605665885;400.473377508576;402.7080366734118;4885.975570122153;5176.818811341604;5824.048943603898;5950.49420799232;6042.667653279068;4809.374781278438;5737.225474560933;5747.482726554609;5904.261967254093;5910.143029260755;4274.294741367687;4364.018095928414;4377;4404.889877753066;4405.295152775557;4231.815091774308;4372.978135109336;4394.824207031715;4412.602865742083;4447.644188464915;4010.4507510852814;4335.197988372145;4352.825886964518;4379.211741886459;4381.474223093217;4158.812853421603;4261.829526818923;4376.759278239696;4379.474463064436;4385.429894113777;3436.3127374525193;3562.2697347044054;3613.843570057583;3743.737938344317;3758.361078616642;5741.368449470555;5746.281714785652;5775.624584402;5785.045467497858;5799.2750906136735;4991.675541089854;5145.536901678867;5169.4830516948;5192.3249977503065;5204.76578553966;5725.055365864669;6248.750049997994;6291.748330066792;6295.968520157416;6332.556721029529;3738.4018557030745;4256.574342565749;4268.295731204347;4281.828726850922;4290.184864875664;6452.64510451925;6681.665916704145;6716.93625356662;6732.899006514906;6777.695003724795;3783.905402364908;4320.78396080201;4336.392904993303;4346.152500262482;4346.717463364871;3890.9805450972563;3995.001249687578;4387.517373088957;4399.714018588781;4426.690131690751;4900.926486102711;5088.491150884956;5153.0466863630345;5165.715885626327;5180.715060671624;5521.475459831309;6280.497560195174;6321.304656487782;6338.651374174465;6352.4918006559365;1209.782239196953;1430.885529157665;1499.3702644889172;1512.9470468533548;1520.247477498623;990.9347451489677;996.0786272697726;1003.2626019875386;1005.9497025148713;1017.8625885505362;6061;6071.753451222988;6073.939260607337;6075.301340345828;6077.817665470043;6567.802965911031;6578;6583.407493325623;6655.767048153291;6689.364510371507;5762.567807414461;6092.72582733778;6093.390660933871;6121.724522396503;6151.323354431009;3420.931581368359;3428.5714285714284;3449.6550344965303;3468.687818096333;3477.4262246729513;5721.828345149652;6332.670139270805;6809.557378770463;6843.414912008966;6870.45036397087;6200.286966998853;6470.708818103197;6822.3859852613505;6826.556273842184;6836.162992358116;5803.274590676166;6234.37656234382;6599.70301336441;6643.833904152435;6663.866722665616;6025.300265792689;6522.836929076621;6601.933980660132;6602;6620.569662971891;5329.920051199158;5646.209530665792;6361.809145725636;6482.54622176462;6489.935100648933;6104.450599445893;6774.93225067743;6793.626350550767;6802.163415877784;6822.658867056726;4714.457837348748;4729.196036673705;4748.501407352178;4778.641601879804;4798.0403919217;5109.693418394908;5811.157382179645;5991.071383935323;6614.66926653675;6618.63597502142;5665.150227465913;5985.371535988658;6362.886494863473;6374.617522948638;6377.394147555975;6020.621854367413;6039.63762174271;6318.557700960889;6338.968305158444;6416.967915160394;6214.564980451325;6233.594816336924;6235.971064774261;6236.314005459487;6242.563020588515;5588.608797384144;6241.96879015602;6387.712552935036;6415.967920160369;6441.1304473895425;6148.200733904564;6191.442770150708;6215.663632319073;6218.352136683873;6233.657148856856 05:04:12 INFO - PID 1639 | |5;yui.html;642.3287664390712;735.7719107076806;741.0699572037092;745.6532712288785;752.713968691897;15448.691026179484;15550.84449155508;15577.844221557782;15716;16182.190890455475;15076.547703568911;15411.306491207923;15581.766273505878;15726.247906616354;15745.134017629025;969.9127078562927;992.4789485520088;995.875515560555;996.8853581838109;998.3760149906309;958.1328897347877;994.751312171957;1002.3234316836143;1005.9899401006006;1007.7430255284892;1057.5188289328337;1068.593934304967;1071.6195750508575;1071.82850743881;1072.774717309366;1054.931429457083;1060.2578195263347;1061.1828891753346;1062.7024433158651;1063.803196408667;785.6150486261748;787.1498781316164;789.6643926331286;791.0981481111537;794.1026639896937;16335.183240838029;16649.16754162287;16796.076215808127;16866.494005179742;16930.068846213453;14761.483348082766;14964;15011.24943752819;15072.849271507364;15864.206789660471;11412.258203216847;11743.11926605508;11776.234544754649;12011.159218854684;12232.694182645417;3012.2469382654335;3109.9067027989195;3111.3932783107302;3130.827804470753;3172.5558421820965;110067;114368;115022;118150.40924795407;119378;11039.668809935714;11428.371439570737;11719.88280117188;12027.15809893299;12052.156349055658;23508.764912350656;25028;25462.872685636823;25635.10277140291;25689.48621027569;6552.344765523505;7906.802329941797;8171.63227654757;8265.710700125586;8267.338612910953;4220.177065472265;4229.534751177368;4269.359596060615;4274.4870615525715;4279.486461624562;4152.418661387408;4199.454070970754;4263.296556068276;4267.231898258281;4276.2089013532595;763.8357753083003;767.244264399566;792.3938187286731;804.1676864445271;810.3881569415054;462.6391414696542;556.2018503447566;581.287922295185;582.4874110782569;588.5791658963776;9463;9821.705348839547;10000.79998400028;10024.348417352849;10068.798624027624;543.1987817968464;547.3470120236942;576.9278840144982;586.0623003194939;590.6957916672917;4259.909932201687;4564.064366804797;4611.538846115362;4683.810544278418;4706.7411292378565;88024;97285;101197;101511.49244253732;102061.48969255105;80529;81462;82156;82380.58809705912;84419;76626.61686691642;78357;79478;79747;79811;8909.242714369351;9192.402493837879;9258.72223833286;9263.722088337361;9264;40160.99597510086;40208.396874047496;41799.37300940428;41819.581804181566;41854.79072604617;52424;52807;52820.73589632181;52950.20574691306;53426.73286633698;12319;13345.266010369523;13812.926743151007;14560.344784484512;14748.115113093249;14723.705525889636;14854;15054.391978916969;15226;15685.882805359828;13921.512747053805;14120.50578229757;14308.49920252786;14309.57071287863;14515.904017857294;14096.577102686935;14265.857341426452;14274.357653905807;14279.785803212751;14432.989690721548;11395.943020285176;11687.824682629938;13810.792838107236;13984.300784960915;14621;8511.319094472552;10071.244656650928;10254.230932680228;10335.896641033494;11018.732845722845;11007.61473348429;11212.943935280271;11324.773504529698;11354.772904542027;11357.659270221906 05:04:12 INFO - PID 1639 | __end_tp_report 05:04:12 INFO - PID 1639 | __start_cc_report 05:04:12 INFO - PID 1639 | _x_x_mozilla_cycle_collect,2905 05:04:12 INFO - PID 1639 | __end_cc_report 05:04:12 INFO - PID 1639 | __startTimestamp1491221052308__endTimestamp 05:04:12 INFO - PID 1639 | 05:04:12 INFO - PID 1639 | ------- Summary: start ------- 05:04:12 INFO - PID 1639 | Number of tests: 6 05:04:12 INFO - PID 1639 | 05:04:12 INFO - PID 1639 | [#0] dojo.html Cycles:165 Average:6057.05 Median:6303.12 stddev:720.59 (11.4%) stddev-sans-first:688.94 05:04:12 INFO - PID 1639 | Values: 3274.2 3513.8 3527.3 3532.3 3569.2 6035.7 6148.4 6253.2 6279.2 6285.7 6173.4 6207.6 6271.7 6273.8 6283.5 5206.6 5326.7 5383.4 5384.3 5516.8 5462.8 5502.0 5503.4 5512.3 5518.0 5284.9 5344.2 5351.0 5364.2 5448.4 4419.0 5374.2 5399.5 5439.0 5485.0 5366.4 5366.6 5378.4 5381.1 5412.4 5771.7 6003.8 6114.0 6211.9 6274.0 6336.9 6510.0 6592.6 6595.8 6596.7 6641.4 6663.0 6676.2 6715.6 6739.9 6303.4 6349.5 6354.8 6360.3 6370.3 6570.1 6641.2 6663.8 6665.4 6899.3 6316.4 6326.6 6354.1 6371.5 6414.0 6663.8 6695.4 6712.8 6719.5 6733.2 6589.7 6601.8 6608.3 6617.3 6629.3 6311.7 6639.9 6644.1 6651.7 6656.0 5230.3 5241.7 5245.7 5245.9 5248.8 4621.8 4624.4 4744.3 4757.2 4759.1 6186.7 6187.1 6188.7 6207.4 6223.0 6117.3 6646.8 6648.7 6648.9 6651.6 6214.3 6280.7 6323.7 6331.2 6344.4 4646.9 5575.6 5804.4 5827.9 5829.2 6339.5 6488.7 6503.6 6601.8 6630.5 5648.6 6523.8 6605.6 6663.1 6672.8 6555.7 6851.1 6869.7 6882.2 6882.6 6270.9 6333.0 6346.7 6468.5 6505.4 6600.7 6610.8 6638.9 6653.7 6684.4 6414.3 6437.4 6446.7 6449.2 6455.1 6199.6 6280.4 6296.6 6397.7 6457.1 5483.2 6268.9 6288.8 6296.0 6309.2 6230.1 6295.2 6300.2 6303.3 6305.8 5232.8 6252.4 6303.1 6313.1 6321.8 05:04:12 INFO - PID 1639 | 05:04:12 INFO - PID 1639 | [#1] ext.html Cycles:180 Average:54102.50 Median:171019.00 stddev:110902.74 (64.8%) stddev-sans-first:111141.63 05:04:12 INFO - PID 1639 | Values: 794.8 808.6 1134.0 1151.5 1155.9 31253.0 38216.9 39129.6 39155.0 39310.6 40945.6 41353.4 41367.6 41376.0 41442.0 6104.8 8645.0 8758.6 8773.7 8805.1 6206.6 6296.8 6306.7 6307.9 8507.7 8747.0 8830.0 8835.0 8841.8 8860.1 8732.8 8775.0 8799.2 8806.0 8824.5 8566.9 8627.8 8639.7 8641.8 8643.3 38704.0 38887.4 38887.6 38913.4 38926.4 2967.0 3004.4 3020.2 3042.9 3064.7 27551.7 27556.4 27666.7 27686.0 28714.3 2803.6 2825.7 2837.0 2856.8 2866.9 308944.5 308979.0 310449.9 310752.4 310785.0 41081.0 41947.8 50079.5 50255.5 50280.0 43418.8 52214.7 52702.7 52902.5 52963.2 12546.4 12737.5 14681.3 14791.9 14796.9 10337.0 10340.6 10364.7 11664.4 11802.1 11901.9 13885.0 13899.2 14033.9 14039.6 5939.1 5952.8 5990.1 6002.6 6030.0 987.4 1003.9 1006.7 1010.9 1046.0 21806.0 22517.8 24416.1 30003.7 30532.1 1065.2 1065.8 1092.4 1096.4 1112.7 11410.6 11621.7 12633.4 12918.2 12965.1 449090.0 453373.0 454203.0 454235.0 454378.0 57543.0 57880.0 57976.0 58023.7 59337.7 1354.5 1414.0 1506.7 1512.0 1529.5 20694.5 20993.9 23325.4 24345.5 24367.5 40535.0 40922.0 41008.0 41023.8 41028.6 467555.0 467994.0 468690.0 469716.7 470389.2 26545.6 26851.5 27399.9 27482.3 33854.6 41690.0 43019.9 43042.1 43134.8 43175.0 28455.0 29284.0 29867.0 29944.7 30273.7 28992.7 29546.8 29559.9 29894.7 30077.4 31323.7 35096.0 36159.6 36164.0 36195.0 29061.4 29356.9 30101.0 30147.8 30364.1 19142.4 20288.3 20619.5 23803.5 24522.3 05:04:12 INFO - PID 1639 | 05:04:12 INFO - PID 1639 | [#2] jquery.html Cycles:180 Average:41025.68 Median:12164.62 stddev:116735.20 (959.6%) stddev-sans-first:117022.75 05:04:12 INFO - PID 1639 | Values: 364.3 392.8 419.5 436.2 448.1 13614.0 15478.5 21040.2 22007.7 22078.6 21477.4 21611.2 22120.7 22323.3 22601.8 5976.3 6070.0 6292.6 6350.7 6355.0 3518.5 3738.8 6267.4 6326.1 6337.5 3842.4 6330.7 6331.9 6332.6 6356.6 5503.6 6093.9 6324.1 6336.0 6365.7 5383.8 5589.2 5602.2 5611.9 5613.0 26456.0 26734.5 27052.1 27690.0 28428.9 2001.6 2022.4 2063.3 2075.7 2137.3 15564.6 16681.8 16709.3 16872.1 17061.5 1879.2 1882.5 1891.7 1894.0 1922.1 156995.0 165382.2 166697.0 168508.0 169660.0 10933.9 11321.6 12197.3 12364.4 12575.7 16496.3 16516.8 16527.8 16537.3 16692.2 8715.1 9009.0 9059.6 9171.6 9188.4 8623.0 8643.3 8658.5 8841.3 8858.3 7661.0 7791.2 7835.2 7838.7 7858.0 1808.4 2083.9 2200.6 2208.6 2380.1 915.7 920.4 931.7 937.6 946.0 17553.9 19745.8 20942.3 20958.6 21379.8 851.5 935.9 960.9 966.0 979.2 10363.5 10698.4 10821.0 10884.8 10889.0 686616.0 687245.0 688540.0 690024.5 705240.0 158937.0 160260.0 160670.0 162180.0 162726.0 1138.6 1168.9 1192.1 1192.2 1196.1 13447.5 17447.8 18364.7 18440.4 18861.0 64761.4 65621.7 65765.0 65779.0 65879.7 85967.0 86464.0 87982.6 94821.0 96310.0 8757.3 8763.5 8969.7 8971.4 9066.6 11454.1 13765.0 13821.2 14040.2 14270.4 10956.8 11628.8 11904.9 11958.9 12044.4 10924.5 11141.9 11159.7 11247.2 11603.2 10227.8 11780.7 11853.5 11956.1 12310.1 8608.4 8813.4 8829.2 8838.4 9171.6 11737.8 11808.0 12005.8 12097.2 12188.5 05:04:12 INFO - PID 1639 | 05:04:12 INFO - PID 1639 | [#3] mootools.html Cycles:180 Average:6727.55 Median:2924.69 stddev:4133.87 (141.3%) stddev-sans-first:4125.87 05:04:12 INFO - PID 1639 | Values: 1370.9 1424.6 1441.7 1445.3 1455.2 10623.8 11088.2 11094.3 11104.0 11108.1 10580.5 10975.5 11042.3 11061.4 11075.2 2431.2 2478.5 2482.6 2483.1 2484.0 2060.4 2350.4 2417.4 2450.9 2457.6 2121.8 2343.7 2444.3 2445.7 2451.9 2431.6 2445.4 2448.0 2450.5 2451.2 2390.1 2429.4 2433.9 2434.4 2437.1 10885.6 11118.1 11131.8 11145.2 11154.7 6103.4 6358.4 6358.9 6366.5 6371.0 3760.2 3858.4 4113.7 4114.5 4125.8 1142.6 1154.8 1182.5 1220.2 1241.9 15079.6 15116.4 15178.8 15196.9 15210.3 4887.7 5198.7 5286.4 5409.5 5441.9 11519.3 11524.6 11525.7 11538.4 11547.1 6292.3 6295.5 6296.2 6308.1 6313.8 5707.3 5736.7 5892.3 5977.4 5992.2 3365.4 3967.3 4104.3 4155.3 4186.8 1046.3 1227.5 1234.3 1236.5 1246.2 584.2 743.6 761.3 769.8 795.8 6475.2 6546.6 6699.3 6815.0 6829.1 883.8 910.0 915.9 916.2 957.4 3981.2 4099.2 4128.8 4147.6 4277.9 12055.0 13758.4 13769.3 13776.4 13797.5 13381.4 13511.3 13659.5 13660.8 13678.3 9809.2 10028.7 10125.6 10142.2 10158.6 6241.4 6367.6 6437.8 6444.4 6559.6 8938.3 12151.3 12303.9 12462.3 12471.3 10463.6 12339.9 12501.3 12639.0 12693.9 8820.0 8907.8 8962.5 9009.3 9018.3 9773.3 9966.4 10105.1 10111.3 10257.0 8678.6 8693.9 8720.7 8728.5 8770.9 7923.7 8352.0 8532.3 8551.4 8625.4 7397.9 7428.8 7503.5 7515.3 7527.4 5601.8 5636.2 5703.3 5782.1 5796.3 5502.3 5875.2 5985.9 6069.7 6262.0 05:04:12 INFO - PID 1639 | 05:04:12 INFO - PID 1639 | [#4] prototype.html Cycles:180 Average:5148.79 Median:5792.16 stddev:1604.69 (27.7%) stddev-sans-first:1568.92 05:04:12 INFO - PID 1639 | Values: 389.0 391.8 399.6 400.5 402.7 4886.0 5176.8 5824.0 5950.5 6042.7 4809.4 5737.2 5747.5 5904.3 5910.1 4274.3 4364.0 4377.0 4404.9 4405.3 4231.8 4373.0 4394.8 4412.6 4447.6 4010.5 4335.2 4352.8 4379.2 4381.5 4158.8 4261.8 4376.8 4379.5 4385.4 3436.3 3562.3 3613.8 3743.7 3758.4 5741.4 5746.3 5775.6 5785.0 5799.3 4991.7 5145.5 5169.5 5192.3 5204.8 5725.1 6248.8 6291.7 6296.0 6332.6 3738.4 4256.6 4268.3 4281.8 4290.2 6452.6 6681.7 6716.9 6732.9 6777.7 3783.9 4320.8 4336.4 4346.2 4346.7 3891.0 3995.0 4387.5 4399.7 4426.7 4900.9 5088.5 5153.0 5165.7 5180.7 5521.5 6280.5 6321.3 6338.7 6352.5 1209.8 1430.9 1499.4 1512.9 1520.2 990.9 996.1 1003.3 1005.9 1017.9 6061.0 6071.8 6073.9 6075.3 6077.8 6567.8 6578.0 6583.4 6655.8 6689.4 5762.6 6092.7 6093.4 6121.7 6151.3 3420.9 3428.6 3449.7 3468.7 3477.4 5721.8 6332.7 6809.6 6843.4 6870.5 6200.3 6470.7 6822.4 6826.6 6836.2 5803.3 6234.4 6599.7 6643.8 6663.9 6025.3 6522.8 6601.9 6602.0 6620.6 5329.9 5646.2 6361.8 6482.5 6489.9 6104.5 6774.9 6793.6 6802.2 6822.7 4714.5 4729.2 4748.5 4778.6 4798.0 5109.7 5811.2 5991.1 6614.7 6618.6 5665.2 5985.4 6362.9 6374.6 6377.4 6020.6 6039.6 6318.6 6339.0 6417.0 6214.6 6233.6 6236.0 6236.3 6242.6 5588.6 6242.0 6387.7 6416.0 6441.1 6148.2 6191.4 6215.7 6218.4 6233.7 05:04:12 INFO - PID 1639 | 05:04:12 INFO - PID 1639 | [#5] yui.html Cycles:180 Average:20066.96 Median:25548.99 stddev:28642.33 (112.1%) stddev-sans-first:28685.55 05:04:12 INFO - PID 1639 | Values: 642.3 735.8 741.1 745.7 752.7 15448.7 15550.8 15577.8 15716.0 16182.2 15076.5 15411.3 15581.8 15726.2 15745.1 969.9 992.5 995.9 996.9 998.4 958.1 994.8 1002.3 1006.0 1007.7 1057.5 1068.6 1071.6 1071.8 1072.8 1054.9 1060.3 1061.2 1062.7 1063.8 785.6 787.1 789.7 791.1 794.1 16335.2 16649.2 16796.1 16866.5 16930.1 14761.5 14964.0 15011.2 15072.8 15864.2 11412.3 11743.1 11776.2 12011.2 12232.7 3012.2 3109.9 3111.4 3130.8 3172.6 110067.0 114368.0 115022.0 118150.4 119378.0 11039.7 11428.4 11719.9 12027.2 12052.2 23508.8 25028.0 25462.9 25635.1 25689.5 6552.3 7906.8 8171.6 8265.7 8267.3 4220.2 4229.5 4269.4 4274.5 4279.5 4152.4 4199.5 4263.3 4267.2 4276.2 763.8 767.2 792.4 804.2 810.4 462.6 556.2 581.3 582.5 588.6 9463.0 9821.7 10000.8 10024.3 10068.8 543.2 547.3 576.9 586.1 590.7 4259.9 4564.1 4611.5 4683.8 4706.7 88024.0 97285.0 101197.0 101511.5 102061.5 80529.0 81462.0 82156.0 82380.6 84419.0 76626.6 78357.0 79478.0 79747.0 79811.0 8909.2 9192.4 9258.7 9263.7 9264.0 40161.0 40208.4 41799.4 41819.6 41854.8 52424.0 52807.0 52820.7 52950.2 53426.7 12319.0 13345.3 13812.9 14560.3 14748.1 14723.7 14854.0 15054.4 15226.0 15685.9 13921.5 14120.5 14308.5 14309.6 14515.9 14096.6 14265.9 14274.4 14279.8 14433.0 11395.9 11687.8 13810.8 13984.3 14621.0 8511.3 10071.2 10254.2 10335.9 11018.7 11007.6 11212.9 11324.8 11354.8 11357.7 05:04:12 INFO - PID 1639 | -------- Summary: end -------- 05:04:12 INFO - PID 1639 | 05:04:12 INFO - TEST-INFO | 1639: exit 0 05:04:12 INFO - TEST-OK | dromaeo_css | took 1121075ms 05:04:12 INFO - TEST-START | kraken 05:04:12 INFO - operating with platform_type : mac_ 05:04:12 INFO - Initialising browser for kraken test... 05:04:13 INFO - TEST-INFO | started process 1646 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmpdJM5Pu/profile http://localhost:49241/getInfo.html) 05:04:15 INFO - PID 1646 | __metrics Screen width/height:1600/1200 05:04:15 INFO - PID 1646 | colorDepth:24 05:04:15 INFO - PID 1646 | Browser inner width/height: 1024/689 05:04:15 INFO - PID 1646 | __metrics 05:04:15 INFO - PID 1646 | 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:04:15 INFO - PID 1646 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:04:16 INFO - TEST-INFO | 1646: exit 0 05:04:16 INFO - Browser initialized. 05:04:16 INFO - Running cycle 1/1 for kraken test... 05:04:16 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmpdJM5Pu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:04:28 INFO - PID 1647 | RSS: Main: 232472576 05:04:28 INFO - PID 1647 | 05:04:31 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 05:04:32 INFO - PID 1647 | RSS: Main: 286355456 05:04:32 INFO - PID 1647 | 05:04:34 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 05:04:35 INFO - PID 1647 | RSS: Main: 286777344 05:04:35 INFO - PID 1647 | 05:04:39 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 05:04:39 INFO - PID 1647 | RSS: Main: 379994112 05:04:39 INFO - PID 1647 | 05:04:41 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 05:04:42 INFO - PID 1647 | RSS: Main: 283811840 05:04:42 INFO - PID 1647 | 05:04:44 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:04:45 INFO - PID 1647 | RSS: Main: 287301632 05:04:45 INFO - PID 1647 | 05:04:48 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 05:04:49 INFO - PID 1647 | RSS: Main: 328597504 05:04:49 INFO - PID 1647 | 05:04:52 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 05:04:53 INFO - PID 1647 | RSS: Main: 338440192 05:04:53 INFO - PID 1647 | 05:04:56 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 05:04:57 INFO - PID 1647 | RSS: Main: 340877312 05:04:57 INFO - PID 1647 | 05:04:58 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:04:59 INFO - PID 1647 | RSS: Main: 304934912 05:04:59 INFO - PID 1647 | 05:05:01 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:05:01 INFO - PID 1647 | RSS: Main: 311046144 05:05:01 INFO - PID 1647 | 05:05:04 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:05:04 INFO - PID 1647 | RSS: Main: 311377920 05:05:04 INFO - PID 1647 | 05:05:07 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:05:08 INFO - PID 1647 | RSS: Main: 326946816 05:05:08 INFO - PID 1647 | 05:05:12 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:05:12 INFO - PID 1647 | RSS: Main: 309989376 05:05:12 INFO - PID 1647 | 05:05:14 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 05:05:14 INFO - PID 1647 | RSS: Main: 375701504 05:05:14 INFO - PID 1647 | 05:05:14 INFO - PID 1647 | __start_tp_report 05:05:14 INFO - PID 1647 | _x_x_mozilla_page_load 05:05:14 INFO - PID 1647 | _x_x_mozilla_page_load_details 05:05:14 INFO - PID 1647 | |i|pagename|runs| 05:05:14 INFO - PID 1647 | |0;ai-astar;111;122;122;124;122;123;123;128;167;122 05:05:14 INFO - PID 1647 | |1;audio-beat-detection;158;121;117;161;117;117;117;118;143;116 05:05:14 INFO - PID 1647 | |2;audio-dft;212;208;213;214;212;208;210;209;214;239 05:05:14 INFO - PID 1647 | |3;audio-fft;83;62;64;99;64;63;63;61;80;62 05:05:14 INFO - PID 1647 | |4;audio-oscillator;95;78;124;111;61;100;128;111;113;110 05:05:14 INFO - PID 1647 | |5;imaging-gaussian-blur;105;85;137;138;91;92;92;92;93;103 05:05:14 INFO - PID 1647 | |6;imaging-darkroom;149;101;100;101;100;101;100;102;100;100 05:05:14 INFO - PID 1647 | |7;imaging-desaturate;102;103;102;101;101;99;102;98;103;100 05:05:14 INFO - PID 1647 | |8;json-parse-financial;50;52;50;51;51;52;53;52;51;54 05:05:14 INFO - PID 1647 | |9;json-stringify-tinderbox;61;63;61;76;71;68;63;62;63;64 05:05:14 INFO - PID 1647 | |10;stanford-crypto-aes;91;90;88;91;89;90;92;89;92;87 05:05:14 INFO - PID 1647 | |11;stanford-crypto-ccm;158;180;165;154;143;168;143;164;222;172 05:05:14 INFO - PID 1647 | |12;stanford-crypto-pbkdf2;258;207;204;202;228;262;234;200;199;200 05:05:14 INFO - PID 1647 | |13;stanford-crypto-sha256-iterative;65;70;103;75;63;99;101;73;73;72 05:05:14 INFO - PID 1647 | __end_tp_report 05:05:14 INFO - PID 1647 | __start_cc_report 05:05:14 INFO - PID 1647 | _x_x_mozilla_cycle_collect,2162 05:05:14 INFO - PID 1647 | __end_cc_report 05:05:14 INFO - PID 1647 | __startTimestamp1491221114951__endTimestamp 05:05:14 INFO - PID 1647 | 05:05:14 INFO - PID 1647 | ------- Summary: start ------- 05:05:14 INFO - PID 1647 | Number of tests: 14 05:05:14 INFO - PID 1647 | 05:05:14 INFO - PID 1647 | [#0] ai-astar Cycles:10 Average:126.40 Median:123.00 stddev:14.89 (12.1%) stddev-sans-first:14.71 05:05:14 INFO - PID 1647 | Values: 111.0 122.0 122.0 124.0 122.0 123.0 123.0 128.0 167.0 122.0 05:05:14 INFO - PID 1647 | 05:05:14 INFO - PID 1647 | [#1] audio-beat-detection Cycles:10 Average:128.50 Median:119.50 stddev:18.22 (15.2%) stddev-sans-first:15.90 05:05:14 INFO - PID 1647 | Values: 158.0 121.0 117.0 161.0 117.0 117.0 117.0 118.0 143.0 116.0 05:05:14 INFO - PID 1647 | 05:05:14 INFO - PID 1647 | [#2] audio-dft Cycles:10 Average:213.90 Median:212.50 stddev:9.11 (4.3%) stddev-sans-first:9.64 05:05:14 INFO - PID 1647 | Values: 212.0 208.0 213.0 214.0 212.0 208.0 210.0 209.0 214.0 239.0 05:05:14 INFO - PID 1647 | 05:05:14 INFO - PID 1647 | [#3] audio-fft Cycles:10 Average:70.10 Median:64.00 stddev:12.86 (20.1%) stddev-sans-first:12.77 05:05:14 INFO - PID 1647 | Values: 83.0 62.0 64.0 99.0 64.0 63.0 63.0 61.0 80.0 62.0 05:05:14 INFO - PID 1647 | 05:05:14 INFO - PID 1647 | [#4] audio-oscillator Cycles:10 Average:103.10 Median:126.00 stddev:20.56 (16.3%) stddev-sans-first:21.60 05:05:14 INFO - PID 1647 | Values: 95.0 78.0 124.0 111.0 61.0 100.0 128.0 111.0 113.0 110.0 05:05:14 INFO - PID 1647 | 05:05:14 INFO - PID 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:102.80 Median:91.50 stddev:19.19 (21.0%) stddev-sans-first:20.34 05:05:14 INFO - PID 1647 | Values: 105.0 85.0 137.0 138.0 91.0 92.0 92.0 92.0 93.0 103.0 05:05:14 INFO - PID 1647 | 05:05:14 INFO - PID 1647 | [#6] imaging-darkroom Cycles:10 Average:105.40 Median:101.00 stddev:15.33 (15.2%) stddev-sans-first:0.73 05:05:14 INFO - PID 1647 | Values: 149.0 101.0 100.0 101.0 100.0 101.0 100.0 102.0 100.0 100.0 05:05:14 INFO - PID 1647 | 05:05:14 INFO - PID 1647 | [#7] imaging-desaturate Cycles:10 Average:101.10 Median:102.50 stddev:1.66 (1.6%) stddev-sans-first:1.73 05:05:14 INFO - PID 1647 | Values: 102.0 103.0 102.0 101.0 101.0 99.0 102.0 98.0 103.0 100.0 05:05:14 INFO - PID 1647 | 05:05:14 INFO - PID 1647 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:52.00 stddev:1.26 (2.4%) stddev-sans-first:1.20 05:05:14 INFO - PID 1647 | Values: 50.0 52.0 50.0 51.0 51.0 52.0 53.0 52.0 51.0 54.0 05:05:14 INFO - PID 1647 | 05:05:14 INFO - PID 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:65.20 Median:63.50 stddev:4.94 (7.8%) stddev-sans-first:5.00 05:05:14 INFO - PID 1647 | Values: 61.0 63.0 61.0 76.0 71.0 68.0 63.0 62.0 63.0 64.0 05:05:14 INFO - PID 1647 | 05:05:14 INFO - PID 1647 | [#10] stanford-crypto-aes Cycles:10 Average:89.90 Median:90.50 stddev:1.66 (1.8%) stddev-sans-first:1.72 05:05:14 INFO - PID 1647 | Values: 91.0 90.0 88.0 91.0 89.0 90.0 92.0 89.0 92.0 87.0 05:05:14 INFO - PID 1647 | 05:05:14 INFO - PID 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:166.90 Median:166.50 stddev:22.69 (13.6%) stddev-sans-first:23.84 05:05:14 INFO - PID 1647 | Values: 158.0 180.0 165.0 154.0 143.0 168.0 143.0 164.0 222.0 172.0 05:05:14 INFO - PID 1647 | 05:05:14 INFO - PID 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:219.40 Median:217.50 stddev:24.62 (11.3%) stddev-sans-first:21.79 05:05:14 INFO - PID 1647 | Values: 258.0 207.0 204.0 202.0 228.0 262.0 234.0 200.0 199.0 200.0 05:05:14 INFO - PID 1647 | 05:05:14 INFO - PID 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:79.40 Median:72.50 stddev:15.38 (21.2%) stddev-sans-first:15.40 05:05:14 INFO - PID 1647 | Values: 65.0 70.0 103.0 75.0 63.0 99.0 101.0 73.0 73.0 72.0 05:05:14 INFO - PID 1647 | -------- Summary: end -------- 05:05:14 INFO - PID 1647 | 05:05:15 INFO - TEST-INFO | 1647: exit 0 05:05:15 INFO - TEST-OK | kraken | took 62901ms 05:05:15 INFO - SUITE-END | took 1183s 05:05:16 INFO - Completed test suite (00:19:44) 05:05:16 INFO - javascript benchmark 05:05:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7650.667237931092, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3274.1814546363407, 3513.7540372173958, 3527.2769082338114, 3532.311199316134, 3569.196930690595, 6035.72839222235, 6148.446639802417, 6253.24961004679, 6279.215098112736, 6285.717142728571, 6173.351798061206, 6207.565470417073, 6271.655058971754, 6273.811785646438, 6283.465905398047, 5206.635535512497, 5326.6537675050995, 5383.380911195204, 5384.326959130109, 5516.806911758089, 5462.754176062087, 5502.0, 5503.449655034505, 5512.255845460852, 5518.034343989786, 5284.867878303035, 5344.171653393731, 5351.0, 5364.222187782789, 5448.4006759256645, 4418.977905110454, 5374.220737993008, 5399.541039011689, 5439.048166570834, 5485.01269771441, 5366.409694933554, 5366.570674346043, 5378.354597448292, 5381.0852155133725, 5412.431694672042, 5771.740271687784, 6003.759849606011, 6114.023656277648, 6211.919007132616, 6274.0, 6336.936630633681, 6510.023496475519, 6592.571482853599, 6595.835104122388, 6596.670166491656, 6641.435477984377, 6663.0, 6676.232233293184, 6715.630640314781, 6739.932600673979, 6303.36966303366, 6349.52378571609, 6354.809355719336, 6360.268569114611, 6370.299267080617, 6570.080188773575, 6641.236257830315, 6663.800085997428, 6665.400113989765, 6899.275576064541, 6316.431521163117, 6326.588771729823, 6354.078658594478, 6371.52213583983, 6414.0, 6663.833404164838, 6695.363940425652, 6712.83217919556, 6719.529632925746, 6733.192016957898, 6589.703463344161, 6601.834954126185, 6608.306127856602, 6617.305182955816, 6629.303923088007, 6311.747530098836, 6639.933600664028, 6644.103046088716, 6651.66741662915, 6656.0, 5230.34620672416, 5241.68549887008, 5245.7114858683135, 5245.921311180336, 5248.76380562868, 4621.838235661736, 4624.44506659203, 4744.288356746516, 4757.215059515142, 4759.143354196209, 6186.659733714599, 6187.133801267826, 6188.690565471708, 6207.441330280297, 6222.968885155546, 6117.296510901214, 6646.767363142363, 6648.7340506379205, 6648.933510664928, 6651.600903945779, 6214.285357183981, 6280.748770049238, 6323.683815809191, 6331.176946996953, 6344.429001389897, 4646.907061858744, 5575.609707320448, 5804.361520232771, 5827.941720582825, 5829.242198514166, 6339.461145802658, 6488.740450381932, 6503.642299673564, 6601.76893808724, 6630.535862489773, 5648.5763567731765, 6523.836904077436, 6605.570637908713, 6663.100481435138, 6672.766453174116, 6555.672216389257, 6851.07510486078, 6869.690863911236, 6882.242953275036, 6882.552634078769, 6270.905936411049, 6333.0, 6346.7461301549265, 6468.450181734605, 6505.41451269388, 6600.669966501559, 6610.768623098361, 6638.867222655616, 6653.73385064592, 6684.4318232950745, 6414.294427612866, 6437.388448097423, 6446.742130314735, 6449.193850768654, 6455.064015717789, 6199.5970261934635, 6280.371962803866, 6296.590721603081, 6397.680115994089, 6457.128287681103, 5483.2323474712775, 6268.937310626835, 6288.779892703734, 6296.024116261987, 6309.179806625109, 6230.096635987847, 6295.244570651551, 6300.21247344082, 6303.275123360872, 6305.779297724557, 5232.8168514103345, 6252.437280644764, 6303.117563541016, 6313.1477250572425, 6321.841953951004], "value": 6009.229237641307, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [794.833085052139, 808.6401551309666, 1133.9943300283496, 1151.4933429291116, 1155.9075273978083, 31253.0, 38216.853494395145, 39129.630462933805, 39155.0, 39310.60689393105, 40945.59054409455, 41353.37969930446, 41367.58632413675, 41375.99999999993, 41441.96395090124, 6104.755809767604, 8645.049044605104, 8758.605862736193, 8773.692920747775, 8805.119488051208, 6206.627602343874, 6296.811095667137, 6306.653134077624, 6307.936920630781, 8507.659693612248, 8746.994095678983, 8830.0, 8834.983976842648, 8841.823163536757, 8860.069692682273, 8732.825343493127, 8775.034746177947, 8799.164079412509, 8805.955970220171, 8824.514651694155, 8566.871496927488, 8627.827443451095, 8639.697610583662, 8641.827163456759, 8643.308535317223, 38704.03239919025, 38887.41668874969, 38887.611123888964, 38913.41629875554, 38926.41610375846, 2966.9554956675665, 3004.4141392428487, 3020.154356780105, 3042.893498727556, 3064.6782087880897, 27551.724482755115, 27556.44887102247, 27666.723332766614, 27686.030988915492, 28714.282142946595, 2803.579463080534, 2825.6891741908375, 2836.957445638317, 2856.7857410694073, 2866.928326791826, 308944.4552777244, 308979.0, 310449.8955010466, 310752.4462377696, 310785.0, 41080.962188318525, 41947.790261048496, 50079.499205008215, 50255.49233523, 50280.0, 43418.78290608527, 52214.73892630589, 52702.73648631732, 52902.470975289754, 52963.205551916755, 12546.435410406553, 12737.490500379881, 14681.265936703123, 14791.926040369945, 14796.926015369854, 10336.966303369603, 10340.586376545005, 10364.740881477872, 11664.416779161009, 11802.055835533136, 11901.940490297493, 13885.0, 13899.235542045284, 14033.947453940791, 14039.649008774863, 5939.109133629903, 5952.809438112395, 5990.101484777319, 6002.639841609517, 6029.969850150721, 987.4026214140341, 1003.9397636141855, 1006.7231511334442, 1010.8534262531891, 1045.9790804183874, 21806.0, 22517.774822251897, 24416.145434909693, 30003.69996300009, 30532.08403747891, 1065.1691680489075, 1065.7815147894662, 1092.3773449133917, 1096.3750662122673, 1112.6828853776635, 11410.573678290213, 11621.6513504595, 12633.431495582721, 12918.224906505451, 12965.092443528862, 449090.0, 453373.0, 454203.0, 454235.0, 454378.0, 57543.0, 57880.0, 57976.0, 58023.709881450326, 59337.703311483165, 1354.5326862232514, 1414.0384538513908, 1506.683596444759, 1511.9773203402178, 1529.4799768078906, 20694.482637934172, 20993.89503052475, 23325.41686457852, 24345.513089737753, 24367.51264974655, 40535.0, 40922.0, 41008.0, 41023.7948810254, 41028.58971410367, 467555.0, 467994.0, 468690.0, 469716.65141674073, 470389.18443261884, 26545.60181597239, 26851.462970740868, 27399.86300068487, 27482.312942176606, 33854.64581416716, 41690.0, 43019.924501887705, 43042.13915721731, 43134.78432607817, 43175.0, 28455.0, 29284.0, 29866.954656586917, 29944.700552995062, 30273.69726302797, 28992.710072899, 29546.783991201177, 29559.85220073886, 29894.701052989192, 30077.398452031273, 31323.68676313208, 35096.0, 36159.63840361563, 36164.0, 36195.0, 29061.418771624027, 29356.853215733783, 30101.0, 30147.849260753555, 30364.089077327717, 19142.425727228205, 20288.289909853083, 20619.4845128867, 23803.45277556953, 24522.264332070066], "value": 17598.597080976517, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [364.28418158318897, 392.8291193330903, 419.4945091165146, 436.20828196822765, 448.0613115522978, 13614.0, 15478.458253961113, 21040.158393664235, 22007.669884951738, 22078.558428831435, 21477.355679329605, 21611.243606473778, 22120.668189977165, 22323.330300090984, 22601.773982260172, 5976.312724036748, 6069.969650151743, 6292.622442653433, 6350.682465876711, 6355.0, 3518.47222916562, 3738.7943663098517, 6267.43593076623, 6326.14597029402, 6337.493000559967, 3842.4236364545263, 6330.746770129213, 6331.936680633204, 6332.588381755194, 6356.586821856565, 5503.587230957694, 6093.939060609426, 6324.146240257575, 6336.017917222838, 6365.681715914186, 5383.81156659515, 5589.245451863987, 5602.159676048625, 5611.8877622447735, 5613.0, 26456.0, 26734.46531069387, 27052.10635255533, 27690.030848920393, 28428.857855710798, 2001.6196922584809, 2022.4438279473115, 2063.2572273981355, 2075.6990236415786, 2137.326742076257, 15564.61088472786, 16681.83318166815, 16709.331626734915, 16872.072036038015, 17061.48815535536, 1879.1731638079339, 1882.4634979031048, 1891.7162425636127, 1893.9810601893942, 1922.1152179833196, 156995.0, 165382.17308913378, 166697.0, 168508.0, 169660.0, 10933.945330273456, 11321.603743868925, 12197.268163910194, 12364.44360003802, 12575.748485030248, 16496.34014639401, 16516.84382093266, 16527.752083718755, 16537.255823487732, 16692.24884880183, 8715.074096943536, 9008.954955225314, 9059.59231834569, 9171.63313467454, 9188.40275382098, 8623.0, 8643.30853531716, 8658.48049117055, 8841.336899732545, 8858.29133669305, 7661.042369703787, 7791.220877912164, 7835.177306382861, 7838.686452541834, 7858.017747781528, 1808.4303444414968, 2083.874967501955, 2200.6478963366103, 2208.5693289808655, 2380.1312520930082, 915.6932427636816, 920.406337912043, 931.6552875436132, 937.6023177132431, 945.976350591227, 17553.912230438767, 19745.801856570124, 20942.267020654202, 20958.580828383347, 21379.78620213778, 851.4891065360735, 935.9064093590587, 960.9135177834029, 965.9565319560637, 979.1921664626569, 10363.481825908675, 10698.358098514114, 10821.0, 10884.782304353868, 10889.0, 686616.0, 687245.0, 688540.0, 690024.5498772574, 705240.0, 158937.0, 160260.0, 160670.0, 162180.0, 162726.0, 1138.6128716236353, 1168.894799468052, 1192.1476144556684, 1192.1952681939829, 1196.0610920427423, 13447.46210151583, 17447.82552174513, 18364.72452913234, 18440.446786596425, 18861.0, 64761.35238647742, 65621.67189164023, 65765.0, 65779.0, 65879.67060164668, 85967.0, 86464.0, 87982.56008720171, 94821.0, 96310.0, 8757.299416046573, 8763.474191548528, 8969.730908072768, 8971.416857904216, 9066.637334506546, 11454.140939429743, 13765.0, 13821.239831809347, 14040.1575905446, 14270.429182832571, 10956.835647465135, 11628.825567616661, 11904.880951190376, 11958.940205298917, 12044.410451752916, 10924.453777310944, 11141.94151555601, 11159.721006974565, 11247.212695111264, 11603.187776855539, 10227.795444091225, 11780.70548236301, 11853.466594003117, 11956.10329225329, 12310.076744244396, 8608.354373422144, 8813.42712723671, 8829.2495137914, 8838.425502342327, 9171.63313467454, 11737.823932641188, 11807.996320312526, 12005.81991270149, 12097.2136811107, 12188.512459501875], "value": 10400.679108674865, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1370.8697673720997, 1424.64383904024, 1441.6972435788484, 1445.349592683292, 1455.2360010994223, 10623.84064239036, 11088.168387370939, 11094.3343399396, 11104.0, 11108.111351091913, 10580.470976451166, 10975.451227438636, 11042.282251653636, 11061.391623460706, 11075.224734268604, 2431.2463136427677, 2478.479519300949, 2482.5779617465073, 2483.1060818105466, 2483.987580062097, 2060.402483279847, 2350.3771500552366, 2417.395651087228, 2450.889709963056, 2457.594496908008, 2121.7666056733747, 2343.742188359279, 2444.291155564884, 2445.6576079348906, 2451.901923923041, 2431.598786200275, 2445.42532504863, 2448.0, 2450.509898020403, 2451.166603354859, 2390.0559279084664, 2429.4290841652196, 2433.85396876188, 2434.403571125068, 2437.098273638765, 10885.619003334845, 11118.110551155889, 11131.833022504668, 11145.16411269158, 11154.665360039131, 6103.42017508336, 6358.42774150324, 6358.936410635881, 6366.458850997671, 6371.044343348489, 3760.2479504099015, 3858.3633700439395, 4113.732607380541, 4114.506259248879, 4125.773082480462, 1142.5829572206085, 1154.8498695169574, 1182.4974385885964, 1220.231254309788, 1241.88823005929, 15079.623009424742, 15116.39534418622, 15178.848211517965, 15196.924015379964, 15210.315535800915, 4887.657863949489, 5198.740062996835, 5286.418493965661, 5409.486098820606, 5441.945580544223, 11519.30884146954, 11524.59663911759, 11525.711857203469, 11538.365389903469, 11547.133964952662, 6292.276388215414, 6295.464885484785, 6296.212973378328, 6308.053791931247, 6313.779017734358, 5707.343655479673, 5736.741846616912, 5892.322382925932, 5977.372375900555, 5992.161097446361, 3365.3942290387963, 3967.305721498726, 4104.343305071234, 4155.252054630196, 4186.769727665008, 1046.340805292676, 1227.5081584383538, 1234.2532767675427, 1236.4621389695512, 1246.1526162209602, 584.1646445582772, 743.6170372258291, 761.3490465651788, 769.7844603511026, 795.7891158842912, 6475.219314688404, 6546.607203567801, 6699.330066993261, 6814.965925170342, 6829.112215411965, 883.8276536075404, 909.9545022748836, 915.8717779510873, 916.1845957098188, 957.3681370295571, 3981.22366138606, 4099.221147981874, 4128.772917489507, 4147.562108543829, 4277.850275240352, 12054.97532709712, 13758.380872860746, 13769.31153442324, 13776.448942042407, 13797.517086902111, 13381.397837097355, 13511.324433778469, 13659.521916732867, 13660.795088073686, 13678.31608419575, 9809.166220871306, 10028.699139025695, 10125.594976201017, 10142.239332049978, 10158.593656253815, 6241.407066328691, 6367.586106903036, 6437.774677886251, 6444.420002199825, 6559.573627714183, 8938.329625278, 12151.270923744603, 12303.876961230273, 12462.252264864137, 12471.314077725812, 10463.587415699089, 12339.93830030844, 12501.312427816558, 12639.0, 12693.936530317289, 8819.955900220459, 8907.821843562962, 8962.507062111647, 9009.279257659502, 9018.323625728228, 9773.267004974514, 9966.40201587878, 10105.090541851268, 10111.292209545556, 10257.0, 8678.566071696516, 8693.869591956252, 8720.651173953225, 8728.519931403835, 8770.91229087701, 7923.6830526778285, 8351.958240209004, 8532.274756645755, 8551.444156129832, 8625.353098517511, 7397.926020739939, 7428.814279643052, 7503.5497870127965, 7515.323620874147, 7527.435442341737, 5601.80393686219, 5636.210930469655, 5703.344115426613, 5782.0630088919, 5796.275465566804, 5502.257195278747, 5875.20684707559, 5985.880282394415, 6069.666168360783, 6262.0], "value": 5135.735163024118, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [389.0, 391.7551530293567, 399.56846605665885, 400.473377508576, 402.7080366734118, 4885.975570122153, 5176.818811341604, 5824.048943603898, 5950.49420799232, 6042.667653279068, 4809.374781278438, 5737.225474560933, 5747.482726554609, 5904.261967254093, 5910.143029260755, 4274.294741367687, 4364.018095928414, 4377.0, 4404.889877753066, 4405.295152775557, 4231.815091774308, 4372.978135109336, 4394.824207031715, 4412.602865742083, 4447.644188464915, 4010.4507510852814, 4335.197988372145, 4352.825886964518, 4379.211741886459, 4381.474223093217, 4158.812853421603, 4261.829526818923, 4376.759278239696, 4379.474463064436, 4385.429894113777, 3436.3127374525193, 3562.2697347044054, 3613.843570057583, 3743.737938344317, 3758.361078616642, 5741.368449470555, 5746.281714785652, 5775.624584402, 5785.045467497858, 5799.2750906136735, 4991.675541089854, 5145.536901678867, 5169.4830516948, 5192.3249977503065, 5204.76578553966, 5725.055365864669, 6248.750049997994, 6291.748330066792, 6295.968520157416, 6332.556721029529, 3738.4018557030745, 4256.574342565749, 4268.295731204347, 4281.828726850922, 4290.184864875664, 6452.64510451925, 6681.665916704145, 6716.93625356662, 6732.899006514906, 6777.695003724795, 3783.905402364908, 4320.78396080201, 4336.392904993303, 4346.152500262482, 4346.717463364871, 3890.9805450972563, 3995.001249687578, 4387.517373088957, 4399.714018588781, 4426.690131690751, 4900.926486102711, 5088.491150884956, 5153.0466863630345, 5165.715885626327, 5180.715060671624, 5521.475459831309, 6280.497560195174, 6321.304656487782, 6338.651374174465, 6352.4918006559365, 1209.782239196953, 1430.885529157665, 1499.3702644889172, 1512.9470468533548, 1520.247477498623, 990.9347451489677, 996.0786272697726, 1003.2626019875386, 1005.9497025148713, 1017.8625885505362, 6061.0, 6071.753451222988, 6073.939260607337, 6075.301340345828, 6077.817665470043, 6567.802965911031, 6578.0, 6583.407493325623, 6655.767048153291, 6689.364510371507, 5762.567807414461, 6092.72582733778, 6093.390660933871, 6121.724522396503, 6151.323354431009, 3420.931581368359, 3428.5714285714284, 3449.6550344965303, 3468.687818096333, 3477.4262246729513, 5721.828345149652, 6332.670139270805, 6809.557378770463, 6843.414912008966, 6870.45036397087, 6200.286966998853, 6470.708818103197, 6822.3859852613505, 6826.556273842184, 6836.162992358116, 5803.274590676166, 6234.37656234382, 6599.70301336441, 6643.833904152435, 6663.866722665616, 6025.300265792689, 6522.836929076621, 6601.933980660132, 6602.0, 6620.569662971891, 5329.920051199158, 5646.209530665792, 6361.809145725636, 6482.54622176462, 6489.935100648933, 6104.450599445893, 6774.93225067743, 6793.626350550767, 6802.163415877784, 6822.658867056726, 4714.457837348748, 4729.196036673705, 4748.501407352178, 4778.641601879804, 4798.0403919217, 5109.693418394908, 5811.157382179645, 5991.071383935323, 6614.66926653675, 6618.63597502142, 5665.150227465913, 5985.371535988658, 6362.886494863473, 6374.617522948638, 6377.394147555975, 6020.621854367413, 6039.63762174271, 6318.557700960889, 6338.968305158444, 6416.967915160394, 6214.564980451325, 6233.594816336924, 6235.971064774261, 6236.314005459487, 6242.563020588515, 5588.608797384144, 6241.96879015602, 6387.712552935036, 6415.967920160369, 6441.1304473895425, 6148.200733904564, 6191.442770150708, 6215.663632319073, 6218.352136683873, 6233.657148856856], "value": 4647.220783457598, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.3287664390712, 735.7719107076806, 741.0699572037092, 745.6532712288785, 752.713968691897, 15448.691026179484, 15550.84449155508, 15577.844221557782, 15716.0, 16182.190890455475, 15076.547703568911, 15411.306491207923, 15581.766273505878, 15726.247906616354, 15745.134017629025, 969.9127078562927, 992.4789485520088, 995.875515560555, 996.8853581838109, 998.3760149906309, 958.1328897347877, 994.751312171957, 1002.3234316836143, 1005.9899401006006, 1007.7430255284892, 1057.5188289328337, 1068.593934304967, 1071.6195750508575, 1071.82850743881, 1072.774717309366, 1054.931429457083, 1060.2578195263347, 1061.1828891753346, 1062.7024433158651, 1063.803196408667, 785.6150486261748, 787.1498781316164, 789.6643926331286, 791.0981481111537, 794.1026639896937, 16335.183240838029, 16649.16754162287, 16796.076215808127, 16866.494005179742, 16930.068846213453, 14761.483348082766, 14964.0, 15011.24943752819, 15072.849271507364, 15864.206789660471, 11412.258203216847, 11743.11926605508, 11776.234544754649, 12011.159218854684, 12232.694182645417, 3012.2469382654335, 3109.9067027989195, 3111.3932783107302, 3130.827804470753, 3172.5558421820965, 110067.0, 114368.0, 115022.0, 118150.40924795407, 119378.0, 11039.668809935714, 11428.371439570737, 11719.88280117188, 12027.15809893299, 12052.156349055658, 23508.764912350656, 25028.0, 25462.872685636823, 25635.10277140291, 25689.48621027569, 6552.344765523505, 7906.802329941797, 8171.63227654757, 8265.710700125586, 8267.338612910953, 4220.177065472265, 4229.534751177368, 4269.359596060615, 4274.4870615525715, 4279.486461624562, 4152.418661387408, 4199.454070970754, 4263.296556068276, 4267.231898258281, 4276.2089013532595, 763.8357753083003, 767.244264399566, 792.3938187286731, 804.1676864445271, 810.3881569415054, 462.6391414696542, 556.2018503447566, 581.287922295185, 582.4874110782569, 588.5791658963776, 9463.0, 9821.705348839547, 10000.79998400028, 10024.348417352849, 10068.798624027624, 543.1987817968464, 547.3470120236942, 576.9278840144982, 586.0623003194939, 590.6957916672917, 4259.909932201687, 4564.064366804797, 4611.538846115362, 4683.810544278418, 4706.7411292378565, 88024.0, 97285.0, 101197.0, 101511.49244253732, 102061.48969255105, 80529.0, 81462.0, 82156.0, 82380.58809705912, 84419.0, 76626.61686691642, 78357.0, 79478.0, 79747.0, 79811.0, 8909.242714369351, 9192.402493837879, 9258.72223833286, 9263.722088337361, 9264.0, 40160.99597510086, 40208.396874047496, 41799.37300940428, 41819.581804181566, 41854.79072604617, 52424.0, 52807.0, 52820.73589632181, 52950.20574691306, 53426.73286633698, 12319.0, 13345.266010369523, 13812.926743151007, 14560.344784484512, 14748.115113093249, 14723.705525889636, 14854.0, 15054.391978916969, 15226.0, 15685.882805359828, 13921.512747053805, 14120.50578229757, 14308.49920252786, 14309.57071287863, 14515.904017857294, 14096.577102686935, 14265.857341426452, 14274.357653905807, 14279.785803212751, 14432.989690721548, 11395.943020285176, 11687.824682629938, 13810.792838107236, 13984.300784960915, 14621.0, 8511.319094472552, 10071.244656650928, 10254.230932680228, 10335.896641033494, 11018.732845722845, 11007.61473348429, 11212.943935280271, 11324.773504529698, 11354.772904542027, 11357.659270221906], "value": 7638.506620109566, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1623.7000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 122.0, 122.0, 124.0, 122.0, 123.0, 123.0, 128.0, 167.0, 122.0], "value": 126.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 121.0, 117.0, 161.0, 117.0, 117.0, 117.0, 118.0, 143.0, 116.0], "value": 128.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [212.0, 208.0, 213.0, 214.0, 212.0, 208.0, 210.0, 209.0, 214.0, 239.0], "value": 213.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 62.0, 64.0, 99.0, 64.0, 63.0, 63.0, 61.0, 80.0, 62.0], "value": 70.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 78.0, 124.0, 111.0, 61.0, 100.0, 128.0, 111.0, 113.0, 110.0], "value": 103.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 85.0, 137.0, 138.0, 91.0, 92.0, 92.0, 92.0, 93.0, 103.0], "value": 102.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 101.0, 100.0, 101.0, 100.0, 101.0, 100.0, 102.0, 100.0, 100.0], "value": 105.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 103.0, 102.0, 101.0, 101.0, 99.0, 102.0, 98.0, 103.0, 100.0], "value": 101.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 52.0, 50.0, 51.0, 51.0, 52.0, 53.0, 52.0, 51.0, 54.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 61.0, 76.0, 71.0, 68.0, 63.0, 62.0, 63.0, 64.0], "value": 65.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 90.0, 88.0, 91.0, 89.0, 90.0, 92.0, 89.0, 92.0, 87.0], "value": 89.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 180.0, 165.0, 154.0, 143.0, 168.0, 143.0, 164.0, 222.0, 172.0], "value": 166.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [258.0, 207.0, 204.0, 202.0, 228.0, 262.0, 234.0, 200.0, 199.0, 200.0], "value": 219.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 70.0, 103.0, 75.0, 63.0, 99.0, 101.0, 73.0, 73.0, 72.0], "value": 79.4, "unit": "score"}]}]} 05:05:16 INFO - Return code: 0 05:05:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:05:16 ERROR - # TBPL SUCCESS # 05:05:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:05:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:05:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:05:16 INFO - 2017-04-03 05:05:16.272 screenresolution[1651:9904] starting screenresolution argv=screenresolution get 05:05:16 INFO - 2017-04-03 05:05:16.275 screenresolution[1651:9904] Display 0: 1600x1200x32@60 05:05:16 INFO - 2017-04-03 05:05:16.281 screenresolution[1652:9907] starting screenresolution argv=screenresolution list 05:05:16 INFO - Available Modes on Display 0 05:05:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:05:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:05:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:05:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:05:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:05:16 INFO - Intel Iris: 05:05:16 INFO - Chipset Model: Intel Iris 05:05:16 INFO - Type: GPU 05:05:16 INFO - Bus: Built-In 05:05:16 INFO - VRAM (Dynamic, Max): 1536 MB 05:05:16 INFO - Vendor: Intel (0x8086) 05:05:16 INFO - Device ID: 0x0a2e 05:05:16 INFO - Revision ID: 0x0009 05:05:16 INFO - Displays: 05:05:16 INFO - Display: 05:05:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:05:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:05:16 INFO - Display Serial Number: 1600x1200 60 05:05:16 INFO - Main Display: Yes 05:05:16 INFO - Mirror: Off 05:05:16 INFO - Online: Yes 05:05:16 INFO - Rotation: Supported 05:05:16 INFO - Return code: 0 05:05:16 INFO - Running post-action listener: _resource_record_post_action 05:05:16 INFO - [mozharness: 2017-04-03 12:05:16.518440Z] Finished run-tests step (success) 05:05:16 INFO - Running post-run listener: _resource_record_post_run 05:05:16 INFO - Total resource usage - Wall time: 1205s; CPU: 54.0%; Read bytes: 50145280; Write bytes: 526915584; Read time: 563; Write time: 1948 05:05:16 INFO - TinderboxPrint: CPU usage
53.6% 05:05:16 INFO - TinderboxPrint: I/O read bytes / time
50,145,280 / 563 05:05:16 INFO - TinderboxPrint: I/O write bytes / time
526,915,584 / 1,948 05:05:16 INFO - TinderboxPrint: CPU idle
2,238.8 (46.4%) 05:05:16 INFO - TinderboxPrint: CPU system
961.1 (19.9%) 05:05:16 INFO - TinderboxPrint: CPU user
1,621.9 (33.6%) 05:05:16 INFO - TinderboxPrint: Swap in / out
254,263,296 / 0 05:05:16 INFO - install - Wall time: 21s; CPU: 55.0%; Read bytes: 208908800; Write bytes: 206600192; Read time: 15744; Write time: 418 05:05:16 INFO - run-tests - Wall time: 1185s; CPU: 54.0%; Read bytes: 43859968; Write bytes: 310362112; Read time: 484; Write time: 1496 05:05:17 INFO - Running post-run listener: _upload_blobber_files 05:05:17 INFO - Blob upload gear active. 05:05:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:05:17 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:05:17 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:05:17 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:05:17 INFO - (blobuploader) - INFO - Open directory for files ... 05:05:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:05:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:05:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:18 INFO - (blobuploader) - INFO - Done attempting. 05:05:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:05:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:05:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:19 INFO - (blobuploader) - INFO - Done attempting. 05:05:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:05:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:05:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:20 INFO - (blobuploader) - INFO - Done attempting. 05:05:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:05:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:05:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:05:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:05:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:05:22 INFO - (blobuploader) - INFO - Done attempting. 05:05:22 INFO - (blobuploader) - INFO - Iteration through files over. 05:05:22 INFO - Return code: 0 05:05:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:05:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:05:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e2d694f6db051b4b262feed967f211365c26197c0bcca08087487e311b8b7a445a6e5648457995ec7e5cdbd46e6c52576ae3cdd692b428bdac2d0863851b7bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60286bff96d039e3ef2a551a2bc1bab40c4eec96d1ebcce74f0f88d381aac952b116fbfc9ef232b60f459398f271096632ecaf34ba0734a0a775e3e1b546d477", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8787d57e70a3f42ddd47856911fbf7160b18b3a21dd387365b3a75b849c328e1be9d4157683766a173e0b72be86302db920e8f41dc3d44f276ccec0f851063ff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c5933e5993eee622a2c28840cf1f4b5d0d90dcdef735e3215e51a7ac8398e9d10a33161c8c749bae7b8038a00f92d7a9dd5a7895026ed8d4b7ca037ebdce15a"} 05:05:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:05:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:05:22 INFO - Contents: 05:05:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0e2d694f6db051b4b262feed967f211365c26197c0bcca08087487e311b8b7a445a6e5648457995ec7e5cdbd46e6c52576ae3cdd692b428bdac2d0863851b7bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60286bff96d039e3ef2a551a2bc1bab40c4eec96d1ebcce74f0f88d381aac952b116fbfc9ef232b60f459398f271096632ecaf34ba0734a0a775e3e1b546d477", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8787d57e70a3f42ddd47856911fbf7160b18b3a21dd387365b3a75b849c328e1be9d4157683766a173e0b72be86302db920e8f41dc3d44f276ccec0f851063ff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c5933e5993eee622a2c28840cf1f4b5d0d90dcdef735e3215e51a7ac8398e9d10a33161c8c749bae7b8038a00f92d7a9dd5a7895026ed8d4b7ca037ebdce15a"} 05:05:22 INFO - Running post-run listener: copy_logs_to_upload_dir 05:05:22 INFO - Copying logs to upload dir... 05:05:22 INFO - mkdir: /builds/slave/test/build/upload/logs 05:05:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1291.183271 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2017-04-03 05:05:22.407823) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 05:05:22.411337) ========= 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.iAFWc1iQ7N/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.mNRIAksYXe/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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/0e2d694f6db051b4b262feed967f211365c26197c0bcca08087487e311b8b7a445a6e5648457995ec7e5cdbd46e6c52576ae3cdd692b428bdac2d0863851b7bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60286bff96d039e3ef2a551a2bc1bab40c4eec96d1ebcce74f0f88d381aac952b116fbfc9ef232b60f459398f271096632ecaf34ba0734a0a775e3e1b546d477", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8787d57e70a3f42ddd47856911fbf7160b18b3a21dd387365b3a75b849c328e1be9d4157683766a173e0b72be86302db920e8f41dc3d44f276ccec0f851063ff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c5933e5993eee622a2c28840cf1f4b5d0d90dcdef735e3215e51a7ac8398e9d10a33161c8c749bae7b8038a00f92d7a9dd5a7895026ed8d4b7ca037ebdce15a"} build_url:https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011045 build_url: 'https://queue.taskcluster.net/v1/task/Fun6LZKGTZyWzsRumFCsCA/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/0e2d694f6db051b4b262feed967f211365c26197c0bcca08087487e311b8b7a445a6e5648457995ec7e5cdbd46e6c52576ae3cdd692b428bdac2d0863851b7bf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/60286bff96d039e3ef2a551a2bc1bab40c4eec96d1ebcce74f0f88d381aac952b116fbfc9ef232b60f459398f271096632ecaf34ba0734a0a775e3e1b546d477", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8787d57e70a3f42ddd47856911fbf7160b18b3a21dd387365b3a75b849c328e1be9d4157683766a173e0b72be86302db920e8f41dc3d44f276ccec0f851063ff", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9c5933e5993eee622a2c28840cf1f4b5d0d90dcdef735e3215e51a7ac8398e9d10a33161c8c749bae7b8038a00f92d7a9dd5a7895026ed8d4b7ca037ebdce15a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-03 05:05:22.445645) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 05:05:22.446017) ========= 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.iAFWc1iQ7N/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.mNRIAksYXe/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/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.005145 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-03 05:05:22.494902) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 05:05:22.495220) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-03 05:05:22.495598) ========= ========= Total master_lag: 0.40 =========