builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0269 starttime: 1491035856.26 results: success (0) buildid: 20170401004003 builduid: 3b93d9103b7a41f3a33e66ef532ea687 revision: 500c5e8ec870c4dfe84effdfe1bd92f0bba5cc7f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-01 01:37:36.263720) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-01 01:37:36.264200) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-01 01:37:36.264478) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-01 01:37:36.293089) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 01:37:36.293461) ========= 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.EV8fi2eAkc/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.Ue8xlMe4Md/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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-01 01:37:36-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 16.3M=0.001s 2017-04-01 01:37:36 (16.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.157480 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 01:37:36.475078) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 01:37:36.475405) ========= 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.EV8fi2eAkc/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.Ue8xlMe4Md/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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.026617 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 01:37:36.523774) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-01 01:37:36.524124) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 500c5e8ec870c4dfe84effdfe1bd92f0bba5cc7f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 500c5e8ec870c4dfe84effdfe1bd92f0bba5cc7f --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EV8fi2eAkc/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.Ue8xlMe4Md/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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-01 01:37:36,643 truncating revision to first 12 chars 2017-04-01 01:37:36,643 Setting DEBUG logging. 2017-04-01 01:37:36,643 attempt 1/10 2017-04-01 01:37:36,643 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/500c5e8ec870?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-01 01:37:37,425 unpacking tar archive at: mozilla-aurora-500c5e8ec870/testing/mozharness/ program finished with exit code 0 elapsedTime=1.063430 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-01 01:37:37.611307) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-01 01:37:37.611631) ========= script_repo_revision: 500c5e8ec870c4dfe84effdfe1bd92f0bba5cc7f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-01 01:37:37.612130) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-01 01:37:37.612415) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-01 01:37:37.632165) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2017-04-01 01:37:37.632527) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EV8fi2eAkc/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.Ue8xlMe4Md/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 01:37:37 INFO - MultiFileLogger online at 20170401 01:37:37 in /builds/slave/test 01:37:37 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 01:37:37 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:37:37 INFO - {'append_to_log': False, 01:37:37 INFO - 'base_work_dir': '/builds/slave/test', 01:37:37 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 01:37:37 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:37:37 INFO - 'branch': 'Mozilla-Aurora', 01:37:37 INFO - 'buildbot_json_path': 'buildprops.json', 01:37:37 INFO - 'config_files': ('talos/mac_config.py',), 01:37:37 INFO - 'default_actions': ('clobber', 01:37:37 INFO - 'read-buildbot-config', 01:37:37 INFO - 'download-and-extract', 01:37:37 INFO - 'populate-webroot', 01:37:37 INFO - 'create-virtualenv', 01:37:37 INFO - 'install', 01:37:37 INFO - 'run-tests'), 01:37:37 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:37:37 INFO - 'download_minidump_stackwalk': True, 01:37:37 INFO - 'download_symbols': 'ondemand', 01:37:37 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:37:37 INFO - 'tooltool.py': '/tools/tooltool.py', 01:37:37 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:37:37 INFO - '/tools/misc-python/virtualenv.py')}, 01:37:37 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:37:37 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:37:37 INFO - 'gecko_profile': False, 01:37:37 INFO - 'gecko_profile_interval': 0, 01:37:37 INFO - 'installer_path': 'installer.exe', 01:37:37 INFO - 'log_level': 'info', 01:37:37 INFO - 'log_name': 'talos', 01:37:37 INFO - 'log_to_console': True, 01:37:37 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:37:37 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:37:37 INFO - 'opt_config_files': (), 01:37:37 INFO - 'pip_index': False, 01:37:37 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:37:37 INFO - 'cmd': ('bash', 01:37:37 INFO - '-c', 01:37:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:37:37 INFO - 'enabled': True, 01:37:37 INFO - 'halt_on_failure': False, 01:37:37 INFO - 'name': 'check_screen_resolution'},), 01:37:37 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:37:37 INFO - 'cmd': ('bash', 01:37:37 INFO - '-c', 01:37:37 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:37:37 INFO - 'enabled': True, 01:37:37 INFO - 'halt_on_failure': False, 01:37:37 INFO - 'name': 'check_screen_resolution'},), 01:37:37 INFO - 'run_cmd_checks_enabled': True, 01:37:37 INFO - 'suite': 'dromaeojs', 01:37:37 INFO - 'system_bits': '32', 01:37:37 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:37:37 INFO - 'title': 't-yosemite-r7-0269', 01:37:37 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:37:37 INFO - 'use_talos_json': True, 01:37:37 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:37:37 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:37:37 INFO - 'work_dir': 'build'} 01:37:37 INFO - [mozharness: 2017-04-01 08:37:37.849542Z] Running clobber step. 01:37:37 INFO - Running pre-action listener: _resource_record_pre_action 01:37:37 INFO - Running main action method: clobber 01:37:37 INFO - rmtree: /builds/slave/test/build 01:37:37 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:37:40 INFO - Running post-action listener: _resource_record_post_action 01:37:40 INFO - [mozharness: 2017-04-01 08:37:40.220447Z] Finished clobber step (success) 01:37:40 INFO - [mozharness: 2017-04-01 08:37:40.220599Z] Running read-buildbot-config step. 01:37:40 INFO - Running pre-action listener: _resource_record_pre_action 01:37:40 INFO - Running main action method: read_buildbot_config 01:37:40 INFO - Using buildbot properties: 01:37:40 INFO - { 01:37:40 INFO - "project": "", 01:37:40 INFO - "product": "firefox", 01:37:40 INFO - "script_repo_revision": "production", 01:37:40 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 01:37:40 INFO - "repository": "", 01:37:40 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 01:37:40 INFO - "buildid": "20170401004003", 01:37:40 INFO - "stage_platform": "macosx64", 01:37:40 INFO - "basedir": "/builds/slave/test", 01:37:40 INFO - "nightly_build": "True", 01:37:40 INFO - "buildnumber": 14, 01:37:40 INFO - "slavename": "t-yosemite-r7-0269", 01:37:40 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 01:37:40 INFO - "platform": "yosemite_r7", 01:37:40 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 01:37:40 INFO - "branch": "mozilla-aurora", 01:37:40 INFO - "repo_path": "releases/mozilla-aurora", 01:37:40 INFO - "revision": "500c5e8ec870c4dfe84effdfe1bd92f0bba5cc7f", 01:37:40 INFO - "pgo_build": "False", 01:37:40 INFO - "builduid": "3b93d9103b7a41f3a33e66ef532ea687", 01:37:40 INFO - "slavebuilddir": "test" 01:37:40 INFO - } 01:37:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/JP1W0odGTwi9rS1uBTyndA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 01:37:40 INFO - Running post-action listener: _resource_record_post_action 01:37:40 INFO - [mozharness: 2017-04-01 08:37:40.223966Z] Finished read-buildbot-config step (success) 01:37:40 INFO - [mozharness: 2017-04-01 08:37:40.224100Z] Running download-and-extract step. 01:37:40 INFO - Running pre-action listener: _resource_record_pre_action 01:37:40 INFO - Running main action method: download_and_extract 01:37:40 INFO - mkdir: /builds/slave/test/build/tests 01:37:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:37:40 INFO - trying https://queue.taskcluster.net/v1/task/JP1W0odGTwi9rS1uBTyndA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 01:37:40 INFO - Downloading https://queue.taskcluster.net/v1/task/JP1W0odGTwi9rS1uBTyndA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 01:37:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JP1W0odGTwi9rS1uBTyndA/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json'}, attempt #1 01:37:41 INFO - Downloaded 1199 bytes. 01:37:41 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 01:37:41 INFO - Using the following test package requirements: 01:37:41 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 01:37:41 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:37:41 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 01:37:41 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:37:41 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 01:37:41 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:37:41 INFO - u'jsshell-mac.zip'], 01:37:41 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:37:41 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 01:37:41 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 01:37:41 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:37:41 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 01:37:41 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:37:41 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 01:37:41 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:37:41 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 01:37:41 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 01:37:41 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 01:37:41 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 01:37:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JP1W0odGTwi9rS1uBTyndA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 01:37:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JP1W0odGTwi9rS1uBTyndA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:37:41 INFO - Fetch https://queue.taskcluster.net/v1/task/JP1W0odGTwi9rS1uBTyndA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 01:37:43 INFO - Expected file size: 51789106 01:37:43 INFO - Obtained file size: 51789106 01:37:59 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip', u'firefox-54.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 01:37:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JP1W0odGTwi9rS1uBTyndA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 01:37:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JP1W0odGTwi9rS1uBTyndA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 01:37:59 INFO - Fetch https://queue.taskcluster.net/v1/task/JP1W0odGTwi9rS1uBTyndA/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 01:38:01 INFO - Expected file size: 51789106 01:38:01 INFO - Obtained file size: 51789106 01:38:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/JP1W0odGTwi9rS1uBTyndA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 01:38:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/JP1W0odGTwi9rS1uBTyndA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 01:38:16 INFO - Fetch https://queue.taskcluster.net/v1/task/JP1W0odGTwi9rS1uBTyndA/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 01:38:17 INFO - Expected file size: 14404438 01:38:17 INFO - Obtained file size: 14404438 01:38:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:18 INFO - trying https://queue.taskcluster.net/v1/task/JP1W0odGTwi9rS1uBTyndA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:38:18 INFO - Downloading https://queue.taskcluster.net/v1/task/JP1W0odGTwi9rS1uBTyndA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 01:38:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/JP1W0odGTwi9rS1uBTyndA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg'}, attempt #1 01:38:20 INFO - Downloaded 74751529 bytes. 01:38:20 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JP1W0odGTwi9rS1uBTyndA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:38:20 INFO - mkdir: /builds/slave/test/properties 01:38:20 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:38:20 INFO - Writing to file /builds/slave/test/properties/build_url 01:38:20 INFO - Contents: 01:38:20 INFO - build_url:https://queue.taskcluster.net/v1/task/JP1W0odGTwi9rS1uBTyndA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 01:38:21 INFO - Running post-action listener: _resource_record_post_action 01:38:21 INFO - Running post-action listener: set_extra_try_arguments 01:38:21 INFO - [mozharness: 2017-04-01 08:38:21.171092Z] Finished download-and-extract step (success) 01:38:21 INFO - [mozharness: 2017-04-01 08:38:21.171240Z] Running populate-webroot step. 01:38:21 INFO - Running pre-action listener: _resource_record_pre_action 01:38:21 INFO - Running main action method: populate_webroot 01:38:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:38:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:38:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:38:21 INFO - '--tppagecycles', 01:38:21 INFO - '7'], 01:38:21 INFO - 'tests': ['tsvgm']}}, 01:38:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:38:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:38:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:38:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:38:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:38:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:38:21 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 01:38:21 INFO - 'talos_options': ['--disable-e10s'], 01:38:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:38:21 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 01:38:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:38:21 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 01:38:21 INFO - 'talos_options': ['--disable-e10s'], 01:38:21 INFO - 'tests': ['damp', 'tps']}, 01:38:21 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 01:38:21 INFO - 'tests': ['damp', 'tps']}, 01:38:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:38:21 INFO - 'tests': ['dromaeo_dom']}, 01:38:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:38:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:38:21 INFO - 'tests': ['basic_compositor_video']}, 01:38:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:38:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:38:21 INFO - 'tests': ['a11yr', 01:38:21 INFO - 'ts_paint', 01:38:21 INFO - 'tpaint', 01:38:21 INFO - 'sessionrestore', 01:38:21 INFO - 'sessionrestore_no_auto_restore', 01:38:21 INFO - 'tabpaint']}, 01:38:21 INFO - 'other-e10s': {'tests': ['a11yr', 01:38:21 INFO - 'ts_paint', 01:38:21 INFO - 'tpaint', 01:38:21 INFO - 'sessionrestore', 01:38:21 INFO - 'sessionrestore_no_auto_restore', 01:38:21 INFO - 'tabpaint']}, 01:38:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:38:21 INFO - 'ts_paint', 01:38:21 INFO - 'tpaint', 01:38:21 INFO - 'sessionrestore', 01:38:21 INFO - 'sessionrestore_no_auto_restore', 01:38:21 INFO - 'tabpaint']}, 01:38:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:38:21 INFO - 'ts_paint', 01:38:21 INFO - 'tpaint', 01:38:21 INFO - 'sessionrestore', 01:38:21 INFO - 'sessionrestore_no_auto_restore', 01:38:21 INFO - 'tabpaint']}, 01:38:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:38:21 INFO - 'tests': ['a11yr', 01:38:21 INFO - 'ts_paint', 01:38:21 INFO - 'tpaint', 01:38:21 INFO - 'sessionrestore', 01:38:21 INFO - 'sessionrestore_no_auto_restore', 01:38:21 INFO - 'tabpaint']}, 01:38:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:38:21 INFO - 'tests': ['a11yr', 01:38:21 INFO - 'ts_paint', 01:38:21 INFO - 'tpaint', 01:38:21 INFO - 'sessionrestore', 01:38:21 INFO - 'sessionrestore_no_auto_restore', 01:38:21 INFO - 'tabpaint']}, 01:38:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:38:21 INFO - 'tests': ['tsvgx', 01:38:21 INFO - 'tsvgr_opacity', 01:38:21 INFO - 'tart', 01:38:21 INFO - 'tscrollx', 01:38:21 INFO - 'cart', 01:38:21 INFO - 'tsvg_static']}, 01:38:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:38:21 INFO - 'tsvgr_opacity', 01:38:21 INFO - 'tart', 01:38:21 INFO - 'tscrollx', 01:38:21 INFO - 'cart', 01:38:21 INFO - 'tsvg_static']}, 01:38:21 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 01:38:21 INFO - 'talos_options': ['--disable-e10s'], 01:38:21 INFO - 'tests': ['tp5o']}, 01:38:21 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 01:38:21 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 01:38:21 INFO - 'talos_options': ['--disable-e10s', 01:38:21 INFO - '--xperf_path', 01:38:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:38:21 INFO - 'tests': ['tp5n']}, 01:38:21 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 01:38:21 INFO - 'talos_options': ['--xperf_path', 01:38:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:38:21 INFO - 'tests': ['tp5n']}}, 01:38:21 INFO - 'talos.zip': {'path': '', 01:38:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:38:21 INFO - Running post-action listener: _resource_record_post_action 01:38:21 INFO - [mozharness: 2017-04-01 08:38:21.189636Z] Finished populate-webroot step (success) 01:38:21 INFO - [mozharness: 2017-04-01 08:38:21.189773Z] Running create-virtualenv step. 01:38:21 INFO - Running pre-action listener: _resource_record_pre_action 01:38:21 INFO - Running main action method: create_virtualenv 01:38:21 INFO - Creating virtualenv /builds/slave/test/build/venv 01:38:21 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:38:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:38:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:38:21 INFO - Using real prefix '/tools/python27' 01:38:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:38:22 INFO - Installing distribute.............................................................................................................................................................................................done. 01:38:24 INFO - Installing pip.................done. 01:38:24 INFO - Return code: 0 01:38:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:38:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:38:25 INFO - Reading from file tmpfile_stdout 01:38:25 INFO - Output received: 01:38:25 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 01:38:25 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:38: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')]} 01:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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')]} 01:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1037c4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa414e55e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035a2d30>, '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 0x1034c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103597be8>, '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.EV8fi2eAkc/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.Ue8xlMe4Md/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:38: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', 'pip>=1.5'] in /builds/slave/test/build 01:38: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 pip>=1.5 01:38:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EV8fi2eAkc/Render', 01:38:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:25 INFO - 'HOME': '/Users/cltbld', 01:38:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:25 INFO - 'LOGNAME': 'cltbld', 01:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:25 INFO - 'MOZ_NO_REMOTE': '1', 01:38:25 INFO - 'NO_EM_RESTART': '1', 01:38:25 INFO - 'PAGER': '/bin/cat', 01:38:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:25 INFO - 'PWD': '/builds/slave/test', 01:38:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:25 INFO - 'SHELL': '/bin/bash', 01:38:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ue8xlMe4Md/Listeners', 01:38:25 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 01:38:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:25 INFO - 'USER': 'cltbld', 01:38:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:25 INFO - 'XPC_FLAGS': '0x0', 01:38:25 INFO - 'XPC_SERVICE_NAME': '0', 01:38:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:25 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:38:25 INFO - Cleaning up... 01:38:25 INFO - Return code: 0 01:38:25 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:38: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')]} 01:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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')]} 01:38:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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', '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 0x1037c4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa414e55e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035a2d30>, '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 0x1034c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103597be8>, '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.EV8fi2eAkc/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.Ue8xlMe4Md/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:38: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', 'psutil>=3.1.1'] in /builds/slave/test/build 01:38: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 psutil>=3.1.1 01:38:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EV8fi2eAkc/Render', 01:38:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:25 INFO - 'HOME': '/Users/cltbld', 01:38:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:25 INFO - 'LOGNAME': 'cltbld', 01:38:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:25 INFO - 'MOZ_NO_REMOTE': '1', 01:38:25 INFO - 'NO_EM_RESTART': '1', 01:38:25 INFO - 'PAGER': '/bin/cat', 01:38:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:25 INFO - 'PWD': '/builds/slave/test', 01:38:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:25 INFO - 'SHELL': '/bin/bash', 01:38:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ue8xlMe4Md/Listeners', 01:38:25 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 01:38:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:25 INFO - 'USER': 'cltbld', 01:38:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:25 INFO - 'XPC_FLAGS': '0x0', 01:38:25 INFO - 'XPC_SERVICE_NAME': '0', 01:38:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:25 INFO - Downloading/unpacking psutil>=3.1.1 01:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:38:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:38:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:38:30 INFO - Installing collected packages: psutil 01:38:30 INFO - Running setup.py install for psutil 01:38:30 INFO - building 'psutil._psutil_osx' extension 01:38:30 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 01:38:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 01:38:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 01:38:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 01:38:31 INFO - building 'psutil._psutil_posix' extension 01:38:31 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 01:38:31 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:38:31 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:38:31 INFO - ^ 01:38:31 INFO - 1 warning generated. 01:38:31 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 01:38:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:38:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:38:31 INFO - Successfully installed psutil 01:38:31 INFO - Cleaning up... 01:38:31 INFO - Return code: 0 01:38:31 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:31 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 0x1037c4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa414e55e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035a2d30>, '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 0x1034c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103597be8>, '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.EV8fi2eAkc/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.Ue8xlMe4Md/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:38:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:38:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:38:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EV8fi2eAkc/Render', 01:38:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:31 INFO - 'HOME': '/Users/cltbld', 01:38:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:31 INFO - 'LOGNAME': 'cltbld', 01:38:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:31 INFO - 'MOZ_NO_REMOTE': '1', 01:38:31 INFO - 'NO_EM_RESTART': '1', 01:38:31 INFO - 'PAGER': '/bin/cat', 01:38:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:31 INFO - 'PWD': '/builds/slave/test', 01:38:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:31 INFO - 'SHELL': '/bin/bash', 01:38:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ue8xlMe4Md/Listeners', 01:38:31 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 01:38:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:31 INFO - 'USER': 'cltbld', 01:38:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:31 INFO - 'XPC_FLAGS': '0x0', 01:38:31 INFO - 'XPC_SERVICE_NAME': '0', 01:38:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:31 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:38:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:38:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:38:34 INFO - Installing collected packages: mozsystemmonitor 01:38:34 INFO - Running setup.py install for mozsystemmonitor 01:38:34 INFO - Successfully installed mozsystemmonitor 01:38:34 INFO - Cleaning up... 01:38:34 INFO - Return code: 0 01:38:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1037c4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa414e55e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035a2d30>, '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 0x1034c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103597be8>, '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.EV8fi2eAkc/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.Ue8xlMe4Md/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:38:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:38:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:38:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EV8fi2eAkc/Render', 01:38:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:34 INFO - 'HOME': '/Users/cltbld', 01:38:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:34 INFO - 'LOGNAME': 'cltbld', 01:38:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:34 INFO - 'MOZ_NO_REMOTE': '1', 01:38:34 INFO - 'NO_EM_RESTART': '1', 01:38:34 INFO - 'PAGER': '/bin/cat', 01:38:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:34 INFO - 'PWD': '/builds/slave/test', 01:38:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:34 INFO - 'SHELL': '/bin/bash', 01:38:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ue8xlMe4Md/Listeners', 01:38:34 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 01:38:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:34 INFO - 'USER': 'cltbld', 01:38:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:34 INFO - 'XPC_FLAGS': '0x0', 01:38:34 INFO - 'XPC_SERVICE_NAME': '0', 01:38:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:35 INFO - Downloading/unpacking jsonschema==2.5.1 01:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:35 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:35 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:35 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:35 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:39 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:38:39 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:39 INFO - Downloading functools32-3.2.3-2.tar.gz 01:38:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:38:40 INFO - warning: no files found matching '*.txt' 01:38:40 INFO - no previously-included directories found matching 'build' 01:38:40 INFO - no previously-included directories found matching 'dist' 01:38:40 INFO - no previously-included directories found matching '.git*' 01:38:40 INFO - Installing collected packages: jsonschema, functools32 01:38:40 INFO - Running setup.py install for functools32 01:38:40 INFO - warning: no files found matching '*.txt' 01:38:40 INFO - no previously-included directories found matching 'build' 01:38:40 INFO - no previously-included directories found matching 'dist' 01:38:40 INFO - no previously-included directories found matching '.git*' 01:38:40 INFO - Successfully installed jsonschema functools32 01:38:40 INFO - Cleaning up... 01:38:40 INFO - Return code: 0 01:38:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1037c4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa414e55e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035a2d30>, '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 0x1034c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103597be8>, '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.EV8fi2eAkc/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.Ue8xlMe4Md/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:38:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 01:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 01:38:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EV8fi2eAkc/Render', 01:38:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:40 INFO - 'HOME': '/Users/cltbld', 01:38:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:40 INFO - 'LOGNAME': 'cltbld', 01:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:40 INFO - 'MOZ_NO_REMOTE': '1', 01:38:40 INFO - 'NO_EM_RESTART': '1', 01:38:40 INFO - 'PAGER': '/bin/cat', 01:38:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:40 INFO - 'PWD': '/builds/slave/test', 01:38:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:40 INFO - 'SHELL': '/bin/bash', 01:38:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ue8xlMe4Md/Listeners', 01:38:40 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 01:38:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:40 INFO - 'USER': 'cltbld', 01:38:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:40 INFO - 'XPC_FLAGS': '0x0', 01:38:40 INFO - 'XPC_SERVICE_NAME': '0', 01:38:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:38:40 INFO - Cleaning up... 01:38:40 INFO - Return code: 0 01:38:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1037c4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa414e55e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035a2d30>, '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 0x1034c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103597be8>, '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.EV8fi2eAkc/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.Ue8xlMe4Md/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:38:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:38:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EV8fi2eAkc/Render', 01:38:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:40 INFO - 'HOME': '/Users/cltbld', 01:38:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:40 INFO - 'LOGNAME': 'cltbld', 01:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:40 INFO - 'MOZ_NO_REMOTE': '1', 01:38:40 INFO - 'NO_EM_RESTART': '1', 01:38:40 INFO - 'PAGER': '/bin/cat', 01:38:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:40 INFO - 'PWD': '/builds/slave/test', 01:38:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:40 INFO - 'SHELL': '/bin/bash', 01:38:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ue8xlMe4Md/Listeners', 01:38:40 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 01:38:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:40 INFO - 'USER': 'cltbld', 01:38:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:40 INFO - 'XPC_FLAGS': '0x0', 01:38:40 INFO - 'XPC_SERVICE_NAME': '0', 01:38:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:40 INFO - Downloading/unpacking blobuploader==1.2.4 01:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:43 INFO - Downloading blobuploader-1.2.4.tar.gz 01:38:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:38:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:38:44 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:45 INFO - Downloading docopt-0.6.1.tar.gz 01:38:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:38:45 INFO - Installing collected packages: blobuploader, requests, docopt 01:38:45 INFO - Running setup.py install for blobuploader 01:38:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:38:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:38:45 INFO - Running setup.py install for requests 01:38:45 INFO - Running setup.py install for docopt 01:38:46 INFO - Successfully installed blobuploader requests docopt 01:38:46 INFO - Cleaning up... 01:38:46 INFO - Return code: 0 01:38:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:38: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')]} 01:38:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38: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')]} 01:38:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:46 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 0x1037c4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa414e55e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035a2d30>, '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 0x1034c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103597be8>, '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.EV8fi2eAkc/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.Ue8xlMe4Md/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:38:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:38:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:38:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EV8fi2eAkc/Render', 01:38:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:46 INFO - 'HOME': '/Users/cltbld', 01:38:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:46 INFO - 'LOGNAME': 'cltbld', 01:38:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:46 INFO - 'MOZ_NO_REMOTE': '1', 01:38:46 INFO - 'NO_EM_RESTART': '1', 01:38:46 INFO - 'PAGER': '/bin/cat', 01:38:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:46 INFO - 'PWD': '/builds/slave/test', 01:38:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:46 INFO - 'SHELL': '/bin/bash', 01:38:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ue8xlMe4Md/Listeners', 01:38:46 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 01:38:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:46 INFO - 'USER': 'cltbld', 01:38:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:46 INFO - 'XPC_FLAGS': '0x0', 01:38:46 INFO - 'XPC_SERVICE_NAME': '0', 01:38:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:38:46 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-QdXQqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:38:46 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-ZYPh0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:38:46 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-wItMN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:38:46 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-mOlkSG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:38:46 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-KSYY2k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:38:46 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-HyASBp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:38:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:38:46 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-MzcZtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:38:47 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-wdUX46-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:38:47 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-IbCm_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:38:47 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-xT2ZG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:38:47 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-I5OrND-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:38:47 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-MrkqWL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:38:47 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-nmEJq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:38:47 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-mcwDh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:38:47 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-A3LZNm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:38:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:38:47 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-RbG1P9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:38:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:38:48 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-f3lAs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:38:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:38:48 INFO - Running setup.py install for manifestparser 01:38:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:38:48 INFO - Running setup.py install for mozcrash 01:38:48 INFO - Running setup.py install for mozdebug 01:38:48 INFO - Running setup.py install for mozdevice 01:38:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:38:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:38:48 INFO - Running setup.py install for mozfile 01:38:48 INFO - Running setup.py install for mozhttpd 01:38:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:38:49 INFO - Running setup.py install for mozinfo 01:38:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:38:49 INFO - Running setup.py install for mozInstall 01:38:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:38:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:38:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:38:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:38:49 INFO - Running setup.py install for mozleak 01:38:49 INFO - Running setup.py install for mozlog 01:38:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:38:49 INFO - Running setup.py install for moznetwork 01:38:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:38:49 INFO - Running setup.py install for mozprocess 01:38:49 INFO - Running setup.py install for mozprofile 01:38:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:38:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:38:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:38:50 INFO - Running setup.py install for mozrunner 01:38:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:38:50 INFO - Running setup.py install for mozscreenshot 01:38:50 INFO - Running setup.py install for moztest 01:38:50 INFO - Running setup.py install for mozversion 01:38:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:38:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:38:50 INFO - Cleaning up... 01:38:50 INFO - Return code: 0 01:38:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:38:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:50 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 0x1037c4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa414e55e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035a2d30>, '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 0x1034c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103597be8>, '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.EV8fi2eAkc/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.Ue8xlMe4Md/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:38:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:38:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:38:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EV8fi2eAkc/Render', 01:38:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:50 INFO - 'HOME': '/Users/cltbld', 01:38:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:50 INFO - 'LOGNAME': 'cltbld', 01:38:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:50 INFO - 'MOZ_NO_REMOTE': '1', 01:38:50 INFO - 'NO_EM_RESTART': '1', 01:38:50 INFO - 'PAGER': '/bin/cat', 01:38:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:50 INFO - 'PWD': '/builds/slave/test', 01:38:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:50 INFO - 'SHELL': '/bin/bash', 01:38:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ue8xlMe4Md/Listeners', 01:38:50 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 01:38:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:50 INFO - 'USER': 'cltbld', 01:38:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:50 INFO - 'XPC_FLAGS': '0x0', 01:38:50 INFO - 'XPC_SERVICE_NAME': '0', 01:38:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:38:50 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-G0wwOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:38:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:38:51 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-tF1u9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:38:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:38:51 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-l_nkjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:38:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:38:51 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-Hrb4vs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:38:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:38:51 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-0PpgBk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:38:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:38:51 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-W0tvER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:38:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:38:51 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-Z5xjd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:38:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:38:51 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-doG7TP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:38:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:38:51 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-su04qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:38:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:38:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:38:51 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-LIg4DQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:38:52 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-wj02Zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:38:52 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-mPi4Uc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:38:52 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-01jxGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:38:52 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-zPWrBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:38:52 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-baXJMY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:38:52 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-6hWOr1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:38:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:38:52 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-XCdjg3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:38:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:38:52 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:59 INFO - Downloading blessings-1.6.tar.gz 01:38:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:39:00 INFO - Installing collected packages: blessings 01:39:00 INFO - Running setup.py install for blessings 01:39:00 INFO - Successfully installed blessings 01:39:00 INFO - Cleaning up... 01:39:00 INFO - Return code: 0 01:39:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:39:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:39:00 INFO - Reading from file tmpfile_stdout 01:39:00 INFO - Current package versions: 01:39:00 INFO - blessings == 1.6 01:39:00 INFO - blobuploader == 1.2.4 01:39:00 INFO - docopt == 0.6.1 01:39:00 INFO - functools32 == 3.2.3-2 01:39:00 INFO - jsonschema == 2.5.1 01:39:00 INFO - manifestparser == 1.1 01:39:00 INFO - mozInstall == 1.12 01:39:00 INFO - mozcrash == 1.0 01:39:00 INFO - mozdebug == 0.1 01:39:00 INFO - mozdevice == 0.49 01:39:00 INFO - mozfile == 1.2 01:39:00 INFO - mozhttpd == 0.7 01:39:00 INFO - mozinfo == 0.9 01:39:00 INFO - mozleak == 0.1 01:39:00 INFO - mozlog == 3.4 01:39:00 INFO - moznetwork == 0.27 01:39:00 INFO - mozprocess == 0.25 01:39:00 INFO - mozprofile == 0.28 01:39:00 INFO - mozrunner == 6.13 01:39:00 INFO - mozscreenshot == 0.1 01:39:00 INFO - mozsystemmonitor == 0.3 01:39:00 INFO - moztest == 0.8 01:39:00 INFO - mozversion == 1.4 01:39:00 INFO - psutil == 3.1.1 01:39:00 INFO - requests == 1.2.3 01:39:00 INFO - wsgiref == 0.1.2 01:39:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:00 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 0x1037c4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa414e55e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035a2d30>, '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 0x1034c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103597be8>, '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.EV8fi2eAkc/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.Ue8xlMe4Md/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:39:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:39:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EV8fi2eAkc/Render', 01:39:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:39:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:39:00 INFO - 'HOME': '/Users/cltbld', 01:39:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:39:00 INFO - 'LOGNAME': 'cltbld', 01:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:39:00 INFO - 'MOZ_NO_REMOTE': '1', 01:39:00 INFO - 'NO_EM_RESTART': '1', 01:39:00 INFO - 'PAGER': '/bin/cat', 01:39:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:39:00 INFO - 'PWD': '/builds/slave/test', 01:39:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:39:00 INFO - 'SHELL': '/bin/bash', 01:39:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ue8xlMe4Md/Listeners', 01:39:00 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 01:39:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:39:00 INFO - 'USER': 'cltbld', 01:39:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:39:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:39:00 INFO - 'XPC_FLAGS': '0x0', 01:39:00 INFO - 'XPC_SERVICE_NAME': '0', 01:39:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:39:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:39:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:39:00 INFO - Cleaning up... 01:39:00 INFO - Return code: 0 01:39:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:39:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:39:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:39:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:39:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:39:00 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 0x1037c4b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1037c7768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffa414e55e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035a2d30>, '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 0x1034c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103597be8>, '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.EV8fi2eAkc/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.Ue8xlMe4Md/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:39:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:39:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EV8fi2eAkc/Render', 01:39:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:39:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:39:00 INFO - 'HOME': '/Users/cltbld', 01:39:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:39:00 INFO - 'LOGNAME': 'cltbld', 01:39:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:39:00 INFO - 'MOZ_NO_REMOTE': '1', 01:39:00 INFO - 'NO_EM_RESTART': '1', 01:39:00 INFO - 'PAGER': '/bin/cat', 01:39:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:39:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:39:00 INFO - 'PWD': '/builds/slave/test', 01:39:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:39:00 INFO - 'SHELL': '/bin/bash', 01:39:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ue8xlMe4Md/Listeners', 01:39:00 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 01:39:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:39:00 INFO - 'USER': 'cltbld', 01:39:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:39:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:39:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:39:00 INFO - 'XPC_FLAGS': '0x0', 01:39:00 INFO - 'XPC_SERVICE_NAME': '0', 01:39:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:39:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:39:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:39:01 INFO - Cleaning up... 01:39:01 INFO - Return code: 0 01:39:01 INFO - Running post-action listener: _resource_record_post_action 01:39:01 INFO - Running post-action listener: _start_resource_monitoring 01:39:01 INFO - Starting resource monitoring. 01:39:01 INFO - [mozharness: 2017-04-01 08:39:01.127617Z] Finished create-virtualenv step (success) 01:39:01 INFO - [mozharness: 2017-04-01 08:39:01.128580Z] Running install step. 01:39:01 INFO - Running pre-action listener: _resource_record_pre_action 01:39:01 INFO - Running main action method: install 01:39:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:39:01 INFO - Reading from file tmpfile_stdout 01:39:01 INFO - Detecting whether we're running mozinstall >=1.0... 01:39:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:39:01 INFO - Reading from file tmpfile_stdout 01:39:01 INFO - Output received: 01:39:01 INFO - Usage: mozinstall [options] installer 01:39:01 INFO - Options: 01:39:01 INFO - -h, --help show this help message and exit 01:39:01 INFO - -d DEST, --destination=DEST 01:39:01 INFO - Directory to install application into. [default: 01:39:01 INFO - "/builds/slave/test"] 01:39:01 INFO - --app=APP Application being installed. [default: firefox] 01:39:01 INFO - mkdir: /builds/slave/test/build/application 01:39:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:39:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 01:39:21 INFO - Reading from file tmpfile_stdout 01:39:21 INFO - Output received: 01:39:21 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 01:39:21 INFO - Running post-action listener: _resource_record_post_action 01:39:21 INFO - [mozharness: 2017-04-01 08:39:21.602574Z] Finished install step (success) 01:39:21 INFO - [mozharness: 2017-04-01 08:39:21.602701Z] Running run-tests step. 01:39:21 INFO - Running pre-action listener: _resource_record_pre_action 01:39:21 INFO - Running main action method: run_tests 01:39:21 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:39:21 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:39:21 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:39:21 INFO - 2017-04-01 01:39:21.617 screenresolution[1636:9303] starting screenresolution argv=screenresolution get 01:39:21 INFO - 2017-04-01 01:39:21.619 screenresolution[1636:9303] Display 0: 1600x1200x32@60 01:39:21 INFO - 2017-04-01 01:39:21.625 screenresolution[1637:9306] starting screenresolution argv=screenresolution list 01:39:21 INFO - Available Modes on Display 0 01:39:21 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:39:21 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:39:21 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:39:21 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:39:21 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:39:21 INFO - Intel Iris: 01:39:21 INFO - Chipset Model: Intel Iris 01:39:21 INFO - Type: GPU 01:39:21 INFO - Bus: Built-In 01:39:21 INFO - VRAM (Dynamic, Max): 1536 MB 01:39:21 INFO - Vendor: Intel (0x8086) 01:39:21 INFO - Device ID: 0x0a2e 01:39:21 INFO - Revision ID: 0x0009 01:39:21 INFO - Displays: 01:39:21 INFO - Display: 01:39:21 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:39:21 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:39:21 INFO - Display Serial Number: 1600x1200 60 01:39:21 INFO - Main Display: Yes 01:39:21 INFO - Mirror: Off 01:39:21 INFO - Online: Yes 01:39:21 INFO - Rotation: Supported 01:39:21 INFO - Return code: 0 01:39:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:39:21 INFO - Python 2.7.3 01:39:21 INFO - Return code: 0 01:39:21 INFO - grabbing minidump binary from tooltool 01:39:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:39:21 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 0x1035a2d30>, '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 0x1034c9db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103597be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:39:21 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:39:21 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 01:39:21 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 01:39:21 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:39:21 INFO - Return code: 0 01:39:21 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:39:21 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:39:21 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:39:21 INFO - ENV: RUST_BACKTRACE is now 1 01:39:21 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:39:21 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:39:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JP1W0odGTwi9rS1uBTyndA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0269', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:39:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JP1W0odGTwi9rS1uBTyndA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0269 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:39:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EV8fi2eAkc/Render', 01:39:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:39:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:39:21 INFO - 'HOME': '/Users/cltbld', 01:39:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:39:21 INFO - 'LOGNAME': 'cltbld', 01:39:21 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:39:21 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:39:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:39:21 INFO - 'MOZ_NO_REMOTE': '1', 01:39:21 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:39:21 INFO - 'NO_EM_RESTART': '1', 01:39:21 INFO - 'PAGER': '/bin/cat', 01:39:21 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:39:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:39:21 INFO - 'PWD': '/builds/slave/test', 01:39:21 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:39:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:39:21 INFO - 'RUST_BACKTRACE': '1', 01:39:22 INFO - 'SHELL': '/bin/bash', 01:39:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Ue8xlMe4Md/Listeners', 01:39:22 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 01:39:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:39:22 INFO - 'USER': 'cltbld', 01:39:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:39:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:39:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:39:22 INFO - 'XPC_FLAGS': '0x0', 01:39:22 INFO - 'XPC_SERVICE_NAME': '0', 01:39:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:39:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JP1W0odGTwi9rS1uBTyndA/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0269', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:39:22 INFO - mozversion application_buildid: 20170401004003 01:39:22 INFO - mozversion application_changeset: 500c5e8ec870c4dfe84effdfe1bd92f0bba5cc7f 01:39:22 INFO - mozversion application_display_name: FirefoxDeveloperEdition 01:39:22 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:39:22 INFO - mozversion application_name: Firefox 01:39:22 INFO - mozversion application_remotingname: firefox-dev 01:39:22 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:39:22 INFO - mozversion application_vendor: Mozilla 01:39:22 INFO - mozversion application_version: 54.0a2 01:39:22 INFO - mozversion platform_buildid: 20170401004003 01:39:22 INFO - mozversion platform_changeset: 500c5e8ec870c4dfe84effdfe1bd92f0bba5cc7f 01:39:22 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 01:39:22 INFO - mozversion platform_version: 54.0a2 01:39:22 INFO - using testdate: 1491035962 01:39:22 INFO - actual date: 1491035962 01:39:22 INFO - starting webserver on 'localhost:49236' 01:39:22 INFO - SUITE-START | Running 2 tests 01:39:22 INFO - TEST-START | dromaeo_css 01:39:22 INFO - operating with platform_type : mac_ 01:39:22 INFO - Initialising browser for dromaeo_css test... 01:39:22 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpaswYsf/profile http://localhost:49236/getInfo.html) 01:39:24 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 01:39:24 INFO - PROCESS | 1647 | colorDepth:24 01:39:24 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 01:39:24 INFO - PROCESS | 1647 | __metrics 01:39:24 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:39:24 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:39:25 INFO - TEST-INFO | 1647: exit 0 01:39:25 INFO - Browser initialized. 01:39:25 INFO - Running cycle 1/1 for dromaeo_css test... 01:39:25 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpaswYsf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:39:37 INFO - PROCESS | 1651 | RSS: Main: 215293952 01:39:37 INFO - PROCESS | 1651 | 01:42:41 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49236/tests/dromaeo/cssquery-ext.html) 01:42:43 INFO - PROCESS | 1651 | RSS: Main: 353013760 01:42:43 INFO - PROCESS | 1651 | 01:44:27 INFO - PROCESS | 1651 | ************************* 01:44:27 INFO - PROCESS | 1651 | A coding exception was thrown and uncaught in a Task. 01:44:27 INFO - PROCESS | 1651 | 01:44:27 ERROR - PROCESS | 1651 | Full message: TypeError: NetworkError when attempting to fetch resource. 01:44:27 INFO - PROCESS | 1651 | Full stack: 01:44:27 INFO - PROCESS | 1651 | ************************* 01:45:46 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-ext.html (next: http://localhost:49236/tests/dromaeo/cssquery-jquery.html) 01:45:47 INFO - PROCESS | 1651 | RSS: Main: 349626368 01:45:47 INFO - PROCESS | 1651 | 01:48:50 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49236/tests/dromaeo/cssquery-mootools.html) 01:48:50 INFO - PROCESS | 1651 | RSS: Main: 329678848 01:48:50 INFO - PROCESS | 1651 | 01:51:53 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49236/tests/dromaeo/cssquery-prototype.html) 01:51:53 INFO - PROCESS | 1651 | RSS: Main: 347570176 01:51:53 INFO - PROCESS | 1651 | 01:54:57 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49236/tests/dromaeo/cssquery-yui.html) 01:54:58 INFO - PROCESS | 1651 | RSS: Main: 320995328 01:54:58 INFO - PROCESS | 1651 | 01:58:01 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49236/tests/dromaeo/cssquery-yui.html (next: http://localhost:49236/tests/dromaeo/cssquery-dojo.html) 01:58:01 INFO - PROCESS | 1651 | RSS: Main: 576094208 01:58:01 INFO - PROCESS | 1651 | 01:58:01 INFO - PROCESS | 1651 | __start_tp_report 01:58:01 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 01:58:01 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 01:58:01 INFO - PROCESS | 1651 | |i|pagename|runs| 01:58:01 INFO - PROCESS | 1651 | |0;dojo.html;3404.676555727205;3421.7262618990467;3423.7603367764254;3425.6574342565737;3465.688088072073;6023.277206735198;6024.060389985464;6058.909116363247;6081.695915204239;6116.785912493064;6001.129836173752;6071.817845464632;6076.574639775217;6088.117223002662;6092.725827337769;5369.301990741208;5400.189971504266;5425.83722488326;5428.647137936041;5505.862353441156;4634.930476042862;5277.182036784305;5327.706976116312;5402.540784033342;5506.174073888928;5337.5196232339085;5389.137737961927;5418.810341638024;5425.9728701356635;5428.891422171554;5414.8917021659345;5415.512603865671;5418.051840927822;5418.8916221675545;5425.13197888338;5253.789848406059;5351.063563876306;5357.946420535823;5362.43694412085;5368.275282836806;6012.699365031731;6025.487833534155;6028.819135425944;6029.6382217066675;6032.215811944463;6277;6298.811035668938;6301.621902685808;6305.968470157666;6322.841928951767;6257.74969001244;6267.4672652824565;6349.888769465325;6403.48772098231;6450.7097180626515;6093.421124993119;6134.631922084689;6142.600730952474;6149.754009839646;6174.96912515439;6572.901406478906;6581.308962558958;6585.9012114818315;6605.900911486331;6610.471162307004;6127.525510585588;6174.135621013062;6229.221347331583;6294.370562943669;6307.2431308242385;4790.023147054662;6261.217347831521;6293.653849038347;6328.7468501260355;6404.583702059351;6303.936960630335;6311.0217916223055;6322.9051564226575;6326.905096423558;6338.873222535616;6369.713362898588;6370;6374.681265936684;6375.394337537927;6380.776672816429;5014.473480284518;5036.11867923112;5171.456997015259;5178.6374953752875;5207.973960130175;4543.522930092358;4545.545445455428;4557.658175636774;4570.520095390003;4579.610733087725;6018.187544681499;6070.514358851281;6086.330503644595;6108.053251745987;6129.448349648553;6225.159603453566;6394.744210231632;6452.709628066748;6465.77369792055;6481.870362592722;5938.020226662552;5948.791792287336;6021.187139736079;6068.75724971005;6104.481119104837;5681.687507187062;5687.175359572839;5687.829365119053;5691;5706.629069110494;6598.538102332983;6635.137432133792;6658.600483970978;6658.833529161907;6660.267370589231;6236.251649801871;6256.217972753406;6284.968575157095;6364.586301890362;6425.9036114457385;6519.967400162969;6584.078229047841;6586.341365863375;6603.405693487609;6604.669766511752;6286.088517165077;6294.653794041372;6304;6317.431431171033;6317.842053948688;6233.345498722569;6278.089676996901;6286.4342209201395;6384.329645387167;6387.977923532212;6115.45331071284;6210.782622608187;6242.188515493139;6290.811275661737;6298.02380631003;6286.842828929313;6292.590981586182;6302.9684851577285;6318.526110541819;6344.460720838781;6078.483328917092;6256.092866534418;6326.778562750282;6329.1139240505445;6342.460890824332;6150.261968563801;6262.906056409066;6281.811545653638;6289.7169627365965;6290.874182516415;6298.307186209605;6313.337099604475;6326.4622507087415;6329.7151628175925;6333.588316759396 01:58:01 INFO - PROCESS | 1651 | |1;ext.html;806.9959650201748;828.6519661742068;868.9000764912033;883.6774577279286;884.9822703890521;40724.59275407245;41811.58188418115;42827;43033.78483107588;43124.56875431249;42005.36991945123;42414.57585424145;42432.36351454723;42436.57563424365;42489.36265956013;7534.2089080646565;7667.616619169047;9167.862482062774;9317.72046838596;9337.253019758404;11276.605318813843;11509;11638.709032274177;11642.359670218177;11643.650690479299;11431.314121152758;11471;11489.368084755335;11515.251508651952;11517.308961462297;7479.962600187018;11402.372869492174;11440;11448.656540303804;11460.140489463281;7468.5145465544565;10947.959943805326;11186.216964812467;11292.887071129266;11312.038476729487;39705.60294397048;39947.800260998796;39967.40048899269;40195.39706904399;40197;3821.9426708599394;3831.214601006787;3911.4328422378594;3915.7454765440157;3954.6440820326306;28478.715212847812;28786;29158.70841291581;29594.704052959627;29805;3086.4135814195456;3128.092853072629;3159.557661927332;3169.524571314298;3187.123541026213;351331.99999999744;352709;352850;354060;355910;42887;42994.92512687145;45300.77349613231;53048.73475632597;53353;54308.45691543034;55164.44835551673;57765.422345776846;57801.132983005285;57913.71043144842;14728.189949552663;14730.779038314435;14782.92608536972;14798.556043318502;14810.481633142788;12712.300823454614;12738.235705857678;12749.043821713409;12761.489540418464;12769.872301276868;12455.93772031134;12458.252504849737;12493.12548121641;12521.123521353418;12584.622461326175;5652.152177173457;5682.403347648437;5689.630174038674;5693.373728889819;5712.143178523172;941.7221919533754;1108.9500972456258;1116.4473585575192;1131.637875879727;1187.4062968515743;24488.632670509956;28041;28850;29033.56449653257;29138.854305728335;977.9755506112405;1028.6039874648313;1034.1209971524145;1065.9467026648792;1080.2492267873909;14418.206998614967;14591.708165836624;14630.90268229887;14879.702405952037;14884.925575372054;467365;474370;474523;475006;475078;57692.26923192311;57931;57956.840863183344;57969.71015144981;58065;1440.6470414748453;1456.5775924981638;1489.5382431446287;1492.731308364505;1497.8801695864304;24809.87595062013;25359.239222823344;26436.8678156608;27763.861180693966;27902.441951160457;47329.52670473251;47401.52598473971;47478.287825683336;47509.52490475051;47710;373882;375103;375369;376605;377278.2272177243;25746.841392137023;26333.34166645849;27096;31278.53082203723;31792.841035795598;42364.576354236066;43538;44216.77891610521;44562.3315650259;44917.77541112273;28785.926214523064;28994.420111598072;29488.41023179567;29972.4005519884;30486.695133049274;28914;29069.273268168465;29129.417411652073;29145.854270728512;29172.56241156342;32438.35123297568;33360.33279334448;33519;33576.664233357355;33676.49485257772;27498.312542186606;27720.02979895694;27924.30189245285;28854.855725721238;29011.274718132216;22793.77206227983;22917.770822291564;22971.196008139636;23095;23264.302070937898 01:58:01 INFO - PROCESS | 1651 | |2;jquery.html;375.9848409294901;427.13718289056106;429.06766177236483;432.23278680342395;444.7887253554562;12682.42929068192;20501.872397018178;21897.99999999998;22674.773252267474;22873.542529149407;22103.668444973297;22648;23040.423989400275;23329.650055249185;23356.182533611325;6157.322694503601;6490.318516555764;6686.699098540553;6875.278095799919;6911.792646220596;6724.495662825308;6748.223954245251;6818.590884546943;6840.589564626139;6841.521093523455;6531.902021469658;6748.898766518506;6795.660216989156;6805.183377994647;6814.693338799766;6230.719617617173;6500.837479063014;6786.694598743068;7125.4680243747325;7450.441216908754;6873.381395674413;7032.683529241196;7335.376492998102;7359.227281135511;7369.963150184215;23164.768352316598;26246.86876565624;26648.200553983217;26959.191224263304;27074;2848.6724026736983;2889.2632378743288;2907.5638654201825;2941.455830671311;2968.7031296870355;15377.769333460006;16491.6701665966;16506.42227522043;16668.166591670368;17129;1887.7545919030438;1954.9511262218416;1958.2069261948934;1958.4418440744462;1963.2147141143657;130535.34732326277;137160;140709.8538594988;144052;148226.25886870603;13488.460461581622;19049.80950190508;20141.47524183262;20285;20389.694154587694;25995.870020649774;26891;27189.728102719117;27319.317017074336;27439.176824694892;9808.509574521246;9890.703278901645;10333.121684656739;10435.94782026085;10741.087007604441;8692;8727.04002559718;8737.563121843883;8850.336224783166;8894.644214231488;7704.768856934301;9007.324450666227;9183.403078799856;9287.767805804773;9326.834145731784;3873.7869417182324;3903.8048097595006;3908.101136738509;3912.178442527101;3914.72596918213;830.4477522447626;867.3928250224868;868.1882439918696;868.9913100869037;877.3678963110668;21304.680429793567;22079.66880496794;22216.77807720591;22247.666285005736;22366;883.5317281840635;891.1712107739864;896.8609865470733;908.3323757038571;913.0914739833775;11193.888061119447;11336.263142895685;11521.711957201138;11529.192956492965;11534.59628912984;706895;727232;743853;750885;771690;144008;145473;146125;152560;172619;1145.7823013627385;1206.6983254186453;1245.894099001577;1255.1151438236204;1256.8177614246065;19581;19641.41075767729;19761.308354207533;20310.492237693587;20341.694874577188;49147.52557423283;52779.73610131925;63476;64126;65386.673066634365;90808;91032.54483727539;91310.17379652502;93786.53106734423;93997.53001235223;9568.712938611852;10816.918308169435;11517.193796434169;11679.883201167879;11847.052235820942;12877.678058048248;13036.283004434847;13329.933350333185;13343.332833358487;13493.595192144252;9076.77774390082;10547.945205479391;11219.71950701239;11555.537778488766;11606.767864642828;8061.395395345256;10484.737881553023;10796.514156863117;10798.73003174927;10955.45222738844;11553.24903881245;11556;11610.76778464443;11742.354170520703;11816.527338906348;11555.364454955059;11569.36368499707;11601.12991525622;11624.6512604622;11881.881181188077;8374.706885259231;10926.726831829268;11422.029127523921;11513.963743262811;11541 01:58:01 INFO - PROCESS | 1651 | |3;mootools.html;1525.4584622459026;1533.5859317984152;1558.3766493402632;1584.0970646731364;1588.5710858068321;10408.739781505457;11015.008649221569;11020.559177632886;11054.060404865597;11054.668359949204;10288.897111028888;10667.199960002992;10836;10836.458177091154;10847.620333288336;2335.7664233576675;2370.9407264818346;2371.336025912747;2372.8813559321966;2375.524895020994;1929.411529483507;2280.6579013147993;2372.2645979746335;2375.786179243876;2376.964345534818;2299.275728145637;2346.530693861226;2357.422431504284;2369.158948573249;2380.321608341623;2269.217120093565;2270.625346817773;2270.8864556772096;2272.534130503251;2279.2250634784255;2367.3134790910617;2380.3216083416314;2381.785639292472;2381.9523609527887;2382.3567636737985;10933.835992460119;11019.118470522339;11026.228164028522;11027.283226590245;11040;5600.047991841356;5729.369769325371;5730.541556675456;5742.827715168552;5752.13717942312;3173.7143657070974;3316.535685004101;3404.3872103021445;3438.6561343865665;3496.318217947501;1121.198343184627;1136.3409222650844;1555.3933965753365;1770.4246120011048;1890.6691329017503;13478.258695771729;13693.383797729126;14062.648433789238;14404.423823047171;14767.926160369238;3937.4684417603257;4245.575442455792;4705.811767529261;4721.102990431807;4725.149473094807;11822.940885295518;11826.408679565988;11829.645110646694;11841.763164736829;11859.229150105388;5369.436209197978;5696.401877802854;5716.942830571724;5720.971395142998;5760.308762948389;5207.427183009866;5207.557357624569;5213.556847667991;5214.348206474191;5218.739063046908;3646.1796095878217;3803.3724435468393;3829.3107240696386;3869.400242962345;3875;987.0770829274651;987.5062468765617;996.0736515040936;998.630506712521;1000.009990109786;911.8723378726984;929.2008872369756;930.4370855632245;943.9528023598792;992.1715367668078;6516.934830651728;6541.967290163519;6695.12963314766;6776.627285499247;6854.725810967506;885.203317014692;938.8357037518543;939.923787263593;947.190152419685;985.6747273399761;4190.580941905785;4210.200061988213;4228.492580890252;4271.572842715766;4397.6921615487245;12729.727027297196;12933.353332333534;13536.59390218295;13568;13573.59279221625;13453.730925381438;13467.191968481726;13469.932650336686;13484.932575337256;13510.12184208043;7941.36469082472;8093.757187284391;8529.530875801891;8925.062868398725;8938.731838044869;5781.392953739965;6640.9335906642245;6807.965960170168;6835.07726456922;6846.110005699227;11932.761344772882;11975.880241197825;12000.63998080059;12068.336241506802;12196.695082623006;12146.635600931986;12172.634820955385;12270.834270744264;12315.261084334968;12386.876131238932;8930.151635594608;9103.544822758704;9279.907200927904;9290.210332121575;9309.487978160996;10349.172066234532;10367;10458.320209186379;10470;10472;8615.181557752254;8777.692780752643;8816.735497935073;8817.16236957488;8961.775955601162;8547.40168188221;8560.143985601639;8620.655173792979;8696.478211307342;8707.47755134694;7900.644470998934;8057.597120143852;8061.31478824283;8064.677412903418;8076.515409075474;5518.613697041169;5562.137868630369;5648.604597678123;5709.857253568694;5764.913526297025;4717.3159891816185;5954.834684965689;5956.255468066492;5961.135635332766;6083.756649733961 01:58:01 INFO - PROCESS | 1651 | |4;prototype.html;324.38205219057704;373.1361897207963;383.88291571070823;391.8284329853738;393.2950658893696;4455.665825063121;4681.695689780162;4825.396825396825;5372.340691357778;5381.48875856794;4112.444819949306;4488.925086315876;4794.664373493857;4820.8071677132875;4951.529604687558;4193.014641559246;4211.284081706117;4252.468441444819;4254.383114448403;4310.52584215736;3526.272126657932;3840.7119466040017;3949.7630142191415;4301.924518870283;4337.63130133939;3564.6613571710645;4114.732542384735;4158.293090174678;4276.647843685976;4290.249206388885;3947.861824836146;4087.2438598859158;4202.768847713374;4230.153969206141;4265.253580623394;3344.8494817733263;3486.267883744417;3852.2680690668685;3866.9613303867163;3944.3097457944746;4078.5717499662405;5040.36995375578;5056.898862022776;5058.671186372874;5074.594032477393;4342.392065110887;4615.792024542944;4877.268409738532;4925.950740492585;4981.576565991895;4848.612111031109;5424.446987223336;5524.558035357162;5530.391656917735;5578.30271216098;4113.609207125318;4300.505441874193;4312.676549258818;4331.328644060176;4356.170408428467;4816.975915120437;5145.819896303648;5170.431252562215;5254.92117618236;5291.841244762663;4009.51885773709;4510;4520.491127424245;4525;4535.886602834956;3879.3599056155417;4479.395281636937;4618.406649705846;4629.583337499641;4631.9536804631525;4446.888827779331;4553.840615578439;4643.326717625993;4653.883068063708;4709.822544363909;4816.831410900601;5449.692073902235;5454.509094181463;5466;5503.523414463508;1303.6089173247988;1434.6771976305247;1502.0912348029285;1562.4687606213943;1575.4013474879473;1077.7251800790748;1156.3639998001065;1173.0029474946227;1176.16492290473;1194.9223300485442;4622.329762184531;4823.6382271329085;4965.120230266437;5178.818741344035;5179.81870634526;5713.628614140068;5716.885662286814;5749.88500229993;5765.261500787176;5803.216565763652;4800.495947925418;4875.318015284721;5047.394312682502;5160.303359046556;5192.559497036463;2840.6165167702097;2881.481333359973;2901.231173738961;2904.6804851466322;2905.8837646493903;5669.858253543694;5795.275590551181;5909.645421274738;5942.286925568959;5947.434993675594;5027.547520723152;5282.392524859613;5525.336959564878;5701.802621449542;5769.644133628594;5049.545540901337;5699.860027994335;5764.904668113045;5858.150568167592;5897.734601942837;4428.427908092581;5165.468920229136;5325.4940780625775;5579.023670857665;5683.9200551896665;4961.305417241517;5256.316678831728;5462.481064298885;5547.472990065938;5600.927656767022;5001.924971125363;5620.325560932714;5639.830805075854;5722.713864306685;5744.798932037359;3969.2656858481273;4007.91984160321;4366.388705581285;4567.360569520203;4599.70101943386;5350.652207606493;5642.746076426489;5684.431556844448;5774.682392468455;5800.535957123504;4300.440942677432;5027.924581131213;5108.56577190943;5339.691775515023;5582.794796055454;4667.789949452351;5417.51242388187;5432.782688692566;5439.0147596126335;5495.725213739217;4385.473743150842;5167.741612919414;5249.110320284618;5335.33308336458;5362.865928351823;5033.92449113271;5089.592832573311;5277.182036784305;5332.5467335276935;5468.589855760754;4894.363732714724;5301.893962120813;5310.8141215057285;5411.402526787086;5419.2413062170535 01:58:01 INFO - PROCESS | 1651 | |5;yui.html;711.4201925430776;732.3591857125019;769.7729169894884;818.7584662524556;829.7427797382813;14899.776503352445;15762.369505219778;15763.68472630548;15799.973001754892;15810.4466343678;14200.857991420082;14240.216788076652;14319;14440.989130760825;15006.699866002673;931.3294428011837;940.0881145289093;945.9337846350758;946.2950102173891;974.1768205866067;951.4671783801059;958.6836344006462;964.0359640359641;964.3827950111934;964.6720115160844;1011.6964910526813;1013.5945621751284;1013.9594416223342;1017.3539802225566;1017.4048181813648;1005.3465247589053;1009.5406590001531;1009.7778488732467;1009.8990100989915;1012.488693209928;741.9220981796941;749.7975546602387;750.89487471754;751.4476859508258;751.673022235324;15504.767428488582;15508.5347439577;15782.684346313124;15882.205889705585;15951.92024039884;14027.368768405446;14083.155010699391;14102.788458173136;14265.072770269899;14298.21272340947;11479.13906457019;11824.940875295568;11872.821907671392;11888.821667674993;12121.45453454588;3670.0254766315215;3718.200586873808;3722.3858063419502;3818.522684664417;3862.3820188769664;107379;107462;112715.43642281818;112980;114043.42978285138;10398.168146548258;10724.624638137628;10859.83710244347;10875.401852898167;10888.61889833852;22652.546949060925;22792.886035569714;22905.19831805879;22907;22973.85130743456;7483.5280769153815;7589.051368578927;7592.088949326006;7664.31021208094;7749.7675069748;4134.545200027995;4221.366794980716;4244.3209086546;4258.723182993095;4330.631896288851;3392.5420068290464;3439.8108104054018;3464.5149679044953;3507.31607336572;3518.3315170117594;547.9369872464717;623.2054130982942;627.9686015699197;634.5811764235582;640.9711562979677;648.6335220600346;660.1580197250786;669.9899501507481;682.474494639125;708.4297140801704;8464.788380290542;10120.443375614264;10331;10528.473576321154;10562.471876406149;644.5874640230256;659.8119535932332;674.75371489407;703.7185125949661;705.3264132753209;4082.1386598168265;4852.320675105488;5012.799488020439;5104.948950510522;5168.638195326366;108005.37991930127;108440.45779771208;108546.37180442299;109143.45428272967;109257.45371273252;68531;73463.63268183624;80094;81362.18637813546;84703;72950.27049729435;73337.26662733412;73385.26614733784;73683.89474157785;77253.2274677246;10611.628592999517;10937.671869843918;11117.05505032049;11162.888371116185;11375.26060806045;46829.2975605373;48667.783305417644;49158.75420622874;50289.74855125701;51032.97934041372;62388.688056561245;62967;63994.720105596694;65665.34334656592;65849.0122648151;11004.779904402027;11157.27477713946;11184.94407527957;11356.772864542829;11515.30908145514;14155;14634.560963170696;14854.010772601954;15278.541643750705;15351.23243837826;13108.934455327662;13307.201567905957;13825.654358641115;14060.78908816389;14720.718288665274;13128.671783205496;13501.932490337878;14005.089669171472;14147.575572732834;14491.927540362653;13254.204747714783;13421.798673019717;13565.914726821633;14005.579832605039;14230.730780765522;8793.560321983747;9111.726648200565;9347.859782103409;9429.717108486757;9539.09378609031;9646.758831029281;10031.899681003388;10922.29005114665;11346.262492937933;11355.602553910574 01:58:01 INFO - PROCESS | 1651 | __end_tp_report 01:58:01 INFO - PROCESS | 1651 | __start_cc_report 01:58:01 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,1846 01:58:01 INFO - PROCESS | 1651 | __end_cc_report 01:58:01 INFO - PROCESS | 1651 | __startTimestamp1491037081566__endTimestamp 01:58:01 INFO - PROCESS | 1651 | 01:58:01 INFO - PROCESS | 1651 | ------- Summary: start ------- 01:58:01 INFO - PROCESS | 1651 | Number of tests: 6 01:58:01 INFO - PROCESS | 1651 | 01:58:01 INFO - PROCESS | 1651 | [#0] dojo.html Cycles:165 Average:5943.01 Median:6225.16 stddev:665.50 (10.7%) stddev-sans-first:637.05 01:58:01 INFO - PROCESS | 1651 | Values: 3404.7 3421.7 3423.8 3425.7 3465.7 6023.3 6024.1 6058.9 6081.7 6116.8 6001.1 6071.8 6076.6 6088.1 6092.7 5369.3 5400.2 5425.8 5428.6 5505.9 4634.9 5277.2 5327.7 5402.5 5506.2 5337.5 5389.1 5418.8 5426.0 5428.9 5414.9 5415.5 5418.1 5418.9 5425.1 5253.8 5351.1 5357.9 5362.4 5368.3 6012.7 6025.5 6028.8 6029.6 6032.2 6277.0 6298.8 6301.6 6306.0 6322.8 6257.7 6267.5 6349.9 6403.5 6450.7 6093.4 6134.6 6142.6 6149.8 6175.0 6572.9 6581.3 6585.9 6605.9 6610.5 6127.5 6174.1 6229.2 6294.4 6307.2 4790.0 6261.2 6293.7 6328.7 6404.6 6303.9 6311.0 6322.9 6326.9 6338.9 6369.7 6370.0 6374.7 6375.4 6380.8 5014.5 5036.1 5171.5 5178.6 5208.0 4543.5 4545.5 4557.7 4570.5 4579.6 6018.2 6070.5 6086.3 6108.1 6129.4 6225.2 6394.7 6452.7 6465.8 6481.9 5938.0 5948.8 6021.2 6068.8 6104.5 5681.7 5687.2 5687.8 5691.0 5706.6 6598.5 6635.1 6658.6 6658.8 6660.3 6236.3 6256.2 6285.0 6364.6 6425.9 6520.0 6584.1 6586.3 6603.4 6604.7 6286.1 6294.7 6304.0 6317.4 6317.8 6233.3 6278.1 6286.4 6384.3 6388.0 6115.5 6210.8 6242.2 6290.8 6298.0 6286.8 6292.6 6303.0 6318.5 6344.5 6078.5 6256.1 6326.8 6329.1 6342.5 6150.3 6262.9 6281.8 6289.7 6290.9 6298.3 6313.3 6326.5 6329.7 6333.6 01:58:01 INFO - PROCESS | 1651 | 01:58:01 INFO - PROCESS | 1651 | [#1] ext.html Cycles:180 Average:54447.93 Median:17203.31 stddev:107035.99 (622.2%) stddev-sans-first:107260.48 01:58:01 INFO - PROCESS | 1651 | Values: 807.0 828.7 868.9 883.7 885.0 40724.6 41811.6 42827.0 43033.8 43124.6 42005.4 42414.6 42432.4 42436.6 42489.4 7534.2 7667.6 9167.9 9317.7 9337.3 11276.6 11509.0 11638.7 11642.4 11643.7 11431.3 11471.0 11489.4 11515.3 11517.3 7480.0 11402.4 11440.0 11448.7 11460.1 7468.5 10948.0 11186.2 11292.9 11312.0 39705.6 39947.8 39967.4 40195.4 40197.0 3821.9 3831.2 3911.4 3915.7 3954.6 28478.7 28786.0 29158.7 29594.7 29805.0 3086.4 3128.1 3159.6 3169.5 3187.1 351332.0 352709.0 352850.0 354060.0 355910.0 42887.0 42994.9 45300.8 53048.7 53353.0 54308.5 55164.4 57765.4 57801.1 57913.7 14728.2 14730.8 14782.9 14798.6 14810.5 12712.3 12738.2 12749.0 12761.5 12769.9 12455.9 12458.3 12493.1 12521.1 12584.6 5652.2 5682.4 5689.6 5693.4 5712.1 941.7 1109.0 1116.4 1131.6 1187.4 24488.6 28041.0 28850.0 29033.6 29138.9 978.0 1028.6 1034.1 1065.9 1080.2 14418.2 14591.7 14630.9 14879.7 14884.9 467365.0 474370.0 474523.0 475006.0 475078.0 57692.3 57931.0 57956.8 57969.7 58065.0 1440.6 1456.6 1489.5 1492.7 1497.9 24809.9 25359.2 26436.9 27763.9 27902.4 47329.5 47401.5 47478.3 47509.5 47710.0 373882.0 375103.0 375369.0 376605.0 377278.2 25746.8 26333.3 27096.0 31278.5 31792.8 42364.6 43538.0 44216.8 44562.3 44917.8 28785.9 28994.4 29488.4 29972.4 30486.7 28914.0 29069.3 29129.4 29145.9 29172.6 32438.4 33360.3 33519.0 33576.7 33676.5 27498.3 27720.0 27924.3 28854.9 29011.3 22793.8 22917.8 22971.2 23095.0 23264.3 01:58:01 INFO - PROCESS | 1651 | 01:58:01 INFO - PROCESS | 1651 | [#2] jquery.html Cycles:180 Average:42270.01 Median:26121.37 stddev:123305.41 (472.0%) stddev-sans-first:123611.18 01:58:01 INFO - PROCESS | 1651 | Values: 376.0 427.1 429.1 432.2 444.8 12682.4 20501.9 21898.0 22674.8 22873.5 22103.7 22648.0 23040.4 23329.7 23356.2 6157.3 6490.3 6686.7 6875.3 6911.8 6724.5 6748.2 6818.6 6840.6 6841.5 6531.9 6748.9 6795.7 6805.2 6814.7 6230.7 6500.8 6786.7 7125.5 7450.4 6873.4 7032.7 7335.4 7359.2 7370.0 23164.8 26246.9 26648.2 26959.2 27074.0 2848.7 2889.3 2907.6 2941.5 2968.7 15377.8 16491.7 16506.4 16668.2 17129.0 1887.8 1955.0 1958.2 1958.4 1963.2 130535.3 137160.0 140709.9 144052.0 148226.3 13488.5 19049.8 20141.5 20285.0 20389.7 25995.9 26891.0 27189.7 27319.3 27439.2 9808.5 9890.7 10333.1 10435.9 10741.1 8692.0 8727.0 8737.6 8850.3 8894.6 7704.8 9007.3 9183.4 9287.8 9326.8 3873.8 3903.8 3908.1 3912.2 3914.7 830.4 867.4 868.2 869.0 877.4 21304.7 22079.7 22216.8 22247.7 22366.0 883.5 891.2 896.9 908.3 913.1 11193.9 11336.3 11521.7 11529.2 11534.6 706895.0 727232.0 743853.0 750885.0 771690.0 144008.0 145473.0 146125.0 152560.0 172619.0 1145.8 1206.7 1245.9 1255.1 1256.8 19581.0 19641.4 19761.3 20310.5 20341.7 49147.5 52779.7 63476.0 64126.0 65386.7 90808.0 91032.5 91310.2 93786.5 93997.5 9568.7 10816.9 11517.2 11679.9 11847.1 12877.7 13036.3 13329.9 13343.3 13493.6 9076.8 10547.9 11219.7 11555.5 11606.8 8061.4 10484.7 10796.5 10798.7 10955.5 11553.2 11556.0 11610.8 11742.4 11816.5 11555.4 11569.4 11601.1 11624.7 11881.9 8374.7 10926.7 11422.0 11514.0 11541.0 01:58:01 INFO - PROCESS | 1651 | 01:58:01 INFO - PROCESS | 1651 | [#3] mootools.html Cycles:180 Average:6605.25 Median:3571.25 stddev:4096.03 (114.7%) stddev-sans-first:4089.73 01:58:01 INFO - PROCESS | 1651 | Values: 1525.5 1533.6 1558.4 1584.1 1588.6 10408.7 11015.0 11020.6 11054.1 11054.7 10288.9 10667.2 10836.0 10836.5 10847.6 2335.8 2370.9 2371.3 2372.9 2375.5 1929.4 2280.7 2372.3 2375.8 2377.0 2299.3 2346.5 2357.4 2369.2 2380.3 2269.2 2270.6 2270.9 2272.5 2279.2 2367.3 2380.3 2381.8 2382.0 2382.4 10933.8 11019.1 11026.2 11027.3 11040.0 5600.0 5729.4 5730.5 5742.8 5752.1 3173.7 3316.5 3404.4 3438.7 3496.3 1121.2 1136.3 1555.4 1770.4 1890.7 13478.3 13693.4 14062.6 14404.4 14767.9 3937.5 4245.6 4705.8 4721.1 4725.1 11822.9 11826.4 11829.6 11841.8 11859.2 5369.4 5696.4 5716.9 5721.0 5760.3 5207.4 5207.6 5213.6 5214.3 5218.7 3646.2 3803.4 3829.3 3869.4 3875.0 987.1 987.5 996.1 998.6 1000.0 911.9 929.2 930.4 944.0 992.2 6516.9 6542.0 6695.1 6776.6 6854.7 885.2 938.8 939.9 947.2 985.7 4190.6 4210.2 4228.5 4271.6 4397.7 12729.7 12933.4 13536.6 13568.0 13573.6 13453.7 13467.2 13469.9 13484.9 13510.1 7941.4 8093.8 8529.5 8925.1 8938.7 5781.4 6640.9 6808.0 6835.1 6846.1 11932.8 11975.9 12000.6 12068.3 12196.7 12146.6 12172.6 12270.8 12315.3 12386.9 8930.2 9103.5 9279.9 9290.2 9309.5 10349.2 10367.0 10458.3 10470.0 10472.0 8615.2 8777.7 8816.7 8817.2 8961.8 8547.4 8560.1 8620.7 8696.5 8707.5 7900.6 8057.6 8061.3 8064.7 8076.5 5518.6 5562.1 5648.6 5709.9 5764.9 4717.3 5954.8 5956.3 5961.1 6083.8 01:58:01 INFO - PROCESS | 1651 | 01:58:01 INFO - PROCESS | 1651 | [#4] prototype.html Cycles:180 Average:4544.64 Median:4876.29 stddev:1272.74 (26.1%) stddev-sans-first:1236.27 01:58:01 INFO - PROCESS | 1651 | Values: 324.4 373.1 383.9 391.8 393.3 4455.7 4681.7 4825.4 5372.3 5381.5 4112.4 4488.9 4794.7 4820.8 4951.5 4193.0 4211.3 4252.5 4254.4 4310.5 3526.3 3840.7 3949.8 4301.9 4337.6 3564.7 4114.7 4158.3 4276.6 4290.2 3947.9 4087.2 4202.8 4230.2 4265.3 3344.8 3486.3 3852.3 3867.0 3944.3 4078.6 5040.4 5056.9 5058.7 5074.6 4342.4 4615.8 4877.3 4926.0 4981.6 4848.6 5424.4 5524.6 5530.4 5578.3 4113.6 4300.5 4312.7 4331.3 4356.2 4817.0 5145.8 5170.4 5254.9 5291.8 4009.5 4510.0 4520.5 4525.0 4535.9 3879.4 4479.4 4618.4 4629.6 4632.0 4446.9 4553.8 4643.3 4653.9 4709.8 4816.8 5449.7 5454.5 5466.0 5503.5 1303.6 1434.7 1502.1 1562.5 1575.4 1077.7 1156.4 1173.0 1176.2 1194.9 4622.3 4823.6 4965.1 5178.8 5179.8 5713.6 5716.9 5749.9 5765.3 5803.2 4800.5 4875.3 5047.4 5160.3 5192.6 2840.6 2881.5 2901.2 2904.7 2905.9 5669.9 5795.3 5909.6 5942.3 5947.4 5027.5 5282.4 5525.3 5701.8 5769.6 5049.5 5699.9 5764.9 5858.2 5897.7 4428.4 5165.5 5325.5 5579.0 5683.9 4961.3 5256.3 5462.5 5547.5 5600.9 5001.9 5620.3 5639.8 5722.7 5744.8 3969.3 4007.9 4366.4 4567.4 4599.7 5350.7 5642.7 5684.4 5774.7 5800.5 4300.4 5027.9 5108.6 5339.7 5582.8 4667.8 5417.5 5432.8 5439.0 5495.7 4385.5 5167.7 5249.1 5335.3 5362.9 5033.9 5089.6 5277.2 5332.5 5468.6 4894.4 5301.9 5310.8 5411.4 5419.2 01:58:01 INFO - PROCESS | 1651 | 01:58:01 INFO - PROCESS | 1651 | [#5] yui.html Cycles:180 Average:20272.82 Median:22906.10 stddev:29224.72 (127.6%) stddev-sans-first:29269.79 01:58:01 INFO - PROCESS | 1651 | Values: 711.4 732.4 769.8 818.8 829.7 14899.8 15762.4 15763.7 15800.0 15810.4 14200.9 14240.2 14319.0 14441.0 15006.7 931.3 940.1 945.9 946.3 974.2 951.5 958.7 964.0 964.4 964.7 1011.7 1013.6 1014.0 1017.4 1017.4 1005.3 1009.5 1009.8 1009.9 1012.5 741.9 749.8 750.9 751.4 751.7 15504.8 15508.5 15782.7 15882.2 15951.9 14027.4 14083.2 14102.8 14265.1 14298.2 11479.1 11824.9 11872.8 11888.8 12121.5 3670.0 3718.2 3722.4 3818.5 3862.4 107379.0 107462.0 112715.4 112980.0 114043.4 10398.2 10724.6 10859.8 10875.4 10888.6 22652.5 22792.9 22905.2 22907.0 22973.9 7483.5 7589.1 7592.1 7664.3 7749.8 4134.5 4221.4 4244.3 4258.7 4330.6 3392.5 3439.8 3464.5 3507.3 3518.3 547.9 623.2 628.0 634.6 641.0 648.6 660.2 670.0 682.5 708.4 8464.8 10120.4 10331.0 10528.5 10562.5 644.6 659.8 674.8 703.7 705.3 4082.1 4852.3 5012.8 5104.9 5168.6 108005.4 108440.5 108546.4 109143.5 109257.5 68531.0 73463.6 80094.0 81362.2 84703.0 72950.3 73337.3 73385.3 73683.9 77253.2 10611.6 10937.7 11117.1 11162.9 11375.3 46829.3 48667.8 49158.8 50289.7 51033.0 62388.7 62967.0 63994.7 65665.3 65849.0 11004.8 11157.3 11184.9 11356.8 11515.3 14155.0 14634.6 14854.0 15278.5 15351.2 13108.9 13307.2 13825.7 14060.8 14720.7 13128.7 13501.9 14005.1 14147.6 14491.9 13254.2 13421.8 13565.9 14005.6 14230.7 8793.6 9111.7 9347.9 9429.7 9539.1 9646.8 10031.9 10922.3 11346.3 11355.6 01:58:01 INFO - PROCESS | 1651 | -------- Summary: end -------- 01:58:01 INFO - PROCESS | 1651 | 01:58:02 INFO - TEST-INFO | 1651: exit 0 01:58:02 INFO - TEST-OK | dromaeo_css | took 1120049ms 01:58:02 INFO - TEST-START | kraken 01:58:02 INFO - operating with platform_type : mac_ 01:58:02 INFO - Initialising browser for kraken test... 01:58:02 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpwLsKvQ/profile http://localhost:49236/getInfo.html) 01:58:04 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 01:58:04 INFO - PROCESS | 1656 | colorDepth:24 01:58:04 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 01:58:04 INFO - PROCESS | 1656 | __metrics 01:58:04 INFO - PROCESS | 1656 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:58:04 INFO - PROCESS | 1656 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:58:05 INFO - TEST-INFO | 1656: exit 0 01:58:05 INFO - Browser initialized. 01:58:05 INFO - Running cycle 1/1 for kraken test... 01:58:05 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpwLsKvQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:58:17 INFO - PROCESS | 1658 | RSS: Main: 214937600 01:58:17 INFO - PROCESS | 1658 | 01:58:20 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection) 01:58:21 INFO - PROCESS | 1658 | RSS: Main: 267497472 01:58:21 INFO - PROCESS | 1658 | 01:58:23 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-dft) 01:58:24 INFO - PROCESS | 1658 | RSS: Main: 278982656 01:58:24 INFO - PROCESS | 1658 | 01:58:27 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-fft) 01:58:28 INFO - PROCESS | 1658 | RSS: Main: 376881152 01:58:28 INFO - PROCESS | 1658 | 01:58:30 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator) 01:58:30 INFO - PROCESS | 1658 | RSS: Main: 278577152 01:58:30 INFO - PROCESS | 1658 | 01:58:33 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:58:33 INFO - PROCESS | 1658 | RSS: Main: 280416256 01:58:33 INFO - PROCESS | 1658 | 01:58:36 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom) 01:58:37 INFO - PROCESS | 1658 | RSS: Main: 320274432 01:58:37 INFO - PROCESS | 1658 | 01:58:40 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate) 01:58:40 INFO - PROCESS | 1658 | RSS: Main: 322596864 01:58:40 INFO - PROCESS | 1658 | 01:58:44 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial) 01:58:44 INFO - PROCESS | 1658 | RSS: Main: 321056768 01:58:44 INFO - PROCESS | 1658 | 01:58:46 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:58:47 INFO - PROCESS | 1658 | RSS: Main: 294436864 01:58:47 INFO - PROCESS | 1658 | 01:58:48 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:58:49 INFO - PROCESS | 1658 | RSS: Main: 297811968 01:58:49 INFO - PROCESS | 1658 | 01:58:51 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:58:52 INFO - PROCESS | 1658 | RSS: Main: 300658688 01:58:52 INFO - PROCESS | 1658 | 01:58:55 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:58:56 INFO - PROCESS | 1658 | RSS: Main: 317759488 01:58:56 INFO - PROCESS | 1658 | 01:58:58 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:58:59 INFO - PROCESS | 1658 | RSS: Main: 310493184 01:58:59 INFO - PROCESS | 1658 | 01:59:01 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49236/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49236/tests/kraken/driver.html?testName=ai-astar) 01:59:01 INFO - PROCESS | 1658 | RSS: Main: 354881536 01:59:01 INFO - PROCESS | 1658 | 01:59:01 INFO - PROCESS | 1658 | __start_tp_report 01:59:01 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 01:59:01 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 01:59:01 INFO - PROCESS | 1658 | |i|pagename|runs| 01:59:01 INFO - PROCESS | 1658 | |0;ai-astar;116;114;113;113;114;113;114;114;113;114 01:59:01 INFO - PROCESS | 1658 | |1;audio-beat-detection;141;107;107;139;111;112;134;136;125;109 01:59:01 INFO - PROCESS | 1658 | |2;audio-dft;185;183;185;185;185;184;185;185;186;183 01:59:01 INFO - PROCESS | 1658 | |3;audio-fft;82;61;61;91;64;60;61;62;75;60 01:59:01 INFO - PROCESS | 1658 | |4;audio-oscillator;86;71;85;75;99;100;117;69;69;83 01:59:01 INFO - PROCESS | 1658 | |5;imaging-gaussian-blur;132;133;86;87;86;87;87;86;86;87 01:59:01 INFO - PROCESS | 1658 | |6;imaging-darkroom;95;94;94;94;95;95;94;94;94;94 01:59:01 INFO - PROCESS | 1658 | |7;imaging-desaturate;84;84;86;100;128;68;128;127;130;85 01:59:01 INFO - PROCESS | 1658 | |8;json-parse-financial;62;62;62;61;62;63;65;64;64;62 01:59:01 INFO - PROCESS | 1658 | |9;json-stringify-tinderbox;54;62;66;63;61;58;58;57;58;59 01:59:01 INFO - PROCESS | 1658 | |10;stanford-crypto-aes;83;80;83;90;79;82;69;80;91;90 01:59:01 INFO - PROCESS | 1658 | |11;stanford-crypto-ccm;139;139;146;145;143;134;140;143;176;182 01:59:01 INFO - PROCESS | 1658 | |12;stanford-crypto-pbkdf2;166;166;164;165;164;162;164;163;164;163 01:59:01 INFO - PROCESS | 1658 | |13;stanford-crypto-sha256-iterative;65;64;65;64;64;65;63;65;64;63 01:59:01 INFO - PROCESS | 1658 | __end_tp_report 01:59:01 INFO - PROCESS | 1658 | __start_cc_report 01:59:01 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,2144 01:59:01 INFO - PROCESS | 1658 | __end_cc_report 01:59:01 INFO - PROCESS | 1658 | __startTimestamp1491037141419__endTimestamp 01:59:01 INFO - PROCESS | 1658 | 01:59:01 INFO - PROCESS | 1658 | ------- Summary: start ------- 01:59:01 INFO - PROCESS | 1658 | Number of tests: 14 01:59:01 INFO - PROCESS | 1658 | 01:59:01 INFO - PROCESS | 1658 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:0.92 (0.8%) stddev-sans-first:0.53 01:59:01 INFO - PROCESS | 1658 | Values: 116.0 114.0 113.0 113.0 114.0 113.0 114.0 114.0 113.0 114.0 01:59:01 INFO - PROCESS | 1658 | 01:59:01 INFO - PROCESS | 1658 | [#1] audio-beat-detection Cycles:10 Average:122.10 Median:129.50 stddev:14.29 (11.0%) stddev-sans-first:13.43 01:59:01 INFO - PROCESS | 1658 | Values: 141.0 107.0 107.0 139.0 111.0 112.0 134.0 136.0 125.0 109.0 01:59:01 INFO - PROCESS | 1658 | 01:59:01 INFO - PROCESS | 1658 | [#2] audio-dft Cycles:10 Average:184.60 Median:185.00 stddev:0.97 (0.5%) stddev-sans-first:1.01 01:59:01 INFO - PROCESS | 1658 | Values: 185.0 183.0 185.0 185.0 185.0 184.0 185.0 185.0 186.0 183.0 01:59:01 INFO - PROCESS | 1658 | 01:59:01 INFO - PROCESS | 1658 | [#3] audio-fft Cycles:10 Average:67.70 Median:63.00 stddev:11.06 (17.5%) stddev-sans-first:10.45 01:59:01 INFO - PROCESS | 1658 | Values: 82.0 61.0 61.0 91.0 64.0 60.0 61.0 62.0 75.0 60.0 01:59:01 INFO - PROCESS | 1658 | 01:59:01 INFO - PROCESS | 1658 | [#4] audio-oscillator Cycles:10 Average:85.40 Median:79.00 stddev:15.83 (20.0%) stddev-sans-first:16.79 01:59:01 INFO - PROCESS | 1658 | Values: 86.0 71.0 85.0 75.0 99.0 100.0 117.0 69.0 69.0 83.0 01:59:01 INFO - PROCESS | 1658 | 01:59:01 INFO - PROCESS | 1658 | [#5] imaging-gaussian-blur Cycles:10 Average:95.70 Median:86.50 stddev:19.40 (22.4%) stddev-sans-first:15.51 01:59:01 INFO - PROCESS | 1658 | Values: 132.0 133.0 86.0 87.0 86.0 87.0 87.0 86.0 86.0 87.0 01:59:01 INFO - PROCESS | 1658 | 01:59:01 INFO - PROCESS | 1658 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:94.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 01:59:01 INFO - PROCESS | 1658 | Values: 95.0 94.0 94.0 94.0 95.0 95.0 94.0 94.0 94.0 94.0 01:59:01 INFO - PROCESS | 1658 | 01:59:01 INFO - PROCESS | 1658 | [#7] imaging-desaturate Cycles:10 Average:102.00 Median:76.00 stddev:23.84 (31.4%) stddev-sans-first:24.38 01:59:01 INFO - PROCESS | 1658 | Values: 84.0 84.0 86.0 100.0 128.0 68.0 128.0 127.0 130.0 85.0 01:59:01 INFO - PROCESS | 1658 | 01:59:01 INFO - PROCESS | 1658 | [#8] json-parse-financial Cycles:10 Average:62.70 Median:62.50 stddev:1.25 (2.0%) stddev-sans-first:1.30 01:59:01 INFO - PROCESS | 1658 | Values: 62.0 62.0 62.0 61.0 62.0 63.0 65.0 64.0 64.0 62.0 01:59:01 INFO - PROCESS | 1658 | 01:59:01 INFO - PROCESS | 1658 | [#9] json-stringify-tinderbox Cycles:10 Average:59.60 Median:60.00 stddev:3.44 (5.7%) stddev-sans-first:2.99 01:59:01 INFO - PROCESS | 1658 | Values: 54.0 62.0 66.0 63.0 61.0 58.0 58.0 57.0 58.0 59.0 01:59:01 INFO - PROCESS | 1658 | 01:59:01 INFO - PROCESS | 1658 | [#10] stanford-crypto-aes Cycles:10 Average:82.70 Median:83.00 stddev:6.60 (8.0%) stddev-sans-first:7.00 01:59:01 INFO - PROCESS | 1658 | Values: 83.0 80.0 83.0 90.0 79.0 82.0 69.0 80.0 91.0 90.0 01:59:01 INFO - PROCESS | 1658 | 01:59:01 INFO - PROCESS | 1658 | [#11] stanford-crypto-ccm Cycles:10 Average:148.70 Median:144.00 stddev:16.40 (11.4%) stddev-sans-first:17.01 01:59:01 INFO - PROCESS | 1658 | Values: 139.0 139.0 146.0 145.0 143.0 134.0 140.0 143.0 176.0 182.0 01:59:01 INFO - PROCESS | 1658 | 01:59:01 INFO - PROCESS | 1658 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.10 Median:164.00 stddev:1.29 (0.8%) stddev-sans-first:1.17 01:59:01 INFO - PROCESS | 1658 | Values: 166.0 166.0 164.0 165.0 164.0 162.0 164.0 163.0 164.0 163.0 01:59:01 INFO - PROCESS | 1658 | 01:59:01 INFO - PROCESS | 1658 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.20 Median:64.50 stddev:0.79 (1.2%) stddev-sans-first:0.78 01:59:01 INFO - PROCESS | 1658 | Values: 65.0 64.0 65.0 64.0 64.0 65.0 63.0 65.0 64.0 63.0 01:59:01 INFO - PROCESS | 1658 | -------- Summary: end -------- 01:59:01 INFO - PROCESS | 1658 | 01:59:02 INFO - TEST-INFO | 1658: exit 0 01:59:02 INFO - TEST-OK | kraken | took 60049ms 01:59:02 INFO - SUITE-END | took 1180s 01:59:02 INFO - Completed test suite (00:19:40) 01:59:02 INFO - javascript benchmark 01:59:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7661.797044874628, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3404.676555727205, 3421.7262618990467, 3423.7603367764254, 3425.6574342565737, 3465.688088072073, 6023.277206735198, 6024.060389985464, 6058.909116363247, 6081.695915204239, 6116.785912493064, 6001.129836173752, 6071.817845464632, 6076.574639775217, 6088.117223002662, 6092.725827337769, 5369.301990741208, 5400.189971504266, 5425.83722488326, 5428.647137936041, 5505.862353441156, 4634.930476042862, 5277.182036784305, 5327.706976116312, 5402.540784033342, 5506.174073888928, 5337.5196232339085, 5389.137737961927, 5418.810341638024, 5425.9728701356635, 5428.891422171554, 5414.8917021659345, 5415.512603865671, 5418.051840927822, 5418.8916221675545, 5425.13197888338, 5253.789848406059, 5351.063563876306, 5357.946420535823, 5362.43694412085, 5368.275282836806, 6012.699365031731, 6025.487833534155, 6028.819135425944, 6029.6382217066675, 6032.215811944463, 6277.0, 6298.811035668938, 6301.621902685808, 6305.968470157666, 6322.841928951767, 6257.74969001244, 6267.4672652824565, 6349.888769465325, 6403.48772098231, 6450.7097180626515, 6093.421124993119, 6134.631922084689, 6142.600730952474, 6149.754009839646, 6174.96912515439, 6572.901406478906, 6581.308962558958, 6585.9012114818315, 6605.900911486331, 6610.471162307004, 6127.525510585588, 6174.135621013062, 6229.221347331583, 6294.370562943669, 6307.2431308242385, 4790.023147054662, 6261.217347831521, 6293.653849038347, 6328.7468501260355, 6404.583702059351, 6303.936960630335, 6311.0217916223055, 6322.9051564226575, 6326.905096423558, 6338.873222535616, 6369.713362898588, 6370.0, 6374.681265936684, 6375.394337537927, 6380.776672816429, 5014.473480284518, 5036.11867923112, 5171.456997015259, 5178.6374953752875, 5207.973960130175, 4543.522930092358, 4545.545445455428, 4557.658175636774, 4570.520095390003, 4579.610733087725, 6018.187544681499, 6070.514358851281, 6086.330503644595, 6108.053251745987, 6129.448349648553, 6225.159603453566, 6394.744210231632, 6452.709628066748, 6465.77369792055, 6481.870362592722, 5938.020226662552, 5948.791792287336, 6021.187139736079, 6068.75724971005, 6104.481119104837, 5681.687507187062, 5687.175359572839, 5687.829365119053, 5691.0, 5706.629069110494, 6598.538102332983, 6635.137432133792, 6658.600483970978, 6658.833529161907, 6660.267370589231, 6236.251649801871, 6256.217972753406, 6284.968575157095, 6364.586301890362, 6425.9036114457385, 6519.967400162969, 6584.078229047841, 6586.341365863375, 6603.405693487609, 6604.669766511752, 6286.088517165077, 6294.653794041372, 6304.0, 6317.431431171033, 6317.842053948688, 6233.345498722569, 6278.089676996901, 6286.4342209201395, 6384.329645387167, 6387.977923532212, 6115.45331071284, 6210.782622608187, 6242.188515493139, 6290.811275661737, 6298.02380631003, 6286.842828929313, 6292.590981586182, 6302.9684851577285, 6318.526110541819, 6344.460720838781, 6078.483328917092, 6256.092866534418, 6326.778562750282, 6329.1139240505445, 6342.460890824332, 6150.261968563801, 6262.906056409066, 6281.811545653638, 6289.7169627365965, 6290.874182516415, 6298.307186209605, 6313.337099604475, 6326.4622507087415, 6329.7151628175925, 6333.588316759396], "value": 5899.777980833109, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [806.9959650201748, 828.6519661742068, 868.9000764912033, 883.6774577279286, 884.9822703890521, 40724.59275407245, 41811.58188418115, 42827.0, 43033.78483107588, 43124.56875431249, 42005.36991945123, 42414.57585424145, 42432.36351454723, 42436.57563424365, 42489.36265956013, 7534.2089080646565, 7667.616619169047, 9167.862482062774, 9317.72046838596, 9337.253019758404, 11276.605318813843, 11509.0, 11638.709032274177, 11642.359670218177, 11643.650690479299, 11431.314121152758, 11471.0, 11489.368084755335, 11515.251508651952, 11517.308961462297, 7479.962600187018, 11402.372869492174, 11440.0, 11448.656540303804, 11460.140489463281, 7468.5145465544565, 10947.959943805326, 11186.216964812467, 11292.887071129266, 11312.038476729487, 39705.60294397048, 39947.800260998796, 39967.40048899269, 40195.39706904399, 40197.0, 3821.9426708599394, 3831.214601006787, 3911.4328422378594, 3915.7454765440157, 3954.6440820326306, 28478.715212847812, 28786.0, 29158.70841291581, 29594.704052959627, 29805.0, 3086.4135814195456, 3128.092853072629, 3159.557661927332, 3169.524571314298, 3187.123541026213, 351331.99999999744, 352709.0, 352850.0, 354060.0, 355910.0, 42887.0, 42994.92512687145, 45300.77349613231, 53048.73475632597, 53353.0, 54308.45691543034, 55164.44835551673, 57765.422345776846, 57801.132983005285, 57913.71043144842, 14728.189949552663, 14730.779038314435, 14782.92608536972, 14798.556043318502, 14810.481633142788, 12712.300823454614, 12738.235705857678, 12749.043821713409, 12761.489540418464, 12769.872301276868, 12455.93772031134, 12458.252504849737, 12493.12548121641, 12521.123521353418, 12584.622461326175, 5652.152177173457, 5682.403347648437, 5689.630174038674, 5693.373728889819, 5712.143178523172, 941.7221919533754, 1108.9500972456258, 1116.4473585575192, 1131.637875879727, 1187.4062968515743, 24488.632670509956, 28041.0, 28850.0, 29033.56449653257, 29138.854305728335, 977.9755506112405, 1028.6039874648313, 1034.1209971524145, 1065.9467026648792, 1080.2492267873909, 14418.206998614967, 14591.708165836624, 14630.90268229887, 14879.702405952037, 14884.925575372054, 467365.0, 474370.0, 474523.0, 475006.0, 475078.0, 57692.26923192311, 57931.0, 57956.840863183344, 57969.71015144981, 58065.0, 1440.6470414748453, 1456.5775924981638, 1489.5382431446287, 1492.731308364505, 1497.8801695864304, 24809.87595062013, 25359.239222823344, 26436.8678156608, 27763.861180693966, 27902.441951160457, 47329.52670473251, 47401.52598473971, 47478.287825683336, 47509.52490475051, 47710.0, 373882.0, 375103.0, 375369.0, 376605.0, 377278.2272177243, 25746.841392137023, 26333.34166645849, 27096.0, 31278.53082203723, 31792.841035795598, 42364.576354236066, 43538.0, 44216.77891610521, 44562.3315650259, 44917.77541112273, 28785.926214523064, 28994.420111598072, 29488.41023179567, 29972.4005519884, 30486.695133049274, 28914.0, 29069.273268168465, 29129.417411652073, 29145.854270728512, 29172.56241156342, 32438.35123297568, 33360.33279334448, 33519.0, 33576.664233357355, 33676.49485257772, 27498.312542186606, 27720.02979895694, 27924.30189245285, 28854.855725721238, 29011.274718132216, 22793.77206227983, 22917.770822291564, 22971.196008139636, 23095.0, 23264.302070937898], "value": 18792.91852029542, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.9848409294901, 427.13718289056106, 429.06766177236483, 432.23278680342395, 444.7887253554562, 12682.42929068192, 20501.872397018178, 21897.99999999998, 22674.773252267474, 22873.542529149407, 22103.668444973297, 22648.0, 23040.423989400275, 23329.650055249185, 23356.182533611325, 6157.322694503601, 6490.318516555764, 6686.699098540553, 6875.278095799919, 6911.792646220596, 6724.495662825308, 6748.223954245251, 6818.590884546943, 6840.589564626139, 6841.521093523455, 6531.902021469658, 6748.898766518506, 6795.660216989156, 6805.183377994647, 6814.693338799766, 6230.719617617173, 6500.837479063014, 6786.694598743068, 7125.4680243747325, 7450.441216908754, 6873.381395674413, 7032.683529241196, 7335.376492998102, 7359.227281135511, 7369.963150184215, 23164.768352316598, 26246.86876565624, 26648.200553983217, 26959.191224263304, 27074.0, 2848.6724026736983, 2889.2632378743288, 2907.5638654201825, 2941.455830671311, 2968.7031296870355, 15377.769333460006, 16491.6701665966, 16506.42227522043, 16668.166591670368, 17129.0, 1887.7545919030438, 1954.9511262218416, 1958.2069261948934, 1958.4418440744462, 1963.2147141143657, 130535.34732326277, 137160.0, 140709.8538594988, 144052.0, 148226.25886870603, 13488.460461581622, 19049.80950190508, 20141.47524183262, 20285.0, 20389.694154587694, 25995.870020649774, 26891.0, 27189.728102719117, 27319.317017074336, 27439.176824694892, 9808.509574521246, 9890.703278901645, 10333.121684656739, 10435.94782026085, 10741.087007604441, 8692.0, 8727.04002559718, 8737.563121843883, 8850.336224783166, 8894.644214231488, 7704.768856934301, 9007.324450666227, 9183.403078799856, 9287.767805804773, 9326.834145731784, 3873.7869417182324, 3903.8048097595006, 3908.101136738509, 3912.178442527101, 3914.72596918213, 830.4477522447626, 867.3928250224868, 868.1882439918696, 868.9913100869037, 877.3678963110668, 21304.680429793567, 22079.66880496794, 22216.77807720591, 22247.666285005736, 22366.0, 883.5317281840635, 891.1712107739864, 896.8609865470733, 908.3323757038571, 913.0914739833775, 11193.888061119447, 11336.263142895685, 11521.711957201138, 11529.192956492965, 11534.59628912984, 706895.0, 727232.0, 743853.0, 750885.0, 771690.0, 144008.0, 145473.0, 146125.0, 152560.0, 172619.0, 1145.7823013627385, 1206.6983254186453, 1245.894099001577, 1255.1151438236204, 1256.8177614246065, 19581.0, 19641.41075767729, 19761.308354207533, 20310.492237693587, 20341.694874577188, 49147.52557423283, 52779.73610131925, 63476.0, 64126.0, 65386.673066634365, 90808.0, 91032.54483727539, 91310.17379652502, 93786.53106734423, 93997.53001235223, 9568.712938611852, 10816.918308169435, 11517.193796434169, 11679.883201167879, 11847.052235820942, 12877.678058048248, 13036.283004434847, 13329.933350333185, 13343.332833358487, 13493.595192144252, 9076.77774390082, 10547.945205479391, 11219.71950701239, 11555.537778488766, 11606.767864642828, 8061.395395345256, 10484.737881553023, 10796.514156863117, 10798.73003174927, 10955.45222738844, 11553.24903881245, 11556.0, 11610.76778464443, 11742.354170520703, 11816.527338906348, 11555.364454955059, 11569.36368499707, 11601.12991525622, 11624.6512604622, 11881.881181188077, 8374.706885259231, 10926.726831829268, 11422.029127523921, 11513.963743262811, 11541.0], "value": 11384.962464695172, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1525.4584622459026, 1533.5859317984152, 1558.3766493402632, 1584.0970646731364, 1588.5710858068321, 10408.739781505457, 11015.008649221569, 11020.559177632886, 11054.060404865597, 11054.668359949204, 10288.897111028888, 10667.199960002992, 10836.0, 10836.458177091154, 10847.620333288336, 2335.7664233576675, 2370.9407264818346, 2371.336025912747, 2372.8813559321966, 2375.524895020994, 1929.411529483507, 2280.6579013147993, 2372.2645979746335, 2375.786179243876, 2376.964345534818, 2299.275728145637, 2346.530693861226, 2357.422431504284, 2369.158948573249, 2380.321608341623, 2269.217120093565, 2270.625346817773, 2270.8864556772096, 2272.534130503251, 2279.2250634784255, 2367.3134790910617, 2380.3216083416314, 2381.785639292472, 2381.9523609527887, 2382.3567636737985, 10933.835992460119, 11019.118470522339, 11026.228164028522, 11027.283226590245, 11040.0, 5600.047991841356, 5729.369769325371, 5730.541556675456, 5742.827715168552, 5752.13717942312, 3173.7143657070974, 3316.535685004101, 3404.3872103021445, 3438.6561343865665, 3496.318217947501, 1121.198343184627, 1136.3409222650844, 1555.3933965753365, 1770.4246120011048, 1890.6691329017503, 13478.258695771729, 13693.383797729126, 14062.648433789238, 14404.423823047171, 14767.926160369238, 3937.4684417603257, 4245.575442455792, 4705.811767529261, 4721.102990431807, 4725.149473094807, 11822.940885295518, 11826.408679565988, 11829.645110646694, 11841.763164736829, 11859.229150105388, 5369.436209197978, 5696.401877802854, 5716.942830571724, 5720.971395142998, 5760.308762948389, 5207.427183009866, 5207.557357624569, 5213.556847667991, 5214.348206474191, 5218.739063046908, 3646.1796095878217, 3803.3724435468393, 3829.3107240696386, 3869.400242962345, 3875.0, 987.0770829274651, 987.5062468765617, 996.0736515040936, 998.630506712521, 1000.009990109786, 911.8723378726984, 929.2008872369756, 930.4370855632245, 943.9528023598792, 992.1715367668078, 6516.934830651728, 6541.967290163519, 6695.12963314766, 6776.627285499247, 6854.725810967506, 885.203317014692, 938.8357037518543, 939.923787263593, 947.190152419685, 985.6747273399761, 4190.580941905785, 4210.200061988213, 4228.492580890252, 4271.572842715766, 4397.6921615487245, 12729.727027297196, 12933.353332333534, 13536.59390218295, 13568.0, 13573.59279221625, 13453.730925381438, 13467.191968481726, 13469.932650336686, 13484.932575337256, 13510.12184208043, 7941.36469082472, 8093.757187284391, 8529.530875801891, 8925.062868398725, 8938.731838044869, 5781.392953739965, 6640.9335906642245, 6807.965960170168, 6835.07726456922, 6846.110005699227, 11932.761344772882, 11975.880241197825, 12000.63998080059, 12068.336241506802, 12196.695082623006, 12146.635600931986, 12172.634820955385, 12270.834270744264, 12315.261084334968, 12386.876131238932, 8930.151635594608, 9103.544822758704, 9279.907200927904, 9290.210332121575, 9309.487978160996, 10349.172066234532, 10367.0, 10458.320209186379, 10470.0, 10472.0, 8615.181557752254, 8777.692780752643, 8816.735497935073, 8817.16236957488, 8961.775955601162, 8547.40168188221, 8560.143985601639, 8620.655173792979, 8696.478211307342, 8707.47755134694, 7900.644470998934, 8057.597120143852, 8061.31478824283, 8064.677412903418, 8076.515409075474, 5518.613697041169, 5562.137868630369, 5648.604597678123, 5709.857253568694, 5764.913526297025, 4717.3159891816185, 5954.834684965689, 5956.255468066492, 5961.135635332766, 6083.756649733961], "value": 5062.82041295503, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [324.38205219057704, 373.1361897207963, 383.88291571070823, 391.8284329853738, 393.2950658893696, 4455.665825063121, 4681.695689780162, 4825.396825396825, 5372.340691357778, 5381.48875856794, 4112.444819949306, 4488.925086315876, 4794.664373493857, 4820.8071677132875, 4951.529604687558, 4193.014641559246, 4211.284081706117, 4252.468441444819, 4254.383114448403, 4310.52584215736, 3526.272126657932, 3840.7119466040017, 3949.7630142191415, 4301.924518870283, 4337.63130133939, 3564.6613571710645, 4114.732542384735, 4158.293090174678, 4276.647843685976, 4290.249206388885, 3947.861824836146, 4087.2438598859158, 4202.768847713374, 4230.153969206141, 4265.253580623394, 3344.8494817733263, 3486.267883744417, 3852.2680690668685, 3866.9613303867163, 3944.3097457944746, 4078.5717499662405, 5040.36995375578, 5056.898862022776, 5058.671186372874, 5074.594032477393, 4342.392065110887, 4615.792024542944, 4877.268409738532, 4925.950740492585, 4981.576565991895, 4848.612111031109, 5424.446987223336, 5524.558035357162, 5530.391656917735, 5578.30271216098, 4113.609207125318, 4300.505441874193, 4312.676549258818, 4331.328644060176, 4356.170408428467, 4816.975915120437, 5145.819896303648, 5170.431252562215, 5254.92117618236, 5291.841244762663, 4009.51885773709, 4510.0, 4520.491127424245, 4525.0, 4535.886602834956, 3879.3599056155417, 4479.395281636937, 4618.406649705846, 4629.583337499641, 4631.9536804631525, 4446.888827779331, 4553.840615578439, 4643.326717625993, 4653.883068063708, 4709.822544363909, 4816.831410900601, 5449.692073902235, 5454.509094181463, 5466.0, 5503.523414463508, 1303.6089173247988, 1434.6771976305247, 1502.0912348029285, 1562.4687606213943, 1575.4013474879473, 1077.7251800790748, 1156.3639998001065, 1173.0029474946227, 1176.16492290473, 1194.9223300485442, 4622.329762184531, 4823.6382271329085, 4965.120230266437, 5178.818741344035, 5179.81870634526, 5713.628614140068, 5716.885662286814, 5749.88500229993, 5765.261500787176, 5803.216565763652, 4800.495947925418, 4875.318015284721, 5047.394312682502, 5160.303359046556, 5192.559497036463, 2840.6165167702097, 2881.481333359973, 2901.231173738961, 2904.6804851466322, 2905.8837646493903, 5669.858253543694, 5795.275590551181, 5909.645421274738, 5942.286925568959, 5947.434993675594, 5027.547520723152, 5282.392524859613, 5525.336959564878, 5701.802621449542, 5769.644133628594, 5049.545540901337, 5699.860027994335, 5764.904668113045, 5858.150568167592, 5897.734601942837, 4428.427908092581, 5165.468920229136, 5325.4940780625775, 5579.023670857665, 5683.9200551896665, 4961.305417241517, 5256.316678831728, 5462.481064298885, 5547.472990065938, 5600.927656767022, 5001.924971125363, 5620.325560932714, 5639.830805075854, 5722.713864306685, 5744.798932037359, 3969.2656858481273, 4007.91984160321, 4366.388705581285, 4567.360569520203, 4599.70101943386, 5350.652207606493, 5642.746076426489, 5684.431556844448, 5774.682392468455, 5800.535957123504, 4300.440942677432, 5027.924581131213, 5108.56577190943, 5339.691775515023, 5582.794796055454, 4667.789949452351, 5417.51242388187, 5432.782688692566, 5439.0147596126335, 5495.725213739217, 4385.473743150842, 5167.741612919414, 5249.110320284618, 5335.33308336458, 5362.865928351823, 5033.92449113271, 5089.592832573311, 5277.182036784305, 5332.5467335276935, 5468.589855760754, 4894.363732714724, 5301.893962120813, 5310.8141215057285, 5411.402526787086, 5419.2413062170535], "value": 4173.711878744099, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [711.4201925430776, 732.3591857125019, 769.7729169894884, 818.7584662524556, 829.7427797382813, 14899.776503352445, 15762.369505219778, 15763.68472630548, 15799.973001754892, 15810.4466343678, 14200.857991420082, 14240.216788076652, 14319.0, 14440.989130760825, 15006.699866002673, 931.3294428011837, 940.0881145289093, 945.9337846350758, 946.2950102173891, 974.1768205866067, 951.4671783801059, 958.6836344006462, 964.0359640359641, 964.3827950111934, 964.6720115160844, 1011.6964910526813, 1013.5945621751284, 1013.9594416223342, 1017.3539802225566, 1017.4048181813648, 1005.3465247589053, 1009.5406590001531, 1009.7778488732467, 1009.8990100989915, 1012.488693209928, 741.9220981796941, 749.7975546602387, 750.89487471754, 751.4476859508258, 751.673022235324, 15504.767428488582, 15508.5347439577, 15782.684346313124, 15882.205889705585, 15951.92024039884, 14027.368768405446, 14083.155010699391, 14102.788458173136, 14265.072770269899, 14298.21272340947, 11479.13906457019, 11824.940875295568, 11872.821907671392, 11888.821667674993, 12121.45453454588, 3670.0254766315215, 3718.200586873808, 3722.3858063419502, 3818.522684664417, 3862.3820188769664, 107379.0, 107462.0, 112715.43642281818, 112980.0, 114043.42978285138, 10398.168146548258, 10724.624638137628, 10859.83710244347, 10875.401852898167, 10888.61889833852, 22652.546949060925, 22792.886035569714, 22905.19831805879, 22907.0, 22973.85130743456, 7483.5280769153815, 7589.051368578927, 7592.088949326006, 7664.31021208094, 7749.7675069748, 4134.545200027995, 4221.366794980716, 4244.3209086546, 4258.723182993095, 4330.631896288851, 3392.5420068290464, 3439.8108104054018, 3464.5149679044953, 3507.31607336572, 3518.3315170117594, 547.9369872464717, 623.2054130982942, 627.9686015699197, 634.5811764235582, 640.9711562979677, 648.6335220600346, 660.1580197250786, 669.9899501507481, 682.474494639125, 708.4297140801704, 8464.788380290542, 10120.443375614264, 10331.0, 10528.473576321154, 10562.471876406149, 644.5874640230256, 659.8119535932332, 674.75371489407, 703.7185125949661, 705.3264132753209, 4082.1386598168265, 4852.320675105488, 5012.799488020439, 5104.948950510522, 5168.638195326366, 108005.37991930127, 108440.45779771208, 108546.37180442299, 109143.45428272967, 109257.45371273252, 68531.0, 73463.63268183624, 80094.0, 81362.18637813546, 84703.0, 72950.27049729435, 73337.26662733412, 73385.26614733784, 73683.89474157785, 77253.2274677246, 10611.628592999517, 10937.671869843918, 11117.05505032049, 11162.888371116185, 11375.26060806045, 46829.2975605373, 48667.783305417644, 49158.75420622874, 50289.74855125701, 51032.97934041372, 62388.688056561245, 62967.0, 63994.720105596694, 65665.34334656592, 65849.0122648151, 11004.779904402027, 11157.27477713946, 11184.94407527957, 11356.772864542829, 11515.30908145514, 14155.0, 14634.560963170696, 14854.010772601954, 15278.541643750705, 15351.23243837826, 13108.934455327662, 13307.201567905957, 13825.654358641115, 14060.78908816389, 14720.718288665274, 13128.671783205496, 13501.932490337878, 14005.089669171472, 14147.575572732834, 14491.927540362653, 13254.204747714783, 13421.798673019717, 13565.914726821633, 14005.579832605039, 14230.730780765522, 8793.560321983747, 9111.726648200565, 9347.859782103409, 9429.717108486757, 9539.09378609031, 9646.758831029281, 10031.899681003388, 10922.29005114665, 11346.262492937933, 11355.602553910574], "value": 7583.426968654995, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1447.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 114.0, 113.0, 113.0, 114.0, 113.0, 114.0, 114.0, 113.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 107.0, 107.0, 139.0, 111.0, 112.0, 134.0, 136.0, 125.0, 109.0], "value": 122.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 185.0, 185.0, 185.0, 184.0, 185.0, 185.0, 186.0, 183.0], "value": 184.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 61.0, 61.0, 91.0, 64.0, 60.0, 61.0, 62.0, 75.0, 60.0], "value": 67.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 71.0, 85.0, 75.0, 99.0, 100.0, 117.0, 69.0, 69.0, 83.0], "value": 85.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 133.0, 86.0, 87.0, 86.0, 87.0, 87.0, 86.0, 86.0, 87.0], "value": 95.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 86.0, 100.0, 128.0, 68.0, 128.0, 127.0, 130.0, 85.0], "value": 102.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 62.0, 61.0, 62.0, 63.0, 65.0, 64.0, 64.0, 62.0], "value": 62.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 62.0, 66.0, 63.0, 61.0, 58.0, 58.0, 57.0, 58.0, 59.0], "value": 59.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 80.0, 83.0, 90.0, 79.0, 82.0, 69.0, 80.0, 91.0, 90.0], "value": 82.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 139.0, 146.0, 145.0, 143.0, 134.0, 140.0, 143.0, 176.0, 182.0], "value": 148.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 164.0, 165.0, 164.0, 162.0, 164.0, 163.0, 164.0, 163.0], "value": 164.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 65.0, 64.0, 64.0, 65.0, 63.0, 65.0, 64.0, 63.0], "value": 64.2, "unit": "score"}]}]} 01:59:02 INFO - Return code: 0 01:59:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:59:02 ERROR - # TBPL SUCCESS # 01:59:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:59:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:59:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:59:02 INFO - 2017-04-01 01:59:02.777 screenresolution[1662:11696] starting screenresolution argv=screenresolution get 01:59:02 INFO - 2017-04-01 01:59:02.780 screenresolution[1662:11696] Display 0: 1600x1200x32@60 01:59:02 INFO - 2017-04-01 01:59:02.786 screenresolution[1663:11699] starting screenresolution argv=screenresolution list 01:59:02 INFO - Available Modes on Display 0 01:59:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:59:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:59:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:59:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:59:03 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:59:03 INFO - Intel Iris: 01:59:03 INFO - Chipset Model: Intel Iris 01:59:03 INFO - Type: GPU 01:59:03 INFO - Bus: Built-In 01:59:03 INFO - VRAM (Dynamic, Max): 1536 MB 01:59:03 INFO - Vendor: Intel (0x8086) 01:59:03 INFO - Device ID: 0x0a2e 01:59:03 INFO - Revision ID: 0x0009 01:59:03 INFO - Displays: 01:59:03 INFO - Display: 01:59:03 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:59:03 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:59:03 INFO - Display Serial Number: 1600x1200 60 01:59:03 INFO - Main Display: Yes 01:59:03 INFO - Mirror: Off 01:59:03 INFO - Online: Yes 01:59:03 INFO - Rotation: Supported 01:59:03 INFO - Return code: 0 01:59:03 INFO - Running post-action listener: _resource_record_post_action 01:59:03 INFO - [mozharness: 2017-04-01 08:59:03.021070Z] Finished run-tests step (success) 01:59:03 INFO - Running post-run listener: _resource_record_post_run 01:59:03 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 32697344; Write bytes: 512143360; Read time: 215; Write time: 1607 01:59:03 INFO - TinderboxPrint: CPU usage
54.0% 01:59:03 INFO - TinderboxPrint: I/O read bytes / time
32,697,344 / 215 01:59:03 INFO - TinderboxPrint: I/O write bytes / time
512,143,360 / 1,607 01:59:03 INFO - TinderboxPrint: CPU idle
2,209.0 (46.0%) 01:59:03 INFO - TinderboxPrint: CPU system
960.5 (20.0%) 01:59:03 INFO - TinderboxPrint: CPU user
1,636.1 (34.0%) 01:59:03 INFO - TinderboxPrint: Swap in / out
236,396,544 / 0 01:59:03 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 203758080; Write bytes: 201795584; Read time: 15478; Write time: 428 01:59:03 INFO - run-tests - Wall time: 1181s; CPU: 54.0%; Read bytes: 30657536; Write bytes: 299563008; Read time: 196; Write time: 1143 01:59:03 INFO - Running post-run listener: _upload_blobber_files 01:59:03 INFO - Blob upload gear active. 01:59:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:59:03 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 01:59:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:59:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:59:03 INFO - (blobuploader) - INFO - Open directory for files ... 01:59:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:59:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:59:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:59:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:59:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:59:05 INFO - (blobuploader) - INFO - Done attempting. 01:59:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:59:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:59:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:59:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:59:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:59:05 INFO - (blobuploader) - INFO - Done attempting. 01:59:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 01:59:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:59:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:59:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 01:59:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:59:06 INFO - (blobuploader) - INFO - Done attempting. 01:59:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:59:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:59:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:59:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:59:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:59:08 INFO - (blobuploader) - INFO - Done attempting. 01:59:08 INFO - (blobuploader) - INFO - Iteration through files over. 01:59:08 INFO - Return code: 0 01:59:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:59:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:59:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/55b86f5e06dd463d84e216f8b4006d285cc9e6b05fbe44274e596b7dfde181a2a8afc39906d380b65df9a65c0c72160d8797dddbb42a07703ee1f4b5c0745515", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1d9223fc199f3887bea297a93783da1f4d60a704b1efc98b4dd55440c9f925c2bb7af3c5161d65c15b789ccbec070ecc8ab7471eb1249873035d70f46f8a44c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee6e2b5055cca651f21874022e349b77cbf0cb3a5fa527c5308751732991c0182e4f33932ef7a01b95234e07cbdde9799d63bf4c258a842612454790b3ef9a59", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/762ca537a3a49b19aba11ed7eda5bc26fc658247baa86d0eb95be595bc76e9f1d05d30044dc662b7d7f73b784cb56c92eb98650cdfaa9c7bfa184d5aad6d3d38"} 01:59:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:59:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:59:08 INFO - Contents: 01:59:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/55b86f5e06dd463d84e216f8b4006d285cc9e6b05fbe44274e596b7dfde181a2a8afc39906d380b65df9a65c0c72160d8797dddbb42a07703ee1f4b5c0745515", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1d9223fc199f3887bea297a93783da1f4d60a704b1efc98b4dd55440c9f925c2bb7af3c5161d65c15b789ccbec070ecc8ab7471eb1249873035d70f46f8a44c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee6e2b5055cca651f21874022e349b77cbf0cb3a5fa527c5308751732991c0182e4f33932ef7a01b95234e07cbdde9799d63bf4c258a842612454790b3ef9a59", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/762ca537a3a49b19aba11ed7eda5bc26fc658247baa86d0eb95be595bc76e9f1d05d30044dc662b7d7f73b784cb56c92eb98650cdfaa9c7bfa184d5aad6d3d38"} 01:59:08 INFO - Running post-run listener: copy_logs_to_upload_dir 01:59:08 INFO - Copying logs to upload dir... 01:59:08 INFO - mkdir: /builds/slave/test/build/upload/logs 01:59:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1291.333648 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2017-04-01 01:59:09.007677) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-01 01:59:09.011655) ========= 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.EV8fi2eAkc/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.Ue8xlMe4Md/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/55b86f5e06dd463d84e216f8b4006d285cc9e6b05fbe44274e596b7dfde181a2a8afc39906d380b65df9a65c0c72160d8797dddbb42a07703ee1f4b5c0745515", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1d9223fc199f3887bea297a93783da1f4d60a704b1efc98b4dd55440c9f925c2bb7af3c5161d65c15b789ccbec070ecc8ab7471eb1249873035d70f46f8a44c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee6e2b5055cca651f21874022e349b77cbf0cb3a5fa527c5308751732991c0182e4f33932ef7a01b95234e07cbdde9799d63bf4c258a842612454790b3ef9a59", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/762ca537a3a49b19aba11ed7eda5bc26fc658247baa86d0eb95be595bc76e9f1d05d30044dc662b7d7f73b784cb56c92eb98650cdfaa9c7bfa184d5aad6d3d38"} build_url:https://queue.taskcluster.net/v1/task/JP1W0odGTwi9rS1uBTyndA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011256 build_url: 'https://queue.taskcluster.net/v1/task/JP1W0odGTwi9rS1uBTyndA/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/55b86f5e06dd463d84e216f8b4006d285cc9e6b05fbe44274e596b7dfde181a2a8afc39906d380b65df9a65c0c72160d8797dddbb42a07703ee1f4b5c0745515", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/1d9223fc199f3887bea297a93783da1f4d60a704b1efc98b4dd55440c9f925c2bb7af3c5161d65c15b789ccbec070ecc8ab7471eb1249873035d70f46f8a44c3", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ee6e2b5055cca651f21874022e349b77cbf0cb3a5fa527c5308751732991c0182e4f33932ef7a01b95234e07cbdde9799d63bf4c258a842612454790b3ef9a59", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/762ca537a3a49b19aba11ed7eda5bc26fc658247baa86d0eb95be595bc76e9f1d05d30044dc662b7d7f73b784cb56c92eb98650cdfaa9c7bfa184d5aad6d3d38"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-01 01:59:09.047419) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 01:59:09.047753) ========= 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.EV8fi2eAkc/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.Ue8xlMe4Md/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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.005203 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-01 01:59:09.095978) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-01 01:59:09.096302) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-01 01:59:09.096621) ========= ========= Total master_lag: 0.18 =========