builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0001 starttime: 1489010153.32 results: success (0) buildid: 20170308122623 builduid: d0562f6066554afb890dad33787c0833 revision: fc5b01fb884a73b3bf8d7f03d30b7b8d498c52e9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-08 13:55:53.324468) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-08 13:55:53.324908) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-08 13:55:53.325198) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-08 13:55:53.352108) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 13:55:53.352463) ========= 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.PsyYwwXN3X/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.YpNKCQ7NaE/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-08 13:55:53-- 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% 159M=0s 2017-03-08 13:55:53 (159 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.094584 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 13:55:53.471325) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 13:55:53.471655) ========= 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.PsyYwwXN3X/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.YpNKCQ7NaE/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.028376 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 13:55:53.521322) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-08 13:55:53.521690) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev fc5b01fb884a73b3bf8d7f03d30b7b8d498c52e9 --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 fc5b01fb884a73b3bf8d7f03d30b7b8d498c52e9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.PsyYwwXN3X/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.YpNKCQ7NaE/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-08 13:55:53,621 truncating revision to first 12 chars 2017-03-08 13:55:53,621 Setting DEBUG logging. 2017-03-08 13:55:53,621 attempt 1/10 2017-03-08 13:55:53,621 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/fc5b01fb884a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-08 13:55:55,468 unpacking tar archive at: mozilla-aurora-fc5b01fb884a/testing/mozharness/ program finished with exit code 0 elapsedTime=2.111567 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-08 13:55:55.659715) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-08 13:55:55.660164) ========= script_repo_revision: fc5b01fb884a73b3bf8d7f03d30b7b8d498c52e9 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-08 13:55:55.660923) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-08 13:55:55.661512) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-08 13:55:55.682660) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-03-08 13:55:55.683322) ========= /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.PsyYwwXN3X/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.YpNKCQ7NaE/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 13:55:55 INFO - MultiFileLogger online at 20170308 13:55:55 in /builds/slave/test 13:55:55 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 13:55:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:55:55 INFO - {'append_to_log': False, 13:55:55 INFO - 'base_work_dir': '/builds/slave/test', 13:55:55 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 13:55:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:55:55 INFO - 'branch': 'Mozilla-Aurora', 13:55:55 INFO - 'buildbot_json_path': 'buildprops.json', 13:55:55 INFO - 'config_files': ('talos/mac_config.py',), 13:55:55 INFO - 'default_actions': ('clobber', 13:55:55 INFO - 'read-buildbot-config', 13:55:55 INFO - 'download-and-extract', 13:55:55 INFO - 'populate-webroot', 13:55:55 INFO - 'create-virtualenv', 13:55:55 INFO - 'install', 13:55:55 INFO - 'run-tests'), 13:55:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:55:55 INFO - 'download_minidump_stackwalk': True, 13:55:55 INFO - 'download_symbols': 'ondemand', 13:55:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:55:55 INFO - 'tooltool.py': '/tools/tooltool.py', 13:55:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:55:55 INFO - '/tools/misc-python/virtualenv.py')}, 13:55:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:55:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:55:55 INFO - 'gecko_profile': False, 13:55:55 INFO - 'gecko_profile_interval': 0, 13:55:55 INFO - 'installer_path': 'installer.exe', 13:55:55 INFO - 'log_level': 'info', 13:55:55 INFO - 'log_name': 'talos', 13:55:55 INFO - 'log_to_console': True, 13:55:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:55:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:55:55 INFO - 'opt_config_files': (), 13:55:55 INFO - 'pip_index': False, 13:55:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:55:55 INFO - 'cmd': ('bash', 13:55:55 INFO - '-c', 13:55:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:55:55 INFO - 'enabled': True, 13:55:55 INFO - 'halt_on_failure': False, 13:55:55 INFO - 'name': 'check_screen_resolution'},), 13:55:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:55:55 INFO - 'cmd': ('bash', 13:55:55 INFO - '-c', 13:55:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:55:55 INFO - 'enabled': True, 13:55:55 INFO - 'halt_on_failure': False, 13:55:55 INFO - 'name': 'check_screen_resolution'},), 13:55:55 INFO - 'run_cmd_checks_enabled': True, 13:55:55 INFO - 'suite': 'dromaeojs', 13:55:55 INFO - 'system_bits': '32', 13:55:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:55:55 INFO - 'title': 't-yosemite-r7-0001', 13:55:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:55:55 INFO - 'use_talos_json': True, 13:55:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:55:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:55:55 INFO - 'work_dir': 'build'} 13:55:55 INFO - [mozharness: 2017-03-08 21:55:55.894216Z] Running clobber step. 13:55:55 INFO - Running pre-action listener: _resource_record_pre_action 13:55:55 INFO - Running main action method: clobber 13:55:55 INFO - rmtree: /builds/slave/test/build 13:55:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:55:58 INFO - Running post-action listener: _resource_record_post_action 13:55:58 INFO - [mozharness: 2017-03-08 21:55:58.513880Z] Finished clobber step (success) 13:55:58 INFO - [mozharness: 2017-03-08 21:55:58.514147Z] Running read-buildbot-config step. 13:55:58 INFO - Running pre-action listener: _resource_record_pre_action 13:55:58 INFO - Running main action method: read_buildbot_config 13:55:58 INFO - Using buildbot properties: 13:55:58 INFO - { 13:55:58 INFO - "project": "", 13:55:58 INFO - "product": "firefox", 13:55:58 INFO - "script_repo_revision": "production", 13:55:58 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 13:55:58 INFO - "repository": "", 13:55:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 13:55:58 INFO - "buildid": "20170308122623", 13:55:58 INFO - "pgo_build": "False", 13:55:58 INFO - "basedir": "/builds/slave/test", 13:55:58 INFO - "buildnumber": 4, 13:55:58 INFO - "slavename": "t-yosemite-r7-0001", 13:55:58 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:55:58 INFO - "platform": "yosemite_r7", 13:55:58 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 13:55:58 INFO - "branch": "mozilla-aurora", 13:55:58 INFO - "repo_path": "releases/mozilla-aurora", 13:55:58 INFO - "revision": "fc5b01fb884a73b3bf8d7f03d30b7b8d498c52e9", 13:55:58 INFO - "stage_platform": "macosx64", 13:55:58 INFO - "builduid": "d0562f6066554afb890dad33787c0833", 13:55:58 INFO - "slavebuilddir": "test" 13:55:58 INFO - } 13:55:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/bY0nnvr5Trm5TeHY4aKWWw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg. 13:55:58 INFO - Running post-action listener: _resource_record_post_action 13:55:58 INFO - [mozharness: 2017-03-08 21:55:58.519830Z] Finished read-buildbot-config step (success) 13:55:58 INFO - [mozharness: 2017-03-08 21:55:58.520072Z] Running download-and-extract step. 13:55:58 INFO - Running pre-action listener: _resource_record_pre_action 13:55:58 INFO - Running main action method: download_and_extract 13:55:58 INFO - mkdir: /builds/slave/test/build/tests 13:55:58 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')]} 13:55:58 INFO - trying https://queue.taskcluster.net/v1/task/bY0nnvr5Trm5TeHY4aKWWw/artifacts/public/build/firefox-54.0a2.en-US.mac.test_packages.json 13:55:58 INFO - Downloading https://queue.taskcluster.net/v1/task/bY0nnvr5Trm5TeHY4aKWWw/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 13:55:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bY0nnvr5Trm5TeHY4aKWWw/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 13:55:59 INFO - Downloaded 1199 bytes. 13:55:59 INFO - Reading from file /builds/slave/test/build/firefox-54.0a2.en-US.mac.test_packages.json 13:55:59 INFO - Using the following test package requirements: 13:55:59 INFO - {u'common': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 13:55:59 INFO - u'cppunittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 13:55:59 INFO - u'firefox-54.0a2.en-US.mac.cppunittest.tests.zip'], 13:55:59 INFO - u'gtest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 13:55:59 INFO - u'firefox-54.0a2.en-US.mac.gtest.tests.zip'], 13:55:59 INFO - u'jittest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 13:55:59 INFO - u'jsshell-mac.zip'], 13:55:59 INFO - u'mochitest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 13:55:59 INFO - u'firefox-54.0a2.en-US.mac.mochitest.tests.zip'], 13:55:59 INFO - u'mozbase': [u'firefox-54.0a2.en-US.mac.common.tests.zip'], 13:55:59 INFO - u'reftest': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 13:55:59 INFO - u'firefox-54.0a2.en-US.mac.reftest.tests.zip'], 13:55:59 INFO - u'talos': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 13:55:59 INFO - u'firefox-54.0a2.en-US.mac.talos.tests.zip'], 13:55:59 INFO - u'web-platform': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 13:55:59 INFO - u'firefox-54.0a2.en-US.mac.web-platform.tests.zip'], 13:55:59 INFO - u'xpcshell': [u'firefox-54.0a2.en-US.mac.common.tests.zip', 13:55:59 INFO - u'firefox-54.0a2.en-US.mac.xpcshell.tests.zip']} 13:55:59 INFO - Downloading packages: [u'firefox-54.0a2.en-US.mac.common.tests.zip'] for test suite category: common 13:55:59 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bY0nnvr5Trm5TeHY4aKWWw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 13:55:59 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bY0nnvr5Trm5TeHY4aKWWw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:55:59 INFO - Fetch https://queue.taskcluster.net/v1/task/bY0nnvr5Trm5TeHY4aKWWw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 13:56:01 INFO - Expected file size: 51777055 13:56:01 INFO - Obtained file size: 51777055 13:56:17 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 13:56:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bY0nnvr5Trm5TeHY4aKWWw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip 13:56:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bY0nnvr5Trm5TeHY4aKWWw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip'}, attempt #1 13:56:17 INFO - Fetch https://queue.taskcluster.net/v1/task/bY0nnvr5Trm5TeHY4aKWWw/artifacts/public/build/firefox-54.0a2.en-US.mac.common.tests.zip into memory 13:56:19 INFO - Expected file size: 51777055 13:56:19 INFO - Obtained file size: 51777055 13:56:34 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/bY0nnvr5Trm5TeHY4aKWWw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip 13:56:34 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/bY0nnvr5Trm5TeHY4aKWWw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip'}, attempt #1 13:56:34 INFO - Fetch https://queue.taskcluster.net/v1/task/bY0nnvr5Trm5TeHY4aKWWw/artifacts/public/build/firefox-54.0a2.en-US.mac.talos.tests.zip into memory 13:56:36 INFO - Expected file size: 14404424 13:56:36 INFO - Obtained file size: 14404424 13:56:36 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')]} 13:56:36 INFO - trying https://queue.taskcluster.net/v1/task/bY0nnvr5Trm5TeHY4aKWWw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 13:56:36 INFO - Downloading https://queue.taskcluster.net/v1/task/bY0nnvr5Trm5TeHY4aKWWw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a2.en-US.mac.dmg 13:56:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/bY0nnvr5Trm5TeHY4aKWWw/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 13:56:38 INFO - Downloaded 74610118 bytes. 13:56:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bY0nnvr5Trm5TeHY4aKWWw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 13:56:38 INFO - mkdir: /builds/slave/test/properties 13:56:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:56:38 INFO - Writing to file /builds/slave/test/properties/build_url 13:56:38 INFO - Contents: 13:56:38 INFO - build_url:https://queue.taskcluster.net/v1/task/bY0nnvr5Trm5TeHY4aKWWw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg 13:56:39 INFO - Running post-action listener: _resource_record_post_action 13:56:39 INFO - Running post-action listener: set_extra_try_arguments 13:56:39 INFO - [mozharness: 2017-03-08 21:56:39.282181Z] Finished download-and-extract step (success) 13:56:39 INFO - [mozharness: 2017-03-08 21:56:39.282325Z] Running populate-webroot step. 13:56:39 INFO - Running pre-action listener: _resource_record_pre_action 13:56:39 INFO - Running main action method: populate_webroot 13:56:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:56:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:56:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:56:39 INFO - '--tppagecycles', 13:56:39 INFO - '7'], 13:56:39 INFO - 'tests': ['tsvgm']}}, 13:56:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:56:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:56:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:56:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:56:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:56:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:56:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 13:56:39 INFO - 'talos_options': ['--disable-e10s'], 13:56:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:56:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 13:56:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:56:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 13:56:39 INFO - 'talos_options': ['--disable-e10s'], 13:56:39 INFO - 'tests': ['damp', 'tps']}, 13:56:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 13:56:39 INFO - 'tests': ['damp', 'tps']}, 13:56:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:56:39 INFO - 'tests': ['dromaeo_dom']}, 13:56:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:56:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 13:56:39 INFO - 'tests': ['basic_compositor_video']}, 13:56:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 13:56:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:56:39 INFO - 'tests': ['a11yr', 13:56:39 INFO - 'ts_paint', 13:56:39 INFO - 'tpaint', 13:56:39 INFO - 'sessionrestore', 13:56:39 INFO - 'sessionrestore_no_auto_restore', 13:56:39 INFO - 'tabpaint']}, 13:56:39 INFO - 'other-e10s': {'tests': ['a11yr', 13:56:39 INFO - 'ts_paint', 13:56:39 INFO - 'tpaint', 13:56:39 INFO - 'sessionrestore', 13:56:39 INFO - 'sessionrestore_no_auto_restore', 13:56:39 INFO - 'tabpaint']}, 13:56:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:56:39 INFO - 'ts_paint', 13:56:39 INFO - 'tpaint', 13:56:39 INFO - 'sessionrestore', 13:56:39 INFO - 'sessionrestore_no_auto_restore', 13:56:39 INFO - 'tabpaint']}, 13:56:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:56:39 INFO - 'ts_paint', 13:56:39 INFO - 'tpaint', 13:56:39 INFO - 'sessionrestore', 13:56:39 INFO - 'sessionrestore_no_auto_restore', 13:56:39 INFO - 'tabpaint']}, 13:56:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:56:39 INFO - 'tests': ['a11yr', 13:56:39 INFO - 'ts_paint', 13:56:39 INFO - 'tpaint', 13:56:39 INFO - 'sessionrestore', 13:56:39 INFO - 'sessionrestore_no_auto_restore', 13:56:39 INFO - 'tabpaint']}, 13:56:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:56:39 INFO - 'tests': ['a11yr', 13:56:39 INFO - 'ts_paint', 13:56:39 INFO - 'tpaint', 13:56:39 INFO - 'sessionrestore', 13:56:39 INFO - 'sessionrestore_no_auto_restore', 13:56:39 INFO - 'tabpaint']}, 13:56:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:56:39 INFO - 'tests': ['tsvgx', 13:56:39 INFO - 'tsvgr_opacity', 13:56:39 INFO - 'tart', 13:56:39 INFO - 'tscrollx', 13:56:39 INFO - 'cart', 13:56:39 INFO - 'tsvg_static']}, 13:56:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:56:39 INFO - 'tsvgr_opacity', 13:56:39 INFO - 'tart', 13:56:39 INFO - 'tscrollx', 13:56:39 INFO - 'cart', 13:56:39 INFO - 'tsvg_static']}, 13:56:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 13:56:39 INFO - 'talos_options': ['--disable-e10s'], 13:56:39 INFO - 'tests': ['tp5o']}, 13:56:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 13:56:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 13:56:39 INFO - 'talos_options': ['--disable-e10s', 13:56:39 INFO - '--xperf_path', 13:56:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:56:39 INFO - 'tests': ['tp5n']}, 13:56:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 13:56:39 INFO - 'talos_options': ['--xperf_path', 13:56:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:56:39 INFO - 'tests': ['tp5n']}}, 13:56:39 INFO - 'talos.zip': {'path': '', 13:56:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:56:39 INFO - Running post-action listener: _resource_record_post_action 13:56:39 INFO - [mozharness: 2017-03-08 21:56:39.301176Z] Finished populate-webroot step (success) 13:56:39 INFO - [mozharness: 2017-03-08 21:56:39.301315Z] Running create-virtualenv step. 13:56:39 INFO - Running pre-action listener: _resource_record_pre_action 13:56:39 INFO - Running main action method: create_virtualenv 13:56:39 INFO - Creating virtualenv /builds/slave/test/build/venv 13:56:39 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 13:56:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:56:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:56:39 INFO - Using real prefix '/tools/python27' 13:56:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:56:40 INFO - Installing distribute.............................................................................................................................................................................................done. 13:56:42 INFO - Installing pip.................done. 13:56:42 INFO - Return code: 0 13:56:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 13:56:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 13:56:43 INFO - Reading from file tmpfile_stdout 13:56:43 INFO - Output received: 13:56:43 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) 13:56:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:56:43 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')]} 13:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:43 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')]} 13:56:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:43 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 0x10f17ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f17d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb680ca58f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef58d30>, '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 0x10ee7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef4dbe8>, '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.PsyYwwXN3X/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.YpNKCQ7NaE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:56:43 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 13:56:43 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 13:56:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PsyYwwXN3X/Render', 13:56:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:43 INFO - 'HOME': '/Users/cltbld', 13:56:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:43 INFO - 'LOGNAME': 'cltbld', 13:56:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:43 INFO - 'MOZ_NO_REMOTE': '1', 13:56:43 INFO - 'NO_EM_RESTART': '1', 13:56:43 INFO - 'PAGER': '/bin/cat', 13:56:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:43 INFO - 'PWD': '/builds/slave/test', 13:56:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:43 INFO - 'SHELL': '/bin/bash', 13:56:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YpNKCQ7NaE/Listeners', 13:56:43 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 13:56:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:43 INFO - 'USER': 'cltbld', 13:56:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:43 INFO - 'XPC_FLAGS': '0x0', 13:56:43 INFO - 'XPC_SERVICE_NAME': '0', 13:56:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:43 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 13:56:43 INFO - Cleaning up... 13:56:43 INFO - Return code: 0 13:56:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 13:56:43 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')]} 13:56:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:43 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')]} 13:56:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:43 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 0x10f17ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f17d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb680ca58f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef58d30>, '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 0x10ee7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef4dbe8>, '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.PsyYwwXN3X/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.YpNKCQ7NaE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:56:43 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 13:56:43 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 13:56:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PsyYwwXN3X/Render', 13:56:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:43 INFO - 'HOME': '/Users/cltbld', 13:56:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:43 INFO - 'LOGNAME': 'cltbld', 13:56:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:43 INFO - 'MOZ_NO_REMOTE': '1', 13:56:43 INFO - 'NO_EM_RESTART': '1', 13:56:43 INFO - 'PAGER': '/bin/cat', 13:56:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:43 INFO - 'PWD': '/builds/slave/test', 13:56:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:43 INFO - 'SHELL': '/bin/bash', 13:56:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YpNKCQ7NaE/Listeners', 13:56:43 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 13:56:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:43 INFO - 'USER': 'cltbld', 13:56:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:43 INFO - 'XPC_FLAGS': '0x0', 13:56:43 INFO - 'XPC_SERVICE_NAME': '0', 13:56:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:43 INFO - Downloading/unpacking psutil>=3.1.1 13:56: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 13:56: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 13:56: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 13:56: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 13:56: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 13:56: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 13:56:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:56:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:56:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:56:47 INFO - Installing collected packages: psutil 13:56:47 INFO - Running setup.py install for psutil 13:56:47 INFO - building 'psutil._psutil_osx' extension 13:56:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 13:56:48 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 13:56:48 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 13:56:48 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 13:56:48 INFO - building 'psutil._psutil_posix' extension 13:56:48 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 13:56:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:56:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:56:48 INFO - ^ 13:56:48 INFO - 1 warning generated. 13:56:48 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 13:56:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:56:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:56:48 INFO - Successfully installed psutil 13:56:48 INFO - Cleaning up... 13:56:48 INFO - Return code: 0 13:56:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 13:56:48 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')]} 13:56:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:48 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')]} 13:56:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:49 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 0x10f17ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f17d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb680ca58f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef58d30>, '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 0x10ee7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef4dbe8>, '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.PsyYwwXN3X/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.YpNKCQ7NaE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:56:49 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 13:56:49 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 13:56:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PsyYwwXN3X/Render', 13:56:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:49 INFO - 'HOME': '/Users/cltbld', 13:56:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:49 INFO - 'LOGNAME': 'cltbld', 13:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:49 INFO - 'MOZ_NO_REMOTE': '1', 13:56:49 INFO - 'NO_EM_RESTART': '1', 13:56:49 INFO - 'PAGER': '/bin/cat', 13:56:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:49 INFO - 'PWD': '/builds/slave/test', 13:56:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:49 INFO - 'SHELL': '/bin/bash', 13:56:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YpNKCQ7NaE/Listeners', 13:56:49 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 13:56:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:49 INFO - 'USER': 'cltbld', 13:56:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:49 INFO - 'XPC_FLAGS': '0x0', 13:56:49 INFO - 'XPC_SERVICE_NAME': '0', 13:56:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 13:56:49 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 13:56:49 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 13:56:49 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 13:56:49 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 13:56:49 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 13:56:49 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 13:56:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 13:56:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:56:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 13:56:52 INFO - Installing collected packages: mozsystemmonitor 13:56:52 INFO - Running setup.py install for mozsystemmonitor 13:56:52 INFO - Successfully installed mozsystemmonitor 13:56:52 INFO - Cleaning up... 13:56:52 INFO - Return code: 0 13:56:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 13:56:52 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')]} 13:56:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:52 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')]} 13:56:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:52 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 0x10f17ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f17d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb680ca58f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef58d30>, '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 0x10ee7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef4dbe8>, '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.PsyYwwXN3X/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.YpNKCQ7NaE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:56:52 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 13:56:52 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 13:56:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PsyYwwXN3X/Render', 13:56:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:52 INFO - 'HOME': '/Users/cltbld', 13:56:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:52 INFO - 'LOGNAME': 'cltbld', 13:56:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:52 INFO - 'MOZ_NO_REMOTE': '1', 13:56:52 INFO - 'NO_EM_RESTART': '1', 13:56:52 INFO - 'PAGER': '/bin/cat', 13:56:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:52 INFO - 'PWD': '/builds/slave/test', 13:56:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:52 INFO - 'SHELL': '/bin/bash', 13:56:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YpNKCQ7NaE/Listeners', 13:56:52 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 13:56:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:52 INFO - 'USER': 'cltbld', 13:56:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:52 INFO - 'XPC_FLAGS': '0x0', 13:56:52 INFO - 'XPC_SERVICE_NAME': '0', 13:56:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:53 INFO - Downloading/unpacking jsonschema==2.5.1 13:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:55 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:56:55 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 13:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:56 INFO - Downloading functools32-3.2.3-2.tar.gz 13:56:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:56:56 INFO - warning: no files found matching '*.txt' 13:56:56 INFO - no previously-included directories found matching 'build' 13:56:56 INFO - no previously-included directories found matching 'dist' 13:56:56 INFO - no previously-included directories found matching '.git*' 13:56:56 INFO - Installing collected packages: jsonschema, functools32 13:56:56 INFO - Running setup.py install for functools32 13:56:56 INFO - warning: no files found matching '*.txt' 13:56:56 INFO - no previously-included directories found matching 'build' 13:56:56 INFO - no previously-included directories found matching 'dist' 13:56:56 INFO - no previously-included directories found matching '.git*' 13:56:56 INFO - Successfully installed jsonschema functools32 13:56:56 INFO - Cleaning up... 13:56:56 INFO - Return code: 0 13:56:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 13:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f17ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f17d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb680ca58f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef58d30>, '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 0x10ee7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef4dbe8>, '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.PsyYwwXN3X/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.YpNKCQ7NaE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:56:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 13:56:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 13:56:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PsyYwwXN3X/Render', 13:56:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:56 INFO - 'HOME': '/Users/cltbld', 13:56:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:56 INFO - 'LOGNAME': 'cltbld', 13:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:56 INFO - 'MOZ_NO_REMOTE': '1', 13:56:56 INFO - 'NO_EM_RESTART': '1', 13:56:56 INFO - 'PAGER': '/bin/cat', 13:56:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:56 INFO - 'PWD': '/builds/slave/test', 13:56:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:56 INFO - 'SHELL': '/bin/bash', 13:56:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YpNKCQ7NaE/Listeners', 13:56:56 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 13:56:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:56 INFO - 'USER': 'cltbld', 13:56:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:56 INFO - 'XPC_FLAGS': '0x0', 13:56:56 INFO - 'XPC_SERVICE_NAME': '0', 13:56:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:56 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 13:56:56 INFO - Cleaning up... 13:56:56 INFO - Return code: 0 13:56:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:56:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:56:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:56:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:56:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f17ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f17d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb680ca58f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef58d30>, '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 0x10ee7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef4dbe8>, '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.PsyYwwXN3X/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.YpNKCQ7NaE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:56:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:56:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:56:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PsyYwwXN3X/Render', 13:56:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:56:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:56:56 INFO - 'HOME': '/Users/cltbld', 13:56:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:56:56 INFO - 'LOGNAME': 'cltbld', 13:56:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:56:56 INFO - 'MOZ_NO_REMOTE': '1', 13:56:56 INFO - 'NO_EM_RESTART': '1', 13:56:56 INFO - 'PAGER': '/bin/cat', 13:56:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:56:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:56:56 INFO - 'PWD': '/builds/slave/test', 13:56:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:56:56 INFO - 'SHELL': '/bin/bash', 13:56:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YpNKCQ7NaE/Listeners', 13:56:56 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 13:56:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:56:56 INFO - 'USER': 'cltbld', 13:56:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:56:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:56:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:56:56 INFO - 'XPC_FLAGS': '0x0', 13:56:56 INFO - 'XPC_SERVICE_NAME': '0', 13:56:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:56:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:56:57 INFO - Downloading/unpacking blobuploader==1.2.4 13:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:56:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:56:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:56:59 INFO - Downloading blobuploader-1.2.4.tar.gz 13:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:56:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:56:59 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 13:56:59 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 13:56:59 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 13:56:59 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 13:56:59 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 13:56:59 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 13:57:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:57:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:57:00 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 13:57:00 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 13:57:00 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 13:57:00 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 13:57:00 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 13:57:00 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 13:57:01 INFO - Downloading docopt-0.6.1.tar.gz 13:57:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:57:01 INFO - Installing collected packages: blobuploader, requests, docopt 13:57:01 INFO - Running setup.py install for blobuploader 13:57:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:57:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:57:01 INFO - Running setup.py install for requests 13:57:01 INFO - Running setup.py install for docopt 13:57:01 INFO - Successfully installed blobuploader requests docopt 13:57:01 INFO - Cleaning up... 13:57:02 INFO - Return code: 0 13:57:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:02 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 0x10f17ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f17d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb680ca58f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef58d30>, '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 0x10ee7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef4dbe8>, '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.PsyYwwXN3X/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.YpNKCQ7NaE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:57:02 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 13:57:02 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 13:57:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PsyYwwXN3X/Render', 13:57:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:02 INFO - 'HOME': '/Users/cltbld', 13:57:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:02 INFO - 'LOGNAME': 'cltbld', 13:57:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:02 INFO - 'MOZ_NO_REMOTE': '1', 13:57:02 INFO - 'NO_EM_RESTART': '1', 13:57:02 INFO - 'PAGER': '/bin/cat', 13:57:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:02 INFO - 'PWD': '/builds/slave/test', 13:57:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:02 INFO - 'SHELL': '/bin/bash', 13:57:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YpNKCQ7NaE/Listeners', 13:57:02 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 13:57:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:02 INFO - 'USER': 'cltbld', 13:57:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:02 INFO - 'XPC_FLAGS': '0x0', 13:57:02 INFO - 'XPC_SERVICE_NAME': '0', 13:57:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:57:02 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-iA9jLX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:57:02 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-A4Lkld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:57:02 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-4K2z1I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:57:02 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-NlZdYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:57:02 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-R0aVx8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:57:02 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-OldoPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:57:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:57:02 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-jEtzuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:57:03 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-eauoab-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:57:03 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-SkvKbr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:57:03 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-WLzXfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:57:03 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-T_VNn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:57:03 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-6LoSEH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:57:03 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-47sUJa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:57:03 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-LWKRcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:57:03 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-iGPvMd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:57:03 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-OQxk9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:57:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:57:03 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-J3QDnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:57:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:57:04 INFO - Running setup.py install for manifestparser 13:57:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:57:04 INFO - Running setup.py install for mozcrash 13:57:04 INFO - Running setup.py install for mozdebug 13:57:04 INFO - Running setup.py install for mozdevice 13:57:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:57:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:57:04 INFO - Running setup.py install for mozfile 13:57:04 INFO - Running setup.py install for mozhttpd 13:57:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:57:04 INFO - Running setup.py install for mozinfo 13:57:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:57:05 INFO - Running setup.py install for mozInstall 13:57:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:57:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:57:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:57:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:57:05 INFO - Running setup.py install for mozleak 13:57:05 INFO - Running setup.py install for mozlog 13:57:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:57:05 INFO - Running setup.py install for moznetwork 13:57:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:57:05 INFO - Running setup.py install for mozprocess 13:57:05 INFO - Running setup.py install for mozprofile 13:57:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:57:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:57:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:57:05 INFO - Running setup.py install for mozrunner 13:57:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:57:06 INFO - Running setup.py install for mozscreenshot 13:57:06 INFO - Running setup.py install for moztest 13:57:06 INFO - Running setup.py install for mozversion 13:57:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:57:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:57:06 INFO - Cleaning up... 13:57:06 INFO - Return code: 0 13:57:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:06 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 0x10f17ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f17d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb680ca58f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef58d30>, '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 0x10ee7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef4dbe8>, '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.PsyYwwXN3X/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.YpNKCQ7NaE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:57:06 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 13:57:06 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 13:57:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PsyYwwXN3X/Render', 13:57:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:06 INFO - 'HOME': '/Users/cltbld', 13:57:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:06 INFO - 'LOGNAME': 'cltbld', 13:57:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:06 INFO - 'MOZ_NO_REMOTE': '1', 13:57:06 INFO - 'NO_EM_RESTART': '1', 13:57:06 INFO - 'PAGER': '/bin/cat', 13:57:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:06 INFO - 'PWD': '/builds/slave/test', 13:57:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:06 INFO - 'SHELL': '/bin/bash', 13:57:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YpNKCQ7NaE/Listeners', 13:57:06 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 13:57:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:06 INFO - 'USER': 'cltbld', 13:57:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:06 INFO - 'XPC_FLAGS': '0x0', 13:57:06 INFO - 'XPC_SERVICE_NAME': '0', 13:57:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:57:06 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-v121kE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:57:07 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)) 13:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:57:07 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-XnKXBI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:57:07 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)) 13:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:57:07 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-WRjJpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:57:07 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)) 13:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:57:07 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-cnMFZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:57:07 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)) 13:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:57:07 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-zKcXdc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:57:07 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)) 13:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:57:07 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-LOpfMl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:57:07 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)) 13:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:57:07 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-cH3fxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:57:07 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)) 13:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:57:07 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-LundXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:57:07 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)) 13:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:57:07 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-TBh0LN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:57:07 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)) 13:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:57:07 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-EhXViW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:57:07 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)) 13:57:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:57:07 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-5vftzW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:57:08 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)) 13:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:57:08 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-oY6B3W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:57:08 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)) 13:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:57:08 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-rriOWp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:57:08 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)) 13:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:57:08 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-8GAz9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:57:08 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)) 13:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:57:08 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-x7spgm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:57:08 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)) 13:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:57:08 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-v4Y7Gg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:57:08 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)) 13:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:57:08 INFO - Running setup.py (path:/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/pip-tC8CGG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:57:08 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)) 13:57:08 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)) 13:57:08 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)) 13:57:08 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)) 13:57:08 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)) 13:57:08 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)) 13:57:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:57:08 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 13:57:08 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 13:57:08 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 13:57:08 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 13:57:08 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 13:57:08 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 13:57:11 INFO - Downloading blessings-1.6.tar.gz 13:57:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:57:11 INFO - Installing collected packages: blessings 13:57:11 INFO - Running setup.py install for blessings 13:57:11 INFO - Successfully installed blessings 13:57:11 INFO - Cleaning up... 13:57:11 INFO - Return code: 0 13:57:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:57:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:57:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:57:12 INFO - Reading from file tmpfile_stdout 13:57:12 INFO - Current package versions: 13:57:12 INFO - blessings == 1.6 13:57:12 INFO - blobuploader == 1.2.4 13:57:12 INFO - docopt == 0.6.1 13:57:12 INFO - functools32 == 3.2.3-2 13:57:12 INFO - jsonschema == 2.5.1 13:57:12 INFO - manifestparser == 1.1 13:57:12 INFO - mozInstall == 1.12 13:57:12 INFO - mozcrash == 1.0 13:57:12 INFO - mozdebug == 0.1 13:57:12 INFO - mozdevice == 0.49 13:57:12 INFO - mozfile == 1.2 13:57:12 INFO - mozhttpd == 0.7 13:57:12 INFO - mozinfo == 0.9 13:57:12 INFO - mozleak == 0.1 13:57:12 INFO - mozlog == 3.4 13:57:12 INFO - moznetwork == 0.27 13:57:12 INFO - mozprocess == 0.25 13:57:12 INFO - mozprofile == 0.28 13:57:12 INFO - mozrunner == 6.13 13:57:12 INFO - mozscreenshot == 0.1 13:57:12 INFO - mozsystemmonitor == 0.3 13:57:12 INFO - moztest == 0.8 13:57:12 INFO - mozversion == 1.4 13:57:12 INFO - psutil == 3.1.1 13:57:12 INFO - requests == 1.2.3 13:57:12 INFO - wsgiref == 0.1.2 13:57:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:12 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 0x10f17ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f17d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb680ca58f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef58d30>, '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 0x10ee7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef4dbe8>, '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.PsyYwwXN3X/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.YpNKCQ7NaE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:57:12 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 13:57:12 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 13:57:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PsyYwwXN3X/Render', 13:57:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:12 INFO - 'HOME': '/Users/cltbld', 13:57:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:12 INFO - 'LOGNAME': 'cltbld', 13:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:12 INFO - 'MOZ_NO_REMOTE': '1', 13:57:12 INFO - 'NO_EM_RESTART': '1', 13:57:12 INFO - 'PAGER': '/bin/cat', 13:57:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:12 INFO - 'PWD': '/builds/slave/test', 13:57:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:12 INFO - 'SHELL': '/bin/bash', 13:57:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YpNKCQ7NaE/Listeners', 13:57:12 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 13:57:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:12 INFO - 'USER': 'cltbld', 13:57:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:12 INFO - 'XPC_FLAGS': '0x0', 13:57:12 INFO - 'XPC_SERVICE_NAME': '0', 13:57:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:12 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)) 13:57:12 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)) 13:57:12 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)) 13:57:12 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)) 13:57:12 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)) 13:57:12 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)) 13:57:12 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)) 13:57:12 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)) 13:57:12 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)) 13:57:12 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)) 13:57:12 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)) 13:57:12 INFO - Cleaning up... 13:57:12 INFO - Return code: 0 13:57:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:57:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:57:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:57:12 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 0x10f17ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f17d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb680ca58f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ef58d30>, '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 0x10ee7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef4dbe8>, '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.PsyYwwXN3X/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.YpNKCQ7NaE/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 13:57:12 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 13:57:12 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 13:57:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PsyYwwXN3X/Render', 13:57:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:12 INFO - 'HOME': '/Users/cltbld', 13:57:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:12 INFO - 'LOGNAME': 'cltbld', 13:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:12 INFO - 'MOZ_NO_REMOTE': '1', 13:57:12 INFO - 'NO_EM_RESTART': '1', 13:57:12 INFO - 'PAGER': '/bin/cat', 13:57:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:12 INFO - 'PWD': '/builds/slave/test', 13:57:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:12 INFO - 'SHELL': '/bin/bash', 13:57:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YpNKCQ7NaE/Listeners', 13:57:12 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 13:57:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:12 INFO - 'USER': 'cltbld', 13:57:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:12 INFO - 'XPC_FLAGS': '0x0', 13:57:12 INFO - 'XPC_SERVICE_NAME': '0', 13:57:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:57:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 13:57:12 INFO - Cleaning up... 13:57:12 INFO - Return code: 0 13:57:12 INFO - Running post-action listener: _resource_record_post_action 13:57:12 INFO - Running post-action listener: _start_resource_monitoring 13:57:12 INFO - Starting resource monitoring. 13:57:12 INFO - [mozharness: 2017-03-08 21:57:12.594576Z] Finished create-virtualenv step (success) 13:57:12 INFO - [mozharness: 2017-03-08 21:57:12.595546Z] Running install step. 13:57:12 INFO - Running pre-action listener: _resource_record_pre_action 13:57:12 INFO - Running main action method: install 13:57:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:57:12 INFO - Reading from file tmpfile_stdout 13:57:12 INFO - Detecting whether we're running mozinstall >=1.0... 13:57:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:57:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:57:12 INFO - Reading from file tmpfile_stdout 13:57:12 INFO - Output received: 13:57:12 INFO - Usage: mozinstall [options] installer 13:57:12 INFO - Options: 13:57:12 INFO - -h, --help show this help message and exit 13:57:12 INFO - -d DEST, --destination=DEST 13:57:12 INFO - Directory to install application into. [default: 13:57:12 INFO - "/builds/slave/test"] 13:57:12 INFO - --app=APP Application being installed. [default: firefox] 13:57:12 INFO - mkdir: /builds/slave/test/build/application 13:57:12 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'] 13:57:12 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 13:57:33 INFO - Reading from file tmpfile_stdout 13:57:33 INFO - Output received: 13:57:33 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 13:57:33 INFO - Running post-action listener: _resource_record_post_action 13:57:33 INFO - [mozharness: 2017-03-08 21:57:33.200497Z] Finished install step (success) 13:57:33 INFO - [mozharness: 2017-03-08 21:57:33.200593Z] Running run-tests step. 13:57:33 INFO - Running pre-action listener: _resource_record_pre_action 13:57:33 INFO - Running main action method: run_tests 13:57:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:57:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:57:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:57:33 INFO - 2017-03-08 13:57:33.212 screenresolution[1627:7445] starting screenresolution argv=screenresolution get 13:57:33 INFO - 2017-03-08 13:57:33.215 screenresolution[1627:7445] Display 0: 1600x1200x32@60 13:57:33 INFO - 2017-03-08 13:57:33.220 screenresolution[1628:7447] starting screenresolution argv=screenresolution list 13:57:33 INFO - Available Modes on Display 0 13:57:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:57:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:57:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:57:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:57:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:57:33 INFO - Intel Iris: 13:57:33 INFO - Chipset Model: Intel Iris 13:57:33 INFO - Type: GPU 13:57:33 INFO - Bus: Built-In 13:57:33 INFO - VRAM (Dynamic, Max): 1536 MB 13:57:33 INFO - Vendor: Intel (0x8086) 13:57:33 INFO - Device ID: 0x0a2e 13:57:33 INFO - Revision ID: 0x0009 13:57:33 INFO - Displays: 13:57:33 INFO - Display: 13:57:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:57:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:57:33 INFO - Display Serial Number: 1600x1200 60 13:57:33 INFO - Main Display: Yes 13:57:33 INFO - Mirror: Off 13:57:33 INFO - Online: Yes 13:57:33 INFO - Rotation: Supported 13:57:33 INFO - Return code: 0 13:57:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:57:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:57:33 INFO - Python 2.7.3 13:57:33 INFO - Return code: 0 13:57:33 INFO - grabbing minidump binary from tooltool 13:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 13:57:33 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 0x10ef58d30>, '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 0x10ee7fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ef4dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:57:33 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 13:57:33 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 13:57:33 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 13:57:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:57:33 INFO - Return code: 0 13:57:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:57:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:57:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:57:33 INFO - ENV: RUST_BACKTRACE is now 1 13:57:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:57:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:57:33 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/bY0nnvr5Trm5TeHY4aKWWw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:57:33 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/bY0nnvr5Trm5TeHY4aKWWw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:57:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.PsyYwwXN3X/Render', 13:57:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:57:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:57:33 INFO - 'HOME': '/Users/cltbld', 13:57:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:57:33 INFO - 'LOGNAME': 'cltbld', 13:57:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:57:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:57:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:57:33 INFO - 'MOZ_NO_REMOTE': '1', 13:57:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:57:33 INFO - 'NO_EM_RESTART': '1', 13:57:33 INFO - 'PAGER': '/bin/cat', 13:57:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:57:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:57:33 INFO - 'PWD': '/builds/slave/test', 13:57:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:57:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:57:33 INFO - 'RUST_BACKTRACE': '1', 13:57:33 INFO - 'SHELL': '/bin/bash', 13:57:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.YpNKCQ7NaE/Listeners', 13:57:33 INFO - 'TMPDIR': '/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/', 13:57:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:57:33 INFO - 'USER': 'cltbld', 13:57:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:57:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:57:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:57:33 INFO - 'XPC_FLAGS': '0x0', 13:57:33 INFO - 'XPC_SERVICE_NAME': '0', 13:57:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:57:33 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/bY0nnvr5Trm5TeHY4aKWWw/artifacts/public/build/firefox-54.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:57:33 INFO - mozversion application_buildid: 20170308122623 13:57:33 INFO - mozversion application_changeset: fc5b01fb884a73b3bf8d7f03d30b7b8d498c52e9 13:57:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 13:57:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:57:33 INFO - mozversion application_name: Firefox 13:57:33 INFO - mozversion application_remotingname: firefox-dev 13:57:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:57:33 INFO - mozversion application_vendor: Mozilla 13:57:33 INFO - mozversion application_version: 54.0a2 13:57:33 INFO - mozversion platform_buildid: 20170308122623 13:57:33 INFO - mozversion platform_changeset: fc5b01fb884a73b3bf8d7f03d30b7b8d498c52e9 13:57:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 13:57:33 INFO - mozversion platform_version: 54.0a2 13:57:33 INFO - using testdate: 1489010253 13:57:33 INFO - actual date: 1489010253 13:57:33 INFO - starting webserver on 'localhost:49245' 13:57:33 INFO - SUITE-START | Running 2 tests 13:57:33 INFO - TEST-START | dromaeo_css 13:57:33 INFO - operating with platform_type : mac_ 13:57:33 INFO - Initialising browser for dromaeo_css test... 13:57:33 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmppnDl0c/profile http://localhost:49245/getInfo.html) 13:57:36 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 13:57:36 INFO - PROCESS | 1638 | colorDepth:24 13:57:36 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 13:57:36 INFO - PROCESS | 1638 | __metrics 13:57:36 INFO - PROCESS | 1638 | 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" 13:57:36 INFO - PROCESS | 1638 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 13:57:37 INFO - TEST-INFO | 1638: exit 0 13:57:37 INFO - Browser initialized. 13:57:37 INFO - Running cycle 1/1 for dromaeo_css test... 13:57:37 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmppnDl0c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:57:49 INFO - PROCESS | 1640 | RSS: Main: 214269952 13:57:49 INFO - PROCESS | 1640 | 14:00:53 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49245/tests/dromaeo/cssquery-ext.html) 14:00:56 INFO - PROCESS | 1640 | RSS: Main: 471826432 14:00:56 INFO - PROCESS | 1640 | 14:02:39 INFO - PROCESS | 1640 | ************************* 14:02:39 INFO - PROCESS | 1640 | A coding exception was thrown and uncaught in a Task. 14:02:39 INFO - PROCESS | 1640 | 14:02:39 ERROR - PROCESS | 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 14:02:39 INFO - PROCESS | 1640 | Full stack: 14:02:39 INFO - PROCESS | 1640 | ************************* 14:03:59 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-ext.html (next: http://localhost:49245/tests/dromaeo/cssquery-jquery.html) 14:04:00 INFO - PROCESS | 1640 | RSS: Main: 351346688 14:04:00 INFO - PROCESS | 1640 | 14:07:02 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49245/tests/dromaeo/cssquery-mootools.html) 14:07:03 INFO - PROCESS | 1640 | RSS: Main: 342028288 14:07:03 INFO - PROCESS | 1640 | 14:10:05 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49245/tests/dromaeo/cssquery-prototype.html) 14:10:06 INFO - PROCESS | 1640 | RSS: Main: 335659008 14:10:06 INFO - PROCESS | 1640 | 14:13:10 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49245/tests/dromaeo/cssquery-yui.html) 14:13:10 INFO - PROCESS | 1640 | RSS: Main: 324882432 14:13:10 INFO - PROCESS | 1640 | 14:16:14 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-yui.html (next: http://localhost:49245/tests/dromaeo/cssquery-dojo.html) 14:16:14 INFO - PROCESS | 1640 | RSS: Main: 433590272 14:16:14 INFO - PROCESS | 1640 | 14:16:14 INFO - PROCESS | 1640 | __start_tp_report 14:16:14 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 14:16:14 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 14:16:14 INFO - PROCESS | 1640 | |i|pagename|runs| 14:16:14 INFO - PROCESS | 1640 | |0;dojo.html;2838.57421386792;3292.489664102064;3374.0721301642047;3378.1385746634605;3431;5698.5726070544715;5754;5763.250777398943;5810;5823.272090988627;5727.799527016556;5810.866880958215;5810.941890581093;5812.273465816773;5840.561957853157;5228.137357336035;5237.164009338883;5288.894222115556;5315.388730296007;5342.973285133569;5190.896182076375;5197.844064678046;5232.424433312332;5357.624966252364;5357.7589008494715;5254;5271.762770675329;5271.815486457975;5277.182036784305;5277.656952298107;5255.159174532057;5272.103742363807;5275.762590683428;5276.234945932857;5309.362876454831;5116.69299842007;5196.220566914955;5198.714070726109;5216.8695782605355;5253.816116435906;5789.913151302734;5797.188393624896;5804.6807425592;5814.215080964058;5814.592978491507;6188.319284878659;6202.627842329474;6203;6206.782762603332;6211.720472578745;6296.433321001086;6310.842228944267;6315.74737010519;6367.936320636827;6395.904061439082;5851.23933888596;5904.350521442638;5915.231019967419;5926.8221953341035;5961.731722072517;6260.154879091356;6334.385236078929;6373.808785736435;6382.106505089291;6401.615903045832;6075.817725468243;6093.146959425684;6095.4818840398175;6100.23747031621;6106.847328816726;6088.330283668793;6164.907526387108;6193.628382297076;6216.627002379872;6236.781712640127;5067.467915868854;6130.417610327012;6182.443580077815;6363.427291543783;6391.009393544008;6369.426751592379;6371.39471750183;6372.840678983062;6378.202724659418;6384.8084557462425;4842.58837998767;5031.270465782441;5040.092783298968;5058.1654027085115;5064.848054558369;4420.336949457607;4435.778211089432;4443.400140980991;4454.10917816438;4524.561692443569;5858.941410585925;5900.704964751745;5901.17383566301;5905.734241959122;5945.940540594625;6222.253329600387;6265.8120256392385;6334.769506637132;6376.872462550816;6387.520935929824;5715.971420142872;5722.54219662426;5729.942700573024;5730.255066841284;5733.684647344353;5421.728913554385;5429.701366424805;5433.212184233264;5436.592255580847;5436.864078398072;6334.841628959313;6343.429091381798;6357.427831495188;6366.713497892606;6368.904466433008;6270.7491700331475;6305.873882522415;6369.617822930639;6382.234131904202;6386.201724784402;6247.843803904939;6337.207849018872;6349.301576826638;6362.554621176473;6362.840928976812;6071.574989750852;6167.167432396569;6170.969145154246;6172.598781079216;6249.656268905072;6198.132261483306;6234.625922444668;6372.299047104908;6386.393292637192;6395.456386207225;6301;6313.652749098844;6323.114763932961;6330.177076979963;6353.5870168438905;6005.789797357072;6301.936980630318;6327.367263273636;6334.303226644974;6354.26925903527;5986.970065149646;5987.161797348288;6004.099385092097;6016.2479690038745;6023.186869772525;6110.103144028831;6133.242854861787;6140.596275277906;6189.535784816247;6216.689165541795;6115.909724157246;6145.35473775265;6149.385061493815;6151.72317245716;6167.259928808392 14:16:14 INFO - PROCESS | 1640 | |1;ext.html;782.5148407987049;800.823818759873;858.9269912057475;871.2986046232784;946.9005754395793;36469.08827279316;36557.81721091394;36768.264634707324;38152.04619884504;38189;36536.81731591338;36775.63224367755;36776;36778.26443471129;36778.81610591943;7173.89239161413;7624.1613422523615;7749.147593764709;7749.922500775005;7754.806129846771;7230.349268565828;7315.378192853614;7322.890156647654;10701.625443109493;10836.295640783324;10851.51168197429;10860.022597966181;10893.945530272338;10904.50929708165;10906.945465272662;10825.566977320937;10867.184961127947;10876.456177191109;10878.72803179919;10880.347179169195;7041.471889608249;7212.350888420015;7228.530145540575;10710.143188544898;10761.56953721858;36560.634393656255;36996.07509812276;38817.417738733944;38866.61133388658;39005.82982510529;3665.963340366589;3704.3517384457614;3830.3488406970882;3880.7865567393783;3889.1638297766117;24425.145119920897;24505.26484205459;25137.748622513725;25701;25788.484230315476;3043.3152540678393;3079.2455848317304;3095.4582947984236;3117.8596963136715;3121.547375630521;354200;354387;355795;356332;356648.21675891714;36200.456993145126;36877.63122368795;44079.33880991788;44131.77934110309;44136.3379549307;37088.62911370852;38643.80678096592;44697.55302446934;46993;47407.525924741;13636.795448068287;13882.514112006233;13882.791758123636;13895.79156312656;13897.79153312701;11869.109816763605;11909.523619055313;11911.3448760319;11913.583024594098;11919.702007449883;11624.244424112405;11625.88374116265;11667.066634669376;11706.297622142698;11756;5485.204645326406;5564.916526252109;5588.30146231721;5593.440655934455;5604.271444712243;1139.3505701749923;1151.5048529132387;1153.1639561318145;1153.9826902596467;1209.6854817747449;26187.345316366864;26383.78132936795;26819;26877.462450750874;27434.45131097407;1271.783796754554;1279.8626294088895;1294.210531575738;1298.6753311672082;1312.8293321868096;13713.382897769625;13714.971377146754;13843.030987830754;14013.509527166703;14017.229052402012;492834;496764;497200;498295;499342;55360.72319638376;55494.72252638711;55569.444305556426;55643.44356556464;55670;1415.3701602786662;1473.0646039764613;1477.1284941884126;1478.7929689843431;1480.800091987611;25174.24477265685;25556.10553630614;26112.955481781275;26220.737792622593;26222.213333600022;37351;45391;45422.31866522071;45486.31770523511;45534.31698524591;444862;446042;446972;447172;447561;31048.689513105484;31523.684763152076;31714.84142579272;31780.887668932402;31847.522287165248;42992;43943.78028109839;43984.780076099414;44032.77983610061;44114;25212.873935630203;32704;33386.66613333933;34987.65012349844;36450.81774591216;32112.197195070312;32131.357372851944;34763.826180868935;36198.8190059048;36281.81859090688;27926.86036569804;29944.25139371533;32195.678043219268;36123.91628251156;36128.819355903055;25393.365165871;27106.864465677547;27796.44407111887;28901;29599;22662.733726627204;22949.54100917939;23153.305400838002;23159.536809263383;23170.652440213074 14:16:14 INFO - PROCESS | 1640 | |2;jquery.html;383.69879644479056;423.0138777393753;430.85781692041627;438.7762241256959;447.6731985650475;16264.593385165377;21041.053152608132;22199.22302719405;22349;22557.66163507549;18154.183061762218;22470.66294005587;22926.88536557319;23003.654945175836;23090.65364019541;6399.776007839727;6494.805155845321;6595.67021648918;6643.701033453506;6688.899666505006;6550.213974323088;6563.278039415661;6621.635810030446;6631.4363279121335;6642.734290628369;4000.4799376081214;4353.934690979638;4420.071784925153;6453.257875344349;7606.467547271694;7230.783076507713;7326.67029983652;7395.112586489602;7505.437092218051;7548.282913123272;7243.927560724378;7299.23358047408;7304.342609165201;7307.123145222554;7311.817204569875;25233;25875.353116172057;26174;27027;27568.862155689294;2919.5036843736616;2962.0521433141403;2964.7035296470394;2968.554716792477;3012.487877060905;15363.078215307118;16011.039337639779;16038.679226415523;16156.515304540882;16889.324427022904;1950.444123424817;2006.759188897327;2009.2565750672345;2013.2349707111205;2013.506690860734;162369.75260494841;167916;170034;171712.14143929325;174203;14917.70164596702;17645.911770441067;18780.71828922567;19596.804031959782;19853.900730496545;25639;29972.85013574918;30640;30685.846570767004;31735.84132079371;9636.518174091267;9909.554070066864;10307.587696492206;10361.274710770325;10575;8594.968603767587;8612.827743445096;8623.870641940375;8746.650133994695;8803.075677053945;9122.498262595622;9188.310876684141;9323.487208203478;9345.392549484262;9355.251579873593;3945.940810887839;3985.4058376649573;3985.4221137934837;4011.3782363733667;4019.91960160801;759.6619504320635;897.3270047464401;901.4185850126763;934.0612684252283;945.3807755919884;16912;21529.892350538146;22327.441813954458;22327.99524021423;22349;917.4816228830689;930.6366173555773;943.8537026760863;947.6541062512272;952.0527075559862;9517.666881659108;9722.152790969692;11132.666020019413;11675.416229188677;11723.824142637868;625708;632726.8363658244;658763;763963;773310;154460.45539544686;157390.42609573988;158781;161587;163521.18239408964;1351.3918736568583;1363.522767031531;1415.6036309833264;1425.3514650833845;1427.6573622330773;19285.4214373569;20262.290819821235;20403.979801010188;20490.282840100524;20568.897155514125;40632.965802653205;54621.90756184934;59208.703956481666;64764;66774.33225667682;87263.56368218118;88013.67979480441;88416.55791721257;88895.11104889127;89196;11583.619844045817;12013.699657508632;12019.978301844441;12089.81865272004;12097.274163550215;10547.894521054692;11565.537378504765;12918.677033074247;13009.21944683322;13347.799783003069;10788.784224315626;11255.437228138397;11574.900384463463;11585.899339562728;11657.358845263252;10542.894571054192;10824;10964.725881852699;11372.829407559058;11414.429278535874;11296.322220666787;11681.357525335849;11687;11741.178117532032;11836.289822610672;11573.537058517903;11584.131190160602;11896.583619573274;11905.285682859056;12008.459619316976;10900.509477073392;11322.433878306216;11476.827847582126;11611.825822612498;11635.360055197045 14:16:14 INFO - PROCESS | 1640 | |3;mootools.html;1520.1942970225784;1530.2578249548974;1562.9452969146082;1569.9607509812256;1581.9129947852866;10567.15462762979;11121.666350009513;11127.332360058392;11137.387443690593;11158.442077896103;10461.895381046206;10864.565417383315;10938.617148399808;10964.28732132411;10971.451427428636;2381.3332266965276;2418.0207016158397;2420.3707036170545;2420.4674971506242;2421.987890060547;2350.5416443793465;2380.595298799208;2382.630692242705;2387.498625288683;2391.7488663690324;1857.544901499128;1981.0589969764392;2368.1948137633203;2378.4291769975252;2383.7735415135535;2296.632538793785;2306.319635707462;2319.1071437496603;2325.1280769711357;2325.802306803924;2304.0898844956314;2367.3963139399516;2370.9762902370926;2372.074890792592;2375.4298968247667;11124.443777811077;11220.831687524693;11227.71930701739;11250.66248012561;11274.774504509864;5286.709230992294;5444.101723215705;5446.319210098738;5448.37343705475;5458.044842152647;3373.9493907591404;3489.1277180704824;3680.6135355787524;3686.5391826021746;3700.962990370089;1137.8179491281355;1188.0851744157037;1200.5737963023175;1212.9575464858688;1236.9443375048145;12823.679408014781;13610.523631672844;14008.159510429407;14312.92843535786;15280.31238594266;4568;4747.715137091785;4755.120302744003;4766.1659209638865;4774;10015.849762253572;11729.003034742142;11730.589429370102;11736.237144585575;11764.117691173025;5725.541956643458;5728.455796699307;5731.083026715705;5738.655680659173;5741.8564535886935;3829.6744776693736;5171.379434467888;5296.3379577552805;5296.523312901781;5298.761555730001;3310.4206763816237;3739.6260373962386;3858.6334298241622;3902.746321489151;3932.901677458029;1025.9333143345807;1029.9588016479406;1038.0449986012886;1038.864947556828;1040.552562398161;788.8185717285056;795.2326005404813;814.9062857771314;817.3910436724559;820.9055958564842;5662.37713851476;6046.73018666085;6055.273367195877;6333.493320534346;6410.518190194035;763.9961800191074;925.0316143743266;949.5015117063597;955.617752898846;972.1445128287062;3524.242287908061;3969.54350249725;3987.5414327352146;4012.337964235868;4027.81874815634;13432.19406835593;13590.59228223155;13950.93024534891;13964.860351396559;13983.930080349737;13681.521146759816;13827.308634568231;13983.37074831635;13997.160170389809;14005.369758360897;9805.80388392228;10129.189664826796;10248;10254.897451025543;10294.124999374988;6287.2140982377205;6307.211598550181;6394.936050639434;6432.517561183024;6442.484601231797;12096.818547721967;12167.695807604881;12203.938980305042;12341.136120471481;12359.073069520002;12406.689832754253;12635.241885486901;12647.87352126467;12735.363231838186;12933.159344642569;8434.367422443218;8537.786555336166;8740.34447416459;9133.041030691948;9376.859347109936;10045.748856278651;10331.535080921527;10435.478226088513;10442.68671939843;10464.319819211727;8535.01847287545;8538.658453661785;8571.22858942698;8729.738107856774;8731.825363492568;8897.644094236159;8923.509206993678;8995.820083598423;8999.19007289347;9003.189712925869;7653.425993050432;7718.652660630398;7792.922070779447;7797.220277972157;7797.844043118992;5164;5344.652597581145;5708.115242137475;5740.0815869460685;5947.494462970696;5564.554835613222;5771.7114144293455;6019.87960240784;6028.457438830526;6163.260408750979 14:16:14 INFO - PROCESS | 1640 | |4;prototype.html;292.64796639525395;293.5362127838016;351.9278547897681;354.85450965104303;385.8765195137556;4490.461144662641;4986.800527978881;5108.003939231851;5319.255304257407;5347.0858382181705;3853.2100919311542;4676.789544470498;4854.587360074389;5047.596192304616;5066.84799456016;3515.8769443069564;3586.659267369596;4031;4234.7815660098395;4259.74441533509;3769.4567106919544;3952.387379956097;4237.279662457374;4253.574642535753;4296.957030429687;3928.8035598220117;3940.2316548273097;4170.4995400551825;4252.574742525753;4268;3236.546883436321;3482.669146431085;3521.559805024372;3629.328574213779;4207.769881962565;3009.0511298926954;3775.414810704345;3807.6573108420375;3908.8241029153755;3939.2909276330247;4216.2199993001395;4235.639970602502;4405.427294451701;4963.815920994751;4972.900541989176;4418.3372494125815;4427.003924117048;4800.927986080212;4843.612510999147;4848.369711937461;4777.546133117348;5258.0009798138235;5337.492938170868;5413.702246376448;5487.149491828773;4028.4158796974275;4080.8163632636306;4261.786910654455;4352.323321157465;4377.365282034088;4546.408966834323;4842.975785121052;5338.3575130310355;5456.290682211287;5708.77164913403;4070.430139780433;4191.413202151702;4192.448793946199;4209.873703788891;4231.9843237622745;3829.885103446901;3893.0267433141717;4051.534073581517;4113.526944401432;4389.912201755947;4495.685302028892;4537.568930951555;4793.274421208432;4829.589484893753;4840.806367745321;5058.608882557326;5338.306020217425;5370.838874833761;5378.704171270618;5472.5621950243885;1480.9407623695147;1507.3367718203956;1518.8025556677783;1523.5657837516476;1526.8549487798641;1048.7519851376837;1073.4203530093662;1102.6471529110609;1138.004246284501;1148.0700632487712;4439.933400998988;4508.256137737237;4527.886802829956;4858.246971719389;4897.534734200245;4823.855284341475;4892.303388746843;5009.298698182258;5074.923876141861;5352.83451469334;4085.89785255371;4535.614472769851;4924.926126108111;5050.267711181858;5052.433745538821;2463.8275320727375;2537.4544472938405;2549.68128983877;2660.0448670227365;2899.955531350435;4847.781849816767;4859.52543931091;5426.701531415731;5701.71491425427;5705.5435565154685;5013.874653133628;5212.452692467236;5280.471952804689;5640.85897852557;5806.274215723035;4571.217225282143;4826.95173048265;4912.38595175603;4948.777305021211;5051.2423136529815;5045.545900868792;5477.589180811376;5542.861428464321;5588.608797384144;5591.916121258103;4796.496367881462;5185.42960274377;5268.631195816256;5397.78408863641;5500.4499550044675;4949.802007919787;5184.403793563789;5567.526760225264;5676.168586204378;5703.62926409782;3500.5274287971815;3771.4908487353855;4178.22702799983;4216.894577635584;4357.389965404909;4712.764361781966;5377.763114483612;5437.809676661298;5661.310877333234;5701.401352858056;4488.551144885485;5212.836672780905;5368.382635996911;5373.032854086302;5457.372402173801;4698.835540756194;4859.611231101574;4867.464578896389;5297.8145764898045;5317.680939143664;4993.501949415088;5016.573591244639;5042.823501177441;5179.8446046618665;5281.273260431969;4768.0463907218;4849.80600775965;5139.280500729826;5185.403678577012;5293.682379057269;4535.682502224812;5221.608379371486;5230.267762513327;5287.603429742708;5313.442088580643 14:16:14 INFO - PROCESS | 1640 | |5;yui.html;718.4360277182412;741.2291217134181;774.5043172369684;821.0680877204373;832.6045128563931;15248.847511524882;16066.036037837723;16070.59823504413;16073.437429689962;16154.030758154518;13373.933130334335;13411.19532828031;13529.255890925995;13565.593032209024;13610.863891361083;926.6247169896203;938.1416004356006;948.648999870049;951.362587066667;969.7914948286117;877.1404024056428;947.1664934857316;964.2671569607079;965.9130678238957;968.1722127580922;972.9124378805906;1013.9543720532557;1015.9085682288593;1016.8373060310352;1018.96943091707;1007.7883644434678;1010.0253255608336;1010.2625083688948;1012.185190921308;1012.3723291559206;746.4215233194318;746.9290417410338;747.7382915979418;748.0574476160023;748.3863232149639;15196.240187990667;15312.540623781193;15375.615609609737;15958.680826383408;16034.957727747777;12198.268103913704;13712.588622341345;13815;13819.516316928859;14129;10205.846912296322;11577.247478913843;11794.528218871235;11878.40607969598;11899.107566932427;3563.322968635977;3621.2576421833724;3638.0359204810748;3703.370427027412;3832.06114501946;93715.53142234313;111894;115561;116081;118554.40722796417;10637.893621063846;10678.252522323519;10778.353298802096;10864.565417383374;11186.832197517044;22299.665505017438;22518.32445026652;22745.658815117786;22764.544709105725;22831.31506054821;7629.961850190713;7641.739113046397;7642.961785191039;7729.149793522708;7736.7678969631;4243.851465198703;4296.3695677152755;4365.519792822787;4421.38100665907;4460.0633866887665;3460.2560449503476;3533.8939831805087;3571.8214089295952;3574.8391322390553;3577.338192434408;548.7283794521737;577.8035467940837;631.2267472346431;631.7315141065029;631.766246488802;667.6701590187629;674.4941294029478;688.2738710660301;690.8324930866819;720.1789959446236;9133.81732365349;9134.862977055349;9858.162056225301;10006.997900629782;10338.586456541805;510.4742115620916;521.0204814947874;528.3395755305868;548.366636534803;551.8565173055034;4693.48371679115;4894.657373983787;4956.43872180262;4965.131102057126;4992.750362481861;87859;94692.52653736687;103937;104635.4768226154;107048.46475767571;89999;90028;91615;92417.53791231135;92985;76693;77683;78318.82521762178;78426.21573784303;79845;7601.847963040819;9629.32594718363;9669;9673.274504412057;9693.41839489633;48804.02391952212;48946;49615.50384496109;50173.24740128828;51387.22919156141;64992;65592;65673.67163164154;66249.66875165593;67472.66263668651;10874;10948.452577370941;11042.613508527164;11063.114950804078;11269;12465.127441079037;12492.812607810709;12551.87448125507;13584.524541640994;14630.926845365704;13617.523386681418;13888;13890.86109138936;14088.859111408754;14393.920455966054;13276.734465310446;13773.449062037405;14076;14140.92929535387;14166.645833853823;12706.682332941751;13421.32893355348;13766.93116534411;14032.929835351166;14231.573052808433;10768.246222764332;11101.500432480396;11306.841458418707;11386;11425.31448113116;10499.317544359592;11011.28426652265;11367.48846301935;11649.534018639159;11785.410729463663 14:16:14 INFO - PROCESS | 1640 | __end_tp_report 14:16:14 INFO - PROCESS | 1640 | __start_cc_report 14:16:14 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,3017 14:16:14 INFO - PROCESS | 1640 | __end_cc_report 14:16:14 INFO - PROCESS | 1640 | __startTimestamp1489011374543__endTimestamp 14:16:14 INFO - PROCESS | 1640 | 14:16:14 INFO - PROCESS | 1640 | ------- Summary: start ------- 14:16:14 INFO - PROCESS | 1640 | Number of tests: 6 14:16:14 INFO - PROCESS | 1640 | 14:16:14 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5807.91 Median:6071.57 stddev:666.32 (11.0%) stddev-sans-first:626.32 14:16:14 INFO - PROCESS | 1640 | Values: 2838.6 3292.5 3374.1 3378.1 3431.0 5698.6 5754.0 5763.3 5810.0 5823.3 5727.8 5810.9 5810.9 5812.3 5840.6 5228.1 5237.2 5288.9 5315.4 5343.0 5190.9 5197.8 5232.4 5357.6 5357.8 5254.0 5271.8 5271.8 5277.2 5277.7 5255.2 5272.1 5275.8 5276.2 5309.4 5116.7 5196.2 5198.7 5216.9 5253.8 5789.9 5797.2 5804.7 5814.2 5814.6 6188.3 6202.6 6203.0 6206.8 6211.7 6296.4 6310.8 6315.7 6367.9 6395.9 5851.2 5904.4 5915.2 5926.8 5961.7 6260.2 6334.4 6373.8 6382.1 6401.6 6075.8 6093.1 6095.5 6100.2 6106.8 6088.3 6164.9 6193.6 6216.6 6236.8 5067.5 6130.4 6182.4 6363.4 6391.0 6369.4 6371.4 6372.8 6378.2 6384.8 4842.6 5031.3 5040.1 5058.2 5064.8 4420.3 4435.8 4443.4 4454.1 4524.6 5858.9 5900.7 5901.2 5905.7 5945.9 6222.3 6265.8 6334.8 6376.9 6387.5 5716.0 5722.5 5729.9 5730.3 5733.7 5421.7 5429.7 5433.2 5436.6 5436.9 6334.8 6343.4 6357.4 6366.7 6368.9 6270.7 6305.9 6369.6 6382.2 6386.2 6247.8 6337.2 6349.3 6362.6 6362.8 6071.6 6167.2 6171.0 6172.6 6249.7 6198.1 6234.6 6372.3 6386.4 6395.5 6301.0 6313.7 6323.1 6330.2 6353.6 6005.8 6301.9 6327.4 6334.3 6354.3 5987.0 5987.2 6004.1 6016.2 6023.2 6110.1 6133.2 6140.6 6189.5 6216.7 6115.9 6145.4 6149.4 6151.7 6167.3 14:16:14 INFO - PROCESS | 1640 | 14:16:14 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:55906.99 Median:33045.33 stddev:116227.86 (351.7%) stddev-sans-first:116480.22 14:16:14 INFO - PROCESS | 1640 | Values: 782.5 800.8 858.9 871.3 946.9 36469.1 36557.8 36768.3 38152.0 38189.0 36536.8 36775.6 36776.0 36778.3 36778.8 7173.9 7624.2 7749.1 7749.9 7754.8 7230.3 7315.4 7322.9 10701.6 10836.3 10851.5 10860.0 10893.9 10904.5 10906.9 10825.6 10867.2 10876.5 10878.7 10880.3 7041.5 7212.4 7228.5 10710.1 10761.6 36560.6 36996.1 38817.4 38866.6 39005.8 3666.0 3704.4 3830.3 3880.8 3889.2 24425.1 24505.3 25137.7 25701.0 25788.5 3043.3 3079.2 3095.5 3117.9 3121.5 354200.0 354387.0 355795.0 356332.0 356648.2 36200.5 36877.6 44079.3 44131.8 44136.3 37088.6 38643.8 44697.6 46993.0 47407.5 13636.8 13882.5 13882.8 13895.8 13897.8 11869.1 11909.5 11911.3 11913.6 11919.7 11624.2 11625.9 11667.1 11706.3 11756.0 5485.2 5564.9 5588.3 5593.4 5604.3 1139.4 1151.5 1153.2 1154.0 1209.7 26187.3 26383.8 26819.0 26877.5 27434.5 1271.8 1279.9 1294.2 1298.7 1312.8 13713.4 13715.0 13843.0 14013.5 14017.2 492834.0 496764.0 497200.0 498295.0 499342.0 55360.7 55494.7 55569.4 55643.4 55670.0 1415.4 1473.1 1477.1 1478.8 1480.8 25174.2 25556.1 26113.0 26220.7 26222.2 37351.0 45391.0 45422.3 45486.3 45534.3 444862.0 446042.0 446972.0 447172.0 447561.0 31048.7 31523.7 31714.8 31780.9 31847.5 42992.0 43943.8 43984.8 44032.8 44114.0 25212.9 32704.0 33386.7 34987.7 36450.8 32112.2 32131.4 34763.8 36198.8 36281.8 27926.9 29944.3 32195.7 36123.9 36128.8 25393.4 27106.9 27796.4 28901.0 29599.0 22662.7 22949.5 23153.3 23159.5 23170.7 14:16:14 INFO - PROCESS | 1640 | 14:16:14 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:41818.37 Median:24161.83 stddev:116902.95 (483.8%) stddev-sans-first:117189.50 14:16:14 INFO - PROCESS | 1640 | Values: 383.7 423.0 430.9 438.8 447.7 16264.6 21041.1 22199.2 22349.0 22557.7 18154.2 22470.7 22926.9 23003.7 23090.7 6399.8 6494.8 6595.7 6643.7 6688.9 6550.2 6563.3 6621.6 6631.4 6642.7 4000.5 4353.9 4420.1 6453.3 7606.5 7230.8 7326.7 7395.1 7505.4 7548.3 7243.9 7299.2 7304.3 7307.1 7311.8 25233.0 25875.4 26174.0 27027.0 27568.9 2919.5 2962.1 2964.7 2968.6 3012.5 15363.1 16011.0 16038.7 16156.5 16889.3 1950.4 2006.8 2009.3 2013.2 2013.5 162369.8 167916.0 170034.0 171712.1 174203.0 14917.7 17645.9 18780.7 19596.8 19853.9 25639.0 29972.9 30640.0 30685.8 31735.8 9636.5 9909.6 10307.6 10361.3 10575.0 8595.0 8612.8 8623.9 8746.7 8803.1 9122.5 9188.3 9323.5 9345.4 9355.3 3945.9 3985.4 3985.4 4011.4 4019.9 759.7 897.3 901.4 934.1 945.4 16912.0 21529.9 22327.4 22328.0 22349.0 917.5 930.6 943.9 947.7 952.1 9517.7 9722.2 11132.7 11675.4 11723.8 625708.0 632726.8 658763.0 763963.0 773310.0 154460.5 157390.4 158781.0 161587.0 163521.2 1351.4 1363.5 1415.6 1425.4 1427.7 19285.4 20262.3 20404.0 20490.3 20568.9 40633.0 54621.9 59208.7 64764.0 66774.3 87263.6 88013.7 88416.6 88895.1 89196.0 11583.6 12013.7 12020.0 12089.8 12097.3 10547.9 11565.5 12918.7 13009.2 13347.8 10788.8 11255.4 11574.9 11585.9 11657.4 10542.9 10824.0 10964.7 11372.8 11414.4 11296.3 11681.4 11687.0 11741.2 11836.3 11573.5 11584.1 11896.6 11905.3 12008.5 10900.5 11322.4 11476.8 11611.8 11635.4 14:16:14 INFO - PROCESS | 1640 | 14:16:14 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:6637.82 Median:2419.20 stddev:4202.72 (173.7%) stddev-sans-first:4196.92 14:16:14 INFO - PROCESS | 1640 | Values: 1520.2 1530.3 1562.9 1570.0 1581.9 10567.2 11121.7 11127.3 11137.4 11158.4 10461.9 10864.6 10938.6 10964.3 10971.5 2381.3 2418.0 2420.4 2420.5 2422.0 2350.5 2380.6 2382.6 2387.5 2391.7 1857.5 1981.1 2368.2 2378.4 2383.8 2296.6 2306.3 2319.1 2325.1 2325.8 2304.1 2367.4 2371.0 2372.1 2375.4 11124.4 11220.8 11227.7 11250.7 11274.8 5286.7 5444.1 5446.3 5448.4 5458.0 3373.9 3489.1 3680.6 3686.5 3701.0 1137.8 1188.1 1200.6 1213.0 1236.9 12823.7 13610.5 14008.2 14312.9 15280.3 4568.0 4747.7 4755.1 4766.2 4774.0 10015.8 11729.0 11730.6 11736.2 11764.1 5725.5 5728.5 5731.1 5738.7 5741.9 3829.7 5171.4 5296.3 5296.5 5298.8 3310.4 3739.6 3858.6 3902.7 3932.9 1025.9 1030.0 1038.0 1038.9 1040.6 788.8 795.2 814.9 817.4 820.9 5662.4 6046.7 6055.3 6333.5 6410.5 764.0 925.0 949.5 955.6 972.1 3524.2 3969.5 3987.5 4012.3 4027.8 13432.2 13590.6 13950.9 13964.9 13983.9 13681.5 13827.3 13983.4 13997.2 14005.4 9805.8 10129.2 10248.0 10254.9 10294.1 6287.2 6307.2 6394.9 6432.5 6442.5 12096.8 12167.7 12203.9 12341.1 12359.1 12406.7 12635.2 12647.9 12735.4 12933.2 8434.4 8537.8 8740.3 9133.0 9376.9 10045.7 10331.5 10435.5 10442.7 10464.3 8535.0 8538.7 8571.2 8729.7 8731.8 8897.6 8923.5 8995.8 8999.2 9003.2 7653.4 7718.7 7792.9 7797.2 7797.8 5164.0 5344.7 5708.1 5740.1 5947.5 5564.6 5771.7 6019.9 6028.5 6163.3 14:16:14 INFO - PROCESS | 1640 | 14:16:14 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4383.48 Median:4812.39 stddev:1237.81 (25.7%) stddev-sans-first:1202.60 14:16:14 INFO - PROCESS | 1640 | Values: 292.6 293.5 351.9 354.9 385.9 4490.5 4986.8 5108.0 5319.3 5347.1 3853.2 4676.8 4854.6 5047.6 5066.8 3515.9 3586.7 4031.0 4234.8 4259.7 3769.5 3952.4 4237.3 4253.6 4297.0 3928.8 3940.2 4170.5 4252.6 4268.0 3236.5 3482.7 3521.6 3629.3 4207.8 3009.1 3775.4 3807.7 3908.8 3939.3 4216.2 4235.6 4405.4 4963.8 4972.9 4418.3 4427.0 4800.9 4843.6 4848.4 4777.5 5258.0 5337.5 5413.7 5487.1 4028.4 4080.8 4261.8 4352.3 4377.4 4546.4 4843.0 5338.4 5456.3 5708.8 4070.4 4191.4 4192.4 4209.9 4232.0 3829.9 3893.0 4051.5 4113.5 4389.9 4495.7 4537.6 4793.3 4829.6 4840.8 5058.6 5338.3 5370.8 5378.7 5472.6 1480.9 1507.3 1518.8 1523.6 1526.9 1048.8 1073.4 1102.6 1138.0 1148.1 4439.9 4508.3 4527.9 4858.2 4897.5 4823.9 4892.3 5009.3 5074.9 5352.8 4085.9 4535.6 4924.9 5050.3 5052.4 2463.8 2537.5 2549.7 2660.0 2900.0 4847.8 4859.5 5426.7 5701.7 5705.5 5013.9 5212.5 5280.5 5640.9 5806.3 4571.2 4827.0 4912.4 4948.8 5051.2 5045.5 5477.6 5542.9 5588.6 5591.9 4796.5 5185.4 5268.6 5397.8 5500.4 4949.8 5184.4 5567.5 5676.2 5703.6 3500.5 3771.5 4178.2 4216.9 4357.4 4712.8 5377.8 5437.8 5661.3 5701.4 4488.6 5212.8 5368.4 5373.0 5457.4 4698.8 4859.6 4867.5 5297.8 5317.7 4993.5 5016.6 5042.8 5179.8 5281.3 4768.0 4849.8 5139.3 5185.4 5293.7 4535.7 5221.6 5230.3 5287.6 5313.4 14:16:14 INFO - PROCESS | 1640 | 14:16:14 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:20503.83 Median:3567.57 stddev:29733.85 (833.4%) stddev-sans-first:29780.15 14:16:14 INFO - PROCESS | 1640 | Values: 718.4 741.2 774.5 821.1 832.6 15248.8 16066.0 16070.6 16073.4 16154.0 13373.9 13411.2 13529.3 13565.6 13610.9 926.6 938.1 948.6 951.4 969.8 877.1 947.2 964.3 965.9 968.2 972.9 1014.0 1015.9 1016.8 1019.0 1007.8 1010.0 1010.3 1012.2 1012.4 746.4 746.9 747.7 748.1 748.4 15196.2 15312.5 15375.6 15958.7 16035.0 12198.3 13712.6 13815.0 13819.5 14129.0 10205.8 11577.2 11794.5 11878.4 11899.1 3563.3 3621.3 3638.0 3703.4 3832.1 93715.5 111894.0 115561.0 116081.0 118554.4 10637.9 10678.3 10778.4 10864.6 11186.8 22299.7 22518.3 22745.7 22764.5 22831.3 7630.0 7641.7 7643.0 7729.1 7736.8 4243.9 4296.4 4365.5 4421.4 4460.1 3460.3 3533.9 3571.8 3574.8 3577.3 548.7 577.8 631.2 631.7 631.8 667.7 674.5 688.3 690.8 720.2 9133.8 9134.9 9858.2 10007.0 10338.6 510.5 521.0 528.3 548.4 551.9 4693.5 4894.7 4956.4 4965.1 4992.8 87859.0 94692.5 103937.0 104635.5 107048.5 89999.0 90028.0 91615.0 92417.5 92985.0 76693.0 77683.0 78318.8 78426.2 79845.0 7601.8 9629.3 9669.0 9673.3 9693.4 48804.0 48946.0 49615.5 50173.2 51387.2 64992.0 65592.0 65673.7 66249.7 67472.7 10874.0 10948.5 11042.6 11063.1 11269.0 12465.1 12492.8 12551.9 13584.5 14630.9 13617.5 13888.0 13890.9 14088.9 14393.9 13276.7 13773.4 14076.0 14140.9 14166.6 12706.7 13421.3 13766.9 14032.9 14231.6 10768.2 11101.5 11306.8 11386.0 11425.3 10499.3 11011.3 11367.5 11649.5 11785.4 14:16:14 INFO - PROCESS | 1640 | -------- Summary: end -------- 14:16:14 INFO - PROCESS | 1640 | 14:16:15 INFO - TEST-INFO | 1640: exit 0 14:16:15 INFO - TEST-OK | dromaeo_css | took 1121412ms 14:16:15 INFO - TEST-START | kraken 14:16:15 INFO - operating with platform_type : mac_ 14:16:15 INFO - Initialising browser for kraken test... 14:16:15 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmpbaj3KR/profile http://localhost:49245/getInfo.html) 14:16:17 INFO - PROCESS | 1650 | __metrics Screen width/height:1600/1200 14:16:17 INFO - PROCESS | 1650 | colorDepth:24 14:16:17 INFO - PROCESS | 1650 | Browser inner width/height: 1024/689 14:16:17 INFO - PROCESS | 1650 | __metrics 14:16:17 INFO - PROCESS | 1650 | 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" 14:16:17 INFO - PROCESS | 1650 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 14:16:18 INFO - TEST-INFO | 1650: exit 0 14:16:18 INFO - Browser initialized. 14:16:18 INFO - Running cycle 1/1 for kraken test... 14:16:18 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/tmpbaj3KR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 14:16:30 INFO - PROCESS | 1651 | RSS: Main: 214142976 14:16:30 INFO - PROCESS | 1651 | 14:16:33 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection) 14:16:34 INFO - PROCESS | 1651 | RSS: Main: 267243520 14:16:34 INFO - PROCESS | 1651 | 14:16:37 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-dft) 14:16:37 INFO - PROCESS | 1651 | RSS: Main: 277979136 14:16:37 INFO - PROCESS | 1651 | 14:16:41 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-fft) 14:16:41 INFO - PROCESS | 1651 | RSS: Main: 373825536 14:16:41 INFO - PROCESS | 1651 | 14:16:43 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator) 14:16:44 INFO - PROCESS | 1651 | RSS: Main: 277770240 14:16:44 INFO - PROCESS | 1651 | 14:16:46 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 14:16:46 INFO - PROCESS | 1651 | RSS: Main: 280244224 14:16:46 INFO - PROCESS | 1651 | 14:16:50 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom) 14:16:50 INFO - PROCESS | 1651 | RSS: Main: 321228800 14:16:50 INFO - PROCESS | 1651 | 14:16:53 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate) 14:16:54 INFO - PROCESS | 1651 | RSS: Main: 321273856 14:16:54 INFO - PROCESS | 1651 | 14:16:57 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial) 14:16:58 INFO - PROCESS | 1651 | RSS: Main: 316960768 14:16:58 INFO - PROCESS | 1651 | 14:16:59 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 14:17:00 INFO - PROCESS | 1651 | RSS: Main: 295505920 14:17:00 INFO - PROCESS | 1651 | 14:17:02 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes) 14:17:02 INFO - PROCESS | 1651 | RSS: Main: 296325120 14:17:02 INFO - PROCESS | 1651 | 14:17:05 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 14:17:05 INFO - PROCESS | 1651 | RSS: Main: 301473792 14:17:05 INFO - PROCESS | 1651 | 14:17:08 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 14:17:09 INFO - PROCESS | 1651 | RSS: Main: 319102976 14:17:09 INFO - PROCESS | 1651 | 14:17:12 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 14:17:12 INFO - PROCESS | 1651 | RSS: Main: 312537088 14:17:12 INFO - PROCESS | 1651 | 14:17:14 INFO - PROCESS | 1651 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49245/tests/kraken/driver.html?testName=ai-astar) 14:17:14 INFO - PROCESS | 1651 | RSS: Main: 357429248 14:17:14 INFO - PROCESS | 1651 | 14:17:14 INFO - PROCESS | 1651 | __start_tp_report 14:17:14 INFO - PROCESS | 1651 | _x_x_mozilla_page_load 14:17:14 INFO - PROCESS | 1651 | _x_x_mozilla_page_load_details 14:17:14 INFO - PROCESS | 1651 | |i|pagename|runs| 14:17:14 INFO - PROCESS | 1651 | |0;ai-astar;116;116;116;116;117;116;115;115;118;114 14:17:14 INFO - PROCESS | 1651 | |1;audio-beat-detection;142;108;110;144;109;116;136;134;126;110 14:17:14 INFO - PROCESS | 1651 | |2;audio-dft;183;187;182;187;186;186;184;185;187;185 14:17:14 INFO - PROCESS | 1651 | |3;audio-fft;82;62;60;94;62;61;59;60;77;59 14:17:14 INFO - PROCESS | 1651 | |4;audio-oscillator;93;68;87;71;69;68;83;68;70;85 14:17:14 INFO - PROCESS | 1651 | |5;imaging-gaussian-blur;126;134;89;88;88;89;89;88;88;88 14:17:14 INFO - PROCESS | 1651 | |6;imaging-darkroom;96;96;95;99;95;96;96;98;95;95 14:17:14 INFO - PROCESS | 1651 | |7;imaging-desaturate;84;83;84;84;84;84;84;84;86;84 14:17:14 INFO - PROCESS | 1651 | |8;json-parse-financial;62;60;61;60;65;65;66;65;64;61 14:17:14 INFO - PROCESS | 1651 | |9;json-stringify-tinderbox;65;54;57;65;62;58;58;58;59;59 14:17:14 INFO - PROCESS | 1651 | |10;stanford-crypto-aes;88;72;92;72;94;98;100;100;98;84 14:17:14 INFO - PROCESS | 1651 | |11;stanford-crypto-ccm;141;146;146;139;140;142;143;138;179;151 14:17:14 INFO - PROCESS | 1651 | |12;stanford-crypto-pbkdf2;166;166;165;166;169;167;169;156;168;164 14:17:14 INFO - PROCESS | 1651 | |13;stanford-crypto-sha256-iterative;66;66;66;66;65;65;66;65;65;64 14:17:14 INFO - PROCESS | 1651 | __end_tp_report 14:17:14 INFO - PROCESS | 1651 | __start_cc_report 14:17:14 INFO - PROCESS | 1651 | _x_x_mozilla_cycle_collect,2123 14:17:14 INFO - PROCESS | 1651 | __end_cc_report 14:17:14 INFO - PROCESS | 1651 | __startTimestamp1489011434944__endTimestamp 14:17:14 INFO - PROCESS | 1651 | 14:17:14 INFO - PROCESS | 1651 | ------- Summary: start ------- 14:17:14 INFO - PROCESS | 1651 | Number of tests: 14 14:17:14 INFO - PROCESS | 1651 | 14:17:14 INFO - PROCESS | 1651 | [#0] ai-astar Cycles:10 Average:115.90 Median:116.00 stddev:1.10 (0.9%) stddev-sans-first:1.17 14:17:14 INFO - PROCESS | 1651 | Values: 116.0 116.0 116.0 116.0 117.0 116.0 115.0 115.0 118.0 114.0 14:17:14 INFO - PROCESS | 1651 | 14:17:14 INFO - PROCESS | 1651 | [#1] audio-beat-detection Cycles:10 Average:123.50 Median:130.00 stddev:14.55 (11.2%) stddev-sans-first:13.81 14:17:14 INFO - PROCESS | 1651 | Values: 142.0 108.0 110.0 144.0 109.0 116.0 136.0 134.0 126.0 110.0 14:17:14 INFO - PROCESS | 1651 | 14:17:14 INFO - PROCESS | 1651 | [#2] audio-dft Cycles:10 Average:185.20 Median:186.00 stddev:1.75 (0.9%) stddev-sans-first:1.67 14:17:14 INFO - PROCESS | 1651 | Values: 183.0 187.0 182.0 187.0 186.0 186.0 184.0 185.0 187.0 185.0 14:17:14 INFO - PROCESS | 1651 | 14:17:14 INFO - PROCESS | 1651 | [#3] audio-fft Cycles:10 Average:67.60 Median:62.00 stddev:12.30 (19.8%) stddev-sans-first:11.90 14:17:14 INFO - PROCESS | 1651 | Values: 82.0 62.0 60.0 94.0 62.0 61.0 59.0 60.0 77.0 59.0 14:17:14 INFO - PROCESS | 1651 | 14:17:14 INFO - PROCESS | 1651 | [#4] audio-oscillator Cycles:10 Average:76.20 Median:77.00 stddev:9.67 (12.6%) stddev-sans-first:8.12 14:17:14 INFO - PROCESS | 1651 | Values: 93.0 68.0 87.0 71.0 69.0 68.0 83.0 68.0 70.0 85.0 14:17:14 INFO - PROCESS | 1651 | 14:17:14 INFO - PROCESS | 1651 | [#5] imaging-gaussian-blur Cycles:10 Average:96.70 Median:88.00 stddev:17.66 (20.1%) stddev-sans-first:15.22 14:17:14 INFO - PROCESS | 1651 | Values: 126.0 134.0 89.0 88.0 88.0 89.0 89.0 88.0 88.0 88.0 14:17:14 INFO - PROCESS | 1651 | 14:17:14 INFO - PROCESS | 1651 | [#6] imaging-darkroom Cycles:10 Average:96.10 Median:96.00 stddev:1.37 (1.4%) stddev-sans-first:1.45 14:17:14 INFO - PROCESS | 1651 | Values: 96.0 96.0 95.0 99.0 95.0 96.0 96.0 98.0 95.0 95.0 14:17:14 INFO - PROCESS | 1651 | 14:17:14 INFO - PROCESS | 1651 | [#7] imaging-desaturate Cycles:10 Average:84.10 Median:84.00 stddev:0.74 (0.9%) stddev-sans-first:0.78 14:17:14 INFO - PROCESS | 1651 | Values: 84.0 83.0 84.0 84.0 84.0 84.0 84.0 84.0 86.0 84.0 14:17:14 INFO - PROCESS | 1651 | 14:17:14 INFO - PROCESS | 1651 | [#8] json-parse-financial Cycles:10 Average:62.90 Median:64.50 stddev:2.33 (3.6%) stddev-sans-first:2.45 14:17:14 INFO - PROCESS | 1651 | Values: 62.0 60.0 61.0 60.0 65.0 65.0 66.0 65.0 64.0 61.0 14:17:14 INFO - PROCESS | 1651 | 14:17:14 INFO - PROCESS | 1651 | [#9] json-stringify-tinderbox Cycles:10 Average:59.50 Median:59.00 stddev:3.50 (5.9%) stddev-sans-first:3.10 14:17:14 INFO - PROCESS | 1651 | Values: 65.0 54.0 57.0 65.0 62.0 58.0 58.0 58.0 59.0 59.0 14:17:14 INFO - PROCESS | 1651 | 14:17:14 INFO - PROCESS | 1651 | [#10] stanford-crypto-aes Cycles:10 Average:89.80 Median:90.00 stddev:10.73 (11.9%) stddev-sans-first:11.36 14:17:14 INFO - PROCESS | 1651 | Values: 88.0 72.0 92.0 72.0 94.0 98.0 100.0 100.0 98.0 84.0 14:17:14 INFO - PROCESS | 1651 | 14:17:14 INFO - PROCESS | 1651 | [#11] stanford-crypto-ccm Cycles:10 Average:146.50 Median:144.50 stddev:12.07 (8.4%) stddev-sans-first:12.63 14:17:14 INFO - PROCESS | 1651 | Values: 141.0 146.0 146.0 139.0 140.0 142.0 143.0 138.0 179.0 151.0 14:17:14 INFO - PROCESS | 1651 | 14:17:14 INFO - PROCESS | 1651 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.60 Median:166.50 stddev:3.75 (2.3%) stddev-sans-first:3.97 14:17:14 INFO - PROCESS | 1651 | Values: 166.0 166.0 165.0 166.0 169.0 167.0 169.0 156.0 168.0 164.0 14:17:14 INFO - PROCESS | 1651 | 14:17:14 INFO - PROCESS | 1651 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.40 Median:66.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 14:17:14 INFO - PROCESS | 1651 | Values: 66.0 66.0 66.0 66.0 65.0 65.0 66.0 65.0 65.0 64.0 14:17:14 INFO - PROCESS | 1651 | -------- Summary: end -------- 14:17:14 INFO - PROCESS | 1651 | 14:17:15 INFO - TEST-INFO | 1651: exit 0 14:17:15 INFO - TEST-OK | kraken | took 60626ms 14:17:15 INFO - SUITE-END | took 1182s 14:17:16 INFO - Completed test suite (00:19:42) 14:17:16 INFO - javascript benchmark 14:17:16 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7534.9688744992045, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2838.57421386792, 3292.489664102064, 3374.0721301642047, 3378.1385746634605, 3431.0, 5698.5726070544715, 5754.0, 5763.250777398943, 5810.0, 5823.272090988627, 5727.799527016556, 5810.866880958215, 5810.941890581093, 5812.273465816773, 5840.561957853157, 5228.137357336035, 5237.164009338883, 5288.894222115556, 5315.388730296007, 5342.973285133569, 5190.896182076375, 5197.844064678046, 5232.424433312332, 5357.624966252364, 5357.7589008494715, 5254.0, 5271.762770675329, 5271.815486457975, 5277.182036784305, 5277.656952298107, 5255.159174532057, 5272.103742363807, 5275.762590683428, 5276.234945932857, 5309.362876454831, 5116.69299842007, 5196.220566914955, 5198.714070726109, 5216.8695782605355, 5253.816116435906, 5789.913151302734, 5797.188393624896, 5804.6807425592, 5814.215080964058, 5814.592978491507, 6188.319284878659, 6202.627842329474, 6203.0, 6206.782762603332, 6211.720472578745, 6296.433321001086, 6310.842228944267, 6315.74737010519, 6367.936320636827, 6395.904061439082, 5851.23933888596, 5904.350521442638, 5915.231019967419, 5926.8221953341035, 5961.731722072517, 6260.154879091356, 6334.385236078929, 6373.808785736435, 6382.106505089291, 6401.615903045832, 6075.817725468243, 6093.146959425684, 6095.4818840398175, 6100.23747031621, 6106.847328816726, 6088.330283668793, 6164.907526387108, 6193.628382297076, 6216.627002379872, 6236.781712640127, 5067.467915868854, 6130.417610327012, 6182.443580077815, 6363.427291543783, 6391.009393544008, 6369.426751592379, 6371.39471750183, 6372.840678983062, 6378.202724659418, 6384.8084557462425, 4842.58837998767, 5031.270465782441, 5040.092783298968, 5058.1654027085115, 5064.848054558369, 4420.336949457607, 4435.778211089432, 4443.400140980991, 4454.10917816438, 4524.561692443569, 5858.941410585925, 5900.704964751745, 5901.17383566301, 5905.734241959122, 5945.940540594625, 6222.253329600387, 6265.8120256392385, 6334.769506637132, 6376.872462550816, 6387.520935929824, 5715.971420142872, 5722.54219662426, 5729.942700573024, 5730.255066841284, 5733.684647344353, 5421.728913554385, 5429.701366424805, 5433.212184233264, 5436.592255580847, 5436.864078398072, 6334.841628959313, 6343.429091381798, 6357.427831495188, 6366.713497892606, 6368.904466433008, 6270.7491700331475, 6305.873882522415, 6369.617822930639, 6382.234131904202, 6386.201724784402, 6247.843803904939, 6337.207849018872, 6349.301576826638, 6362.554621176473, 6362.840928976812, 6071.574989750852, 6167.167432396569, 6170.969145154246, 6172.598781079216, 6249.656268905072, 6198.132261483306, 6234.625922444668, 6372.299047104908, 6386.393292637192, 6395.456386207225, 6301.0, 6313.652749098844, 6323.114763932961, 6330.177076979963, 6353.5870168438905, 6005.789797357072, 6301.936980630318, 6327.367263273636, 6334.303226644974, 6354.26925903527, 5986.970065149646, 5987.161797348288, 6004.099385092097, 6016.2479690038745, 6023.186869772525, 6110.103144028831, 6133.242854861787, 6140.596275277906, 6189.535784816247, 6216.689165541795, 6115.909724157246, 6145.35473775265, 6149.385061493815, 6151.72317245716, 6167.259928808392], "value": 5762.704171098768, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [782.5148407987049, 800.823818759873, 858.9269912057475, 871.2986046232784, 946.9005754395793, 36469.08827279316, 36557.81721091394, 36768.264634707324, 38152.04619884504, 38189.0, 36536.81731591338, 36775.63224367755, 36776.0, 36778.26443471129, 36778.81610591943, 7173.89239161413, 7624.1613422523615, 7749.147593764709, 7749.922500775005, 7754.806129846771, 7230.349268565828, 7315.378192853614, 7322.890156647654, 10701.625443109493, 10836.295640783324, 10851.51168197429, 10860.022597966181, 10893.945530272338, 10904.50929708165, 10906.945465272662, 10825.566977320937, 10867.184961127947, 10876.456177191109, 10878.72803179919, 10880.347179169195, 7041.471889608249, 7212.350888420015, 7228.530145540575, 10710.143188544898, 10761.56953721858, 36560.634393656255, 36996.07509812276, 38817.417738733944, 38866.61133388658, 39005.82982510529, 3665.963340366589, 3704.3517384457614, 3830.3488406970882, 3880.7865567393783, 3889.1638297766117, 24425.145119920897, 24505.26484205459, 25137.748622513725, 25701.0, 25788.484230315476, 3043.3152540678393, 3079.2455848317304, 3095.4582947984236, 3117.8596963136715, 3121.547375630521, 354200.0, 354387.0, 355795.0, 356332.0, 356648.21675891714, 36200.456993145126, 36877.63122368795, 44079.33880991788, 44131.77934110309, 44136.3379549307, 37088.62911370852, 38643.80678096592, 44697.55302446934, 46993.0, 47407.525924741, 13636.795448068287, 13882.514112006233, 13882.791758123636, 13895.79156312656, 13897.79153312701, 11869.109816763605, 11909.523619055313, 11911.3448760319, 11913.583024594098, 11919.702007449883, 11624.244424112405, 11625.88374116265, 11667.066634669376, 11706.297622142698, 11756.0, 5485.204645326406, 5564.916526252109, 5588.30146231721, 5593.440655934455, 5604.271444712243, 1139.3505701749923, 1151.5048529132387, 1153.1639561318145, 1153.9826902596467, 1209.6854817747449, 26187.345316366864, 26383.78132936795, 26819.0, 26877.462450750874, 27434.45131097407, 1271.783796754554, 1279.8626294088895, 1294.210531575738, 1298.6753311672082, 1312.8293321868096, 13713.382897769625, 13714.971377146754, 13843.030987830754, 14013.509527166703, 14017.229052402012, 492834.0, 496764.0, 497200.0, 498295.0, 499342.0, 55360.72319638376, 55494.72252638711, 55569.444305556426, 55643.44356556464, 55670.0, 1415.3701602786662, 1473.0646039764613, 1477.1284941884126, 1478.7929689843431, 1480.800091987611, 25174.24477265685, 25556.10553630614, 26112.955481781275, 26220.737792622593, 26222.213333600022, 37351.0, 45391.0, 45422.31866522071, 45486.31770523511, 45534.31698524591, 444862.0, 446042.0, 446972.0, 447172.0, 447561.0, 31048.689513105484, 31523.684763152076, 31714.84142579272, 31780.887668932402, 31847.522287165248, 42992.0, 43943.78028109839, 43984.780076099414, 44032.77983610061, 44114.0, 25212.873935630203, 32704.0, 33386.66613333933, 34987.65012349844, 36450.81774591216, 32112.197195070312, 32131.357372851944, 34763.826180868935, 36198.8190059048, 36281.81859090688, 27926.86036569804, 29944.25139371533, 32195.678043219268, 36123.91628251156, 36128.819355903055, 25393.365165871, 27106.864465677547, 27796.44407111887, 28901.0, 29599.0, 22662.733726627204, 22949.54100917939, 23153.305400838002, 23159.536809263383, 23170.652440213074], "value": 18166.20855573006, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [383.69879644479056, 423.0138777393753, 430.85781692041627, 438.7762241256959, 447.6731985650475, 16264.593385165377, 21041.053152608132, 22199.22302719405, 22349.0, 22557.66163507549, 18154.183061762218, 22470.66294005587, 22926.88536557319, 23003.654945175836, 23090.65364019541, 6399.776007839727, 6494.805155845321, 6595.67021648918, 6643.701033453506, 6688.899666505006, 6550.213974323088, 6563.278039415661, 6621.635810030446, 6631.4363279121335, 6642.734290628369, 4000.4799376081214, 4353.934690979638, 4420.071784925153, 6453.257875344349, 7606.467547271694, 7230.783076507713, 7326.67029983652, 7395.112586489602, 7505.437092218051, 7548.282913123272, 7243.927560724378, 7299.23358047408, 7304.342609165201, 7307.123145222554, 7311.817204569875, 25233.0, 25875.353116172057, 26174.0, 27027.0, 27568.862155689294, 2919.5036843736616, 2962.0521433141403, 2964.7035296470394, 2968.554716792477, 3012.487877060905, 15363.078215307118, 16011.039337639779, 16038.679226415523, 16156.515304540882, 16889.324427022904, 1950.444123424817, 2006.759188897327, 2009.2565750672345, 2013.2349707111205, 2013.506690860734, 162369.75260494841, 167916.0, 170034.0, 171712.14143929325, 174203.0, 14917.70164596702, 17645.911770441067, 18780.71828922567, 19596.804031959782, 19853.900730496545, 25639.0, 29972.85013574918, 30640.0, 30685.846570767004, 31735.84132079371, 9636.518174091267, 9909.554070066864, 10307.587696492206, 10361.274710770325, 10575.0, 8594.968603767587, 8612.827743445096, 8623.870641940375, 8746.650133994695, 8803.075677053945, 9122.498262595622, 9188.310876684141, 9323.487208203478, 9345.392549484262, 9355.251579873593, 3945.940810887839, 3985.4058376649573, 3985.4221137934837, 4011.3782363733667, 4019.91960160801, 759.6619504320635, 897.3270047464401, 901.4185850126763, 934.0612684252283, 945.3807755919884, 16912.0, 21529.892350538146, 22327.441813954458, 22327.99524021423, 22349.0, 917.4816228830689, 930.6366173555773, 943.8537026760863, 947.6541062512272, 952.0527075559862, 9517.666881659108, 9722.152790969692, 11132.666020019413, 11675.416229188677, 11723.824142637868, 625708.0, 632726.8363658244, 658763.0, 763963.0, 773310.0, 154460.45539544686, 157390.42609573988, 158781.0, 161587.0, 163521.18239408964, 1351.3918736568583, 1363.522767031531, 1415.6036309833264, 1425.3514650833845, 1427.6573622330773, 19285.4214373569, 20262.290819821235, 20403.979801010188, 20490.282840100524, 20568.897155514125, 40632.965802653205, 54621.90756184934, 59208.703956481666, 64764.0, 66774.33225667682, 87263.56368218118, 88013.67979480441, 88416.55791721257, 88895.11104889127, 89196.0, 11583.619844045817, 12013.699657508632, 12019.978301844441, 12089.81865272004, 12097.274163550215, 10547.894521054692, 11565.537378504765, 12918.677033074247, 13009.21944683322, 13347.799783003069, 10788.784224315626, 11255.437228138397, 11574.900384463463, 11585.899339562728, 11657.358845263252, 10542.894571054192, 10824.0, 10964.725881852699, 11372.829407559058, 11414.429278535874, 11296.322220666787, 11681.357525335849, 11687.0, 11741.178117532032, 11836.289822610672, 11573.537058517903, 11584.131190160602, 11896.583619573274, 11905.285682859056, 12008.459619316976, 10900.509477073392, 11322.433878306216, 11476.827847582126, 11611.825822612498, 11635.360055197045], "value": 11507.804625541168, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1520.1942970225784, 1530.2578249548974, 1562.9452969146082, 1569.9607509812256, 1581.9129947852866, 10567.15462762979, 11121.666350009513, 11127.332360058392, 11137.387443690593, 11158.442077896103, 10461.895381046206, 10864.565417383315, 10938.617148399808, 10964.28732132411, 10971.451427428636, 2381.3332266965276, 2418.0207016158397, 2420.3707036170545, 2420.4674971506242, 2421.987890060547, 2350.5416443793465, 2380.595298799208, 2382.630692242705, 2387.498625288683, 2391.7488663690324, 1857.544901499128, 1981.0589969764392, 2368.1948137633203, 2378.4291769975252, 2383.7735415135535, 2296.632538793785, 2306.319635707462, 2319.1071437496603, 2325.1280769711357, 2325.802306803924, 2304.0898844956314, 2367.3963139399516, 2370.9762902370926, 2372.074890792592, 2375.4298968247667, 11124.443777811077, 11220.831687524693, 11227.71930701739, 11250.66248012561, 11274.774504509864, 5286.709230992294, 5444.101723215705, 5446.319210098738, 5448.37343705475, 5458.044842152647, 3373.9493907591404, 3489.1277180704824, 3680.6135355787524, 3686.5391826021746, 3700.962990370089, 1137.8179491281355, 1188.0851744157037, 1200.5737963023175, 1212.9575464858688, 1236.9443375048145, 12823.679408014781, 13610.523631672844, 14008.159510429407, 14312.92843535786, 15280.31238594266, 4568.0, 4747.715137091785, 4755.120302744003, 4766.1659209638865, 4774.0, 10015.849762253572, 11729.003034742142, 11730.589429370102, 11736.237144585575, 11764.117691173025, 5725.541956643458, 5728.455796699307, 5731.083026715705, 5738.655680659173, 5741.8564535886935, 3829.6744776693736, 5171.379434467888, 5296.3379577552805, 5296.523312901781, 5298.761555730001, 3310.4206763816237, 3739.6260373962386, 3858.6334298241622, 3902.746321489151, 3932.901677458029, 1025.9333143345807, 1029.9588016479406, 1038.0449986012886, 1038.864947556828, 1040.552562398161, 788.8185717285056, 795.2326005404813, 814.9062857771314, 817.3910436724559, 820.9055958564842, 5662.37713851476, 6046.73018666085, 6055.273367195877, 6333.493320534346, 6410.518190194035, 763.9961800191074, 925.0316143743266, 949.5015117063597, 955.617752898846, 972.1445128287062, 3524.242287908061, 3969.54350249725, 3987.5414327352146, 4012.337964235868, 4027.81874815634, 13432.19406835593, 13590.59228223155, 13950.93024534891, 13964.860351396559, 13983.930080349737, 13681.521146759816, 13827.308634568231, 13983.37074831635, 13997.160170389809, 14005.369758360897, 9805.80388392228, 10129.189664826796, 10248.0, 10254.897451025543, 10294.124999374988, 6287.2140982377205, 6307.211598550181, 6394.936050639434, 6432.517561183024, 6442.484601231797, 12096.818547721967, 12167.695807604881, 12203.938980305042, 12341.136120471481, 12359.073069520002, 12406.689832754253, 12635.241885486901, 12647.87352126467, 12735.363231838186, 12933.159344642569, 8434.367422443218, 8537.786555336166, 8740.34447416459, 9133.041030691948, 9376.859347109936, 10045.748856278651, 10331.535080921527, 10435.478226088513, 10442.68671939843, 10464.319819211727, 8535.01847287545, 8538.658453661785, 8571.22858942698, 8729.738107856774, 8731.825363492568, 8897.644094236159, 8923.509206993678, 8995.820083598423, 8999.19007289347, 9003.189712925869, 7653.425993050432, 7718.652660630398, 7792.922070779447, 7797.220277972157, 7797.844043118992, 5164.0, 5344.652597581145, 5708.115242137475, 5740.0815869460685, 5947.494462970696, 5564.554835613222, 5771.7114144293455, 6019.87960240784, 6028.457438830526, 6163.260408750979], "value": 5021.310177832134, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [292.64796639525395, 293.5362127838016, 351.9278547897681, 354.85450965104303, 385.8765195137556, 4490.461144662641, 4986.800527978881, 5108.003939231851, 5319.255304257407, 5347.0858382181705, 3853.2100919311542, 4676.789544470498, 4854.587360074389, 5047.596192304616, 5066.84799456016, 3515.8769443069564, 3586.659267369596, 4031.0, 4234.7815660098395, 4259.74441533509, 3769.4567106919544, 3952.387379956097, 4237.279662457374, 4253.574642535753, 4296.957030429687, 3928.8035598220117, 3940.2316548273097, 4170.4995400551825, 4252.574742525753, 4268.0, 3236.546883436321, 3482.669146431085, 3521.559805024372, 3629.328574213779, 4207.769881962565, 3009.0511298926954, 3775.414810704345, 3807.6573108420375, 3908.8241029153755, 3939.2909276330247, 4216.2199993001395, 4235.639970602502, 4405.427294451701, 4963.815920994751, 4972.900541989176, 4418.3372494125815, 4427.003924117048, 4800.927986080212, 4843.612510999147, 4848.369711937461, 4777.546133117348, 5258.0009798138235, 5337.492938170868, 5413.702246376448, 5487.149491828773, 4028.4158796974275, 4080.8163632636306, 4261.786910654455, 4352.323321157465, 4377.365282034088, 4546.408966834323, 4842.975785121052, 5338.3575130310355, 5456.290682211287, 5708.77164913403, 4070.430139780433, 4191.413202151702, 4192.448793946199, 4209.873703788891, 4231.9843237622745, 3829.885103446901, 3893.0267433141717, 4051.534073581517, 4113.526944401432, 4389.912201755947, 4495.685302028892, 4537.568930951555, 4793.274421208432, 4829.589484893753, 4840.806367745321, 5058.608882557326, 5338.306020217425, 5370.838874833761, 5378.704171270618, 5472.5621950243885, 1480.9407623695147, 1507.3367718203956, 1518.8025556677783, 1523.5657837516476, 1526.8549487798641, 1048.7519851376837, 1073.4203530093662, 1102.6471529110609, 1138.004246284501, 1148.0700632487712, 4439.933400998988, 4508.256137737237, 4527.886802829956, 4858.246971719389, 4897.534734200245, 4823.855284341475, 4892.303388746843, 5009.298698182258, 5074.923876141861, 5352.83451469334, 4085.89785255371, 4535.614472769851, 4924.926126108111, 5050.267711181858, 5052.433745538821, 2463.8275320727375, 2537.4544472938405, 2549.68128983877, 2660.0448670227365, 2899.955531350435, 4847.781849816767, 4859.52543931091, 5426.701531415731, 5701.71491425427, 5705.5435565154685, 5013.874653133628, 5212.452692467236, 5280.471952804689, 5640.85897852557, 5806.274215723035, 4571.217225282143, 4826.95173048265, 4912.38595175603, 4948.777305021211, 5051.2423136529815, 5045.545900868792, 5477.589180811376, 5542.861428464321, 5588.608797384144, 5591.916121258103, 4796.496367881462, 5185.42960274377, 5268.631195816256, 5397.78408863641, 5500.4499550044675, 4949.802007919787, 5184.403793563789, 5567.526760225264, 5676.168586204378, 5703.62926409782, 3500.5274287971815, 3771.4908487353855, 4178.22702799983, 4216.894577635584, 4357.389965404909, 4712.764361781966, 5377.763114483612, 5437.809676661298, 5661.310877333234, 5701.401352858056, 4488.551144885485, 5212.836672780905, 5368.382635996911, 5373.032854086302, 5457.372402173801, 4698.835540756194, 4859.611231101574, 4867.464578896389, 5297.8145764898045, 5317.680939143664, 4993.501949415088, 5016.573591244639, 5042.823501177441, 5179.8446046618665, 5281.273260431969, 4768.0463907218, 4849.80600775965, 5139.280500729826, 5185.403678577012, 5293.682379057269, 4535.682502224812, 5221.608379371486, 5230.267762513327, 5287.603429742708, 5313.442088580643], "value": 4018.6997922736396, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.4360277182412, 741.2291217134181, 774.5043172369684, 821.0680877204373, 832.6045128563931, 15248.847511524882, 16066.036037837723, 16070.59823504413, 16073.437429689962, 16154.030758154518, 13373.933130334335, 13411.19532828031, 13529.255890925995, 13565.593032209024, 13610.863891361083, 926.6247169896203, 938.1416004356006, 948.648999870049, 951.362587066667, 969.7914948286117, 877.1404024056428, 947.1664934857316, 964.2671569607079, 965.9130678238957, 968.1722127580922, 972.9124378805906, 1013.9543720532557, 1015.9085682288593, 1016.8373060310352, 1018.96943091707, 1007.7883644434678, 1010.0253255608336, 1010.2625083688948, 1012.185190921308, 1012.3723291559206, 746.4215233194318, 746.9290417410338, 747.7382915979418, 748.0574476160023, 748.3863232149639, 15196.240187990667, 15312.540623781193, 15375.615609609737, 15958.680826383408, 16034.957727747777, 12198.268103913704, 13712.588622341345, 13815.0, 13819.516316928859, 14129.0, 10205.846912296322, 11577.247478913843, 11794.528218871235, 11878.40607969598, 11899.107566932427, 3563.322968635977, 3621.2576421833724, 3638.0359204810748, 3703.370427027412, 3832.06114501946, 93715.53142234313, 111894.0, 115561.0, 116081.0, 118554.40722796417, 10637.893621063846, 10678.252522323519, 10778.353298802096, 10864.565417383374, 11186.832197517044, 22299.665505017438, 22518.32445026652, 22745.658815117786, 22764.544709105725, 22831.31506054821, 7629.961850190713, 7641.739113046397, 7642.961785191039, 7729.149793522708, 7736.7678969631, 4243.851465198703, 4296.3695677152755, 4365.519792822787, 4421.38100665907, 4460.0633866887665, 3460.2560449503476, 3533.8939831805087, 3571.8214089295952, 3574.8391322390553, 3577.338192434408, 548.7283794521737, 577.8035467940837, 631.2267472346431, 631.7315141065029, 631.766246488802, 667.6701590187629, 674.4941294029478, 688.2738710660301, 690.8324930866819, 720.1789959446236, 9133.81732365349, 9134.862977055349, 9858.162056225301, 10006.997900629782, 10338.586456541805, 510.4742115620916, 521.0204814947874, 528.3395755305868, 548.366636534803, 551.8565173055034, 4693.48371679115, 4894.657373983787, 4956.43872180262, 4965.131102057126, 4992.750362481861, 87859.0, 94692.52653736687, 103937.0, 104635.4768226154, 107048.46475767571, 89999.0, 90028.0, 91615.0, 92417.53791231135, 92985.0, 76693.0, 77683.0, 78318.82521762178, 78426.21573784303, 79845.0, 7601.847963040819, 9629.32594718363, 9669.0, 9673.274504412057, 9693.41839489633, 48804.02391952212, 48946.0, 49615.50384496109, 50173.24740128828, 51387.22919156141, 64992.0, 65592.0, 65673.67163164154, 66249.66875165593, 67472.66263668651, 10874.0, 10948.452577370941, 11042.613508527164, 11063.114950804078, 11269.0, 12465.127441079037, 12492.812607810709, 12551.87448125507, 13584.524541640994, 14630.926845365704, 13617.523386681418, 13888.0, 13890.86109138936, 14088.859111408754, 14393.920455966054, 13276.734465310446, 13773.449062037405, 14076.0, 14140.92929535387, 14166.645833853823, 12706.682332941751, 13421.32893355348, 13766.93116534411, 14032.929835351166, 14231.573052808433, 10768.246222764332, 11101.500432480396, 11306.841458418707, 11386.0, 11425.31448113116, 10499.317544359592, 11011.28426652265, 11367.48846301935, 11649.534018639159, 11785.410729463663], "value": 7527.653754557736, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1435.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 116.0, 116.0, 116.0, 117.0, 116.0, 115.0, 115.0, 118.0, 114.0], "value": 115.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 108.0, 110.0, 144.0, 109.0, 116.0, 136.0, 134.0, 126.0, 110.0], "value": 123.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 187.0, 182.0, 187.0, 186.0, 186.0, 184.0, 185.0, 187.0, 185.0], "value": 185.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 62.0, 60.0, 94.0, 62.0, 61.0, 59.0, 60.0, 77.0, 59.0], "value": 67.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 68.0, 87.0, 71.0, 69.0, 68.0, 83.0, 68.0, 70.0, 85.0], "value": 76.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 134.0, 89.0, 88.0, 88.0, 89.0, 89.0, 88.0, 88.0, 88.0], "value": 96.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 99.0, 95.0, 96.0, 96.0, 98.0, 95.0, 95.0], "value": 96.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 84.0, 84.0, 84.0, 84.0, 84.0, 84.0, 86.0, 84.0], "value": 84.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 61.0, 60.0, 65.0, 65.0, 66.0, 65.0, 64.0, 61.0], "value": 62.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 54.0, 57.0, 65.0, 62.0, 58.0, 58.0, 58.0, 59.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 72.0, 92.0, 72.0, 94.0, 98.0, 100.0, 100.0, 98.0, 84.0], "value": 89.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 146.0, 146.0, 139.0, 140.0, 142.0, 143.0, 138.0, 179.0, 151.0], "value": 146.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 166.0, 165.0, 166.0, 169.0, 167.0, 169.0, 156.0, 168.0, 164.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 66.0, 65.0, 65.0, 66.0, 65.0, 65.0, 64.0], "value": 65.4, "unit": "score"}]}]} 14:17:16 INFO - Return code: 0 14:17:16 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 14:17:16 ERROR - # TBPL SUCCESS # 14:17:16 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 14:17:16 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 14:17:16 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 14:17:16 INFO - 2017-03-08 14:17:16.271 screenresolution[1655:10154] starting screenresolution argv=screenresolution get 14:17:16 INFO - 2017-03-08 14:17:16.274 screenresolution[1655:10154] Display 0: 1600x1200x32@60 14:17:16 INFO - 2017-03-08 14:17:16.280 screenresolution[1656:10157] starting screenresolution argv=screenresolution list 14:17:16 INFO - Available Modes on Display 0 14:17:16 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 14:17:16 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 14:17:16 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 14:17:16 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 14:17:16 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 14:17:16 INFO - Intel Iris: 14:17:16 INFO - Chipset Model: Intel Iris 14:17:16 INFO - Type: GPU 14:17:16 INFO - Bus: Built-In 14:17:16 INFO - VRAM (Dynamic, Max): 1536 MB 14:17:16 INFO - Vendor: Intel (0x8086) 14:17:16 INFO - Device ID: 0x0a2e 14:17:16 INFO - Revision ID: 0x0009 14:17:16 INFO - Displays: 14:17:16 INFO - Display: 14:17:16 INFO - Resolution: 1600 x 1200 @ 60 Hz 14:17:16 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 14:17:16 INFO - Display Serial Number: 1600x1200 60 14:17:16 INFO - Main Display: Yes 14:17:16 INFO - Mirror: Off 14:17:16 INFO - Online: Yes 14:17:16 INFO - Rotation: Supported 14:17:16 INFO - Return code: 0 14:17:16 INFO - Running post-action listener: _resource_record_post_action 14:17:16 INFO - [mozharness: 2017-03-08 22:17:16.524852Z] Finished run-tests step (success) 14:17:16 INFO - Running post-run listener: _resource_record_post_run 14:17:16 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 38319104; Write bytes: 508379136; Read time: 371; Write time: 1537 14:17:16 INFO - TinderboxPrint: CPU usage
53.9% 14:17:16 INFO - TinderboxPrint: I/O read bytes / time
38,319,104 / 371 14:17:16 INFO - TinderboxPrint: I/O write bytes / time
508,379,136 / 1,537 14:17:16 INFO - TinderboxPrint: CPU idle
2,219.1 (46.1%) 14:17:16 INFO - TinderboxPrint: CPU system
962.2 (20.0%) 14:17:16 INFO - TinderboxPrint: CPU user
1,632.4 (33.9%) 14:17:16 INFO - TinderboxPrint: Swap in / out
246,845,440 / 0 14:17:16 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 202035712; Write bytes: 200812544; Read time: 15671; Write time: 367 14:17:16 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 36500480; Write bytes: 296810496; Read time: 353; Write time: 1105 14:17:17 INFO - Running post-run listener: _upload_blobber_files 14:17:17 INFO - Blob upload gear active. 14:17:17 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 14:17:17 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 14:17:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 14:17:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 14:17:17 INFO - (blobuploader) - INFO - Open directory for files ... 14:17:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 14:17:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:17:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:17:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 14:17:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:17:18 INFO - (blobuploader) - INFO - Done attempting. 14:17:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 14:17:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:17:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:17:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 14:17:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:17:19 INFO - (blobuploader) - INFO - Done attempting. 14:17:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 14:17:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:17:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:17:20 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 14:17:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:17:20 INFO - (blobuploader) - INFO - Done attempting. 14:17:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 14:17:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 14:17:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 14:17:22 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 14:17:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 14:17:22 INFO - (blobuploader) - INFO - Done attempting. 14:17:22 INFO - (blobuploader) - INFO - Iteration through files over. 14:17:22 INFO - Return code: 0 14:17:22 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 14:17:22 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 14:17:22 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ddb630a2dac9bf625c32186e0550e2f7b3cda6fa038b1564ff34f92addd16092b5455e0db0723fdf40e875e23aa50e36098b7a096eeb034ad6a738f8202898e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ebb200d0cce680ce8cab7732d7788597b7da857e53d8229a363f3428bed6b598a56d7a34bd191f25a98ad6462bdf25078eca1488cf40daee37bf9a73c7a890c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e5027687aca793d8878035cd8711fbe9be4f1d28dcf0597c1a735b473bb0095983665ce6c94b56882cfdbc93b27fd8c896136af232c7ba40d35f356d735a0d1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c9b0d6fbfdb83fe51b56b89527e2b931f3daffbbbeca92a6237592e1264720ecc969c5137630c0d99f6d120d91def476a86cb3fa7ae45e6c6397d00674e8e432"} 14:17:22 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 14:17:22 INFO - Writing to file /builds/slave/test/properties/blobber_files 14:17:22 INFO - Contents: 14:17:22 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ddb630a2dac9bf625c32186e0550e2f7b3cda6fa038b1564ff34f92addd16092b5455e0db0723fdf40e875e23aa50e36098b7a096eeb034ad6a738f8202898e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ebb200d0cce680ce8cab7732d7788597b7da857e53d8229a363f3428bed6b598a56d7a34bd191f25a98ad6462bdf25078eca1488cf40daee37bf9a73c7a890c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e5027687aca793d8878035cd8711fbe9be4f1d28dcf0597c1a735b473bb0095983665ce6c94b56882cfdbc93b27fd8c896136af232c7ba40d35f356d735a0d1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c9b0d6fbfdb83fe51b56b89527e2b931f3daffbbbeca92a6237592e1264720ecc969c5137630c0d99f6d120d91def476a86cb3fa7ae45e6c6397d00674e8e432"} 14:17:22 INFO - Running post-run listener: copy_logs_to_upload_dir 14:17:22 INFO - Copying logs to upload dir... 14:17:22 INFO - mkdir: /builds/slave/test/build/upload/logs 14:17:22 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.093642 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-03-08 14:17:22.820834) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-08 14:17:22.826523) ========= 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.PsyYwwXN3X/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.YpNKCQ7NaE/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4ddb630a2dac9bf625c32186e0550e2f7b3cda6fa038b1564ff34f92addd16092b5455e0db0723fdf40e875e23aa50e36098b7a096eeb034ad6a738f8202898e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ebb200d0cce680ce8cab7732d7788597b7da857e53d8229a363f3428bed6b598a56d7a34bd191f25a98ad6462bdf25078eca1488cf40daee37bf9a73c7a890c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e5027687aca793d8878035cd8711fbe9be4f1d28dcf0597c1a735b473bb0095983665ce6c94b56882cfdbc93b27fd8c896136af232c7ba40d35f356d735a0d1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c9b0d6fbfdb83fe51b56b89527e2b931f3daffbbbeca92a6237592e1264720ecc969c5137630c0d99f6d120d91def476a86cb3fa7ae45e6c6397d00674e8e432"} build_url:https://queue.taskcluster.net/v1/task/bY0nnvr5Trm5TeHY4aKWWw/artifacts/public/build/firefox-54.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011239 build_url: 'https://queue.taskcluster.net/v1/task/bY0nnvr5Trm5TeHY4aKWWw/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/4ddb630a2dac9bf625c32186e0550e2f7b3cda6fa038b1564ff34f92addd16092b5455e0db0723fdf40e875e23aa50e36098b7a096eeb034ad6a738f8202898e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0ebb200d0cce680ce8cab7732d7788597b7da857e53d8229a363f3428bed6b598a56d7a34bd191f25a98ad6462bdf25078eca1488cf40daee37bf9a73c7a890c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/4e5027687aca793d8878035cd8711fbe9be4f1d28dcf0597c1a735b473bb0095983665ce6c94b56882cfdbc93b27fd8c896136af232c7ba40d35f356d735a0d1", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c9b0d6fbfdb83fe51b56b89527e2b931f3daffbbbeca92a6237592e1264720ecc969c5137630c0d99f6d120d91def476a86cb3fa7ae45e6c6397d00674e8e432"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-08 14:17:22.862491) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 14:17:22.862974) ========= 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.PsyYwwXN3X/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.YpNKCQ7NaE/Listeners TMPDIR=/var/folders/n0/6tpw2p6j3vx8fzyb0wrmlcwc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.004680 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-08 14:17:22.912261) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-08 14:17:22.912635) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-08 14:17:22.913060) ========= ========= Total master_lag: 0.19 =========