builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0347 starttime: 1491458945.65 results: success (0) buildid: 20170405213646 builduid: 9ed5321ae2f84ff6a63291928e787fa2 revision: ec8d1d3db50c85037e8077c32c8403570a5df493 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 23:09:05.654796) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-05 23:09:05.655284) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 23:09:05.655654) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-05 23:09:05.683161) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 23:09:05.683685) ========= 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.zUMJEQAPIZ/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.yxdLmYrbca/Listeners TMPDIR=/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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-05 23:09:05-- 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% 18.4M=0.001s 2017-04-05 23:09:05 (18.4 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.104890 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 23:09:05.813061) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 23:09:05.813428) ========= 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.zUMJEQAPIZ/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.yxdLmYrbca/Listeners TMPDIR=/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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.027848 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 23:09:05.863472) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-05 23:09:05.863910) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev ec8d1d3db50c85037e8077c32c8403570a5df493 --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 ec8d1d3db50c85037e8077c32c8403570a5df493 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.zUMJEQAPIZ/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.yxdLmYrbca/Listeners TMPDIR=/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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-05 23:09:05,970 truncating revision to first 12 chars 2017-04-05 23:09:05,970 Setting DEBUG logging. 2017-04-05 23:09:05,970 attempt 1/10 2017-04-05 23:09:05,970 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/ec8d1d3db50c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-05 23:09:07,780 unpacking tar archive at: mozilla-central-ec8d1d3db50c/testing/mozharness/ program finished with exit code 0 elapsedTime=2.095071 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-04-05 23:09:07.982750) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 23:09:07.983147) ========= script_repo_revision: ec8d1d3db50c85037e8077c32c8403570a5df493 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-05 23:09:07.983554) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 23:09:07.983840) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-05 23:09:08.003417) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2017-04-05 23:09:08.003728) ========= /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.zUMJEQAPIZ/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.yxdLmYrbca/Listeners TMPDIR=/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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 23:09:08 INFO - MultiFileLogger online at 20170405 23:09:08 in /builds/slave/test 23:09:08 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 23:09:08 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:09:08 INFO - {'append_to_log': False, 23:09:08 INFO - 'base_work_dir': '/builds/slave/test', 23:09:08 INFO - 'blob_upload_branch': 'Firefox', 23:09:08 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:09:08 INFO - 'branch': 'Firefox', 23:09:08 INFO - 'buildbot_json_path': 'buildprops.json', 23:09:08 INFO - 'config_files': ('talos/mac_config.py',), 23:09:08 INFO - 'default_actions': ('clobber', 23:09:08 INFO - 'read-buildbot-config', 23:09:08 INFO - 'download-and-extract', 23:09:08 INFO - 'populate-webroot', 23:09:08 INFO - 'create-virtualenv', 23:09:08 INFO - 'install', 23:09:08 INFO - 'run-tests'), 23:09:08 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:09:08 INFO - 'download_minidump_stackwalk': True, 23:09:08 INFO - 'download_symbols': 'ondemand', 23:09:08 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:09:08 INFO - 'tooltool.py': '/tools/tooltool.py', 23:09:08 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:09:08 INFO - '/tools/misc-python/virtualenv.py')}, 23:09:08 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:09:08 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:09:08 INFO - 'gecko_profile': False, 23:09:08 INFO - 'gecko_profile_interval': 0, 23:09:08 INFO - 'installer_path': 'installer.exe', 23:09:08 INFO - 'log_level': 'info', 23:09:08 INFO - 'log_name': 'talos', 23:09:08 INFO - 'log_to_console': True, 23:09:08 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 23:09:08 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 23:09:08 INFO - 'opt_config_files': (), 23:09:08 INFO - 'pip_index': False, 23:09:08 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:09:08 INFO - 'cmd': ('bash', 23:09:08 INFO - '-c', 23:09:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:09:08 INFO - 'enabled': True, 23:09:08 INFO - 'halt_on_failure': False, 23:09:08 INFO - 'name': 'check_screen_resolution'},), 23:09:08 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 23:09:08 INFO - 'cmd': ('bash', 23:09:08 INFO - '-c', 23:09:08 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 23:09:08 INFO - 'enabled': True, 23:09:08 INFO - 'halt_on_failure': False, 23:09:08 INFO - 'name': 'check_screen_resolution'},), 23:09:08 INFO - 'run_cmd_checks_enabled': True, 23:09:08 INFO - 'suite': 'dromaeojs', 23:09:08 INFO - 'system_bits': '32', 23:09:08 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:09:08 INFO - 'title': 't-yosemite-r7-0347', 23:09:08 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:09:08 INFO - 'use_talos_json': True, 23:09:08 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:09:08 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:09:08 INFO - 'work_dir': 'build'} 23:09:08 INFO - [mozharness: 2017-04-06 06:09:08.212908Z] Running clobber step. 23:09:08 INFO - Running pre-action listener: _resource_record_pre_action 23:09:08 INFO - Running main action method: clobber 23:09:08 INFO - rmtree: /builds/slave/test/build 23:09:08 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:09:10 INFO - Running post-action listener: _resource_record_post_action 23:09:10 INFO - [mozharness: 2017-04-06 06:09:10.668874Z] Finished clobber step (success) 23:09:10 INFO - [mozharness: 2017-04-06 06:09:10.669066Z] Running read-buildbot-config step. 23:09:10 INFO - Running pre-action listener: _resource_record_pre_action 23:09:10 INFO - Running main action method: read_buildbot_config 23:09:10 INFO - Using buildbot properties: 23:09:10 INFO - { 23:09:10 INFO - "project": "", 23:09:10 INFO - "product": "firefox", 23:09:10 INFO - "script_repo_revision": "production", 23:09:10 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 23:09:10 INFO - "repository": "", 23:09:10 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 23:09:10 INFO - "buildid": "20170405213646", 23:09:10 INFO - "pgo_build": "False", 23:09:10 INFO - "basedir": "/builds/slave/test", 23:09:10 INFO - "buildnumber": 28, 23:09:10 INFO - "slavename": "t-yosemite-r7-0347", 23:09:10 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 23:09:10 INFO - "platform": "yosemite_r7", 23:09:10 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 23:09:10 INFO - "branch": "mozilla-central", 23:09:10 INFO - "repo_path": "mozilla-central", 23:09:10 INFO - "revision": "ec8d1d3db50c85037e8077c32c8403570a5df493", 23:09:10 INFO - "stage_platform": "macosx64", 23:09:10 INFO - "builduid": "9ed5321ae2f84ff6a63291928e787fa2", 23:09:10 INFO - "slavebuilddir": "test" 23:09:10 INFO - } 23:09:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/AA6IgIOpQrOXPnm6QBkTmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 23:09:10 INFO - Running post-action listener: _resource_record_post_action 23:09:10 INFO - [mozharness: 2017-04-06 06:09:10.672491Z] Finished read-buildbot-config step (success) 23:09:10 INFO - [mozharness: 2017-04-06 06:09:10.672629Z] Running download-and-extract step. 23:09:10 INFO - Running pre-action listener: _resource_record_pre_action 23:09:10 INFO - Running main action method: download_and_extract 23:09:10 INFO - mkdir: /builds/slave/test/build/tests 23:09: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')]} 23:09:10 INFO - trying https://queue.taskcluster.net/v1/task/AA6IgIOpQrOXPnm6QBkTmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 23:09:10 INFO - Downloading https://queue.taskcluster.net/v1/task/AA6IgIOpQrOXPnm6QBkTmQ/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 23:09:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AA6IgIOpQrOXPnm6QBkTmQ/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 23:09:12 INFO - Downloaded 1325 bytes. 23:09:12 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 23:09:12 INFO - Using the following test package requirements: 23:09:12 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 23:09:12 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 23:09:12 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 23:09:12 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 23:09:12 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 23:09:12 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 23:09:12 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 23:09:12 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 23:09:12 INFO - u'jsshell-mac.zip'], 23:09:12 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 23:09:12 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 23:09:12 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 23:09:12 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 23:09:12 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 23:09:12 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 23:09:12 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 23:09:12 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 23:09:12 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 23:09:12 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 23:09:12 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 23:09:12 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 23:09:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AA6IgIOpQrOXPnm6QBkTmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 23:09:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AA6IgIOpQrOXPnm6QBkTmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:09:12 INFO - Fetch https://queue.taskcluster.net/v1/task/AA6IgIOpQrOXPnm6QBkTmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 23:09:14 INFO - Expected file size: 52517975 23:09:14 INFO - Obtained file size: 52517975 23:09:31 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 23:09:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AA6IgIOpQrOXPnm6QBkTmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 23:09:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AA6IgIOpQrOXPnm6QBkTmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 23:09:31 INFO - Fetch https://queue.taskcluster.net/v1/task/AA6IgIOpQrOXPnm6QBkTmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 23:09:33 INFO - Expected file size: 52517975 23:09:33 INFO - Obtained file size: 52517975 23:09:48 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/AA6IgIOpQrOXPnm6QBkTmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 23:09:48 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/AA6IgIOpQrOXPnm6QBkTmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 23:09:48 INFO - Fetch https://queue.taskcluster.net/v1/task/AA6IgIOpQrOXPnm6QBkTmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 23:09:49 INFO - Expected file size: 14404152 23:09:49 INFO - Obtained file size: 14404152 23:09:49 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')]} 23:09:49 INFO - trying https://queue.taskcluster.net/v1/task/AA6IgIOpQrOXPnm6QBkTmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 23:09:49 INFO - Downloading https://queue.taskcluster.net/v1/task/AA6IgIOpQrOXPnm6QBkTmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 23:09:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/AA6IgIOpQrOXPnm6QBkTmQ/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 23:09:51 INFO - Downloaded 70745707 bytes. 23:09:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AA6IgIOpQrOXPnm6QBkTmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 23:09:51 INFO - mkdir: /builds/slave/test/properties 23:09:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:09:51 INFO - Writing to file /builds/slave/test/properties/build_url 23:09:51 INFO - Contents: 23:09:51 INFO - build_url:https://queue.taskcluster.net/v1/task/AA6IgIOpQrOXPnm6QBkTmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 23:09:52 INFO - Running post-action listener: _resource_record_post_action 23:09:52 INFO - Running post-action listener: set_extra_try_arguments 23:09:52 INFO - [mozharness: 2017-04-06 06:09:52.588221Z] Finished download-and-extract step (success) 23:09:52 INFO - [mozharness: 2017-04-06 06:09:52.588349Z] Running populate-webroot step. 23:09:52 INFO - Running pre-action listener: _resource_record_pre_action 23:09:52 INFO - Running main action method: populate_webroot 23:09:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:09:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:09:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:09:52 INFO - '--tppagecycles', 23:09:52 INFO - '7'], 23:09:52 INFO - 'tests': ['tsvgm']}}, 23:09:52 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:09:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:09:52 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:09:52 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:09:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:09:52 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:09:52 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 23:09:52 INFO - 'talos_options': ['--disable-e10s'], 23:09:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:09:52 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 23:09:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:09:52 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 23:09:52 INFO - 'talos_options': ['--disable-e10s'], 23:09:52 INFO - 'tests': ['damp', 'tps']}, 23:09:52 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 23:09:52 INFO - 'tests': ['damp', 'tps']}, 23:09:52 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:09:52 INFO - 'tests': ['dromaeo_dom']}, 23:09:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:09:52 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:09:52 INFO - 'tests': ['basic_compositor_video']}, 23:09:52 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:09:52 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:09:52 INFO - 'tests': ['a11yr', 23:09:52 INFO - 'ts_paint', 23:09:52 INFO - 'tpaint', 23:09:52 INFO - 'sessionrestore', 23:09:52 INFO - 'sessionrestore_no_auto_restore', 23:09:52 INFO - 'tabpaint']}, 23:09:52 INFO - 'other-e10s': {'tests': ['a11yr', 23:09:52 INFO - 'ts_paint', 23:09:52 INFO - 'tpaint', 23:09:52 INFO - 'sessionrestore', 23:09:52 INFO - 'sessionrestore_no_auto_restore', 23:09:52 INFO - 'tabpaint']}, 23:09:52 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:09:52 INFO - 'ts_paint', 23:09:52 INFO - 'tpaint', 23:09:52 INFO - 'sessionrestore', 23:09:52 INFO - 'sessionrestore_no_auto_restore', 23:09:52 INFO - 'tabpaint']}, 23:09:52 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:09:52 INFO - 'ts_paint', 23:09:52 INFO - 'tpaint', 23:09:52 INFO - 'sessionrestore', 23:09:52 INFO - 'sessionrestore_no_auto_restore', 23:09:52 INFO - 'tabpaint']}, 23:09:52 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:09:52 INFO - 'tests': ['a11yr', 23:09:52 INFO - 'ts_paint', 23:09:52 INFO - 'tpaint', 23:09:52 INFO - 'sessionrestore', 23:09:52 INFO - 'sessionrestore_no_auto_restore', 23:09:52 INFO - 'tabpaint']}, 23:09:52 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:09:52 INFO - 'tests': ['a11yr', 23:09:52 INFO - 'ts_paint', 23:09:52 INFO - 'tpaint', 23:09:52 INFO - 'sessionrestore', 23:09:52 INFO - 'sessionrestore_no_auto_restore', 23:09:52 INFO - 'tabpaint']}, 23:09:52 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:09:52 INFO - 'tests': ['tsvgx', 23:09:52 INFO - 'tsvgr_opacity', 23:09:52 INFO - 'tart', 23:09:52 INFO - 'tscrollx', 23:09:52 INFO - 'cart', 23:09:52 INFO - 'tsvg_static']}, 23:09:52 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:09:52 INFO - 'tsvgr_opacity', 23:09:52 INFO - 'tart', 23:09:52 INFO - 'tscrollx', 23:09:52 INFO - 'cart', 23:09:52 INFO - 'tsvg_static']}, 23:09:52 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 23:09:52 INFO - 'talos_options': ['--disable-e10s'], 23:09:52 INFO - 'tests': ['tp5o']}, 23:09:52 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 23:09:52 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 23:09:52 INFO - 'talos_options': ['--disable-e10s', 23:09:52 INFO - '--xperf_path', 23:09:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:09:52 INFO - 'tests': ['tp5n']}, 23:09:52 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 23:09:52 INFO - 'talos_options': ['--xperf_path', 23:09:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:09:52 INFO - 'tests': ['tp5n']}}, 23:09:52 INFO - 'talos.zip': {'path': '', 23:09:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:09:52 INFO - Running post-action listener: _resource_record_post_action 23:09:52 INFO - [mozharness: 2017-04-06 06:09:52.606482Z] Finished populate-webroot step (success) 23:09:52 INFO - [mozharness: 2017-04-06 06:09:52.606622Z] Running create-virtualenv step. 23:09:52 INFO - Running pre-action listener: _resource_record_pre_action 23:09:52 INFO - Running main action method: create_virtualenv 23:09:52 INFO - Creating virtualenv /builds/slave/test/build/venv 23:09:52 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 23:09:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:09:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:09:52 INFO - Using real prefix '/tools/python27' 23:09:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:09:53 INFO - Installing distribute.............................................................................................................................................................................................done. 23:09:56 INFO - Installing pip.................done. 23:09:56 INFO - Return code: 0 23:09:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 23:09:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 23:09:56 INFO - Reading from file tmpfile_stdout 23:09:56 INFO - Output received: 23:09:56 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) 23:09:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:56 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 0x10310eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103111768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb62348cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eecd30>, '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 0x102e13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ee1be8>, '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.zUMJEQAPIZ/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.yxdLmYrbca/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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 23:09:56 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 23:09:56 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 23:09:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zUMJEQAPIZ/Render', 23:09:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:09:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:09:56 INFO - 'HOME': '/Users/cltbld', 23:09:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:09:56 INFO - 'LOGNAME': 'cltbld', 23:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:56 INFO - 'MOZ_NO_REMOTE': '1', 23:09:56 INFO - 'NO_EM_RESTART': '1', 23:09:56 INFO - 'PAGER': '/bin/cat', 23:09:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:56 INFO - 'PWD': '/builds/slave/test', 23:09:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:09:56 INFO - 'SHELL': '/bin/bash', 23:09:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxdLmYrbca/Listeners', 23:09:56 INFO - 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/', 23:09:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:09:56 INFO - 'USER': 'cltbld', 23:09:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:09:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:56 INFO - 'XPC_FLAGS': '0x0', 23:09:56 INFO - 'XPC_SERVICE_NAME': '0', 23:09:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:09:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:56 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 23:09:56 INFO - Cleaning up... 23:09:56 INFO - Return code: 0 23:09:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:09:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:09:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:09:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:09:56 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 0x10310eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103111768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb62348cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eecd30>, '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 0x102e13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ee1be8>, '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.zUMJEQAPIZ/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.yxdLmYrbca/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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 23:09:56 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 23:09:56 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 23:09:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zUMJEQAPIZ/Render', 23:09:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:09:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:09:56 INFO - 'HOME': '/Users/cltbld', 23:09:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:09:56 INFO - 'LOGNAME': 'cltbld', 23:09:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:09:56 INFO - 'MOZ_NO_REMOTE': '1', 23:09:56 INFO - 'NO_EM_RESTART': '1', 23:09:56 INFO - 'PAGER': '/bin/cat', 23:09:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:09:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:09:56 INFO - 'PWD': '/builds/slave/test', 23:09:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:09:56 INFO - 'SHELL': '/bin/bash', 23:09:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxdLmYrbca/Listeners', 23:09:56 INFO - 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/', 23:09:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:09:56 INFO - 'USER': 'cltbld', 23:09:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:09:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:09:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:09:56 INFO - 'XPC_FLAGS': '0x0', 23:09:56 INFO - 'XPC_SERVICE_NAME': '0', 23:09:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:09:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:09:57 INFO - Downloading/unpacking psutil>=3.1.1 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:09: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 23:10:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:10:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:10:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:10:00 INFO - Installing collected packages: psutil 23:10:00 INFO - Running setup.py install for psutil 23:10:00 INFO - building 'psutil._psutil_osx' extension 23:10:00 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 23:10:01 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 23:10:01 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 23:10:01 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 23:10:01 INFO - building 'psutil._psutil_posix' extension 23:10:01 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 23:10:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 23:10:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 23:10:01 INFO - ^ 23:10:01 INFO - 1 warning generated. 23:10:01 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 23:10:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:10:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:10:01 INFO - Successfully installed psutil 23:10:01 INFO - Cleaning up... 23:10:01 INFO - Return code: 0 23:10:01 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:10:01 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')]} 23:10:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:10:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10310eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103111768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb62348cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eecd30>, '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 0x102e13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ee1be8>, '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.zUMJEQAPIZ/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.yxdLmYrbca/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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 23:10:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:10:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:10:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zUMJEQAPIZ/Render', 23:10:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:10:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:10:02 INFO - 'HOME': '/Users/cltbld', 23:10:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:10:02 INFO - 'LOGNAME': 'cltbld', 23:10:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:02 INFO - 'MOZ_NO_REMOTE': '1', 23:10:02 INFO - 'NO_EM_RESTART': '1', 23:10:02 INFO - 'PAGER': '/bin/cat', 23:10:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:10:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:02 INFO - 'PWD': '/builds/slave/test', 23:10:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:10:02 INFO - 'SHELL': '/bin/bash', 23:10:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxdLmYrbca/Listeners', 23:10:02 INFO - 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/', 23:10:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:10:02 INFO - 'USER': 'cltbld', 23:10:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:10:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:10:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:02 INFO - 'XPC_FLAGS': '0x0', 23:10:02 INFO - 'XPC_SERVICE_NAME': '0', 23:10:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:03 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:10:03 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 23:10:03 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 23:10:03 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 23:10:03 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 23:10:03 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 23:10:03 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 23:10:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:10:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:10:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:10:06 INFO - Installing collected packages: mozsystemmonitor 23:10:06 INFO - Running setup.py install for mozsystemmonitor 23:10:06 INFO - Successfully installed mozsystemmonitor 23:10:06 INFO - Cleaning up... 23:10:06 INFO - Return code: 0 23:10:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:10:06 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')]} 23:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:06 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')]} 23:10:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:06 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 0x10310eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103111768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb62348cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eecd30>, '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 0x102e13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ee1be8>, '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.zUMJEQAPIZ/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.yxdLmYrbca/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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 23:10:06 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 23:10:06 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 23:10:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zUMJEQAPIZ/Render', 23:10:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:10:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:10:06 INFO - 'HOME': '/Users/cltbld', 23:10:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:10:06 INFO - 'LOGNAME': 'cltbld', 23:10:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:06 INFO - 'MOZ_NO_REMOTE': '1', 23:10:06 INFO - 'NO_EM_RESTART': '1', 23:10:06 INFO - 'PAGER': '/bin/cat', 23:10:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:10:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:06 INFO - 'PWD': '/builds/slave/test', 23:10:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:10:06 INFO - 'SHELL': '/bin/bash', 23:10:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxdLmYrbca/Listeners', 23:10:06 INFO - 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/', 23:10:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:10:06 INFO - 'USER': 'cltbld', 23:10:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:10:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:10:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:06 INFO - 'XPC_FLAGS': '0x0', 23:10:06 INFO - 'XPC_SERVICE_NAME': '0', 23:10:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:10:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:06 INFO - Downloading/unpacking jsonschema==2.5.1 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10: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 23:10:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:10:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:10:09 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 23:10:09 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 23:10:09 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 23:10:09 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 23:10:09 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 23:10:09 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 23:10:09 INFO - Downloading functools32-3.2.3-2.tar.gz 23:10:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:10:09 INFO - warning: no files found matching '*.txt' 23:10:09 INFO - no previously-included directories found matching 'build' 23:10:09 INFO - no previously-included directories found matching 'dist' 23:10:09 INFO - no previously-included directories found matching '.git*' 23:10:09 INFO - Installing collected packages: jsonschema, functools32 23:10:09 INFO - Running setup.py install for functools32 23:10:10 INFO - warning: no files found matching '*.txt' 23:10:10 INFO - no previously-included directories found matching 'build' 23:10:10 INFO - no previously-included directories found matching 'dist' 23:10:10 INFO - no previously-included directories found matching '.git*' 23:10:10 INFO - Successfully installed jsonschema functools32 23:10:10 INFO - Cleaning up... 23:10:10 INFO - Return code: 0 23:10:10 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:10: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')]} 23:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10: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')]} 23:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10: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', '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 0x10310eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103111768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb62348cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eecd30>, '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 0x102e13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ee1be8>, '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.zUMJEQAPIZ/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.yxdLmYrbca/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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 23:10: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 23:10: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 functools32==3.2.3-2 23:10:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zUMJEQAPIZ/Render', 23:10:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:10:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:10:10 INFO - 'HOME': '/Users/cltbld', 23:10:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:10:10 INFO - 'LOGNAME': 'cltbld', 23:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:10 INFO - 'MOZ_NO_REMOTE': '1', 23:10:10 INFO - 'NO_EM_RESTART': '1', 23:10:10 INFO - 'PAGER': '/bin/cat', 23:10:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:10 INFO - 'PWD': '/builds/slave/test', 23:10:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:10:10 INFO - 'SHELL': '/bin/bash', 23:10:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxdLmYrbca/Listeners', 23:10:10 INFO - 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/', 23:10:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:10:10 INFO - 'USER': 'cltbld', 23:10:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:10:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:10 INFO - 'XPC_FLAGS': '0x0', 23:10:10 INFO - 'XPC_SERVICE_NAME': '0', 23:10:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:10:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:10 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:10:10 INFO - Cleaning up... 23:10:10 INFO - Return code: 0 23:10:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:10: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')]} 23:10:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10: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')]} 23:10:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10: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', '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 0x10310eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103111768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb62348cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eecd30>, '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 0x102e13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ee1be8>, '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.zUMJEQAPIZ/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.yxdLmYrbca/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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 23:10: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:10: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 blobuploader==1.2.4 23:10:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zUMJEQAPIZ/Render', 23:10:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:10:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:10:10 INFO - 'HOME': '/Users/cltbld', 23:10:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:10:10 INFO - 'LOGNAME': 'cltbld', 23:10:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:10 INFO - 'MOZ_NO_REMOTE': '1', 23:10:10 INFO - 'NO_EM_RESTART': '1', 23:10:10 INFO - 'PAGER': '/bin/cat', 23:10:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:10:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:10 INFO - 'PWD': '/builds/slave/test', 23:10:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:10:10 INFO - 'SHELL': '/bin/bash', 23:10:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxdLmYrbca/Listeners', 23:10:10 INFO - 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/', 23:10:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:10:10 INFO - 'USER': 'cltbld', 23:10:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:10:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:10:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:10 INFO - 'XPC_FLAGS': '0x0', 23:10:10 INFO - 'XPC_SERVICE_NAME': '0', 23:10:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:10:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:10 INFO - Downloading/unpacking blobuploader==1.2.4 23:10:10 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 23:10:10 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 23:10:10 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 23:10:10 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 23:10:10 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 23:10:10 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 23:10:13 INFO - Downloading blobuploader-1.2.4.tar.gz 23:10:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:10:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:10:13 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 23:10:13 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 23:10:13 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 23:10:13 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 23:10:13 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 23:10:13 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 23:10:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:10:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:10:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:10:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:10:14 INFO - Downloading docopt-0.6.1.tar.gz 23:10:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:10:14 INFO - Installing collected packages: blobuploader, requests, docopt 23:10:14 INFO - Running setup.py install for blobuploader 23:10:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:10:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:10:14 INFO - Running setup.py install for requests 23:10:15 INFO - Running setup.py install for docopt 23:10:15 INFO - Successfully installed blobuploader requests docopt 23:10:15 INFO - Cleaning up... 23:10:15 INFO - Return code: 0 23:10:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:10:15 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')]} 23:10:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:15 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')]} 23:10:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:15 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 0x10310eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103111768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb62348cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eecd30>, '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 0x102e13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ee1be8>, '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.zUMJEQAPIZ/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.yxdLmYrbca/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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 23:10:15 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 23:10:15 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 23:10:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zUMJEQAPIZ/Render', 23:10:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:10:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:10:15 INFO - 'HOME': '/Users/cltbld', 23:10:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:10:15 INFO - 'LOGNAME': 'cltbld', 23:10:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:15 INFO - 'MOZ_NO_REMOTE': '1', 23:10:15 INFO - 'NO_EM_RESTART': '1', 23:10:15 INFO - 'PAGER': '/bin/cat', 23:10:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:10:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:15 INFO - 'PWD': '/builds/slave/test', 23:10:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:10:15 INFO - 'SHELL': '/bin/bash', 23:10:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxdLmYrbca/Listeners', 23:10:15 INFO - 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/', 23:10:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:10:15 INFO - 'USER': 'cltbld', 23:10:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:10:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:10:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:15 INFO - 'XPC_FLAGS': '0x0', 23:10:15 INFO - 'XPC_SERVICE_NAME': '0', 23:10:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:10:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:10:15 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-TrGBjF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:10:15 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-CECM2b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:10:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:10:15 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-1BXxaV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:10:16 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-R6eCbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:10:16 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-WpqjBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:10:16 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-t_5OVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:10:16 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-w2ibWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:10:16 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-MwYUec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:10:16 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-6uf79g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:10:16 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-Anru8x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:10:16 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-NVDffn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:10:16 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-FMJkPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:10:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:10:17 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-K5i0H9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:10:17 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-neN0tU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:10:17 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-HTOM9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:10:17 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-YaJBu2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:10:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:10:17 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-gcxxVi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:10:17 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:10:17 INFO - Running setup.py install for manifestparser 23:10:17 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:10:17 INFO - Running setup.py install for mozcrash 23:10:17 INFO - Running setup.py install for mozdebug 23:10:17 INFO - Running setup.py install for mozdevice 23:10:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:10:18 INFO - Running setup.py install for mozfile 23:10:18 INFO - Running setup.py install for mozhttpd 23:10:18 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:10:18 INFO - Running setup.py install for mozinfo 23:10:18 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:10:18 INFO - Running setup.py install for mozInstall 23:10:18 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:10:18 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:10:18 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:10:18 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:10:18 INFO - Running setup.py install for mozleak 23:10:18 INFO - Running setup.py install for mozlog 23:10:18 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:10:19 INFO - Running setup.py install for moznetwork 23:10:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:10:19 INFO - Running setup.py install for mozprocess 23:10:19 INFO - Running setup.py install for mozprofile 23:10:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:10:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:10:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:10:19 INFO - Running setup.py install for mozrunner 23:10:19 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:10:19 INFO - Running setup.py install for mozscreenshot 23:10:19 INFO - Running setup.py install for moztest 23:10:19 INFO - Running setup.py install for mozversion 23:10:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:10:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:10:20 INFO - Cleaning up... 23:10:20 INFO - Return code: 0 23:10:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:10:20 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')]} 23:10:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:20 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')]} 23:10:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:20 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 0x10310eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103111768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb62348cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eecd30>, '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 0x102e13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ee1be8>, '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.zUMJEQAPIZ/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.yxdLmYrbca/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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 23:10:20 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 23:10:20 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 23:10:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zUMJEQAPIZ/Render', 23:10:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:10:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:10:20 INFO - 'HOME': '/Users/cltbld', 23:10:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:10:20 INFO - 'LOGNAME': 'cltbld', 23:10:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:20 INFO - 'MOZ_NO_REMOTE': '1', 23:10:20 INFO - 'NO_EM_RESTART': '1', 23:10:20 INFO - 'PAGER': '/bin/cat', 23:10:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:10:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:20 INFO - 'PWD': '/builds/slave/test', 23:10:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:10:20 INFO - 'SHELL': '/bin/bash', 23:10:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxdLmYrbca/Listeners', 23:10:20 INFO - 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/', 23:10:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:10:20 INFO - 'USER': 'cltbld', 23:10:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:10:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:10:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:20 INFO - 'XPC_FLAGS': '0x0', 23:10:20 INFO - 'XPC_SERVICE_NAME': '0', 23:10:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:10:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:10:20 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-5sJWWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:10:20 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)) 23:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:10:20 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-UvHWpO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:10:20 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)) 23:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:10:20 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-BF7eQJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:10:20 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)) 23:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:10:20 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-PFTDvJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:10:20 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)) 23:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:10:20 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-10tJwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:10:20 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)) 23:10:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:10:20 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-9l1sSo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:10:21 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)) 23:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:10:21 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-ocTANC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:10:21 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)) 23:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:10:21 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-9LDdRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:10:21 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)) 23:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:10:21 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-x_ohmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:10:21 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)) 23:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:10:21 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-sIZRki-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:10:21 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)) 23:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:10:21 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-3w4pdy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:10:21 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)) 23:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:10:21 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-rtWkTt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:10:21 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)) 23:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:10:21 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-5SZ_4z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:10:21 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)) 23:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:10:21 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-E_fxkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:10:21 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)) 23:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:10:21 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-T8favR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:10:21 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)) 23:10:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:10:21 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-vYqrOC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:10:22 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)) 23:10:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:10:22 INFO - Running setup.py (path:/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/pip-u_Yy_K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:10:22 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)) 23:10:22 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)) 23:10:22 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)) 23:10:22 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)) 23:10:22 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)) 23:10:22 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)) 23:10:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:10:22 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 23:10:22 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 23:10:22 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 23:10:22 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 23:10:22 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 23:10:22 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 23:10:24 INFO - Downloading blessings-1.6.tar.gz 23:10:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:10:24 INFO - Installing collected packages: blessings 23:10:24 INFO - Running setup.py install for blessings 23:10:25 INFO - Successfully installed blessings 23:10:25 INFO - Cleaning up... 23:10:25 INFO - Return code: 0 23:10:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:10:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:10:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:10:25 INFO - Reading from file tmpfile_stdout 23:10:25 INFO - Current package versions: 23:10:25 INFO - blessings == 1.6 23:10:25 INFO - blobuploader == 1.2.4 23:10:25 INFO - docopt == 0.6.1 23:10:25 INFO - functools32 == 3.2.3-2 23:10:25 INFO - jsonschema == 2.5.1 23:10:25 INFO - manifestparser == 1.1 23:10:25 INFO - mozInstall == 1.12 23:10:25 INFO - mozcrash == 1.0 23:10:25 INFO - mozdebug == 0.1 23:10:25 INFO - mozdevice == 0.49 23:10:25 INFO - mozfile == 1.2 23:10:25 INFO - mozhttpd == 0.7 23:10:25 INFO - mozinfo == 0.9 23:10:25 INFO - mozleak == 0.1 23:10:25 INFO - mozlog == 3.4 23:10:25 INFO - moznetwork == 0.27 23:10:25 INFO - mozprocess == 0.25 23:10:25 INFO - mozprofile == 0.28 23:10:25 INFO - mozrunner == 6.13 23:10:25 INFO - mozscreenshot == 0.1 23:10:25 INFO - mozsystemmonitor == 0.3 23:10:25 INFO - moztest == 0.8 23:10:25 INFO - mozversion == 1.4 23:10:25 INFO - psutil == 3.1.1 23:10:25 INFO - requests == 1.2.3 23:10:25 INFO - wsgiref == 0.1.2 23:10:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:10:25 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')]} 23:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:25 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')]} 23:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:25 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 0x10310eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103111768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb62348cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eecd30>, '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 0x102e13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ee1be8>, '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.zUMJEQAPIZ/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.yxdLmYrbca/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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 23:10:25 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 23:10:25 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 23:10:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zUMJEQAPIZ/Render', 23:10:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:10:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:10:25 INFO - 'HOME': '/Users/cltbld', 23:10:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:10:25 INFO - 'LOGNAME': 'cltbld', 23:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:25 INFO - 'MOZ_NO_REMOTE': '1', 23:10:25 INFO - 'NO_EM_RESTART': '1', 23:10:25 INFO - 'PAGER': '/bin/cat', 23:10:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:25 INFO - 'PWD': '/builds/slave/test', 23:10:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:10:25 INFO - 'SHELL': '/bin/bash', 23:10:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxdLmYrbca/Listeners', 23:10:25 INFO - 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/', 23:10:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:10:25 INFO - 'USER': 'cltbld', 23:10:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:10:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:25 INFO - 'XPC_FLAGS': '0x0', 23:10:25 INFO - 'XPC_SERVICE_NAME': '0', 23:10:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:10:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:25 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)) 23:10:25 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)) 23:10:25 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)) 23:10:25 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)) 23:10:25 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)) 23:10:25 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)) 23:10:25 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)) 23:10:25 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)) 23:10:25 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)) 23:10:25 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)) 23:10:25 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)) 23:10:25 INFO - Cleaning up... 23:10:25 INFO - Return code: 0 23:10:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:10:25 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')]} 23:10:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:10:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:25 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')]} 23:10:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:10:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:10:25 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 0x10310eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103111768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb62348cfb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102eecd30>, '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 0x102e13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ee1be8>, '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.zUMJEQAPIZ/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.yxdLmYrbca/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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 23:10:25 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 23:10:25 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 23:10:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zUMJEQAPIZ/Render', 23:10:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:10:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:10:25 INFO - 'HOME': '/Users/cltbld', 23:10:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:10:25 INFO - 'LOGNAME': 'cltbld', 23:10:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:25 INFO - 'MOZ_NO_REMOTE': '1', 23:10:25 INFO - 'NO_EM_RESTART': '1', 23:10:25 INFO - 'PAGER': '/bin/cat', 23:10:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:10:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:25 INFO - 'PWD': '/builds/slave/test', 23:10:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:10:25 INFO - 'SHELL': '/bin/bash', 23:10:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxdLmYrbca/Listeners', 23:10:25 INFO - 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/', 23:10:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:10:25 INFO - 'USER': 'cltbld', 23:10:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:10:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:10:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:25 INFO - 'XPC_FLAGS': '0x0', 23:10:25 INFO - 'XPC_SERVICE_NAME': '0', 23:10:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:10:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:10:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:10:26 INFO - Cleaning up... 23:10:26 INFO - Return code: 0 23:10:26 INFO - Running post-action listener: _resource_record_post_action 23:10:26 INFO - Running post-action listener: _start_resource_monitoring 23:10:26 INFO - Starting resource monitoring. 23:10:26 INFO - [mozharness: 2017-04-06 06:10:26.068627Z] Finished create-virtualenv step (success) 23:10:26 INFO - [mozharness: 2017-04-06 06:10:26.069575Z] Running install step. 23:10:26 INFO - Running pre-action listener: _resource_record_pre_action 23:10:26 INFO - Running main action method: install 23:10:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:10:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:10:26 INFO - Reading from file tmpfile_stdout 23:10:26 INFO - Detecting whether we're running mozinstall >=1.0... 23:10:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:10:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:10:26 INFO - Reading from file tmpfile_stdout 23:10:26 INFO - Output received: 23:10:26 INFO - Usage: mozinstall [options] installer 23:10:26 INFO - Options: 23:10:26 INFO - -h, --help show this help message and exit 23:10:26 INFO - -d DEST, --destination=DEST 23:10:26 INFO - Directory to install application into. [default: 23:10:26 INFO - "/builds/slave/test"] 23:10:26 INFO - --app=APP Application being installed. [default: firefox] 23:10:26 INFO - mkdir: /builds/slave/test/build/application 23:10:26 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'] 23:10:26 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 23:10:45 INFO - Reading from file tmpfile_stdout 23:10:45 INFO - Output received: 23:10:45 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 23:10:45 INFO - Running post-action listener: _resource_record_post_action 23:10:45 INFO - [mozharness: 2017-04-06 06:10:45.972477Z] Finished install step (success) 23:10:45 INFO - [mozharness: 2017-04-06 06:10:45.972595Z] Running run-tests step. 23:10:45 INFO - Running pre-action listener: _resource_record_pre_action 23:10:45 INFO - Running main action method: run_tests 23:10:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:10:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:10:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:10:45 INFO - 2017-04-05 23:10:45.987 screenresolution[1627:7664] starting screenresolution argv=screenresolution get 23:10:45 INFO - 2017-04-05 23:10:45.989 screenresolution[1627:7664] Display 0: 1600x1200x32@60 23:10:45 INFO - 2017-04-05 23:10:45.995 screenresolution[1628:7667] starting screenresolution argv=screenresolution list 23:10:45 INFO - Available Modes on Display 0 23:10:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:10:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:10:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:10:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:10:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:10:46 INFO - Intel Iris: 23:10:46 INFO - Chipset Model: Intel Iris 23:10:46 INFO - Type: GPU 23:10:46 INFO - Bus: Built-In 23:10:46 INFO - VRAM (Dynamic, Max): 1536 MB 23:10:46 INFO - Vendor: Intel (0x8086) 23:10:46 INFO - Device ID: 0x0a2e 23:10:46 INFO - Revision ID: 0x0009 23:10:46 INFO - Displays: 23:10:46 INFO - Display: 23:10:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:10:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:10:46 INFO - Display Serial Number: 1600x1200 60 23:10:46 INFO - Main Display: Yes 23:10:46 INFO - Mirror: Off 23:10:46 INFO - Online: Yes 23:10:46 INFO - Rotation: Supported 23:10:46 INFO - Return code: 0 23:10:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:10:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:10:46 INFO - Python 2.7.3 23:10:46 INFO - Return code: 0 23:10:46 INFO - grabbing minidump binary from tooltool 23:10:46 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')]} 23:10:46 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 0x102eecd30>, '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 0x102e13db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102ee1be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:10:46 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 23:10:46 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 23:10:46 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 23:10:46 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:10:46 INFO - Return code: 0 23:10:46 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 23:10:46 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:10:46 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:10:46 INFO - ENV: RUST_BACKTRACE is now 1 23:10:46 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 23:10:46 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:10:46 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/AA6IgIOpQrOXPnm6QBkTmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0347', '--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 23:10:46 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/AA6IgIOpQrOXPnm6QBkTmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0347 --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 23:10:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.zUMJEQAPIZ/Render', 23:10:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 23:10:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 23:10:46 INFO - 'HOME': '/Users/cltbld', 23:10:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 23:10:46 INFO - 'LOGNAME': 'cltbld', 23:10:46 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:10:46 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 23:10:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:10:46 INFO - 'MOZ_NO_REMOTE': '1', 23:10:46 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:10:46 INFO - 'NO_EM_RESTART': '1', 23:10:46 INFO - 'PAGER': '/bin/cat', 23:10:46 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 23:10:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:10:46 INFO - 'PWD': '/builds/slave/test', 23:10:46 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:10:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 23:10:46 INFO - 'RUST_BACKTRACE': '1', 23:10:46 INFO - 'SHELL': '/bin/bash', 23:10:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.yxdLmYrbca/Listeners', 23:10:46 INFO - 'TMPDIR': '/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/', 23:10:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 23:10:46 INFO - 'USER': 'cltbld', 23:10:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 23:10:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 23:10:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:10:46 INFO - 'XPC_FLAGS': '0x0', 23:10:46 INFO - 'XPC_SERVICE_NAME': '0', 23:10:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 23:10:46 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/AA6IgIOpQrOXPnm6QBkTmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0347', '--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 23:10:46 INFO - mozversion application_buildid: 20170405213646 23:10:46 INFO - mozversion application_changeset: ec8d1d3db50c85037e8077c32c8403570a5df493 23:10:46 INFO - mozversion application_display_name: Nightly 23:10:46 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:10:46 INFO - mozversion application_name: Firefox 23:10:46 INFO - mozversion application_remotingname: firefox 23:10:46 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 23:10:46 INFO - mozversion application_vendor: Mozilla 23:10:46 INFO - mozversion application_version: 55.0a1 23:10:46 INFO - mozversion platform_buildid: 20170405213646 23:10:46 INFO - mozversion platform_changeset: ec8d1d3db50c85037e8077c32c8403570a5df493 23:10:46 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 23:10:46 INFO - mozversion platform_version: 55.0a1 23:10:46 INFO - using testdate: 1491459046 23:10:46 INFO - actual date: 1491459046 23:10:46 INFO - starting webserver on 'localhost:49244' 23:10:46 INFO - SUITE-START | Running 2 tests 23:10:46 INFO - TEST-START | dromaeo_css 23:10:46 INFO - operating with platform_type : mac_ 23:10:46 INFO - Initialising browser for dromaeo_css test... 23:10:46 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/tmpACu8H1/profile http://localhost:49244/getInfo.html) 23:10:49 INFO - PID 1638 | __metrics Screen width/height:1600/1200 23:10:49 INFO - PID 1638 | colorDepth:24 23:10:49 INFO - PID 1638 | Browser inner width/height: 1024/689 23:10:49 INFO - PID 1638 | __metrics 23:10:49 INFO - PID 1638 | 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" 23:10:49 INFO - PID 1638 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:10:50 INFO - TEST-INFO | 1638: exit 0 23:10:50 INFO - Browser initialized. 23:10:50 INFO - Running cycle 1/1 for dromaeo_css test... 23:10:50 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/tmpACu8H1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:11:03 INFO - PID 1640 | RSS: Main: 239243264 23:11:03 INFO - PID 1640 | 23:14:08 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 23:14:11 INFO - PID 1640 | RSS: Main: 461008896 23:14:11 INFO - PID 1640 | 23:15:52 INFO - PID 1640 | ************************* 23:15:52 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 23:15:52 INFO - PID 1640 | 23:15:52 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 23:15:52 INFO - PID 1640 | Full stack: 23:15:52 INFO - PID 1640 | ************************* 23:15:52 INFO - PID 1640 | ************************* 23:15:52 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 23:15:52 INFO - PID 1640 | 23:15:52 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 23:15:52 INFO - PID 1640 | Full stack: 23:15:52 INFO - PID 1640 | ************************* 23:15:52 INFO - PID 1640 | ************************* 23:15:52 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 23:15:52 INFO - PID 1640 | 23:15:52 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 23:15:52 INFO - PID 1640 | Full stack: 23:15:52 INFO - PID 1640 | ************************* 23:15:52 INFO - PID 1640 | ************************* 23:15:52 INFO - PID 1640 | A coding exception was thrown and uncaught in a Task. 23:15:52 INFO - PID 1640 | 23:15:52 ERROR - PID 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 23:15:52 INFO - PID 1640 | Full stack: 23:15:52 INFO - PID 1640 | ************************* 23:17:13 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 23:17:14 INFO - PID 1640 | RSS: Main: 369778688 23:17:14 INFO - PID 1640 | 23:20:16 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 23:20:17 INFO - PID 1640 | RSS: Main: 344281088 23:20:17 INFO - PID 1640 | 23:23:19 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 23:23:20 INFO - PID 1640 | RSS: Main: 351887360 23:23:20 INFO - PID 1640 | 23:26:24 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 23:26:24 INFO - PID 1640 | RSS: Main: 330268672 23:26:24 INFO - PID 1640 | 23:29:27 INFO - PID 1640 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 23:29:28 INFO - PID 1640 | RSS: Main: 410181632 23:29:28 INFO - PID 1640 | 23:29:28 INFO - PID 1640 | __start_tp_report 23:29:28 INFO - PID 1640 | _x_x_mozilla_page_load 23:29:28 INFO - PID 1640 | _x_x_mozilla_page_load_details 23:29:28 INFO - PID 1640 | |i|pagename|runs| 23:29:28 INFO - PID 1640 | |0;dojo.html;3210.4542227821266;3459.08334291413;3466.7919924804496;3494.825258737064;3542.415501442262;5676.205331253617;5860.824175274738;6006.159137720711;6163.845903852406;6170.290416602092;6049.879002419949;6093.634381937087;6140.320203811479;6151.41561551653;6174.444300012998;5134.358205224347;5290.127129023706;5293.947060529403;5302.337207849019;5352.170413585901;5328.973355133238;5381.48875856793;5383.892322153554;5386.569074474052;5427.348718153827;5181.326427564392;5261.263423120766;5270.39390470097;5283.445238250005;5333.813316533922;5254.947450525522;5265;5273.920891186597;5278.313819203518;5293.708846013467;4559.768862407132;5046.268291097807;5183.067047931371;5251.50110739483;5264.631475796696;5944.583879128462;5948.881022379572;5968.850778730523;5979;5992.34084250732;5611.298587676541;6147.446729794296;6319.4312511873695;6334.208223972004;6348.492120630339;6346.650934198663;6387.968060159716;6408.67956602168;6420.5505614607;6536.379043990813;6219.036049412348;6247.375262473762;6281.309056003836;6283.2460104787715;6283.8743225135695;6689.866202676017;6704.497162712816;6707.993800929899;6709.127813384326;6735.764248251287;6247.750089996349;6375.171227740364;6381.680915954184;6416.582922110141;6420.229572451336;6395.808125756234;6408.903866442007;6454.741810327534;6514.185726784152;6545.378189072126;6413;6418.807435776934;6428.4214420702365;6437.967810160919;6445.677716114175;6401.967990160019;6428.003659432796;6428.678566071678;6432.324605916405;6443.162388889508;5132.897342053138;5171.68969861802;5197.948020519746;5207.6875387476875;5249.317588713443;4601.608863246594;4647.488776234679;4690.319903614025;4733.9763301183275;4734.100520901018;6072.878542429126;6092.085047331085;6104.769568543233;6115.149072927094;6142.78500252489;6374.840628984312;6396.808095757135;6396.840078998062;6416.967915160394;6495.772647957298;6122.663253521099;6153.907691384633;6159.969200153971;6166.445019948226;6174.845628859314;5708.001099807517;5714.971425142848;5718.714064296769;5726.226959360516;5747.1379293106365;6538.313477084837;6545.607263564201;6670.699818508082;6678.532502724763;6688.331166883273;5472.91790623133;6361.395667411589;6516.152900123143;6531.11829902976;6535.803925882231;6712.93287067123;6714.563553369016;6729.528932974645;6738.46092312604;6738.460923126237;6437.5171862111465;6440.29156792743;6443.162388889415;6446;6455.515836312389;6360.204974378203;6373.362663733589;6397.424231819158;6448.322926092693;6463.289038205699;6371.331010243857;6376.234851817811;6389.9361006389345;6396.42432181106;6397.360263973565;6217.502599792097;6333.96833015832;6334.461570766536;6412.487001039813;6425.06836508713;6157.353477884758;6260.968695156495;6371.617702937839;6380.234371875219;6387.489000879826;5918.023526118142;6304.18045654062;6350.079238510298;6377.617342959437;6382.170317858649;6317.778877739257;6334.588251763621;6344.873102537831;6345;6345.397187267202 23:29:28 INFO - PID 1640 | |1;ext.html;804.7786858613882;821.084490792766;1142.4002398740665;1162.4652659776502;1164.4759858063874;36078.278434431326;36676.26647467053;36703.81648091762;36745.81627091861;37254;38167.427488587695;38549.4580216791;38587.22825543487;38706.61293387065;38749.80625096871;6154.169187159743;8461.957690211555;8601.182887625666;8630.956845215796;8631.266342360906;6201.596896201732;6284.465820405271;6285.9685701571425;6289.1509646197865;8402.495850248974;8590.570471476432;8660.13398660132;8662.913370866305;8680.479171249714;8693.7826554336;8567.571621418936;8626.266767324816;8642.265407440374;8643.65425382984;8665.136995545989;8405.453645513022;8445.83108337836;8458.238758511701;8466.78833029173;8468.957655211747;36628.08429789277;36918.815405923066;36935.89192324234;36940.26119477622;37055.62944370549;3066.4940284853196;3356.8825091121694;3374.7637665363436;3398.8130652814084;3399.55805745254;29630.555541666894;29704.70295297041;29725;29745.405091898258;29778.85110574455;2866.7706583473273;2911.3595009098176;2927.1072322941495;2935.6770755216908;2945.5876177334976;231774;278893.56043373595;282646;283208;284075;38430.84707458781;38495;39055.80472097678;47783.283250751265;47922.041559169316;48216.5178348212;48419.75790121097;48991;49017;49172.75413622909;14040.719185616435;14173.291335433187;14204;14204.289785510684;14242.931780116533;11548.422578871023;11567.537298507965;11578.47896844644;11581.726010138878;11603.129765267639;9703.708888733348;9841.901580984242;11891.227070240408;11969.64091077269;12091.274523528617;5389.649672771257;5413.323334583177;5436.673799572039;5443.265159203536;5450.182472629137;960.6493629825203;965.4448692002127;974.878140232471;982.3565564555228;990.3810118675827;26891.462170756477;27475.900963961216;27899.581506277424;28008.579871301947;28347.149585512467;896.6592694776074;1037.699067270483;1055.5672174408455;1084.9403282819521;1087.1465899269035;11725.765484690259;14078.436862525588;14793.482228121964;14953.476628317956;15302.693946121015;341072;341304.293478536;342063;342647;343453;50864.23703644448;50964.490355096714;50978.49021509737;50980;51316.48683513192;1412.173878281217;1453.4331610671636;1500.5873384819045;1502.0912348029503;1514.6364872430759;21684.097399819042;26381.34046648849;27117.72882271231;27324.180274591796;27376.58935115935;36091;36186.09534761652;36233.81883090568;36332.45501317535;36338.63661363353;297255;298084;299017;299224;299395;29205.90721495648;29545.704542955154;30005.69994300029;30031.69968300289;30035.249118772204;37294.81352593219;37527.43708844315;38298.80850595729;38650;38838.2232355357;27107.45785084248;27286.590701139896;27815.304617383918;27933.301667458476;28064.877404904393;27290.04103953479;27750.167494975183;27952.02167924113;28023.659187900706;28543.571846421906;34160.31679366448;34825.82587087048;34827.129321767155;34914.47628285527;35203.94388168359;29489.705102949552;29900.888145192395;30049.098527044225;30092.93745344438;30273.545896812007;20940;20994.895025525384;23222.82435447821;23307.41731456659;23710.170144044874 23:29:28 INFO - PID 1640 | |2;jquery.html;399.7201958628959;401.31393153881584;429.4481591155364;432.90476095259044;439.4858016121139;15006.474773382934;20583.38249852505;20787.168513259472;21058.473538161554;22002.559948801016;22400.55198896021;22868.19961301355;23547.646785298235;23652.408689782766;23753.5249295014;5245.554127899133;7042.366187043165;7238.855222895539;7259.564426134449;7272.454565907552;6826.419754320888;7121.145462544502;7141.857442767175;7164;7169.713211471561;7012.544184628008;7086.751963681272;7098.290170982912;7106.147262328528;7111.644417779116;4780.95219047812;6866.725330986755;6907.240203577602;7091.929080709204;7108.969199466074;6502.642354670491;6782.423494003016;6793.524453288272;6802.387785099315;6816.693248803816;28026.95514807334;28516.429671406662;28757.712422875713;28888.711112888814;29342.706572934425;2228.7882651148116;2299.275728145629;2305.1240528599023;2307.111761971636;2311.66480860276;17893.642127157513;18312.725309120375;18437.815621843878;18534.165962531584;18737.969411682352;1693.2718930859726;2194.9451263718374;2269.853723869452;2287.714035745532;2291.278247352079;140075;157217;158805;161556;164264.9999999988;16942.322307107577;19268.4219473416;21405.571888562143;22880.88559557225;23317.533649326917;40719.796401017804;41054.794726026776;41196.79401602973;41260.1747965039;41312.58687413087;10735;11055.0603198729;11105.500252488657;11150.442477876073;11263.26788758728;8821.558922053871;8825.338099642553;8865.734027979172;9012.369134160546;9019.909800902038;10713.250072494851;11023.44882755859;11078.889211107948;11153;11200.38397888124;3614.801185934799;3812.0279328770985;4391.978040109779;4434.82260709568;4466.749310193151;891.6149300620814;912.885889263842;915.7390143808982;936.9953150234205;949.2216382566368;15082.698346033018;19390.2243910242;19447.61104777925;20260.696089558667;20614;935.5462600638684;955.1356022799378;968.5012218707371;972.2659392158874;977.3012296208245;7995.160508146677;9743.661521234853;9943.204543636637;9950.303478756417;9967.700968970943;643655;663178;672237;681911;693344;150012;152777;152828;153658;155499;971.8493633486679;1134.3364131982883;1166.5158959031908;1168.0597119318859;1205.9457324420598;20258.837974215952;21838.454038648524;21856.89071554632;21953.890230548746;21996.120155193614;63813.04280435704;64622.67688661526;64809.35190648033;65000;65137.674311628136;79238;82966;83205;83304.25479795766;84239.57880210559;8448.107526775217;8628.101817600118;8701.564921753761;8744.956275218583;8818.647254110021;13079.869201307865;13338.466461341437;13344.266065366499;13759.518416855362;13778.65553361174;11462.656120316404;11477.598284060017;11644.767104658029;11859.822102668639;11892.345920974429;10757.977992090739;10792.136629069813;10962.123030157409;10984.588785882455;11140.665780026613;11885.82171267449;12033.819492707442;12076.818847717115;12120.393980300772;12160.027197823976;8627.611757471055;8674.696385626472;8699.086595907338;8768.561571921506;8926;10187.898121018696;11268.887311126784;11483.023942964941;11890.405479726152;11992.64022079339 23:29:28 INFO - PID 1640 | |3;mootools.html;1355.8711922367374;1428.9071210371326;1436.5115860607398;1445.2556933179412;1459.5767227504025;8950.910490895089;11349.43252837358;11370.60202892899;11372.203945723802;11378.146639002087;10968.17738669599;11130.332180069201;11242.325460472357;11373.886261137386;11426.42867856608;2381.6070348392495;2417.7703118203744;2423.103451722865;2426.599611064172;2431.4043059450373;2345.6598793175067;2484.85090894546;2511.6860392450944;2514.2205916165954;2515.0442831723917;2077.5429405530836;2112.725345705056;2199.0104452996134;2202.41635966469;2397.244867866625;2471.4933438645126;2500.949981000388;2500.9746004138397;2502.274340441279;2503.3866702657783;2443.2914454808083;2484.763947424992;2485.7141428735745;2489.3403248139257;2495.851908122248;11190.992810647082;11451.25566838153;11460.541578336857;11469.483873225725;11486.827697584544;6413.647249401281;6632.93367066328;6654.567453115532;6654.966725166391;6670.899936500957;3833.6039975015615;3996.8800935971967;4104.343305071204;4174.853880114181;4177.436046133764;1164.4236103128922;1175.2243519277235;1191.7973944429382;1219.5365761010848;1223.8103094020441;15665.921670391688;15807.446739364183;15822.762658560016;15822.920885395615;15840;5191.377034755854;5363.624546281723;5581.441855814386;5581.720913954286;5620.606557540933;11825.349605771593;11866.228695134789;11876.10929180315;11876.228045177037;11912.761744765055;5578.163275508625;6462.3537646235;6467.967660161669;6469.482441404676;6471.838204044842;5846.649201047951;5894.2926848778425;6116.724747386378;6197.597156184924;6200.720967556471;3443.104792753902;4155.794819502371;4284.592963668447;4348.130373925164;4395.934060989088;1065.0999905080196;1223.1437993404652;1274.7705413025558;1296.3453456004845;1298.214580178997;714.8641758065951;736.8636802191612;760.4220792197859;769.7844603511026;796.8725003999448;5849.473547380756;5943.494802941712;6089.421504957022;6146.416090471487;6223.502119830403;569.6525119676994;589.3634874335708;598.1924402057188;603.2308806272039;604.9866473656607;3617.8733744318824;3761.39817629178;3836.405357169643;3853.2678791029616;3862.8647997320522;13954.441822327197;14753.262336883114;14802.185879776716;14814.703705925822;14830.480933167288;13962.301884905713;14227.004109712221;14692.412303507954;14720.779188312184;14750.483733069292;8759.467093258654;10302.845457318146;10358.431632668202;10464.686059418229;10481.004304591052;6498.480121590167;6669.966650166718;6711.0940023096255;6906.240313565403;6921.342472465108;11445.969862712063;12562.685932851386;13025.023123265604;13104.606861794162;13124.540641077516;13242.933785331012;13348.199108053548;13471.797923030967;13568.321583920962;13747.38136783867;9153.313501487282;9292.117248861347;9298.814023719353;9401.576929038072;9421.670241541513;10257.384556926609;10333.84499232497;10491.422971736627;10494.370337779757;10509.9474502627;6968.442524598121;8724.258438032839;8726.82546349082;8979.191872731486;8986.056464071178;7045.542039767399;8516.914830851612;8690.522021288889;8700.173483519056;8710.782230444036;7878.212178782076;7905.249001344863;7965.004374453193;7981.8802717958115;8015.238552337519;5924.4667979882015;5948.791792287249;6040.244969378828;6070.514358851369;6126.479249263863;5857.7949771757785;6009.90985135232;6146.631202127886;6165.691715414301;6255.499560035278 23:29:28 INFO - PID 1640 | |4;prototype.html;368.5761374419418;383.89826695925586;405.18153330272867;406.10048742036383;406.48985523168403;5949.37531559186;5970.253718285215;5978.491828194608;5983.700814959251;5996.940030599692;4533.8413155539565;5112.7473768926575;5533.778648854051;5615;5845.252731216321;3498.265364273506;4257.829686812539;4261.616454519092;4264.6801489888385;4270.124624451995;4267.381229721688;4280.122574872159;4280.865570623787;4290.806913688892;4297.59172878576;3330.916727081818;4212.115455754295;4257.489101307832;4275.209086319041;4285.528591854893;3872.605861889703;3899.6685281751083;4244.957550424487;4254.404383386328;4261.76560289184;3323.3685599735973;3668.321360548307;3722.758020728644;3730.0674831292176;3732.5707543632557;5472.671639701591;5639.041362968305;5652.802151924663;5655.8586035349035;5668.31980162379;4422.6240769534625;4868.880157563744;5006.5744411725045;5081.568066714297;5124.333836601218;5645.32256129263;5785.537157027427;6149.2620885494025;6160.260768707739;6172.814815555541;3669.321175582526;4176.4570605821045;4208.957910420887;4234.809433575466;4245.1934132514725;6260.749570017194;6316.715747791314;6329.8734025320155;6527.15147030883;6554.836129096763;4152.065785198306;4157.711109556048;4159.563245859202;4160.105577300895;4162.211318416668;3767.3972164453558;4145.595554578397;4343;4352.608265256142;4356.106998065389;4538.29656403258;4581.862544123682;4695.140529551897;4940.530649588283;5073.543381095719;4724.858254252378;6257.749690012349;6272.874542509125;6289.7169627366875;6290.232297788958;1465.5969608357573;1475.638468575206;1476.2323591732238;1480.9185494797673;1482.2366481262159;926.3885835348638;984.0995489127369;988.17981075707;991.7718924647371;995.3381001633977;4866.391701037371;5863.5309175265875;5890.4993075589055;5904.793332233351;5915.260592425947;5508.980838544882;5729.71081506666;6439.710213040425;6478.643674597943;6510.25132109804;5185.714785686823;5514.5864060195645;5603.635763675348;5635.633683810539;5858.56060795442;2969.777266705006;3006.7895247332913;3209.422303985258;3368.898933032013;3390.1355154435955;6337.429631333202;6623.271440141581;6635.037919501645;6655.966720166368;6706.631135287508;6650.235222949423;6651.966740166268;6663.233728121231;6665.300143484961;6666.166729158856;6003.039513677878;6146.631202127886;6372;6649.966750166218;6663.566868153457;5978.834127345126;6138.754449821957;6408.391202835724;6467.41793238592;6475.611463312216;5565.5825813063375;6403.935960640334;6408.93591064102;6409.308090601865;6421.743130274736;5698.0512608243935;6013.707052983629;6314.273858506331;6464.22429308486;6639.302873198245;4226.640735537514;4273.893152671208;4286.207051695446;4287.97856010718;4293.849715260076;5598.804041858515;5955.642661440327;6235.781747638993;6493.480521558169;6494.707738151889;5409.648372855751;5464.388005538296;6117.510599152146;6196.349383314687;6230.504678877128;5372.1941708744;6216.347283535345;6233.096201050913;6272.428304395176;6297.905531417124;5834.299884013776;6057.57596968208;6127.571070025056;6145.955187618027;6192.969035154975;5411.567074634098;6268.341824108586;6269.899583639532;6320.62076275425;6327.145835312174;4600.102979918884;4888.388951381077;5017.448080711192;5589.385167631639;6091.786787462417 23:29:28 INFO - PID 1640 | |5;yui.html;807.903051633804;815.2703330519186;832.2426591801462;832.4797001873828;838.5932822581049;15816.288267027983;16158.515244542654;16203.756943645854;16224.10767407792;16247.756283655739;13709.862901370983;14450.277486125678;14996.325165367558;15158.242087895616;15196.620084497894;934.4113208678523;969.5152423788106;972.4311277902435;975.1759763000254;977.2475194100539;1005.4319309590059;1009.0212493880961;1009.0766948242349;1010.9393436393804;1012.0688966151122;1053.4574694032578;1053.7102296868384;1055.3615062886959;1056.1445229364201;1058.0794708603487;1051.2431049644244;1051.51104736298;1052.2213561964168;1052.5789684126373;1054.3199636234624;783.5455435847194;786.535943793159;787.1852632525366;787.4723934963588;787.5747096567846;16030.519084427486;16504.75242871358;16716.498505044867;16734.24695888688;16736.58158546034;14777;14866.033707809065;14885.776713349309;14919.925400373037;15107.848921510864;13311.733765324736;13408.798868016987;13429.194248345033;13452.192868427828;13482.460701571925;3330.217398911254;3330.9833450832834;3331.217163966466;3359.5968483781858;3360.2439451123546;119831;121018.78981210163;121806;123136;123951.3802430991;7688.884666730003;11395.658130256106;11592.768144637228;11715.882841171479;12026.27842329463;24166.39584010414;24422.755772442404;24850.751492484844;24862.254132376056;24930;7997.040355157418;8011.639476223584;8053.315468185153;8158.918410815934;8162.3878209134555;4148.647364974011;4156.147989662112;4163.607136478205;4236.76697781625;4238.978805105955;4128.545859955402;4190.979045104755;4228.471441069866;4228.682848786353;4231.492220933507;799.6361655446758;894.0924961164424;919.3288899103692;930.4277869110448;947.1806887042796;584.6170758153417;594.313567829158;606.1392822192497;621.6425555305627;640.9647469389229;8672.60973256205;9842.75393115178;10124.088832005154;10216.387016779017;10373.377597344184;551.302602208207;578.1732123064058;601.5638661970124;635.2186810223451;640.8750293692685;4017.134226359956;4522;4526.23054080807;4545.181867263925;4711;98063.50968245113;100138;100472.49291260637;101892;102853;87923;88164;90054.54972725094;90407.55417585802;91281.41545137666;69054;69409.30590694028;69849.65075174693;70046.9492957606;70402.2959770406;8822.602982865916;8877.357688827587;9318.72043838686;9348.158665720119;9484.116142172381;38497.80751096339;38684.6131538681;39087.60912390953;39290.01774955649;40002;41996.580034199265;44593.77703111464;51311.74344128255;52415.47584524106;52862.73568632132;13438.193708377528;13695.657608559866;13725.519606813714;14056.156630602196;14110.490231046548;13834.65413364674;13849.584512464642;13952.720945581235;13987.463501649261;14124.223167725462;12611.807242079693;12711.237325760483;13084.35286542199;13362.465501379836;13603.727925441633;12849.164804287691;13014.883356709886;13178.406971686489;13197.736045278849;13230.603081907559;11267.323960562393;12886.29125398112;13489.463697193805;13579.728405431639;13733.45066197341;9085.36402451822;9341.392809467634;9691.920073839512;9710.563024664048;10134.797304054026;10368.896311037095;10744.892551074388;10805.945970270413;10960.28758130719;10998.560057597606 23:29:28 INFO - PID 1640 | __end_tp_report 23:29:28 INFO - PID 1640 | __start_cc_report 23:29:28 INFO - PID 1640 | _x_x_mozilla_cycle_collect,2249 23:29:28 INFO - PID 1640 | __end_cc_report 23:29:28 INFO - PID 1640 | __startTimestamp1491460168255__endTimestamp 23:29:28 INFO - PID 1640 | 23:29:28 INFO - PID 1640 | ------- Summary: start ------- 23:29:28 INFO - PID 1640 | Number of tests: 6 23:29:28 INFO - PID 1640 | 23:29:28 INFO - PID 1640 | [#0] dojo.html Cycles:165 Average:5981.68 Median:6283.87 stddev:697.74 (11.1%) stddev-sans-first:665.15 23:29:28 INFO - PID 1640 | Values: 3210.5 3459.1 3466.8 3494.8 3542.4 5676.2 5860.8 6006.2 6163.8 6170.3 6049.9 6093.6 6140.3 6151.4 6174.4 5134.4 5290.1 5293.9 5302.3 5352.2 5329.0 5381.5 5383.9 5386.6 5427.3 5181.3 5261.3 5270.4 5283.4 5333.8 5254.9 5265.0 5273.9 5278.3 5293.7 4559.8 5046.3 5183.1 5251.5 5264.6 5944.6 5948.9 5968.9 5979.0 5992.3 5611.3 6147.4 6319.4 6334.2 6348.5 6346.7 6388.0 6408.7 6420.6 6536.4 6219.0 6247.4 6281.3 6283.2 6283.9 6689.9 6704.5 6708.0 6709.1 6735.8 6247.8 6375.2 6381.7 6416.6 6420.2 6395.8 6408.9 6454.7 6514.2 6545.4 6413.0 6418.8 6428.4 6438.0 6445.7 6402.0 6428.0 6428.7 6432.3 6443.2 5132.9 5171.7 5197.9 5207.7 5249.3 4601.6 4647.5 4690.3 4734.0 4734.1 6072.9 6092.1 6104.8 6115.1 6142.8 6374.8 6396.8 6396.8 6417.0 6495.8 6122.7 6153.9 6160.0 6166.4 6174.8 5708.0 5715.0 5718.7 5726.2 5747.1 6538.3 6545.6 6670.7 6678.5 6688.3 5472.9 6361.4 6516.2 6531.1 6535.8 6712.9 6714.6 6729.5 6738.5 6738.5 6437.5 6440.3 6443.2 6446.0 6455.5 6360.2 6373.4 6397.4 6448.3 6463.3 6371.3 6376.2 6389.9 6396.4 6397.4 6217.5 6334.0 6334.5 6412.5 6425.1 6157.4 6261.0 6371.6 6380.2 6387.5 5918.0 6304.2 6350.1 6377.6 6382.2 6317.8 6334.6 6344.9 6345.0 6345.4 23:29:28 INFO - PID 1640 | 23:29:28 INFO - PID 1640 | [#1] ext.html Cycles:180 Average:44585.28 Median:341188.15 stddev:80374.81 (23.6%) stddev-sans-first:80533.07 23:29:28 INFO - PID 1640 | Values: 804.8 821.1 1142.4 1162.5 1164.5 36078.3 36676.3 36703.8 36745.8 37254.0 38167.4 38549.5 38587.2 38706.6 38749.8 6154.2 8462.0 8601.2 8631.0 8631.3 6201.6 6284.5 6286.0 6289.2 8402.5 8590.6 8660.1 8662.9 8680.5 8693.8 8567.6 8626.3 8642.3 8643.7 8665.1 8405.5 8445.8 8458.2 8466.8 8469.0 36628.1 36918.8 36935.9 36940.3 37055.6 3066.5 3356.9 3374.8 3398.8 3399.6 29630.6 29704.7 29725.0 29745.4 29778.9 2866.8 2911.4 2927.1 2935.7 2945.6 231774.0 278893.6 282646.0 283208.0 284075.0 38430.8 38495.0 39055.8 47783.3 47922.0 48216.5 48419.8 48991.0 49017.0 49172.8 14040.7 14173.3 14204.0 14204.3 14242.9 11548.4 11567.5 11578.5 11581.7 11603.1 9703.7 9841.9 11891.2 11969.6 12091.3 5389.6 5413.3 5436.7 5443.3 5450.2 960.6 965.4 974.9 982.4 990.4 26891.5 27475.9 27899.6 28008.6 28347.1 896.7 1037.7 1055.6 1084.9 1087.1 11725.8 14078.4 14793.5 14953.5 15302.7 341072.0 341304.3 342063.0 342647.0 343453.0 50864.2 50964.5 50978.5 50980.0 51316.5 1412.2 1453.4 1500.6 1502.1 1514.6 21684.1 26381.3 27117.7 27324.2 27376.6 36091.0 36186.1 36233.8 36332.5 36338.6 297255.0 298084.0 299017.0 299224.0 299395.0 29205.9 29545.7 30005.7 30031.7 30035.2 37294.8 37527.4 38298.8 38650.0 38838.2 27107.5 27286.6 27815.3 27933.3 28064.9 27290.0 27750.2 27952.0 28023.7 28543.6 34160.3 34825.8 34827.1 34914.5 35203.9 29489.7 29900.9 30049.1 30092.9 30273.5 20940.0 20994.9 23222.8 23307.4 23710.2 23:29:28 INFO - PID 1640 | 23:29:28 INFO - PID 1640 | [#2] jquery.html Cycles:180 Average:41216.56 Median:28637.07 stddev:112702.76 (393.6%) stddev-sans-first:112977.25 23:29:28 INFO - PID 1640 | Values: 399.7 401.3 429.4 432.9 439.5 15006.5 20583.4 20787.2 21058.5 22002.6 22400.6 22868.2 23547.6 23652.4 23753.5 5245.6 7042.4 7238.9 7259.6 7272.5 6826.4 7121.1 7141.9 7164.0 7169.7 7012.5 7086.8 7098.3 7106.1 7111.6 4781.0 6866.7 6907.2 7091.9 7109.0 6502.6 6782.4 6793.5 6802.4 6816.7 28027.0 28516.4 28757.7 28888.7 29342.7 2228.8 2299.3 2305.1 2307.1 2311.7 17893.6 18312.7 18437.8 18534.2 18738.0 1693.3 2194.9 2269.9 2287.7 2291.3 140075.0 157217.0 158805.0 161556.0 164265.0 16942.3 19268.4 21405.6 22880.9 23317.5 40719.8 41054.8 41196.8 41260.2 41312.6 10735.0 11055.1 11105.5 11150.4 11263.3 8821.6 8825.3 8865.7 9012.4 9019.9 10713.3 11023.4 11078.9 11153.0 11200.4 3614.8 3812.0 4392.0 4434.8 4466.7 891.6 912.9 915.7 937.0 949.2 15082.7 19390.2 19447.6 20260.7 20614.0 935.5 955.1 968.5 972.3 977.3 7995.2 9743.7 9943.2 9950.3 9967.7 643655.0 663178.0 672237.0 681911.0 693344.0 150012.0 152777.0 152828.0 153658.0 155499.0 971.8 1134.3 1166.5 1168.1 1205.9 20258.8 21838.5 21856.9 21953.9 21996.1 63813.0 64622.7 64809.4 65000.0 65137.7 79238.0 82966.0 83205.0 83304.3 84239.6 8448.1 8628.1 8701.6 8745.0 8818.6 13079.9 13338.5 13344.3 13759.5 13778.7 11462.7 11477.6 11644.8 11859.8 11892.3 10758.0 10792.1 10962.1 10984.6 11140.7 11885.8 12033.8 12076.8 12120.4 12160.0 8627.6 8674.7 8699.1 8768.6 8926.0 10187.9 11268.9 11483.0 11890.4 11992.6 23:29:28 INFO - PID 1640 | 23:29:28 INFO - PID 1640 | [#3] mootools.html Cycles:180 Average:6931.37 Median:2512.95 stddev:4400.84 (175.1%) stddev-sans-first:4393.24 23:29:28 INFO - PID 1640 | Values: 1355.9 1428.9 1436.5 1445.3 1459.6 8950.9 11349.4 11370.6 11372.2 11378.1 10968.2 11130.3 11242.3 11373.9 11426.4 2381.6 2417.8 2423.1 2426.6 2431.4 2345.7 2484.9 2511.7 2514.2 2515.0 2077.5 2112.7 2199.0 2202.4 2397.2 2471.5 2500.9 2501.0 2502.3 2503.4 2443.3 2484.8 2485.7 2489.3 2495.9 11191.0 11451.3 11460.5 11469.5 11486.8 6413.6 6632.9 6654.6 6655.0 6670.9 3833.6 3996.9 4104.3 4174.9 4177.4 1164.4 1175.2 1191.8 1219.5 1223.8 15665.9 15807.4 15822.8 15822.9 15840.0 5191.4 5363.6 5581.4 5581.7 5620.6 11825.3 11866.2 11876.1 11876.2 11912.8 5578.2 6462.4 6468.0 6469.5 6471.8 5846.6 5894.3 6116.7 6197.6 6200.7 3443.1 4155.8 4284.6 4348.1 4395.9 1065.1 1223.1 1274.8 1296.3 1298.2 714.9 736.9 760.4 769.8 796.9 5849.5 5943.5 6089.4 6146.4 6223.5 569.7 589.4 598.2 603.2 605.0 3617.9 3761.4 3836.4 3853.3 3862.9 13954.4 14753.3 14802.2 14814.7 14830.5 13962.3 14227.0 14692.4 14720.8 14750.5 8759.5 10302.8 10358.4 10464.7 10481.0 6498.5 6670.0 6711.1 6906.2 6921.3 11446.0 12562.7 13025.0 13104.6 13124.5 13242.9 13348.2 13471.8 13568.3 13747.4 9153.3 9292.1 9298.8 9401.6 9421.7 10257.4 10333.8 10491.4 10494.4 10509.9 6968.4 8724.3 8726.8 8979.2 8986.1 7045.5 8516.9 8690.5 8700.2 8710.8 7878.2 7905.2 7965.0 7981.9 8015.2 5924.5 5948.8 6040.2 6070.5 6126.5 5857.8 6009.9 6146.6 6165.7 6255.5 23:29:28 INFO - PID 1640 | 23:29:28 INFO - PID 1640 | [#4] prototype.html Cycles:180 Average:4978.32 Median:5625.32 stddev:1571.30 (27.9%) stddev-sans-first:1537.14 23:29:28 INFO - PID 1640 | Values: 368.6 383.9 405.2 406.1 406.5 5949.4 5970.3 5978.5 5983.7 5996.9 4533.8 5112.7 5533.8 5615.0 5845.3 3498.3 4257.8 4261.6 4264.7 4270.1 4267.4 4280.1 4280.9 4290.8 4297.6 3330.9 4212.1 4257.5 4275.2 4285.5 3872.6 3899.7 4245.0 4254.4 4261.8 3323.4 3668.3 3722.8 3730.1 3732.6 5472.7 5639.0 5652.8 5655.9 5668.3 4422.6 4868.9 5006.6 5081.6 5124.3 5645.3 5785.5 6149.3 6160.3 6172.8 3669.3 4176.5 4209.0 4234.8 4245.2 6260.7 6316.7 6329.9 6527.2 6554.8 4152.1 4157.7 4159.6 4160.1 4162.2 3767.4 4145.6 4343.0 4352.6 4356.1 4538.3 4581.9 4695.1 4940.5 5073.5 4724.9 6257.7 6272.9 6289.7 6290.2 1465.6 1475.6 1476.2 1480.9 1482.2 926.4 984.1 988.2 991.8 995.3 4866.4 5863.5 5890.5 5904.8 5915.3 5509.0 5729.7 6439.7 6478.6 6510.3 5185.7 5514.6 5603.6 5635.6 5858.6 2969.8 3006.8 3209.4 3368.9 3390.1 6337.4 6623.3 6635.0 6656.0 6706.6 6650.2 6652.0 6663.2 6665.3 6666.2 6003.0 6146.6 6372.0 6650.0 6663.6 5978.8 6138.8 6408.4 6467.4 6475.6 5565.6 6403.9 6408.9 6409.3 6421.7 5698.1 6013.7 6314.3 6464.2 6639.3 4226.6 4273.9 4286.2 4288.0 4293.8 5598.8 5955.6 6235.8 6493.5 6494.7 5409.6 5464.4 6117.5 6196.3 6230.5 5372.2 6216.3 6233.1 6272.4 6297.9 5834.3 6057.6 6127.6 6146.0 6193.0 5411.6 6268.3 6269.9 6320.6 6327.1 4600.1 4888.4 5017.4 5589.4 6091.8 23:29:28 INFO - PID 1640 | 23:29:28 INFO - PID 1640 | [#5] yui.html Cycles:180 Average:19980.89 Median:24896.13 stddev:29309.18 (117.7%) stddev-sans-first:29356.04 23:29:28 INFO - PID 1640 | Values: 807.9 815.3 832.2 832.5 838.6 15816.3 16158.5 16203.8 16224.1 16247.8 13709.9 14450.3 14996.3 15158.2 15196.6 934.4 969.5 972.4 975.2 977.2 1005.4 1009.0 1009.1 1010.9 1012.1 1053.5 1053.7 1055.4 1056.1 1058.1 1051.2 1051.5 1052.2 1052.6 1054.3 783.5 786.5 787.2 787.5 787.6 16030.5 16504.8 16716.5 16734.2 16736.6 14777.0 14866.0 14885.8 14919.9 15107.8 13311.7 13408.8 13429.2 13452.2 13482.5 3330.2 3331.0 3331.2 3359.6 3360.2 119831.0 121018.8 121806.0 123136.0 123951.4 7688.9 11395.7 11592.8 11715.9 12026.3 24166.4 24422.8 24850.8 24862.3 24930.0 7997.0 8011.6 8053.3 8158.9 8162.4 4148.6 4156.1 4163.6 4236.8 4239.0 4128.5 4191.0 4228.5 4228.7 4231.5 799.6 894.1 919.3 930.4 947.2 584.6 594.3 606.1 621.6 641.0 8672.6 9842.8 10124.1 10216.4 10373.4 551.3 578.2 601.6 635.2 640.9 4017.1 4522.0 4526.2 4545.2 4711.0 98063.5 100138.0 100472.5 101892.0 102853.0 87923.0 88164.0 90054.5 90407.6 91281.4 69054.0 69409.3 69849.7 70046.9 70402.3 8822.6 8877.4 9318.7 9348.2 9484.1 38497.8 38684.6 39087.6 39290.0 40002.0 41996.6 44593.8 51311.7 52415.5 52862.7 13438.2 13695.7 13725.5 14056.2 14110.5 13834.7 13849.6 13952.7 13987.5 14124.2 12611.8 12711.2 13084.4 13362.5 13603.7 12849.2 13014.9 13178.4 13197.7 13230.6 11267.3 12886.3 13489.5 13579.7 13733.5 9085.4 9341.4 9691.9 9710.6 10134.8 10368.9 10744.9 10805.9 10960.3 10998.6 23:29:28 INFO - PID 1640 | -------- Summary: end -------- 23:29:28 INFO - PID 1640 | 23:29:28 INFO - TEST-INFO | 1640: exit 0 23:29:29 INFO - TEST-OK | dromaeo_css | took 1122431ms 23:29:29 INFO - TEST-START | kraken 23:29:29 INFO - operating with platform_type : mac_ 23:29:29 INFO - Initialising browser for kraken test... 23:29:29 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/tmpfb7G9n/profile http://localhost:49244/getInfo.html) 23:29:31 INFO - PID 1651 | __metrics Screen width/height:1600/1200 23:29:31 INFO - PID 1651 | colorDepth:24 23:29:31 INFO - PID 1651 | Browser inner width/height: 1024/689 23:29:31 INFO - PID 1651 | __metrics 23:29:31 INFO - PID 1651 | 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" 23:29:31 INFO - PID 1651 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:29:32 INFO - TEST-INFO | 1651: exit 0 23:29:32 INFO - Browser initialized. 23:29:32 INFO - Running cycle 1/1 for kraken test... 23:29:32 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/T/tmpfb7G9n/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:29:44 INFO - PID 1652 | RSS: Main: 238309376 23:29:44 INFO - PID 1652 | 23:29:48 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 23:29:49 INFO - PID 1652 | RSS: Main: 291713024 23:29:49 INFO - PID 1652 | 23:29:51 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 23:29:52 INFO - PID 1652 | RSS: Main: 292089856 23:29:52 INFO - PID 1652 | 23:29:56 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 23:29:56 INFO - PID 1652 | RSS: Main: 387801088 23:29:56 INFO - PID 1652 | 23:29:58 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 23:29:59 INFO - PID 1652 | RSS: Main: 289624064 23:29:59 INFO - PID 1652 | 23:30:01 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:30:02 INFO - PID 1652 | RSS: Main: 290115584 23:30:02 INFO - PID 1652 | 23:30:05 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 23:30:06 INFO - PID 1652 | RSS: Main: 332636160 23:30:06 INFO - PID 1652 | 23:30:09 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 23:30:09 INFO - PID 1652 | RSS: Main: 342196224 23:30:09 INFO - PID 1652 | 23:30:13 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 23:30:13 INFO - PID 1652 | RSS: Main: 344883200 23:30:13 INFO - PID 1652 | 23:30:15 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:30:15 INFO - PID 1652 | RSS: Main: 310398976 23:30:15 INFO - PID 1652 | 23:30:17 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:30:18 INFO - PID 1652 | RSS: Main: 315084800 23:30:18 INFO - PID 1652 | 23:30:20 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:30:21 INFO - PID 1652 | RSS: Main: 316784640 23:30:21 INFO - PID 1652 | 23:30:24 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:30:25 INFO - PID 1652 | RSS: Main: 334868480 23:30:25 INFO - PID 1652 | 23:30:28 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:30:29 INFO - PID 1652 | RSS: Main: 317673472 23:30:29 INFO - PID 1652 | 23:30:31 INFO - PID 1652 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 23:30:31 INFO - PID 1652 | RSS: Main: 383934464 23:30:31 INFO - PID 1652 | 23:30:31 INFO - PID 1652 | __start_tp_report 23:30:31 INFO - PID 1652 | _x_x_mozilla_page_load 23:30:31 INFO - PID 1652 | _x_x_mozilla_page_load_details 23:30:31 INFO - PID 1652 | |i|pagename|runs| 23:30:31 INFO - PID 1652 | |0;ai-astar;112;122;123;125;170;183;125;162;182;124 23:30:31 INFO - PID 1652 | |1;audio-beat-detection;151;117;119;159;131;155;155;101;168;154 23:30:31 INFO - PID 1652 | |2;audio-dft;214;217;214;214;227;206;212;215;212;216 23:30:31 INFO - PID 1652 | |3;audio-fft;80;63;66;98;70;68;65;65;84;62 23:30:31 INFO - PID 1652 | |4;audio-oscillator;91;76;125;111;76;100;130;107;74;92 23:30:31 INFO - PID 1652 | |5;imaging-gaussian-blur;91;92;92;103;109;93;92;91;96;94 23:30:31 INFO - PID 1652 | |6;imaging-darkroom;114;98;99;100;100;104;100;100;101;103 23:30:31 INFO - PID 1652 | |7;imaging-desaturate;102;103;103;101;103;100;102;103;102;100 23:30:31 INFO - PID 1652 | |8;json-parse-financial;51;50;50;49;51;52;51;51;50;50 23:30:31 INFO - PID 1652 | |9;json-stringify-tinderbox;56;67;64;62;70;90;91;90;78;62 23:30:31 INFO - PID 1652 | |10;stanford-crypto-aes;90;90;90;93;88;90;91;91;90;90 23:30:31 INFO - PID 1652 | |11;stanford-crypto-ccm;153;155;170;150;168;144;171;162;201;173 23:30:31 INFO - PID 1652 | |12;stanford-crypto-pbkdf2;200;202;239;257;203;199;204;203;202;202 23:30:31 INFO - PID 1652 | |13;stanford-crypto-sha256-iterative;72;76;94;102;74;74;72;71;74;73 23:30:31 INFO - PID 1652 | __end_tp_report 23:30:31 INFO - PID 1652 | __start_cc_report 23:30:31 INFO - PID 1652 | _x_x_mozilla_cycle_collect,2218 23:30:31 INFO - PID 1652 | __end_cc_report 23:30:31 INFO - PID 1652 | __startTimestamp1491460231704__endTimestamp 23:30:31 INFO - PID 1652 | 23:30:31 INFO - PID 1652 | ------- Summary: start ------- 23:30:31 INFO - PID 1652 | Number of tests: 14 23:30:31 INFO - PID 1652 | 23:30:31 INFO - PID 1652 | [#0] ai-astar Cycles:10 Average:142.80 Median:143.50 stddev:27.93 (19.5%) stddev-sans-first:27.31 23:30:31 INFO - PID 1652 | Values: 112.0 122.0 123.0 125.0 170.0 183.0 125.0 162.0 182.0 124.0 23:30:31 INFO - PID 1652 | 23:30:31 INFO - PID 1652 | [#1] audio-beat-detection Cycles:10 Average:141.00 Median:154.50 stddev:22.30 (14.4%) stddev-sans-first:23.35 23:30:31 INFO - PID 1652 | Values: 151.0 117.0 119.0 159.0 131.0 155.0 155.0 101.0 168.0 154.0 23:30:31 INFO - PID 1652 | 23:30:31 INFO - PID 1652 | [#2] audio-dft Cycles:10 Average:214.70 Median:214.50 stddev:5.27 (2.5%) stddev-sans-first:5.59 23:30:31 INFO - PID 1652 | Values: 214.0 217.0 214.0 214.0 227.0 206.0 212.0 215.0 212.0 216.0 23:30:31 INFO - PID 1652 | 23:30:31 INFO - PID 1652 | [#3] audio-fft Cycles:10 Average:72.10 Median:69.00 stddev:11.64 (16.9%) stddev-sans-first:11.99 23:30:31 INFO - PID 1652 | Values: 80.0 63.0 66.0 98.0 70.0 68.0 65.0 65.0 84.0 62.0 23:30:31 INFO - PID 1652 | 23:30:31 INFO - PID 1652 | [#4] audio-oscillator Cycles:10 Average:98.20 Median:75.00 stddev:20.10 (26.8%) stddev-sans-first:21.15 23:30:31 INFO - PID 1652 | Values: 91.0 76.0 125.0 111.0 76.0 100.0 130.0 107.0 74.0 92.0 23:30:31 INFO - PID 1652 | 23:30:31 INFO - PID 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:95.30 Median:92.00 stddev:6.00 (6.5%) stddev-sans-first:6.16 23:30:31 INFO - PID 1652 | Values: 91.0 92.0 92.0 103.0 109.0 93.0 92.0 91.0 96.0 94.0 23:30:31 INFO - PID 1652 | 23:30:31 INFO - PID 1652 | [#6] imaging-darkroom Cycles:10 Average:101.90 Median:103.50 stddev:4.61 (4.4%) stddev-sans-first:1.88 23:30:31 INFO - PID 1652 | Values: 114.0 98.0 99.0 100.0 100.0 104.0 100.0 100.0 101.0 103.0 23:30:31 INFO - PID 1652 | 23:30:31 INFO - PID 1652 | [#7] imaging-desaturate Cycles:10 Average:101.90 Median:102.50 stddev:1.20 (1.2%) stddev-sans-first:1.27 23:30:31 INFO - PID 1652 | Values: 102.0 103.0 103.0 101.0 103.0 100.0 102.0 103.0 102.0 100.0 23:30:31 INFO - PID 1652 | 23:30:31 INFO - PID 1652 | [#8] json-parse-financial Cycles:10 Average:50.50 Median:51.00 stddev:0.85 (1.7%) stddev-sans-first:0.88 23:30:31 INFO - PID 1652 | Values: 51.0 50.0 50.0 49.0 51.0 52.0 51.0 51.0 50.0 50.0 23:30:31 INFO - PID 1652 | 23:30:31 INFO - PID 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:73.00 Median:74.00 stddev:13.27 (17.9%) stddev-sans-first:12.56 23:30:31 INFO - PID 1652 | Values: 56.0 67.0 64.0 62.0 70.0 90.0 91.0 90.0 78.0 62.0 23:30:31 INFO - PID 1652 | 23:30:31 INFO - PID 1652 | [#10] stanford-crypto-aes Cycles:10 Average:90.30 Median:90.00 stddev:1.25 (1.4%) stddev-sans-first:1.32 23:30:31 INFO - PID 1652 | Values: 90.0 90.0 90.0 93.0 88.0 90.0 91.0 91.0 90.0 90.0 23:30:31 INFO - PID 1652 | 23:30:31 INFO - PID 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:164.70 Median:169.00 stddev:16.15 (9.6%) stddev-sans-first:16.57 23:30:31 INFO - PID 1652 | Values: 153.0 155.0 170.0 150.0 168.0 144.0 171.0 162.0 201.0 173.0 23:30:31 INFO - PID 1652 | 23:30:31 INFO - PID 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:211.10 Median:203.00 stddev:19.96 (9.8%) stddev-sans-first:20.76 23:30:31 INFO - PID 1652 | Values: 200.0 202.0 239.0 257.0 203.0 199.0 204.0 203.0 202.0 202.0 23:30:31 INFO - PID 1652 | 23:30:31 INFO - PID 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.20 Median:74.00 stddev:10.70 (14.5%) stddev-sans-first:11.11 23:30:31 INFO - PID 1652 | Values: 72.0 76.0 94.0 102.0 74.0 74.0 72.0 71.0 74.0 73.0 23:30:31 INFO - PID 1652 | -------- Summary: end -------- 23:30:31 INFO - PID 1652 | 23:30:32 INFO - TEST-INFO | 1652: exit 0 23:30:32 INFO - TEST-OK | kraken | took 63807ms 23:30:32 INFO - SUITE-END | took 1186s 23:30:32 INFO - Completed test suite (00:19:46) 23:30:32 INFO - javascript benchmark 23:30:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7687.280110641879, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3210.4542227821266, 3459.08334291413, 3466.7919924804496, 3494.825258737064, 3542.415501442262, 5676.205331253617, 5860.824175274738, 6006.159137720711, 6163.845903852406, 6170.290416602092, 6049.879002419949, 6093.634381937087, 6140.320203811479, 6151.41561551653, 6174.444300012998, 5134.358205224347, 5290.127129023706, 5293.947060529403, 5302.337207849019, 5352.170413585901, 5328.973355133238, 5381.48875856793, 5383.892322153554, 5386.569074474052, 5427.348718153827, 5181.326427564392, 5261.263423120766, 5270.39390470097, 5283.445238250005, 5333.813316533922, 5254.947450525522, 5265.0, 5273.920891186597, 5278.313819203518, 5293.708846013467, 4559.768862407132, 5046.268291097807, 5183.067047931371, 5251.50110739483, 5264.631475796696, 5944.583879128462, 5948.881022379572, 5968.850778730523, 5979.0, 5992.34084250732, 5611.298587676541, 6147.446729794296, 6319.4312511873695, 6334.208223972004, 6348.492120630339, 6346.650934198663, 6387.968060159716, 6408.67956602168, 6420.5505614607, 6536.379043990813, 6219.036049412348, 6247.375262473762, 6281.309056003836, 6283.2460104787715, 6283.8743225135695, 6689.866202676017, 6704.497162712816, 6707.993800929899, 6709.127813384326, 6735.764248251287, 6247.750089996349, 6375.171227740364, 6381.680915954184, 6416.582922110141, 6420.229572451336, 6395.808125756234, 6408.903866442007, 6454.741810327534, 6514.185726784152, 6545.378189072126, 6413.0, 6418.807435776934, 6428.4214420702365, 6437.967810160919, 6445.677716114175, 6401.967990160019, 6428.003659432796, 6428.678566071678, 6432.324605916405, 6443.162388889508, 5132.897342053138, 5171.68969861802, 5197.948020519746, 5207.6875387476875, 5249.317588713443, 4601.608863246594, 4647.488776234679, 4690.319903614025, 4733.9763301183275, 4734.100520901018, 6072.878542429126, 6092.085047331085, 6104.769568543233, 6115.149072927094, 6142.78500252489, 6374.840628984312, 6396.808095757135, 6396.840078998062, 6416.967915160394, 6495.772647957298, 6122.663253521099, 6153.907691384633, 6159.969200153971, 6166.445019948226, 6174.845628859314, 5708.001099807517, 5714.971425142848, 5718.714064296769, 5726.226959360516, 5747.1379293106365, 6538.313477084837, 6545.607263564201, 6670.699818508082, 6678.532502724763, 6688.331166883273, 5472.91790623133, 6361.395667411589, 6516.152900123143, 6531.11829902976, 6535.803925882231, 6712.93287067123, 6714.563553369016, 6729.528932974645, 6738.46092312604, 6738.460923126237, 6437.5171862111465, 6440.29156792743, 6443.162388889415, 6446.0, 6455.515836312389, 6360.204974378203, 6373.362663733589, 6397.424231819158, 6448.322926092693, 6463.289038205699, 6371.331010243857, 6376.234851817811, 6389.9361006389345, 6396.42432181106, 6397.360263973565, 6217.502599792097, 6333.96833015832, 6334.461570766536, 6412.487001039813, 6425.06836508713, 6157.353477884758, 6260.968695156495, 6371.617702937839, 6380.234371875219, 6387.489000879826, 5918.023526118142, 6304.18045654062, 6350.079238510298, 6377.617342959437, 6382.170317858649, 6317.778877739257, 6334.588251763621, 6344.873102537831, 6345.0, 6345.397187267202], "value": 5934.599781355214, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [804.7786858613882, 821.084490792766, 1142.4002398740665, 1162.4652659776502, 1164.4759858063874, 36078.278434431326, 36676.26647467053, 36703.81648091762, 36745.81627091861, 37254.0, 38167.427488587695, 38549.4580216791, 38587.22825543487, 38706.61293387065, 38749.80625096871, 6154.169187159743, 8461.957690211555, 8601.182887625666, 8630.956845215796, 8631.266342360906, 6201.596896201732, 6284.465820405271, 6285.9685701571425, 6289.1509646197865, 8402.495850248974, 8590.570471476432, 8660.13398660132, 8662.913370866305, 8680.479171249714, 8693.7826554336, 8567.571621418936, 8626.266767324816, 8642.265407440374, 8643.65425382984, 8665.136995545989, 8405.453645513022, 8445.83108337836, 8458.238758511701, 8466.78833029173, 8468.957655211747, 36628.08429789277, 36918.815405923066, 36935.89192324234, 36940.26119477622, 37055.62944370549, 3066.4940284853196, 3356.8825091121694, 3374.7637665363436, 3398.8130652814084, 3399.55805745254, 29630.555541666894, 29704.70295297041, 29725.0, 29745.405091898258, 29778.85110574455, 2866.7706583473273, 2911.3595009098176, 2927.1072322941495, 2935.6770755216908, 2945.5876177334976, 231774.0, 278893.56043373595, 282646.0, 283208.0, 284075.0, 38430.84707458781, 38495.0, 39055.80472097678, 47783.283250751265, 47922.041559169316, 48216.5178348212, 48419.75790121097, 48991.0, 49017.0, 49172.75413622909, 14040.719185616435, 14173.291335433187, 14204.0, 14204.289785510684, 14242.931780116533, 11548.422578871023, 11567.537298507965, 11578.47896844644, 11581.726010138878, 11603.129765267639, 9703.708888733348, 9841.901580984242, 11891.227070240408, 11969.64091077269, 12091.274523528617, 5389.649672771257, 5413.323334583177, 5436.673799572039, 5443.265159203536, 5450.182472629137, 960.6493629825203, 965.4448692002127, 974.878140232471, 982.3565564555228, 990.3810118675827, 26891.462170756477, 27475.900963961216, 27899.581506277424, 28008.579871301947, 28347.149585512467, 896.6592694776074, 1037.699067270483, 1055.5672174408455, 1084.9403282819521, 1087.1465899269035, 11725.765484690259, 14078.436862525588, 14793.482228121964, 14953.476628317956, 15302.693946121015, 341072.0, 341304.293478536, 342063.0, 342647.0, 343453.0, 50864.23703644448, 50964.490355096714, 50978.49021509737, 50980.0, 51316.48683513192, 1412.173878281217, 1453.4331610671636, 1500.5873384819045, 1502.0912348029503, 1514.6364872430759, 21684.097399819042, 26381.34046648849, 27117.72882271231, 27324.180274591796, 27376.58935115935, 36091.0, 36186.09534761652, 36233.81883090568, 36332.45501317535, 36338.63661363353, 297255.0, 298084.0, 299017.0, 299224.0, 299395.0, 29205.90721495648, 29545.704542955154, 30005.69994300029, 30031.69968300289, 30035.249118772204, 37294.81352593219, 37527.43708844315, 38298.80850595729, 38650.0, 38838.2232355357, 27107.45785084248, 27286.590701139896, 27815.304617383918, 27933.301667458476, 28064.877404904393, 27290.04103953479, 27750.167494975183, 27952.02167924113, 28023.659187900706, 28543.571846421906, 34160.31679366448, 34825.82587087048, 34827.129321767155, 34914.47628285527, 35203.94388168359, 29489.705102949552, 29900.888145192395, 30049.098527044225, 30092.93745344438, 30273.545896812007, 20940.0, 20994.895025525384, 23222.82435447821, 23307.41731456659, 23710.170144044874], "value": 16931.502588579915, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [399.7201958628959, 401.31393153881584, 429.4481591155364, 432.90476095259044, 439.4858016121139, 15006.474773382934, 20583.38249852505, 20787.168513259472, 21058.473538161554, 22002.559948801016, 22400.55198896021, 22868.19961301355, 23547.646785298235, 23652.408689782766, 23753.5249295014, 5245.554127899133, 7042.366187043165, 7238.855222895539, 7259.564426134449, 7272.454565907552, 6826.419754320888, 7121.145462544502, 7141.857442767175, 7164.0, 7169.713211471561, 7012.544184628008, 7086.751963681272, 7098.290170982912, 7106.147262328528, 7111.644417779116, 4780.95219047812, 6866.725330986755, 6907.240203577602, 7091.929080709204, 7108.969199466074, 6502.642354670491, 6782.423494003016, 6793.524453288272, 6802.387785099315, 6816.693248803816, 28026.95514807334, 28516.429671406662, 28757.712422875713, 28888.711112888814, 29342.706572934425, 2228.7882651148116, 2299.275728145629, 2305.1240528599023, 2307.111761971636, 2311.66480860276, 17893.642127157513, 18312.725309120375, 18437.815621843878, 18534.165962531584, 18737.969411682352, 1693.2718930859726, 2194.9451263718374, 2269.853723869452, 2287.714035745532, 2291.278247352079, 140075.0, 157217.0, 158805.0, 161556.0, 164264.9999999988, 16942.322307107577, 19268.4219473416, 21405.571888562143, 22880.88559557225, 23317.533649326917, 40719.796401017804, 41054.794726026776, 41196.79401602973, 41260.1747965039, 41312.58687413087, 10735.0, 11055.0603198729, 11105.500252488657, 11150.442477876073, 11263.26788758728, 8821.558922053871, 8825.338099642553, 8865.734027979172, 9012.369134160546, 9019.909800902038, 10713.250072494851, 11023.44882755859, 11078.889211107948, 11153.0, 11200.38397888124, 3614.801185934799, 3812.0279328770985, 4391.978040109779, 4434.82260709568, 4466.749310193151, 891.6149300620814, 912.885889263842, 915.7390143808982, 936.9953150234205, 949.2216382566368, 15082.698346033018, 19390.2243910242, 19447.61104777925, 20260.696089558667, 20614.0, 935.5462600638684, 955.1356022799378, 968.5012218707371, 972.2659392158874, 977.3012296208245, 7995.160508146677, 9743.661521234853, 9943.204543636637, 9950.303478756417, 9967.700968970943, 643655.0, 663178.0, 672237.0, 681911.0, 693344.0, 150012.0, 152777.0, 152828.0, 153658.0, 155499.0, 971.8493633486679, 1134.3364131982883, 1166.5158959031908, 1168.0597119318859, 1205.9457324420598, 20258.837974215952, 21838.454038648524, 21856.89071554632, 21953.890230548746, 21996.120155193614, 63813.04280435704, 64622.67688661526, 64809.35190648033, 65000.0, 65137.674311628136, 79238.0, 82966.0, 83205.0, 83304.25479795766, 84239.57880210559, 8448.107526775217, 8628.101817600118, 8701.564921753761, 8744.956275218583, 8818.647254110021, 13079.869201307865, 13338.466461341437, 13344.266065366499, 13759.518416855362, 13778.65553361174, 11462.656120316404, 11477.598284060017, 11644.767104658029, 11859.822102668639, 11892.345920974429, 10757.977992090739, 10792.136629069813, 10962.123030157409, 10984.588785882455, 11140.665780026613, 11885.82171267449, 12033.819492707442, 12076.818847717115, 12120.393980300772, 12160.027197823976, 8627.611757471055, 8674.696385626472, 8699.086595907338, 8768.561571921506, 8926.0, 10187.898121018696, 11268.887311126784, 11483.023942964941, 11890.405479726152, 11992.64022079339], "value": 11543.19403655878, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1355.8711922367374, 1428.9071210371326, 1436.5115860607398, 1445.2556933179412, 1459.5767227504025, 8950.910490895089, 11349.43252837358, 11370.60202892899, 11372.203945723802, 11378.146639002087, 10968.17738669599, 11130.332180069201, 11242.325460472357, 11373.886261137386, 11426.42867856608, 2381.6070348392495, 2417.7703118203744, 2423.103451722865, 2426.599611064172, 2431.4043059450373, 2345.6598793175067, 2484.85090894546, 2511.6860392450944, 2514.2205916165954, 2515.0442831723917, 2077.5429405530836, 2112.725345705056, 2199.0104452996134, 2202.41635966469, 2397.244867866625, 2471.4933438645126, 2500.949981000388, 2500.9746004138397, 2502.274340441279, 2503.3866702657783, 2443.2914454808083, 2484.763947424992, 2485.7141428735745, 2489.3403248139257, 2495.851908122248, 11190.992810647082, 11451.25566838153, 11460.541578336857, 11469.483873225725, 11486.827697584544, 6413.647249401281, 6632.93367066328, 6654.567453115532, 6654.966725166391, 6670.899936500957, 3833.6039975015615, 3996.8800935971967, 4104.343305071204, 4174.853880114181, 4177.436046133764, 1164.4236103128922, 1175.2243519277235, 1191.7973944429382, 1219.5365761010848, 1223.8103094020441, 15665.921670391688, 15807.446739364183, 15822.762658560016, 15822.920885395615, 15840.0, 5191.377034755854, 5363.624546281723, 5581.441855814386, 5581.720913954286, 5620.606557540933, 11825.349605771593, 11866.228695134789, 11876.10929180315, 11876.228045177037, 11912.761744765055, 5578.163275508625, 6462.3537646235, 6467.967660161669, 6469.482441404676, 6471.838204044842, 5846.649201047951, 5894.2926848778425, 6116.724747386378, 6197.597156184924, 6200.720967556471, 3443.104792753902, 4155.794819502371, 4284.592963668447, 4348.130373925164, 4395.934060989088, 1065.0999905080196, 1223.1437993404652, 1274.7705413025558, 1296.3453456004845, 1298.214580178997, 714.8641758065951, 736.8636802191612, 760.4220792197859, 769.7844603511026, 796.8725003999448, 5849.473547380756, 5943.494802941712, 6089.421504957022, 6146.416090471487, 6223.502119830403, 569.6525119676994, 589.3634874335708, 598.1924402057188, 603.2308806272039, 604.9866473656607, 3617.8733744318824, 3761.39817629178, 3836.405357169643, 3853.2678791029616, 3862.8647997320522, 13954.441822327197, 14753.262336883114, 14802.185879776716, 14814.703705925822, 14830.480933167288, 13962.301884905713, 14227.004109712221, 14692.412303507954, 14720.779188312184, 14750.483733069292, 8759.467093258654, 10302.845457318146, 10358.431632668202, 10464.686059418229, 10481.004304591052, 6498.480121590167, 6669.966650166718, 6711.0940023096255, 6906.240313565403, 6921.342472465108, 11445.969862712063, 12562.685932851386, 13025.023123265604, 13104.606861794162, 13124.540641077516, 13242.933785331012, 13348.199108053548, 13471.797923030967, 13568.321583920962, 13747.38136783867, 9153.313501487282, 9292.117248861347, 9298.814023719353, 9401.576929038072, 9421.670241541513, 10257.384556926609, 10333.84499232497, 10491.422971736627, 10494.370337779757, 10509.9474502627, 6968.442524598121, 8724.258438032839, 8726.82546349082, 8979.191872731486, 8986.056464071178, 7045.542039767399, 8516.914830851612, 8690.522021288889, 8700.173483519056, 8710.782230444036, 7878.212178782076, 7905.249001344863, 7965.004374453193, 7981.8802717958115, 8015.238552337519, 5924.4667979882015, 5948.791792287249, 6040.244969378828, 6070.514358851369, 6126.479249263863, 5857.7949771757785, 6009.90985135232, 6146.631202127886, 6165.691715414301, 6255.499560035278], "value": 5179.440479493722, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.5761374419418, 383.89826695925586, 405.18153330272867, 406.10048742036383, 406.48985523168403, 5949.37531559186, 5970.253718285215, 5978.491828194608, 5983.700814959251, 5996.940030599692, 4533.8413155539565, 5112.7473768926575, 5533.778648854051, 5615.0, 5845.252731216321, 3498.265364273506, 4257.829686812539, 4261.616454519092, 4264.6801489888385, 4270.124624451995, 4267.381229721688, 4280.122574872159, 4280.865570623787, 4290.806913688892, 4297.59172878576, 3330.916727081818, 4212.115455754295, 4257.489101307832, 4275.209086319041, 4285.528591854893, 3872.605861889703, 3899.6685281751083, 4244.957550424487, 4254.404383386328, 4261.76560289184, 3323.3685599735973, 3668.321360548307, 3722.758020728644, 3730.0674831292176, 3732.5707543632557, 5472.671639701591, 5639.041362968305, 5652.802151924663, 5655.8586035349035, 5668.31980162379, 4422.6240769534625, 4868.880157563744, 5006.5744411725045, 5081.568066714297, 5124.333836601218, 5645.32256129263, 5785.537157027427, 6149.2620885494025, 6160.260768707739, 6172.814815555541, 3669.321175582526, 4176.4570605821045, 4208.957910420887, 4234.809433575466, 4245.1934132514725, 6260.749570017194, 6316.715747791314, 6329.8734025320155, 6527.15147030883, 6554.836129096763, 4152.065785198306, 4157.711109556048, 4159.563245859202, 4160.105577300895, 4162.211318416668, 3767.3972164453558, 4145.595554578397, 4343.0, 4352.608265256142, 4356.106998065389, 4538.29656403258, 4581.862544123682, 4695.140529551897, 4940.530649588283, 5073.543381095719, 4724.858254252378, 6257.749690012349, 6272.874542509125, 6289.7169627366875, 6290.232297788958, 1465.5969608357573, 1475.638468575206, 1476.2323591732238, 1480.9185494797673, 1482.2366481262159, 926.3885835348638, 984.0995489127369, 988.17981075707, 991.7718924647371, 995.3381001633977, 4866.391701037371, 5863.5309175265875, 5890.4993075589055, 5904.793332233351, 5915.260592425947, 5508.980838544882, 5729.71081506666, 6439.710213040425, 6478.643674597943, 6510.25132109804, 5185.714785686823, 5514.5864060195645, 5603.635763675348, 5635.633683810539, 5858.56060795442, 2969.777266705006, 3006.7895247332913, 3209.422303985258, 3368.898933032013, 3390.1355154435955, 6337.429631333202, 6623.271440141581, 6635.037919501645, 6655.966720166368, 6706.631135287508, 6650.235222949423, 6651.966740166268, 6663.233728121231, 6665.300143484961, 6666.166729158856, 6003.039513677878, 6146.631202127886, 6372.0, 6649.966750166218, 6663.566868153457, 5978.834127345126, 6138.754449821957, 6408.391202835724, 6467.41793238592, 6475.611463312216, 5565.5825813063375, 6403.935960640334, 6408.93591064102, 6409.308090601865, 6421.743130274736, 5698.0512608243935, 6013.707052983629, 6314.273858506331, 6464.22429308486, 6639.302873198245, 4226.640735537514, 4273.893152671208, 4286.207051695446, 4287.97856010718, 4293.849715260076, 5598.804041858515, 5955.642661440327, 6235.781747638993, 6493.480521558169, 6494.707738151889, 5409.648372855751, 5464.388005538296, 6117.510599152146, 6196.349383314687, 6230.504678877128, 5372.1941708744, 6216.347283535345, 6233.096201050913, 6272.428304395176, 6297.905531417124, 5834.299884013776, 6057.57596968208, 6127.571070025056, 6145.955187618027, 6192.969035154975, 5411.567074634098, 6268.341824108586, 6269.899583639532, 6320.62076275425, 6327.145835312174, 4600.102979918884, 4888.388951381077, 5017.448080711192, 5589.385167631639, 6091.786787462417], "value": 4498.019754323706, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [807.903051633804, 815.2703330519186, 832.2426591801462, 832.4797001873828, 838.5932822581049, 15816.288267027983, 16158.515244542654, 16203.756943645854, 16224.10767407792, 16247.756283655739, 13709.862901370983, 14450.277486125678, 14996.325165367558, 15158.242087895616, 15196.620084497894, 934.4113208678523, 969.5152423788106, 972.4311277902435, 975.1759763000254, 977.2475194100539, 1005.4319309590059, 1009.0212493880961, 1009.0766948242349, 1010.9393436393804, 1012.0688966151122, 1053.4574694032578, 1053.7102296868384, 1055.3615062886959, 1056.1445229364201, 1058.0794708603487, 1051.2431049644244, 1051.51104736298, 1052.2213561964168, 1052.5789684126373, 1054.3199636234624, 783.5455435847194, 786.535943793159, 787.1852632525366, 787.4723934963588, 787.5747096567846, 16030.519084427486, 16504.75242871358, 16716.498505044867, 16734.24695888688, 16736.58158546034, 14777.0, 14866.033707809065, 14885.776713349309, 14919.925400373037, 15107.848921510864, 13311.733765324736, 13408.798868016987, 13429.194248345033, 13452.192868427828, 13482.460701571925, 3330.217398911254, 3330.9833450832834, 3331.217163966466, 3359.5968483781858, 3360.2439451123546, 119831.0, 121018.78981210163, 121806.0, 123136.0, 123951.3802430991, 7688.884666730003, 11395.658130256106, 11592.768144637228, 11715.882841171479, 12026.27842329463, 24166.39584010414, 24422.755772442404, 24850.751492484844, 24862.254132376056, 24930.0, 7997.040355157418, 8011.639476223584, 8053.315468185153, 8158.918410815934, 8162.3878209134555, 4148.647364974011, 4156.147989662112, 4163.607136478205, 4236.76697781625, 4238.978805105955, 4128.545859955402, 4190.979045104755, 4228.471441069866, 4228.682848786353, 4231.492220933507, 799.6361655446758, 894.0924961164424, 919.3288899103692, 930.4277869110448, 947.1806887042796, 584.6170758153417, 594.313567829158, 606.1392822192497, 621.6425555305627, 640.9647469389229, 8672.60973256205, 9842.75393115178, 10124.088832005154, 10216.387016779017, 10373.377597344184, 551.302602208207, 578.1732123064058, 601.5638661970124, 635.2186810223451, 640.8750293692685, 4017.134226359956, 4522.0, 4526.23054080807, 4545.181867263925, 4711.0, 98063.50968245113, 100138.0, 100472.49291260637, 101892.0, 102853.0, 87923.0, 88164.0, 90054.54972725094, 90407.55417585802, 91281.41545137666, 69054.0, 69409.30590694028, 69849.65075174693, 70046.9492957606, 70402.2959770406, 8822.602982865916, 8877.357688827587, 9318.72043838686, 9348.158665720119, 9484.116142172381, 38497.80751096339, 38684.6131538681, 39087.60912390953, 39290.01774955649, 40002.0, 41996.580034199265, 44593.77703111464, 51311.74344128255, 52415.47584524106, 52862.73568632132, 13438.193708377528, 13695.657608559866, 13725.519606813714, 14056.156630602196, 14110.490231046548, 13834.65413364674, 13849.584512464642, 13952.720945581235, 13987.463501649261, 14124.223167725462, 12611.807242079693, 12711.237325760483, 13084.35286542199, 13362.465501379836, 13603.727925441633, 12849.164804287691, 13014.883356709886, 13178.406971686489, 13197.736045278849, 13230.603081907559, 11267.323960562393, 12886.29125398112, 13489.463697193805, 13579.728405431639, 13733.45066197341, 9085.36402451822, 9341.392809467634, 9691.920073839512, 9710.563024664048, 10134.797304054026, 10368.896311037095, 10744.892551074388, 10805.945970270413, 10960.28758130719, 10998.560057597606], "value": 7636.32408142511, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1635.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 122.0, 123.0, 125.0, 170.0, 183.0, 125.0, 162.0, 182.0, 124.0], "value": 142.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 117.0, 119.0, 159.0, 131.0, 155.0, 155.0, 101.0, 168.0, 154.0], "value": 141.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [214.0, 217.0, 214.0, 214.0, 227.0, 206.0, 212.0, 215.0, 212.0, 216.0], "value": 214.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 63.0, 66.0, 98.0, 70.0, 68.0, 65.0, 65.0, 84.0, 62.0], "value": 72.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 76.0, 125.0, 111.0, 76.0, 100.0, 130.0, 107.0, 74.0, 92.0], "value": 98.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 92.0, 92.0, 103.0, 109.0, 93.0, 92.0, 91.0, 96.0, 94.0], "value": 95.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 98.0, 99.0, 100.0, 100.0, 104.0, 100.0, 100.0, 101.0, 103.0], "value": 101.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 103.0, 103.0, 101.0, 103.0, 100.0, 102.0, 103.0, 102.0, 100.0], "value": 101.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 50.0, 50.0, 49.0, 51.0, 52.0, 51.0, 51.0, 50.0, 50.0], "value": 50.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [56.0, 67.0, 64.0, 62.0, 70.0, 90.0, 91.0, 90.0, 78.0, 62.0], "value": 73.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 90.0, 93.0, 88.0, 90.0, 91.0, 91.0, 90.0, 90.0], "value": 90.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 155.0, 170.0, 150.0, 168.0, 144.0, 171.0, 162.0, 201.0, 173.0], "value": 164.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [200.0, 202.0, 239.0, 257.0, 203.0, 199.0, 204.0, 203.0, 202.0, 202.0], "value": 211.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 76.0, 94.0, 102.0, 74.0, 74.0, 72.0, 71.0, 74.0, 73.0], "value": 78.2, "unit": "score"}]}]} 23:30:32 INFO - Return code: 0 23:30:32 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:30:33 ERROR - # TBPL SUCCESS # 23:30:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 23:30:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 23:30:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 23:30:33 INFO - 2017-04-05 23:30:33.023 screenresolution[1657:10074] starting screenresolution argv=screenresolution get 23:30:33 INFO - 2017-04-05 23:30:33.026 screenresolution[1657:10074] Display 0: 1600x1200x32@60 23:30:33 INFO - 2017-04-05 23:30:33.033 screenresolution[1658:10077] starting screenresolution argv=screenresolution list 23:30:33 INFO - Available Modes on Display 0 23:30:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 23:30:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 23:30:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 23:30:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 23:30:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 23:30:33 INFO - Intel Iris: 23:30:33 INFO - Chipset Model: Intel Iris 23:30:33 INFO - Type: GPU 23:30:33 INFO - Bus: Built-In 23:30:33 INFO - VRAM (Dynamic, Max): 1536 MB 23:30:33 INFO - Vendor: Intel (0x8086) 23:30:33 INFO - Device ID: 0x0a2e 23:30:33 INFO - Revision ID: 0x0009 23:30:33 INFO - Displays: 23:30:33 INFO - Display: 23:30:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 23:30:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 23:30:33 INFO - Display Serial Number: 1600x1200 60 23:30:33 INFO - Main Display: Yes 23:30:33 INFO - Mirror: Off 23:30:33 INFO - Online: Yes 23:30:33 INFO - Rotation: Supported 23:30:33 INFO - Return code: 0 23:30:33 INFO - Running post-action listener: _resource_record_post_action 23:30:33 INFO - [mozharness: 2017-04-06 06:30:33.278513Z] Finished run-tests step (success) 23:30:33 INFO - Running post-run listener: _resource_record_post_run 23:30:33 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 37667840; Write bytes: 514569728; Read time: 239; Write time: 1567 23:30:33 INFO - TinderboxPrint: CPU usage
53.4% 23:30:33 INFO - TinderboxPrint: I/O read bytes / time
37,667,840 / 239 23:30:33 INFO - TinderboxPrint: I/O write bytes / time
514,569,728 / 1,567 23:30:33 INFO - TinderboxPrint: CPU idle
2,251.1 (46.6%) 23:30:33 INFO - TinderboxPrint: CPU system
961.5 (19.9%) 23:30:33 INFO - TinderboxPrint: CPU user
1,613.0 (33.4%) 23:30:33 INFO - TinderboxPrint: Swap in / out
244,629,504 / 0 23:30:33 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 193559040; Write bytes: 193164800; Read time: 14874; Write time: 401 23:30:33 INFO - run-tests - Wall time: 1187s; CPU: 53.0%; Read bytes: 36713472; Write bytes: 304562176; Read time: 227; Write time: 1115 23:30:33 INFO - Running post-run listener: _upload_blobber_files 23:30:33 INFO - Blob upload gear active. 23:30:33 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:30:33 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 23:30:33 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'] 23:30:33 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 23:30:34 INFO - (blobuploader) - INFO - Open directory for files ... 23:30:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 23:30:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:30:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:30:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 23:30:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:30:35 INFO - (blobuploader) - INFO - Done attempting. 23:30:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 23:30:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:30:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:30:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 23:30:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:30:36 INFO - (blobuploader) - INFO - Done attempting. 23:30:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 23:30:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:30:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:30:37 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 23:30:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:30:37 INFO - (blobuploader) - INFO - Done attempting. 23:30:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:30:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:30:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:30:39 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:30:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:30:39 INFO - (blobuploader) - INFO - Done attempting. 23:30:39 INFO - (blobuploader) - INFO - Iteration through files over. 23:30:39 INFO - Return code: 0 23:30:39 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:30:39 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:30:39 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3671bb2d71c95e283069e0ea20ddf95556c480984fc6ce43c2f7990fb3cdbcb11ae598d92cc4b9e4d283205c8d69e9a11b138b160a71860465295f9c8e6f2e76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fabb613c528c0e959e07150f6741f3c9231693a3e44ea4d11fc237cf2a76b70b4ad385b091397d2c8746fd90779841557a68e730cbcb990bcd9d8f401e6671d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/576cd14c597b7c0eebf6b7f53109aa0139fb81f3bf6e8c928536c5fffa8d170a1d8443ae9a7fb55608b6ba1904046f0677c6d6a0627f06a8b2657eab7dba6c6f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf78267d016ce3b91c0566481adc275c079258b779b57cd09e1e6442b02613208e341eacb436c00e443689f12deb16837f28925042fb8bf5c7788ace6147ef2a"} 23:30:39 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:30:39 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:30:39 INFO - Contents: 23:30:39 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3671bb2d71c95e283069e0ea20ddf95556c480984fc6ce43c2f7990fb3cdbcb11ae598d92cc4b9e4d283205c8d69e9a11b138b160a71860465295f9c8e6f2e76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fabb613c528c0e959e07150f6741f3c9231693a3e44ea4d11fc237cf2a76b70b4ad385b091397d2c8746fd90779841557a68e730cbcb990bcd9d8f401e6671d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/576cd14c597b7c0eebf6b7f53109aa0139fb81f3bf6e8c928536c5fffa8d170a1d8443ae9a7fb55608b6ba1904046f0677c6d6a0627f06a8b2657eab7dba6c6f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf78267d016ce3b91c0566481adc275c079258b779b57cd09e1e6442b02613208e341eacb436c00e443689f12deb16837f28925042fb8bf5c7788ace6147ef2a"} 23:30:39 INFO - Running post-run listener: copy_logs_to_upload_dir 23:30:39 INFO - Copying logs to upload dir... 23:30:39 INFO - mkdir: /builds/slave/test/build/upload/logs 23:30:39 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1291.360492 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2017-04-05 23:30:39.401612) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 23:30:39.407493) ========= 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.zUMJEQAPIZ/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.yxdLmYrbca/Listeners TMPDIR=/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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/3671bb2d71c95e283069e0ea20ddf95556c480984fc6ce43c2f7990fb3cdbcb11ae598d92cc4b9e4d283205c8d69e9a11b138b160a71860465295f9c8e6f2e76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fabb613c528c0e959e07150f6741f3c9231693a3e44ea4d11fc237cf2a76b70b4ad385b091397d2c8746fd90779841557a68e730cbcb990bcd9d8f401e6671d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/576cd14c597b7c0eebf6b7f53109aa0139fb81f3bf6e8c928536c5fffa8d170a1d8443ae9a7fb55608b6ba1904046f0677c6d6a0627f06a8b2657eab7dba6c6f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf78267d016ce3b91c0566481adc275c079258b779b57cd09e1e6442b02613208e341eacb436c00e443689f12deb16837f28925042fb8bf5c7788ace6147ef2a"} build_url:https://queue.taskcluster.net/v1/task/AA6IgIOpQrOXPnm6QBkTmQ/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011159 build_url: 'https://queue.taskcluster.net/v1/task/AA6IgIOpQrOXPnm6QBkTmQ/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/3671bb2d71c95e283069e0ea20ddf95556c480984fc6ce43c2f7990fb3cdbcb11ae598d92cc4b9e4d283205c8d69e9a11b138b160a71860465295f9c8e6f2e76", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1fabb613c528c0e959e07150f6741f3c9231693a3e44ea4d11fc237cf2a76b70b4ad385b091397d2c8746fd90779841557a68e730cbcb990bcd9d8f401e6671d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/576cd14c597b7c0eebf6b7f53109aa0139fb81f3bf6e8c928536c5fffa8d170a1d8443ae9a7fb55608b6ba1904046f0677c6d6a0627f06a8b2657eab7dba6c6f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf78267d016ce3b91c0566481adc275c079258b779b57cd09e1e6442b02613208e341eacb436c00e443689f12deb16837f28925042fb8bf5c7788ace6147ef2a"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-05 23:30:39.440863) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 23:30:39.441154) ========= 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.zUMJEQAPIZ/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.yxdLmYrbca/Listeners TMPDIR=/var/folders/sv/7xl3wp255lq9blb11pnmfnq000000w/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.005171 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-05 23:30:39.489749) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 23:30:39.490038) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-05 23:30:39.490349) ========= ========= Total master_lag: 0.17 =========