builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0007 starttime: 1488936502.02 results: success (0) buildid: 20170307162823 builduid: 31c6b45ef88b4098b62ad13cca7e1048 revision: dd92d0734a266dab534af530c8ae35670aedd282 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-07 17:28:22.025176) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-07 17:28:22.025663) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-07 17:28:22.025948) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-07 17:28:22.058853) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-07 17:28:22.059252) ========= 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.KfMhwnGMPF/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.RnsgGYn4wq/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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-07 17:28:22-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 159M=0s 2017-03-07 17:28:22 (159 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.161382 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-07 17:28:22.244997) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-07 17:28:22.245321) ========= 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.KfMhwnGMPF/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.RnsgGYn4wq/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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.028696 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-07 17:28:22.295744) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-07 17:28:22.296098) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev dd92d0734a266dab534af530c8ae35670aedd282 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev dd92d0734a266dab534af530c8ae35670aedd282 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KfMhwnGMPF/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.RnsgGYn4wq/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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-07 17:28:22,398 truncating revision to first 12 chars 2017-03-07 17:28:22,398 Setting DEBUG logging. 2017-03-07 17:28:22,399 attempt 1/10 2017-03-07 17:28:22,399 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/dd92d0734a26?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-07 17:28:23,582 unpacking tar archive at: mozilla-central-dd92d0734a26/testing/mozharness/ program finished with exit code 0 elapsedTime=1.456149 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-07 17:28:23.774126) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-07 17:28:23.774453) ========= script_repo_revision: dd92d0734a266dab534af530c8ae35670aedd282 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-07 17:28:23.774871) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-07 17:28:23.775145) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-07 17:28:23.793155) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-03-07 17:28:23.793660) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KfMhwnGMPF/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.RnsgGYn4wq/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 17:28:23 INFO - MultiFileLogger online at 20170307 17:28:23 in /builds/slave/test 17:28:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 17:28:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:28:23 INFO - {'append_to_log': False, 17:28:23 INFO - 'base_work_dir': '/builds/slave/test', 17:28:23 INFO - 'blob_upload_branch': 'Firefox', 17:28:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:28:23 INFO - 'branch': 'Firefox', 17:28:23 INFO - 'buildbot_json_path': 'buildprops.json', 17:28:23 INFO - 'config_files': ('talos/mac_config.py',), 17:28:23 INFO - 'default_actions': ('clobber', 17:28:23 INFO - 'read-buildbot-config', 17:28:23 INFO - 'download-and-extract', 17:28:23 INFO - 'populate-webroot', 17:28:23 INFO - 'create-virtualenv', 17:28:23 INFO - 'install', 17:28:23 INFO - 'run-tests'), 17:28:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:28:23 INFO - 'download_minidump_stackwalk': True, 17:28:23 INFO - 'download_symbols': 'ondemand', 17:28:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:28:23 INFO - 'tooltool.py': '/tools/tooltool.py', 17:28:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:28:23 INFO - '/tools/misc-python/virtualenv.py')}, 17:28:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:28:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:28:23 INFO - 'gecko_profile': False, 17:28:23 INFO - 'gecko_profile_interval': 0, 17:28:23 INFO - 'installer_path': 'installer.exe', 17:28:23 INFO - 'log_level': 'info', 17:28:23 INFO - 'log_name': 'talos', 17:28:23 INFO - 'log_to_console': True, 17:28:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 17:28:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 17:28:23 INFO - 'opt_config_files': (), 17:28:23 INFO - 'pip_index': False, 17:28:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:28:23 INFO - 'cmd': ('bash', 17:28:23 INFO - '-c', 17:28:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:28:23 INFO - 'enabled': True, 17:28:23 INFO - 'halt_on_failure': False, 17:28:23 INFO - 'name': 'check_screen_resolution'},), 17:28:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 17:28:23 INFO - 'cmd': ('bash', 17:28:23 INFO - '-c', 17:28:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 17:28:23 INFO - 'enabled': True, 17:28:23 INFO - 'halt_on_failure': False, 17:28:23 INFO - 'name': 'check_screen_resolution'},), 17:28:23 INFO - 'run_cmd_checks_enabled': True, 17:28:23 INFO - 'suite': 'dromaeojs', 17:28:23 INFO - 'system_bits': '32', 17:28:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:28:23 INFO - 'title': 't-yosemite-r7-0007', 17:28:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:28:23 INFO - 'use_talos_json': True, 17:28:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:28:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:28:23 INFO - 'work_dir': 'build'} 17:28:23 INFO - [mozharness: 2017-03-08 01:28:23.993224Z] Running clobber step. 17:28:23 INFO - Running pre-action listener: _resource_record_pre_action 17:28:23 INFO - Running main action method: clobber 17:28:23 INFO - rmtree: /builds/slave/test/build 17:28:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:28:26 INFO - Running post-action listener: _resource_record_post_action 17:28:26 INFO - [mozharness: 2017-03-08 01:28:26.466030Z] Finished clobber step (success) 17:28:26 INFO - [mozharness: 2017-03-08 01:28:26.466166Z] Running read-buildbot-config step. 17:28:26 INFO - Running pre-action listener: _resource_record_pre_action 17:28:26 INFO - Running main action method: read_buildbot_config 17:28:26 INFO - Using buildbot properties: 17:28:26 INFO - { 17:28:26 INFO - "project": "", 17:28:26 INFO - "product": "firefox", 17:28:26 INFO - "script_repo_revision": "production", 17:28:26 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 17:28:26 INFO - "repository": "", 17:28:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 17:28:26 INFO - "buildid": "20170307162823", 17:28:26 INFO - "pgo_build": "False", 17:28:26 INFO - "basedir": "/builds/slave/test", 17:28:26 INFO - "buildnumber": 11, 17:28:26 INFO - "slavename": "t-yosemite-r7-0007", 17:28:26 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 17:28:26 INFO - "platform": "yosemite_r7", 17:28:26 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 17:28:26 INFO - "branch": "mozilla-central", 17:28:26 INFO - "repo_path": "mozilla-central", 17:28:26 INFO - "revision": "dd92d0734a266dab534af530c8ae35670aedd282", 17:28:26 INFO - "stage_platform": "macosx64", 17:28:26 INFO - "builduid": "31c6b45ef88b4098b62ad13cca7e1048", 17:28:26 INFO - "slavebuilddir": "test" 17:28:26 INFO - } 17:28:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/cZuJhUXmRee3oY-OaQ6_0g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 17:28:26 INFO - Running post-action listener: _resource_record_post_action 17:28:26 INFO - [mozharness: 2017-03-08 01:28:26.469616Z] Finished read-buildbot-config step (success) 17:28:26 INFO - [mozharness: 2017-03-08 01:28:26.469795Z] Running download-and-extract step. 17:28:26 INFO - Running pre-action listener: _resource_record_pre_action 17:28:26 INFO - Running main action method: download_and_extract 17:28:26 INFO - mkdir: /builds/slave/test/build/tests 17:28:26 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')]} 17:28:26 INFO - trying https://queue.taskcluster.net/v1/task/cZuJhUXmRee3oY-OaQ6_0g/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 17:28:26 INFO - Downloading https://queue.taskcluster.net/v1/task/cZuJhUXmRee3oY-OaQ6_0g/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:28:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cZuJhUXmRee3oY-OaQ6_0g/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 17:28:27 INFO - Downloaded 1199 bytes. 17:28:27 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 17:28:27 INFO - Using the following test package requirements: 17:28:27 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:28:27 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:28:27 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 17:28:27 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:28:27 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 17:28:27 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:28:27 INFO - u'jsshell-mac.zip'], 17:28:27 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:28:27 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 17:28:27 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 17:28:27 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:28:27 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 17:28:27 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:28:27 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 17:28:27 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:28:27 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 17:28:27 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 17:28:27 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 17:28:27 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 17:28:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cZuJhUXmRee3oY-OaQ6_0g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:28:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cZuJhUXmRee3oY-OaQ6_0g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:28:27 INFO - Fetch https://queue.taskcluster.net/v1/task/cZuJhUXmRee3oY-OaQ6_0g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:28:29 INFO - Expected file size: 51787693 17:28:29 INFO - Obtained file size: 51787693 17:28:45 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 17:28:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cZuJhUXmRee3oY-OaQ6_0g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 17:28:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cZuJhUXmRee3oY-OaQ6_0g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 17:28:45 INFO - Fetch https://queue.taskcluster.net/v1/task/cZuJhUXmRee3oY-OaQ6_0g/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 17:28:47 INFO - Expected file size: 51787693 17:28:47 INFO - Obtained file size: 51787693 17:29:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/cZuJhUXmRee3oY-OaQ6_0g/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 17:29:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cZuJhUXmRee3oY-OaQ6_0g/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 17:29:02 INFO - Fetch https://queue.taskcluster.net/v1/task/cZuJhUXmRee3oY-OaQ6_0g/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 17:29:04 INFO - Expected file size: 14404424 17:29:04 INFO - Obtained file size: 14404424 17:29:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:29:04 INFO - trying https://queue.taskcluster.net/v1/task/cZuJhUXmRee3oY-OaQ6_0g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:29:04 INFO - Downloading https://queue.taskcluster.net/v1/task/cZuJhUXmRee3oY-OaQ6_0g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 17:29:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cZuJhUXmRee3oY-OaQ6_0g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 17:29:06 INFO - Downloaded 74914980 bytes. 17:29:06 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cZuJhUXmRee3oY-OaQ6_0g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:29:06 INFO - mkdir: /builds/slave/test/properties 17:29:06 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:29:06 INFO - Writing to file /builds/slave/test/properties/build_url 17:29:06 INFO - Contents: 17:29:06 INFO - build_url:https://queue.taskcluster.net/v1/task/cZuJhUXmRee3oY-OaQ6_0g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 17:29:07 INFO - Running post-action listener: _resource_record_post_action 17:29:07 INFO - Running post-action listener: set_extra_try_arguments 17:29:07 INFO - [mozharness: 2017-03-08 01:29:07.289489Z] Finished download-and-extract step (success) 17:29:07 INFO - [mozharness: 2017-03-08 01:29:07.289615Z] Running populate-webroot step. 17:29:07 INFO - Running pre-action listener: _resource_record_pre_action 17:29:07 INFO - Running main action method: populate_webroot 17:29:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:29:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:29:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:29:07 INFO - '--tppagecycles', 17:29:07 INFO - '7'], 17:29:07 INFO - 'tests': ['tsvgm']}}, 17:29:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 17:29:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:29:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 17:29:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 17:29:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 17:29:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 17:29:07 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 17:29:07 INFO - 'talos_options': ['--disable-e10s'], 17:29:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:29:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 17:29:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:29:07 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 17:29:07 INFO - 'talos_options': ['--disable-e10s'], 17:29:07 INFO - 'tests': ['damp', 'tps']}, 17:29:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 17:29:07 INFO - 'tests': ['damp', 'tps']}, 17:29:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 17:29:07 INFO - 'tests': ['dromaeo_dom']}, 17:29:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:29:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 17:29:07 INFO - 'tests': ['basic_compositor_video']}, 17:29:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 17:29:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 17:29:07 INFO - 'tests': ['a11yr', 17:29:07 INFO - 'ts_paint', 17:29:07 INFO - 'tpaint', 17:29:07 INFO - 'sessionrestore', 17:29:07 INFO - 'sessionrestore_no_auto_restore', 17:29:07 INFO - 'tabpaint']}, 17:29:07 INFO - 'other-e10s': {'tests': ['a11yr', 17:29:07 INFO - 'ts_paint', 17:29:07 INFO - 'tpaint', 17:29:07 INFO - 'sessionrestore', 17:29:07 INFO - 'sessionrestore_no_auto_restore', 17:29:07 INFO - 'tabpaint']}, 17:29:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 17:29:07 INFO - 'ts_paint', 17:29:07 INFO - 'tpaint', 17:29:07 INFO - 'sessionrestore', 17:29:07 INFO - 'sessionrestore_no_auto_restore', 17:29:07 INFO - 'tabpaint']}, 17:29:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 17:29:07 INFO - 'ts_paint', 17:29:07 INFO - 'tpaint', 17:29:07 INFO - 'sessionrestore', 17:29:07 INFO - 'sessionrestore_no_auto_restore', 17:29:07 INFO - 'tabpaint']}, 17:29:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 17:29:07 INFO - 'tests': ['a11yr', 17:29:07 INFO - 'ts_paint', 17:29:07 INFO - 'tpaint', 17:29:07 INFO - 'sessionrestore', 17:29:07 INFO - 'sessionrestore_no_auto_restore', 17:29:07 INFO - 'tabpaint']}, 17:29:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 17:29:07 INFO - 'tests': ['a11yr', 17:29:07 INFO - 'ts_paint', 17:29:07 INFO - 'tpaint', 17:29:07 INFO - 'sessionrestore', 17:29:07 INFO - 'sessionrestore_no_auto_restore', 17:29:07 INFO - 'tabpaint']}, 17:29:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 17:29:07 INFO - 'tests': ['tsvgx', 17:29:07 INFO - 'tsvgr_opacity', 17:29:07 INFO - 'tart', 17:29:07 INFO - 'tscrollx', 17:29:07 INFO - 'cart', 17:29:07 INFO - 'tsvg_static']}, 17:29:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 17:29:07 INFO - 'tsvgr_opacity', 17:29:07 INFO - 'tart', 17:29:07 INFO - 'tscrollx', 17:29:07 INFO - 'cart', 17:29:07 INFO - 'tsvg_static']}, 17:29:07 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 17:29:07 INFO - 'talos_options': ['--disable-e10s'], 17:29:07 INFO - 'tests': ['tp5o']}, 17:29:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 17:29:07 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 17:29:07 INFO - 'talos_options': ['--disable-e10s', 17:29:07 INFO - '--xperf_path', 17:29:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:29:07 INFO - 'tests': ['tp5n']}, 17:29:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 17:29:07 INFO - 'talos_options': ['--xperf_path', 17:29:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:29:07 INFO - 'tests': ['tp5n']}}, 17:29:07 INFO - 'talos.zip': {'path': '', 17:29:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:29:07 INFO - Running post-action listener: _resource_record_post_action 17:29:07 INFO - [mozharness: 2017-03-08 01:29:07.308245Z] Finished populate-webroot step (success) 17:29:07 INFO - [mozharness: 2017-03-08 01:29:07.308387Z] Running create-virtualenv step. 17:29:07 INFO - Running pre-action listener: _resource_record_pre_action 17:29:07 INFO - Running main action method: create_virtualenv 17:29:07 INFO - Creating virtualenv /builds/slave/test/build/venv 17:29:07 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 17:29:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:29:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:29:07 INFO - Using real prefix '/tools/python27' 17:29:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:29:08 INFO - Installing distribute.............................................................................................................................................................................................done. 17:29:10 INFO - Installing pip.................done. 17:29:11 INFO - Return code: 0 17:29:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 17:29:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 17:29:11 INFO - Reading from file tmpfile_stdout 17:29:11 INFO - Output received: 17:29:11 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) 17:29:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:29:11 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')]} 17:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:11 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')]} 17:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:11 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 0x102d18b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d1b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f14eb050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102af6d30>, '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 0x102a1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102aebbe8>, '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.KfMhwnGMPF/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.RnsgGYn4wq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 17:29:11 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 17:29:11 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 17:29:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KfMhwnGMPF/Render', 17:29:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:29:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:29:11 INFO - 'HOME': '/Users/cltbld', 17:29:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:29:11 INFO - 'LOGNAME': 'cltbld', 17:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:11 INFO - 'MOZ_NO_REMOTE': '1', 17:29:11 INFO - 'NO_EM_RESTART': '1', 17:29:11 INFO - 'PAGER': '/bin/cat', 17:29:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:11 INFO - 'PWD': '/builds/slave/test', 17:29:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:29:11 INFO - 'SHELL': '/bin/bash', 17:29:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RnsgGYn4wq/Listeners', 17:29:11 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 17:29:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:29:11 INFO - 'USER': 'cltbld', 17:29:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:29:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:11 INFO - 'XPC_FLAGS': '0x0', 17:29:11 INFO - 'XPC_SERVICE_NAME': '0', 17:29:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:11 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 17:29:11 INFO - Cleaning up... 17:29:11 INFO - Return code: 0 17:29:11 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 17:29:11 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')]} 17:29:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:11 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')]} 17:29:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:11 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 0x102d18b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d1b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f14eb050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102af6d30>, '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 0x102a1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102aebbe8>, '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.KfMhwnGMPF/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.RnsgGYn4wq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 17:29:11 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 17:29:11 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 17:29:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KfMhwnGMPF/Render', 17:29:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:29:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:29:11 INFO - 'HOME': '/Users/cltbld', 17:29:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:29:11 INFO - 'LOGNAME': 'cltbld', 17:29:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:11 INFO - 'MOZ_NO_REMOTE': '1', 17:29:11 INFO - 'NO_EM_RESTART': '1', 17:29:11 INFO - 'PAGER': '/bin/cat', 17:29:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:29:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:11 INFO - 'PWD': '/builds/slave/test', 17:29:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:29:11 INFO - 'SHELL': '/bin/bash', 17:29:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RnsgGYn4wq/Listeners', 17:29:11 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 17:29:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:29:11 INFO - 'USER': 'cltbld', 17:29:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:29:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:29:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:11 INFO - 'XPC_FLAGS': '0x0', 17:29:11 INFO - 'XPC_SERVICE_NAME': '0', 17:29:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:29:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:11 INFO - Downloading/unpacking psutil>=3.1.1 17:29:11 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 17:29:11 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 17:29:11 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 17:29:11 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 17:29:11 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 17:29:11 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 17:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:29:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:29:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:29:15 INFO - Installing collected packages: psutil 17:29:15 INFO - Running setup.py install for psutil 17:29:15 INFO - building 'psutil._psutil_osx' extension 17:29:15 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 17:29:15 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 17:29:16 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 17:29:16 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 17:29:16 INFO - building 'psutil._psutil_posix' extension 17:29:16 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 17:29:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 17:29:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 17:29:16 INFO - ^ 17:29:16 INFO - 1 warning generated. 17:29:16 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 17:29:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:29:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:29:16 INFO - Successfully installed psutil 17:29:16 INFO - Cleaning up... 17:29:16 INFO - Return code: 0 17:29:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 17:29:16 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')]} 17:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:16 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')]} 17:29:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:17 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 0x102d18b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d1b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f14eb050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102af6d30>, '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 0x102a1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102aebbe8>, '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.KfMhwnGMPF/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.RnsgGYn4wq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 17:29:17 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 17:29:17 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 17:29:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KfMhwnGMPF/Render', 17:29:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:29:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:29:17 INFO - 'HOME': '/Users/cltbld', 17:29:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:29:17 INFO - 'LOGNAME': 'cltbld', 17:29:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:17 INFO - 'MOZ_NO_REMOTE': '1', 17:29:17 INFO - 'NO_EM_RESTART': '1', 17:29:17 INFO - 'PAGER': '/bin/cat', 17:29:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:29:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:17 INFO - 'PWD': '/builds/slave/test', 17:29:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:29:17 INFO - 'SHELL': '/bin/bash', 17:29:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RnsgGYn4wq/Listeners', 17:29:17 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 17:29:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:29:17 INFO - 'USER': 'cltbld', 17:29:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:29:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:29:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:17 INFO - 'XPC_FLAGS': '0x0', 17:29:17 INFO - 'XPC_SERVICE_NAME': '0', 17:29:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:29:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 17:29:17 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 17:29:17 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 17:29:17 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 17:29:17 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 17:29:17 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 17:29:17 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 17:29:20 INFO - Downloading mozsystemmonitor-0.3.tar.gz 17:29:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:29:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 17:29:20 INFO - Installing collected packages: mozsystemmonitor 17:29:20 INFO - Running setup.py install for mozsystemmonitor 17:29:20 INFO - Successfully installed mozsystemmonitor 17:29:20 INFO - Cleaning up... 17:29:20 INFO - Return code: 0 17:29:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 17:29:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:29:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:29:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:20 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 0x102d18b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d1b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f14eb050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102af6d30>, '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 0x102a1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102aebbe8>, '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.KfMhwnGMPF/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.RnsgGYn4wq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 17:29:20 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 17:29:20 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 17:29:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KfMhwnGMPF/Render', 17:29:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:29:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:29:20 INFO - 'HOME': '/Users/cltbld', 17:29:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:29:20 INFO - 'LOGNAME': 'cltbld', 17:29:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:20 INFO - 'MOZ_NO_REMOTE': '1', 17:29:20 INFO - 'NO_EM_RESTART': '1', 17:29:20 INFO - 'PAGER': '/bin/cat', 17:29:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:29:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:20 INFO - 'PWD': '/builds/slave/test', 17:29:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:29:20 INFO - 'SHELL': '/bin/bash', 17:29:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RnsgGYn4wq/Listeners', 17:29:20 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 17:29:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:29:20 INFO - 'USER': 'cltbld', 17:29:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:29:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:29:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:20 INFO - 'XPC_FLAGS': '0x0', 17:29:20 INFO - 'XPC_SERVICE_NAME': '0', 17:29:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:29:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:21 INFO - Downloading/unpacking jsonschema==2.5.1 17:29:21 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 17:29:21 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 17:29:21 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 17:29:21 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 17:29:21 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 17:29:21 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 17:29:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 17:29:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 17:29:23 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 17:29:23 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 17:29:23 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 17:29:23 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 17:29:23 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 17:29:23 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 17:29:24 INFO - Downloading functools32-3.2.3-2.tar.gz 17:29:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 17:29:24 INFO - warning: no files found matching '*.txt' 17:29:24 INFO - no previously-included directories found matching 'build' 17:29:24 INFO - no previously-included directories found matching 'dist' 17:29:24 INFO - no previously-included directories found matching '.git*' 17:29:24 INFO - Installing collected packages: jsonschema, functools32 17:29:24 INFO - Running setup.py install for functools32 17:29:24 INFO - warning: no files found matching '*.txt' 17:29:24 INFO - no previously-included directories found matching 'build' 17:29:24 INFO - no previously-included directories found matching 'dist' 17:29:24 INFO - no previously-included directories found matching '.git*' 17:29:24 INFO - Successfully installed jsonschema functools32 17:29:24 INFO - Cleaning up... 17:29:24 INFO - Return code: 0 17:29:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 17:29:24 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')]} 17:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:24 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')]} 17:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:24 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 0x102d18b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d1b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f14eb050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102af6d30>, '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 0x102a1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102aebbe8>, '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.KfMhwnGMPF/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.RnsgGYn4wq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 17:29:24 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 17:29:24 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 17:29:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KfMhwnGMPF/Render', 17:29:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:29:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:29:24 INFO - 'HOME': '/Users/cltbld', 17:29:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:29:24 INFO - 'LOGNAME': 'cltbld', 17:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:24 INFO - 'MOZ_NO_REMOTE': '1', 17:29:24 INFO - 'NO_EM_RESTART': '1', 17:29:24 INFO - 'PAGER': '/bin/cat', 17:29:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:24 INFO - 'PWD': '/builds/slave/test', 17:29:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:29:24 INFO - 'SHELL': '/bin/bash', 17:29:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RnsgGYn4wq/Listeners', 17:29:24 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 17:29:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:29:24 INFO - 'USER': 'cltbld', 17:29:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:29:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:24 INFO - 'XPC_FLAGS': '0x0', 17:29:24 INFO - 'XPC_SERVICE_NAME': '0', 17:29:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:29:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 17:29:24 INFO - Cleaning up... 17:29:24 INFO - Return code: 0 17:29:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:29:24 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')]} 17:29:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:24 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')]} 17:29:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:24 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 0x102d18b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d1b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f14eb050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102af6d30>, '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 0x102a1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102aebbe8>, '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.KfMhwnGMPF/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.RnsgGYn4wq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 17:29:24 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 17:29:24 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 17:29:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KfMhwnGMPF/Render', 17:29:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:29:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:29:24 INFO - 'HOME': '/Users/cltbld', 17:29:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:29:24 INFO - 'LOGNAME': 'cltbld', 17:29:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:24 INFO - 'MOZ_NO_REMOTE': '1', 17:29:24 INFO - 'NO_EM_RESTART': '1', 17:29:24 INFO - 'PAGER': '/bin/cat', 17:29:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:29:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:24 INFO - 'PWD': '/builds/slave/test', 17:29:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:29:24 INFO - 'SHELL': '/bin/bash', 17:29:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RnsgGYn4wq/Listeners', 17:29:24 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 17:29:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:29:24 INFO - 'USER': 'cltbld', 17:29:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:29:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:29:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:24 INFO - 'XPC_FLAGS': '0x0', 17:29:24 INFO - 'XPC_SERVICE_NAME': '0', 17:29:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:29:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:25 INFO - Downloading/unpacking blobuploader==1.2.4 17:29:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:29:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:29:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:29:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 17:29:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 17:29:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 17:29:27 INFO - Downloading blobuploader-1.2.4.tar.gz 17:29:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:29:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:29:27 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 17:29:27 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 17:29:27 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 17:29:27 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 17:29:27 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 17:29:27 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 17:29:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:29:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:29:28 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 17:29:28 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 17:29:28 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 17:29:28 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 17:29:28 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 17:29:28 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 17:29:28 INFO - Downloading docopt-0.6.1.tar.gz 17:29:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:29:28 INFO - Installing collected packages: blobuploader, requests, docopt 17:29:28 INFO - Running setup.py install for blobuploader 17:29:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:29:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:29:29 INFO - Running setup.py install for requests 17:29:29 INFO - Running setup.py install for docopt 17:29:29 INFO - Successfully installed blobuploader requests docopt 17:29:29 INFO - Cleaning up... 17:29:29 INFO - Return code: 0 17:29:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:29:29 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')]} 17:29:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:29 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')]} 17:29:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:29 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 0x102d18b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d1b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f14eb050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102af6d30>, '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 0x102a1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102aebbe8>, '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.KfMhwnGMPF/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.RnsgGYn4wq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 17:29:29 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 17:29:29 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 17:29:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KfMhwnGMPF/Render', 17:29:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:29:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:29:29 INFO - 'HOME': '/Users/cltbld', 17:29:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:29:29 INFO - 'LOGNAME': 'cltbld', 17:29:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:29 INFO - 'MOZ_NO_REMOTE': '1', 17:29:29 INFO - 'NO_EM_RESTART': '1', 17:29:29 INFO - 'PAGER': '/bin/cat', 17:29:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:29:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:29 INFO - 'PWD': '/builds/slave/test', 17:29:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:29:29 INFO - 'SHELL': '/bin/bash', 17:29:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RnsgGYn4wq/Listeners', 17:29:29 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 17:29:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:29:29 INFO - 'USER': 'cltbld', 17:29:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:29:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:29:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:29 INFO - 'XPC_FLAGS': '0x0', 17:29:29 INFO - 'XPC_SERVICE_NAME': '0', 17:29:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:29:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:29:30 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-WlkowV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:29:30 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-aoEuMU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:29:30 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-koW7ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:29:30 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-8vqXMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:29:30 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-RlFkBH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:29:30 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-auQre0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:29:30 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-Ng1KLt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:29:30 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-ZJePec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:29:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:29:30 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-3cOGUq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:29:31 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-t7KE1Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:29:31 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-UP6NCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:29:31 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-TkXdeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:29:31 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-1RYGRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:29:31 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-JcTVyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:29:31 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-AvbiFj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:29:31 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-xN3tca-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:29:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:29:31 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-K18uYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:29:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:29:31 INFO - Running setup.py install for manifestparser 17:29:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:29:32 INFO - Running setup.py install for mozcrash 17:29:32 INFO - Running setup.py install for mozdebug 17:29:32 INFO - Running setup.py install for mozdevice 17:29:32 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:29:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:29:32 INFO - Running setup.py install for mozfile 17:29:32 INFO - Running setup.py install for mozhttpd 17:29:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:29:32 INFO - Running setup.py install for mozinfo 17:29:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:29:32 INFO - Running setup.py install for mozInstall 17:29:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:29:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:29:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:29:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:29:33 INFO - Running setup.py install for mozleak 17:29:33 INFO - Running setup.py install for mozlog 17:29:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:29:33 INFO - Running setup.py install for moznetwork 17:29:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:29:33 INFO - Running setup.py install for mozprocess 17:29:33 INFO - Running setup.py install for mozprofile 17:29:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:29:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:29:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:29:33 INFO - Running setup.py install for mozrunner 17:29:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:29:34 INFO - Running setup.py install for mozscreenshot 17:29:34 INFO - Running setup.py install for moztest 17:29:34 INFO - Running setup.py install for mozversion 17:29:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:29:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:29:34 INFO - Cleaning up... 17:29:34 INFO - Return code: 0 17:29:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:29:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:29:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:34 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 0x102d18b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d1b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f14eb050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102af6d30>, '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 0x102a1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102aebbe8>, '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.KfMhwnGMPF/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.RnsgGYn4wq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 17:29:34 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 17:29:34 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 17:29:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KfMhwnGMPF/Render', 17:29:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:29:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:29:34 INFO - 'HOME': '/Users/cltbld', 17:29:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:29:34 INFO - 'LOGNAME': 'cltbld', 17:29:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:34 INFO - 'MOZ_NO_REMOTE': '1', 17:29:34 INFO - 'NO_EM_RESTART': '1', 17:29:34 INFO - 'PAGER': '/bin/cat', 17:29:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:29:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:34 INFO - 'PWD': '/builds/slave/test', 17:29:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:29:34 INFO - 'SHELL': '/bin/bash', 17:29:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RnsgGYn4wq/Listeners', 17:29:34 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 17:29:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:29:34 INFO - 'USER': 'cltbld', 17:29:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:29:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:29:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:34 INFO - 'XPC_FLAGS': '0x0', 17:29:34 INFO - 'XPC_SERVICE_NAME': '0', 17:29:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:29:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:29:34 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-KJAyCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:29:34 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)) 17:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:29:34 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-cKnmsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:29:34 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)) 17:29:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:29:34 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-Vi0IE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:29:35 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)) 17:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:29:35 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-ESr5vo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:29:35 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)) 17:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:29:35 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-aCK6KD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:29:35 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)) 17:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:29:35 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-DLvV2w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:29:35 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)) 17:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:29:35 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-c6pE6B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:29:35 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)) 17:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:29:35 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-UIw1gu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:29:35 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)) 17:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:29:35 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-ha5kyH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:29:35 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)) 17:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:29:35 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-NGvRbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:29:35 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)) 17:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:29:35 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-_Zp4IN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:29:35 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)) 17:29:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:29:35 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-5ov94A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:29:36 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)) 17:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:29:36 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-2E02B9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:29:36 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)) 17:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:29:36 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-lUWGsM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:29:36 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)) 17:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:29:36 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-WOUxwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:29:36 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)) 17:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:29:36 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-eahI6S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:29:36 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)) 17:29:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:29:36 INFO - Running setup.py (path:/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/pip-_hUwIS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:29:36 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)) 17:29:36 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)) 17:29:36 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)) 17:29:36 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)) 17:29:36 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)) 17:29:36 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)) 17:29:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:29:36 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 17:29:36 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 17:29:36 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 17:29:36 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 17:29:36 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 17:29:36 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 17:29:39 INFO - Downloading blessings-1.6.tar.gz 17:29:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:29:39 INFO - Installing collected packages: blessings 17:29:39 INFO - Running setup.py install for blessings 17:29:39 INFO - Successfully installed blessings 17:29:39 INFO - Cleaning up... 17:29:39 INFO - Return code: 0 17:29:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:29:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:29:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:29:39 INFO - Reading from file tmpfile_stdout 17:29:39 INFO - Current package versions: 17:29:39 INFO - blessings == 1.6 17:29:39 INFO - blobuploader == 1.2.4 17:29:39 INFO - docopt == 0.6.1 17:29:39 INFO - functools32 == 3.2.3-2 17:29:39 INFO - jsonschema == 2.5.1 17:29:39 INFO - manifestparser == 1.1 17:29:39 INFO - mozInstall == 1.12 17:29:39 INFO - mozcrash == 1.0 17:29:39 INFO - mozdebug == 0.1 17:29:39 INFO - mozdevice == 0.49 17:29:39 INFO - mozfile == 1.2 17:29:39 INFO - mozhttpd == 0.7 17:29:39 INFO - mozinfo == 0.9 17:29:39 INFO - mozleak == 0.1 17:29:39 INFO - mozlog == 3.4 17:29:39 INFO - moznetwork == 0.27 17:29:39 INFO - mozprocess == 0.25 17:29:39 INFO - mozprofile == 0.28 17:29:39 INFO - mozrunner == 6.13 17:29:39 INFO - mozscreenshot == 0.1 17:29:39 INFO - mozsystemmonitor == 0.3 17:29:39 INFO - moztest == 0.8 17:29:39 INFO - mozversion == 1.4 17:29:39 INFO - psutil == 3.1.1 17:29:39 INFO - requests == 1.2.3 17:29:39 INFO - wsgiref == 0.1.2 17:29:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:29:39 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')]} 17:29:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:39 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')]} 17:29:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:39 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 0x102d18b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d1b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f14eb050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102af6d30>, '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 0x102a1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102aebbe8>, '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.KfMhwnGMPF/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.RnsgGYn4wq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 17:29:39 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 17:29:39 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 17:29:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KfMhwnGMPF/Render', 17:29:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:29:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:29:39 INFO - 'HOME': '/Users/cltbld', 17:29:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:29:39 INFO - 'LOGNAME': 'cltbld', 17:29:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:39 INFO - 'MOZ_NO_REMOTE': '1', 17:29:39 INFO - 'NO_EM_RESTART': '1', 17:29:39 INFO - 'PAGER': '/bin/cat', 17:29:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:29:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:39 INFO - 'PWD': '/builds/slave/test', 17:29:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:29:39 INFO - 'SHELL': '/bin/bash', 17:29:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RnsgGYn4wq/Listeners', 17:29:39 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 17:29:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:29:39 INFO - 'USER': 'cltbld', 17:29:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:29:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:29:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:39 INFO - 'XPC_FLAGS': '0x0', 17:29:39 INFO - 'XPC_SERVICE_NAME': '0', 17:29:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:29:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:40 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)) 17:29:40 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)) 17:29:40 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)) 17:29:40 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)) 17:29:40 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)) 17:29:40 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)) 17:29:40 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)) 17:29:40 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)) 17:29:40 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)) 17:29:40 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)) 17:29:40 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)) 17:29:40 INFO - Cleaning up... 17:29:40 INFO - Return code: 0 17:29:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 17:29:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:29:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:29:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:29:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:29:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:29:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x102d18b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102d1b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f14eb050>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102af6d30>, '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 0x102a1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102aebbe8>, '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.KfMhwnGMPF/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.RnsgGYn4wq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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 17:29:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 17:29:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 17:29:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KfMhwnGMPF/Render', 17:29:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:29:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:29:40 INFO - 'HOME': '/Users/cltbld', 17:29:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:29:40 INFO - 'LOGNAME': 'cltbld', 17:29:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:29:40 INFO - 'MOZ_NO_REMOTE': '1', 17:29:40 INFO - 'NO_EM_RESTART': '1', 17:29:40 INFO - 'PAGER': '/bin/cat', 17:29:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:29:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:29:40 INFO - 'PWD': '/builds/slave/test', 17:29:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:29:40 INFO - 'SHELL': '/bin/bash', 17:29:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RnsgGYn4wq/Listeners', 17:29:40 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 17:29:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:29:40 INFO - 'USER': 'cltbld', 17:29:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:29:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:29:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:29:40 INFO - 'XPC_FLAGS': '0x0', 17:29:40 INFO - 'XPC_SERVICE_NAME': '0', 17:29:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:29:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:29:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 17:29:40 INFO - Cleaning up... 17:29:40 INFO - Return code: 0 17:29:40 INFO - Running post-action listener: _resource_record_post_action 17:29:40 INFO - Running post-action listener: _start_resource_monitoring 17:29:40 INFO - Starting resource monitoring. 17:29:40 INFO - [mozharness: 2017-03-08 01:29:40.322813Z] Finished create-virtualenv step (success) 17:29:40 INFO - [mozharness: 2017-03-08 01:29:40.323733Z] Running install step. 17:29:40 INFO - Running pre-action listener: _resource_record_pre_action 17:29:40 INFO - Running main action method: install 17:29:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:29:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:29:40 INFO - Reading from file tmpfile_stdout 17:29:40 INFO - Detecting whether we're running mozinstall >=1.0... 17:29:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:29:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:29:40 INFO - Reading from file tmpfile_stdout 17:29:40 INFO - Output received: 17:29:40 INFO - Usage: mozinstall [options] installer 17:29:40 INFO - Options: 17:29:40 INFO - -h, --help show this help message and exit 17:29:40 INFO - -d DEST, --destination=DEST 17:29:40 INFO - Directory to install application into. [default: 17:29:40 INFO - "/builds/slave/test"] 17:29:40 INFO - --app=APP Application being installed. [default: firefox] 17:29:40 INFO - mkdir: /builds/slave/test/build/application 17:29:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 17:29:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 17:30:00 INFO - Reading from file tmpfile_stdout 17:30:00 INFO - Output received: 17:30:00 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 17:30:00 INFO - Running post-action listener: _resource_record_post_action 17:30:00 INFO - [mozharness: 2017-03-08 01:30:00.896064Z] Finished install step (success) 17:30:00 INFO - [mozharness: 2017-03-08 01:30:00.896154Z] Running run-tests step. 17:30:00 INFO - Running pre-action listener: _resource_record_pre_action 17:30:00 INFO - Running main action method: run_tests 17:30:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:30:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:30:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:30:00 INFO - 2017-03-07 17:30:00.908 screenresolution[1624:7330] starting screenresolution argv=screenresolution get 17:30:00 INFO - 2017-03-07 17:30:00.910 screenresolution[1624:7330] Display 0: 1600x1200x32@60 17:30:00 INFO - 2017-03-07 17:30:00.915 screenresolution[1625:7333] starting screenresolution argv=screenresolution list 17:30:00 INFO - Available Modes on Display 0 17:30:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:30:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:30:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:30:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:30:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:30:01 INFO - Intel Iris: 17:30:01 INFO - Chipset Model: Intel Iris 17:30:01 INFO - Type: GPU 17:30:01 INFO - Bus: Built-In 17:30:01 INFO - VRAM (Dynamic, Max): 1536 MB 17:30:01 INFO - Vendor: Intel (0x8086) 17:30:01 INFO - Device ID: 0x0a2e 17:30:01 INFO - Revision ID: 0x0009 17:30:01 INFO - Displays: 17:30:01 INFO - Display: 17:30:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:30:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:30:01 INFO - Display Serial Number: 1600x1200 60 17:30:01 INFO - Main Display: Yes 17:30:01 INFO - Mirror: Off 17:30:01 INFO - Online: Yes 17:30:01 INFO - Rotation: Supported 17:30:01 INFO - Return code: 0 17:30:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:30:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:30:01 INFO - Python 2.7.3 17:30:01 INFO - Return code: 0 17:30:01 INFO - grabbing minidump binary from tooltool 17:30:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 17:30:01 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 0x102af6d30>, '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 0x102a1ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102aebbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:30:01 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 17:30:01 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 17:30:01 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 17:30:01 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:30:01 INFO - Return code: 0 17:30:01 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 17:30:01 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:30:01 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:30:01 INFO - ENV: RUST_BACKTRACE is now 1 17:30:01 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 17:30:01 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:30:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cZuJhUXmRee3oY-OaQ6_0g/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0007', '--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 17:30:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cZuJhUXmRee3oY-OaQ6_0g/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0007 --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 17:30:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KfMhwnGMPF/Render', 17:30:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 17:30:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 17:30:01 INFO - 'HOME': '/Users/cltbld', 17:30:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 17:30:01 INFO - 'LOGNAME': 'cltbld', 17:30:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:30:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 17:30:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:30:01 INFO - 'MOZ_NO_REMOTE': '1', 17:30:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:30:01 INFO - 'NO_EM_RESTART': '1', 17:30:01 INFO - 'PAGER': '/bin/cat', 17:30:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 17:30:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:30:01 INFO - 'PWD': '/builds/slave/test', 17:30:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:30:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 17:30:01 INFO - 'RUST_BACKTRACE': '1', 17:30:01 INFO - 'SHELL': '/bin/bash', 17:30:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.RnsgGYn4wq/Listeners', 17:30:01 INFO - 'TMPDIR': '/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/', 17:30:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 17:30:01 INFO - 'USER': 'cltbld', 17:30:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 17:30:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 17:30:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:30:01 INFO - 'XPC_FLAGS': '0x0', 17:30:01 INFO - 'XPC_SERVICE_NAME': '0', 17:30:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 17:30:01 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cZuJhUXmRee3oY-OaQ6_0g/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0007', '--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 17:30:01 INFO - mozversion application_buildid: 20170307162823 17:30:01 INFO - mozversion application_changeset: dd92d0734a266dab534af530c8ae35670aedd282 17:30:01 INFO - mozversion application_display_name: Nightly 17:30:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:30:01 INFO - mozversion application_name: Firefox 17:30:01 INFO - mozversion application_remotingname: firefox 17:30:01 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 17:30:01 INFO - mozversion application_vendor: Mozilla 17:30:01 INFO - mozversion application_version: 55.0a1 17:30:01 INFO - mozversion platform_buildid: 20170307162823 17:30:01 INFO - mozversion platform_changeset: dd92d0734a266dab534af530c8ae35670aedd282 17:30:01 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 17:30:01 INFO - mozversion platform_version: 55.0a1 17:30:01 INFO - using testdate: 1488936601 17:30:01 INFO - actual date: 1488936601 17:30:01 INFO - starting webserver on 'localhost:49243' 17:30:01 INFO - SUITE-START | Running 2 tests 17:30:01 INFO - TEST-START | dromaeo_css 17:30:01 INFO - operating with platform_type : mac_ 17:30:01 INFO - Initialising browser for dromaeo_css test... 17:30:01 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpC8HgPR/profile http://localhost:49243/getInfo.html) 17:30:04 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 17:30:04 INFO - PROCESS | 1635 | colorDepth:24 17:30:04 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 17:30:04 INFO - PROCESS | 1635 | __metrics 17:30:04 INFO - PROCESS | 1635 | 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" 17:30:04 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:30:05 INFO - TEST-INFO | 1635: exit 0 17:30:05 INFO - Browser initialized. 17:30:05 INFO - Running cycle 1/1 for dromaeo_css test... 17:30:05 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpC8HgPR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:30:17 INFO - PROCESS | 1638 | RSS: Main: 231968768 17:30:17 INFO - PROCESS | 1638 | 17:33:21 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 17:33:24 INFO - PROCESS | 1638 | RSS: Main: 396238848 17:33:24 INFO - PROCESS | 1638 | 17:35:07 INFO - PROCESS | 1638 | ************************* 17:35:07 INFO - PROCESS | 1638 | A coding exception was thrown and uncaught in a Task. 17:35:07 INFO - PROCESS | 1638 | 17:35:07 ERROR - PROCESS | 1638 | Full message: TypeError: NetworkError when attempting to fetch resource. 17:35:07 INFO - PROCESS | 1638 | Full stack: 17:35:07 INFO - PROCESS | 1638 | ************************* 17:36:28 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 17:36:28 INFO - PROCESS | 1638 | RSS: Main: 368177152 17:36:28 INFO - PROCESS | 1638 | 17:39:31 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 17:39:31 INFO - PROCESS | 1638 | RSS: Main: 346836992 17:39:31 INFO - PROCESS | 1638 | 17:42:34 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 17:42:34 INFO - PROCESS | 1638 | RSS: Main: 339947520 17:42:34 INFO - PROCESS | 1638 | 17:45:38 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 17:45:39 INFO - PROCESS | 1638 | RSS: Main: 337666048 17:45:39 INFO - PROCESS | 1638 | 17:48:42 INFO - PROCESS | 1638 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 17:48:43 INFO - PROCESS | 1638 | RSS: Main: 600641536 17:48:43 INFO - PROCESS | 1638 | 17:48:43 INFO - PROCESS | 1638 | __start_tp_report 17:48:43 INFO - PROCESS | 1638 | _x_x_mozilla_page_load 17:48:43 INFO - PROCESS | 1638 | _x_x_mozilla_page_load_details 17:48:43 INFO - PROCESS | 1638 | |i|pagename|runs| 17:48:43 INFO - PROCESS | 1638 | |0;dojo.html;3338.582677165354;3358.798472091676;3368.595768507779;3376.662333766622;3429.6570342965692;5686.346070201928;5757.568182386317;5783.710814459276;5868.64788112713;5897.616654917428;5794.0729483282685;5872;5879.353271140171;5898.911516327258;5947.018741907591;4347.41309923161;5227.2159176123505;5309.8938021239555;5321.8403447896435;5324.307839980797;4428.623566996793;5361.490658387447;5411.512963833255;5428.4300148484435;5482.205080263379;5173.198154286091;5205.895882082337;5281.498257665516;5287.947120528823;5374.811881584145;5274;5287.656302340336;5289.418164001957;5291.444398338196;5300.893982120336;5179.48205179479;5216.113260745645;5239.764210610531;5242.056429842627;5245.26566280721;5737.827865164052;5742.569307301927;5747.885042299131;5755.510781583571;5758.625689330222;6268.811935641938;6273.811785646438;6292.370762923717;6292.968535157295;6296.1500197473215;5243.554297884684;6210.1616281801835;6268.623882567015;6332.1135041094285;6345.175127233476;6094.299155597075;6098.32918378978;6102.21659592427;6103.664298463583;6142.692865356715;6344.49244060474;6387.265464471645;6398.104265402847;6400.519961002943;6411.647359395185;6138.848241798344;6163.722632481549;6180.845478863064;6365.61806291624;6378.330275321117;6298.7480500780375;6318.462930650946;6332.936670633327;6351.333110023474;6358.300586935434;6213.937860621426;6346.555741098171;6375.681215939185;6376.84057898547;6389.712462939179;6140.412224875342;6325.620462772248;6379.71291291893;6387.329330420332;6387.361263873669;4978.925316120261;5051.621128415383;5054.848354549369;5063.949360506422;5093.490650934951;4545.36364908913;4551.499335073139;4587.3807036050375;4593.219152744042;4598.149342371605;5797.246357973437;5798.10129429939;5800.4199580042505;5800.4489573490455;5802.65184088956;5768.875069361434;6230.719617617218;6326.5255105867245;6328.367163283727;6332.271788744261;4440.911181776346;5332.813351532755;5753.367129615739;5785.595008349375;5804.680742559115;5621.0444224481935;5626.859328516738;5636.718164091779;5640.097584386478;5658.85852853682;6429.903551446639;6471.611703297817;6473.255575608771;6476.579022363437;6488.805335839932;6230.376962303733;6276.968615156895;6327.651979141191;6334.714937827901;6339;6307.842303942438;6309.684515774285;6314.715837787218;6320.304766475776;6322.114903913548;5999.820005399845;6198.442140207403;6210.285817130907;6257.186565746424;6287.622742635456;5772.9711351442975;6309.3690630936535;6322.968385158045;6329.525285603506;6334.809955701337;6170.598911070945;6306.621602703853;6318.241810982711;6322.0516922462;6344.555881088279;5849.678267695318;6095.1466794647895;6139.492138333381;6299.716512757029;6322.905156422749;5994.550408719277;6011.158437818796;6014.669193194416;6015.909761353496;6016.699165041818;5761.48146666802;6134.957077261001;6136.978641397139;6281.842953926006;6301.149344838388;5138.486151384981;6153.169322141453;6154.692265386802;6158.32258451561;6168.19813424252 17:48:43 INFO - PROCESS | 1638 | |1;ext.html;778.3189709004621;869.1482347299644;877.9692710755124;880.8326417980584;881.7927786970057;28720.28199295016;29155.562666559992;29205.707942920566;29237.415251695005;40601.59398406022;34855.651443485556;40377.59622403775;41521.16957660845;41603.58396416035;41653;9196.448213107218;9345.579448924815;9357.532123393838;9364.578593963253;9400.952995235015;7304.48868579197;7503.699852005913;9151.176394124528;9297.023812499692;9307.115823996743;7470.738524151656;7528.849423011537;9152.359334846564;11151.665450036471;11329.150313726463;11056.11551075912;11141;11142.052925501343;11143.331400115978;11164.385958772264;10863;10925.016748492673;10933.726656833564;10942.835857462145;10970.670879873616;24481.510369792504;27326.5901011485;28485.72714092882;28488.86044558215;38769.61230387716;3192.808431494118;3781.829817658212;3816.2939856126704;3830.4445855351096;3983.541892682321;28061.298467538272;28345.149645510668;28602;28979.710202897913;29216.707832921824;2984.5985146787575;3072.0937323489625;3173.698498642625;3189.872405103793;3194.744420446382;322187;322584;322591.74082591786;324187.75812242046;324204.37897810596;42640.29438822474;50559;51066.744666277176;51068;51108.74445627748;52898.73550632299;53017;53067.46932530625;53114.734426327625;53301.46698533043;13643.249621270726;13797.965152613595;13815.930920345334;13828.446862125402;13852.238126902916;11744.823827642593;11750.647480575597;11759.706007349714;11764.470598823074;11769;11760.88239117615;12034.277943323254;12401.25592464455;12505.687357816127;12594.055445841599;4819.3012013258585;5601.691906945076;5604.955540013939;5607.495325420732;5628.465295796893;826.7809030606894;847.7244895409017;854.7563944275852;870.2288563131299;886.7073865624458;23026.769732302797;25120;26633.600495992574;26740.46519069608;26856.462870742474;941.7833898203452;960.4525420510382;969.4328817641758;975.6536429567543;978.7748817771952;12719.918806901516;13145.60563183106;13431.529896453578;13807.723845523033;13849.792253116211;403222;403553;405103.9744801257;406162;406729;55526.444735552126;55558.444415556136;55581.72209138928;55599;55599.166012509035;1362.087401441037;1430.592281199853;1438.079629037417;1438.4174409364225;1441.3369849868968;24068.51862962766;25171.74828251694;26295.342616434744;26304.210873673055;26407.735922640528;46018.76990615026;46027.3095903555;46176;46244.76877615591;46342;374949;376909;377503;377509;378200;32699.509507357885;33286.83356583298;33298.33403331968;33424;33456;41291.1741765169;41953.580464194965;42453;42685.35971960485;42713.359299611155;26940.595891062043;27535.31161720973;28968.275793105342;34153.48769768406;34888.825555872056;29565.26086847846;33042.17394565059;34000;34138.14654633654;35134.472982904765;33941;35481.75813846503;35834.28331433409;35844.820775895954;35958.28083438264;27554.724452755217;29402.558961615166;31476.842615786776;31481.527777083822;31661.8416907914;23481.530369392858;23748.45219328524;23931.803409829092;23959.04163833427;24076.87961560181 17:48:43 INFO - PROCESS | 1638 | |2;jquery.html;378.1472778883617;393.1704104339842;411.59252340183207;418.38079642129645;442.1532764755493;11694.239874408167;20389.2863749769;20554.075066622;21179.894100529513;21249.15003399866;21106;21474.785252147474;21733.891330543363;22009.33971980839;22315;6071.696415179245;6228.813135605939;6348.619082855021;6521.315261897504;6600.570962887421;6460.192475940507;6485.254195767477;6536.60780353178;6554.80335589933;6581.506387020969;6556.737730490775;6557.3442655734525;7183.42532597391;7492.887606685904;7634.809129771745;6444.77549265638;7105.573665580082;7617.733379331725;7692.115406728214;7705.267999540035;7499.275166711687;7510.474266801326;7511.474196806225;7522.13495448025;7551.69793208271;28674.713252867412;29122.70877291221;29855.552166717516;29906.40187196244;30239.941602043822;2807.508685979966;2810.8172968756967;2864.212341606054;2864.3125649844096;2865.2693563141474;15756.76364854528;16480.587985300463;16515.33938642453;16705.828242328542;17223.052732099728;1886.4340697790608;2016.7176595276674;2037.9796202037937;2053.9589208215752;2070.2029718558465;134810;141323;142695.28652356775;142844.28577857045;146696;16513.504594862174;22820.74485903258;22965.54068918646;23376;23443.648345274836;40092.596759113876;40694.79652601777;40963.7951810239;40978;41008.97477563025;8519.616617252239;10664.573417063231;10700.411477368663;10917;10938.890611093946;8420.600128963217;8430.620622072021;8449.873251901226;8612.397132200686;8622.26710729595;9157.313201509913;10771.676849694522;11009.559617615367;11115.166362522843;11155.705053554278;3864.401017842239;4372.912541749147;4392.231359512072;4504.729716217037;4521.547845215452;842.372432537751;852.4416507187802;854.3293514591016;903.6701603914655;907.3467103685336;19515.902420487808;20579;21100.683489747666;21314.78685213159;21367.78632213658;886.2466903132286;903.8689390038408;905.6422713028317;918.8851393575803;921.5162039928957;10030.498475076363;10966.451677416097;10999.505022274017;11036.896310368898;11125.888741112485;469514;703782.4810875913;719278;720783.9608019578;721784;145835.2708236452;152697.23651381893;154959;158928;164886;1257.4278703190027;1294.0876681939399;1297.7469393468184;1319.7096638739463;1324.6224825924564;14828.481003165269;19281.61436771285;19282.107683847535;19512.9024354883;19599.80400196037;61899.38100618936;62206.114212619046;62329.688351557954;62585.68707156435;64108.35891641024;88199.11800882166;88907.55546222227;90536.64195037211;90726;92351.53824230836;11169.72075698114;11215.775684486101;11669.76660466803;11672.70818229551;11729.589464368706;12371.13402061847;12619.116661833583;12700.301483418501;12722.872771272168;12805.118848259068;10315.432651203955;10544.947275263574;10574.629887954192;10627.36235825853;10669.986351296615;8171.55056471876;10522.684319470429;10539.578416863545;10930.45347732626;11002.394868282321;10726.356418614909;10733.516991735547;10833.349999000086;10874.130069594255;11017;10661.413622250851;10963.671089867317;10998.615048473264;11342.773144537228;11473;8888;10232.53953572106;10486.108680762221;10665.89334106649;10731.89268107309 17:48:43 INFO - PROCESS | 1638 | |3;mootools.html;1533.4479587348553;1534.1102160746768;1553.3864123671144;1565.5146904459614;1565.8590726834586;9110;10165.796684066314;10701.090407315378;10705.090067344265;10710.196735244848;10176.236782241325;10555;10605.78788424231;10651.946740266307;10654.200934929891;2270.3075561953597;2312.7571604981486;2313.4910319729634;2314.8032417244553;2317.8377513574055;2267.7505474397803;2307.48081681622;2309.861408315498;2312.5721741477796;2315.733690625574;2259.0963614554144;2277.851939623919;2283.7602051784575;2287.9199228027023;2288.5766133265315;2179.934601961944;2195.5279614882797;2201.1635578480077;2201.768814274494;2206.150632006673;2214.55708858229;2281.1673739085113;2284.0635339510886;2285.3486756274383;2288.2677543186187;10613.681589552325;10658.786824263549;10673.573057077707;10680.35917844924;10687.786244275148;5431.83704488866;5605.215269862222;5606.775728970836;5607.887842243133;5615.382307946123;3255.641879393265;3349.4138525757894;3562.2163124112653;3565.5899571549344;3566.1797786509246;1166.8716441191461;1209.1656756837754;1754.736789481588;1785.3305010621018;1863.850891928656;12817.423215955305;14398.85601143996;14548.563543093724;14695.77956330656;14751.336189871481;4499.752513611717;4595.40259766235;4616.976915115403;4624.329472226508;4635.3278774578175;11188.888111118948;11206.663800086011;11229.494672739746;11233.382163980896;11235;5556.111022236423;5556.277683901148;5558.194061861008;5558.749856256478;5564.527015203753;4973.32860063894;5072.213806859869;5089;5147.510986456281;5159.638825282194;3565.4651802229873;3702.648248416396;3718.8326525305883;3759.3045286622064;3794;910.961503885571;981.5043403081398;1013.8124446977333;1017.623479312659;1026.3226270661328;883.7525492862009;899.6401439424152;914.2046419614977;946.4205446363734;958.990410095904;6256.843578910563;6383.521235907326;6590.80227593173;6742.797716068526;6770.815107356193;956.799072194833;988.3378136648463;991.8395477291587;1020.3928662445833;1033.1373303291684;3733.34132550097;4023.5372932113182;4081.918361632751;4275.40144379787;4339.435873336446;11653.30080195191;12306.323152226714;12729.172603780724;12893.161944473766;13134.540291089957;12686.365681715877;12812.55156069533;12980.221186728826;12998.480060797652;13041.608751737464;7883.7240696575345;8298.170182981774;8460.492370457792;9498;9739.805203896025;6204.751809927733;6236;6386.265579458236;6461.38616831419;6500.544961852814;11536.538538458368;11750.70623234426;11890.881091189323;11901.523939042341;12009.459574319351;9980.8023037236;12067.517299307929;12197.939010304892;12248.203866748632;12253.509859605516;7637.427192960439;7659.731909383145;7952.165022672536;8303;8322.250997410261;8298.419110662197;9862.753431164278;9873.506324683593;9932.900670993198;9937.65218217359;8662.566871656267;8742.213200811957;8812.647494100163;8954.820903581762;8959.820803584022;8478.788030299045;8569.742907712778;8627.91372086271;8691.782705432162;8692.391532592657;7576.469647124648;7658.6170691464085;7682.8079298018;7752.7674169775;7756.224377562198;5761.366249712612;5886.58793884424;5902.321233058254;5974.2233509643465;5997.790077347272;5924.911126333194;5929.851753706192;5941.851453713692;5946.345901950695;6010.879782404415 17:48:43 INFO - PROCESS | 1638 | |4;prototype.html;366.7084667689187;366.96146904575016;367.11891460494826;374.3598446656216;378.93179227739006;4999.425066117397;5003.399592048954;5229.686218826873;5236.895262094756;5280.4983526564965;4151.937720934188;4326.653867690585;4589.678722489427;4731.90536189276;5075.670081444703;3948.8420463181437;4064.979675101628;4111.794410279489;4229.788510574459;4259.957400425987;4233.375307309472;4246.299360605496;4246.936295955563;4288.185244803493;4348.977990172307;4257.616814486695;4258.893527661802;4301.569843015689;4311.676624253178;4316.223079845627;4089.3457046872504;4177.248095342837;4207.221663992156;4216.47294088239;4272.658187345005;3264.9388948591804;3455.6026057003514;3513.8945831624837;3698.4822124902535;3758.1919887224103;4433.667474939392;4504.121696269229;4625.491195968474;4966.726830024347;5016.372953380827;4545.999880026389;4634.930476042862;4662.94830274678;4679.245283018868;4871.512848715136;4932.383452068491;5159.529534082806;5332.546733527654;5421.322334708161;5484.945150548483;4372.5627437256335;4378.321360189176;4378.934315985231;4390.429244198266;4396.450443694538;4755.833545825914;4852.805887764485;5248.3701955765555;5451.291332126798;5854.813808127209;3908.609139086069;4392.978035109804;4410.757408342572;4421.756803375781;4423.270160423494;3880.5343358797127;3893.065664240562;4432.623227025674;4448.221561226773;4523.457185137739;4324.875532361546;4400.625946794495;4823.445303790109;4874.8781280467565;4897.188040425065;4710.3405523226775;4967.5032496750755;5458.890822183614;5465.125579907196;5534.612577119644;1376.105531404575;1417.6172433442912;1458.1469840143634;1516.052467207995;1537.9769303460457;1003.7490627343165;1029.7528593137592;1082.6373164989816;1097.550004498168;1163.836163836164;4465;4569.383133277031;4837.927431088537;5148.253503242009;5211.635185537052;4877.634347341536;5142.485751424902;5178.896422071537;5182.331099483769;5761.711914404347;4190.497140343117;4264.87205383839;4653.952860606337;5066.301599832143;5179.896402072013;2655.907043253477;2718.497078040569;2920.2845302900923;2932.255308091682;2951.719586639266;5071.847844564669;5490.835274941758;5823.359430462646;5853.560982926298;5872.530197584183;4718.433787945469;5015.473375295542;5508.889822203533;5686.772529098873;5810.50610698087;4599.609033232079;4868.079152508467;4943.060818444484;5334.146536554133;5883.823485295534;4644.744539050384;5501.669899806025;5635.9009993052605;5679.5172410345585;5702.543796496353;4573.428321459817;5194.337811900155;5419.891602168013;5578.581606379619;5652.63257888236;4637.078640456491;5864.853378665567;5867.442592953663;5867.882642347044;5871.530277577869;4128.616913333946;4168.458100446923;4209.852655157055;4364.9524114213;4476.865694029184;4893.510648935078;5038.622103342191;5303.655262407931;5491.572191230229;5731.942680573307;4323.329883868006;4561.25629345477;5208.374995000624;5516.9448305518035;5521.475459831309;5062.924056139234;5519.199716041232;5520.475554822286;5534.91697624544;5537.640053396677;4528.728276303433;5011.523905228997;5348.769782949866;5386.48828361305;5414.187871819258;4592.770361481846;4897.167481528078;4902.779374928065;5143.3570803649545;5505.889882202254;4724.362211101457;5143.125668636266;5199.480051994921;5377.650452720561;5419.810306639249 17:48:43 INFO - PROCESS | 1638 | |5;yui.html;718.6406796601699;725.5465334166146;755.2824816424395;824.5588610093599;884.4648987362646;14824.703505929889;15519;15845.366185352586;15855.286512106954;15865.524034278962;13881.583552493415;14434.5669629911;14618.195999220039;14645.560633181021;14650.853491465083;945.8723072385209;957.9185769209626;976.3702411944328;979.2998006425404;981.813455443467;957.3537861943161;973.8149751547219;974.5614473486924;976.9853452198223;977.8630991661173;1031.587365053977;1033.1270076785104;1033.1837848100029;1033.188946676859;1036.9014943580348;1026.6098882424706;1027.1012863744224;1027.2757705817419;1027.5941003303728;1027.9383237005804;761.4137114421919;762.9923700762977;763.6220071064803;765.2729906588763;767.2021098058013;15565.066096034274;15826.129562874037;15980.200989950456;16096;16271;13627.931860340635;13665.18008919468;13766.24285664288;13797;13915.23466209358;11633.592824251195;11729.4135293235;11833.171677982544;11867.169298149132;12124;3443.8794642187654;3526.8236588170744;3544.3620148373284;3638.6907112895437;3645.580758212813;94723;100589.98820023632;104758;106547.46726266397;110112;10544.209184311054;10592.117725645861;10595;10601.787964240671;11046.057573209955;18647.906760466383;22339.776602234095;22525.098996040302;22609.208677696202;23102.65346019811;7583.62081895903;7699.846003079907;7817.374610031184;7944.960275198702;8074.394420418492;4133.759698569717;4162.708610397303;4190.434401053115;4214.4099826024385;4219.3249080147025;3477.0611934777467;3538.5046093546925;3582.2119133791048;3582.964170358315;3586.246888153517;633.3349982518338;640.5836206465834;644.5939058393183;646.0825627608807;654.5516321319911;665.1685393258427;672.3612568060264;689.4725534965755;697.5291678117251;707.2432497227917;8710.956445217733;9080.954595226982;9541.856872146924;10050.74873128163;10111.292209545261;650.8340373204802;652.5464801962685;687.3229868579546;687.9312068793181;703.4759104467205;4829.9034019319415;4840.564349208517;4852.296417019513;4859.781309841065;4898.559129678346;103313.96686033043;103477.48261258796;104062;105414.89170216552;107291.46354268178;59460;87258.56370718233;88377;89934;91151.63272550917;77681.61159194168;78934;79361.60319198483;80238;81284.68437840504;7406.888896666662;8099.797505062421;9409.576569054272;9510.619575216913;9533.067141226345;47390.28914566353;48086.519134809605;52118;53082.73458632682;53627.19559206693;64321.35678643341;66025.66987165033;66902;67168.99246511208;67843.66078169577;11418.657440276806;11664.6500604982;11699.766004680028;11760.764784704086;11761.88238117608;12400.689982750504;12620;12709;12921.202436831893;12951.158174718614;11400.48697808584;11577.710557236136;11704.94147529257;11930;12272.75454490923;11470.483828227583;11556.306621602731;11558.017568506772;11673.35796531165;11942.940285298519;11618.915338051838;11672.591459298883;11796.351200684045;12220.144589878622;12423.75152496927;8066.435349525477;9819.214462843098;9832.705018849447;9853.901460985298;10814.45927703596;7706.451275356344;8504.927907912943;9175.28400997597;9794.804103918024;9872.40765554069 17:48:43 INFO - PROCESS | 1638 | __end_tp_report 17:48:43 INFO - PROCESS | 1638 | __start_cc_report 17:48:43 INFO - PROCESS | 1638 | _x_x_mozilla_cycle_collect,3063 17:48:43 INFO - PROCESS | 1638 | __end_cc_report 17:48:43 INFO - PROCESS | 1638 | __startTimestamp1488937723024__endTimestamp 17:48:43 INFO - PROCESS | 1638 | 17:48:43 INFO - PROCESS | 1638 | ------- Summary: start ------- 17:48:43 INFO - PROCESS | 1638 | Number of tests: 6 17:48:43 INFO - PROCESS | 1638 | 17:48:43 INFO - PROCESS | 1638 | [#0] dojo.html Cycles:165 Average:5809.17 Median:6094.30 stddev:670.32 (11.0%) stddev-sans-first:643.74 17:48:43 INFO - PROCESS | 1638 | Values: 3338.6 3358.8 3368.6 3376.7 3429.7 5686.3 5757.6 5783.7 5868.6 5897.6 5794.1 5872.0 5879.4 5898.9 5947.0 4347.4 5227.2 5309.9 5321.8 5324.3 4428.6 5361.5 5411.5 5428.4 5482.2 5173.2 5205.9 5281.5 5287.9 5374.8 5274.0 5287.7 5289.4 5291.4 5300.9 5179.5 5216.1 5239.8 5242.1 5245.3 5737.8 5742.6 5747.9 5755.5 5758.6 6268.8 6273.8 6292.4 6293.0 6296.2 5243.6 6210.2 6268.6 6332.1 6345.2 6094.3 6098.3 6102.2 6103.7 6142.7 6344.5 6387.3 6398.1 6400.5 6411.6 6138.8 6163.7 6180.8 6365.6 6378.3 6298.7 6318.5 6332.9 6351.3 6358.3 6213.9 6346.6 6375.7 6376.8 6389.7 6140.4 6325.6 6379.7 6387.3 6387.4 4978.9 5051.6 5054.8 5063.9 5093.5 4545.4 4551.5 4587.4 4593.2 4598.1 5797.2 5798.1 5800.4 5800.4 5802.7 5768.9 6230.7 6326.5 6328.4 6332.3 4440.9 5332.8 5753.4 5785.6 5804.7 5621.0 5626.9 5636.7 5640.1 5658.9 6429.9 6471.6 6473.3 6476.6 6488.8 6230.4 6277.0 6327.7 6334.7 6339.0 6307.8 6309.7 6314.7 6320.3 6322.1 5999.8 6198.4 6210.3 6257.2 6287.6 5773.0 6309.4 6323.0 6329.5 6334.8 6170.6 6306.6 6318.2 6322.1 6344.6 5849.7 6095.1 6139.5 6299.7 6322.9 5994.6 6011.2 6014.7 6015.9 6016.7 5761.5 6135.0 6137.0 6281.8 6301.1 5138.5 6153.2 6154.7 6158.3 6168.2 17:48:43 INFO - PROCESS | 1638 | 17:48:43 INFO - PROCESS | 1638 | [#1] ext.html Cycles:180 Average:50988.89 Median:33698.50 stddev:97736.28 (290.0%) stddev-sans-first:97937.75 17:48:43 INFO - PROCESS | 1638 | Values: 778.3 869.1 878.0 880.8 881.8 28720.3 29155.6 29205.7 29237.4 40601.6 34855.7 40377.6 41521.2 41603.6 41653.0 9196.4 9345.6 9357.5 9364.6 9401.0 7304.5 7503.7 9151.2 9297.0 9307.1 7470.7 7528.8 9152.4 11151.7 11329.2 11056.1 11141.0 11142.1 11143.3 11164.4 10863.0 10925.0 10933.7 10942.8 10970.7 24481.5 27326.6 28485.7 28488.9 38769.6 3192.8 3781.8 3816.3 3830.4 3983.5 28061.3 28345.1 28602.0 28979.7 29216.7 2984.6 3072.1 3173.7 3189.9 3194.7 322187.0 322584.0 322591.7 324187.8 324204.4 42640.3 50559.0 51066.7 51068.0 51108.7 52898.7 53017.0 53067.5 53114.7 53301.5 13643.2 13798.0 13815.9 13828.4 13852.2 11744.8 11750.6 11759.7 11764.5 11769.0 11760.9 12034.3 12401.3 12505.7 12594.1 4819.3 5601.7 5605.0 5607.5 5628.5 826.8 847.7 854.8 870.2 886.7 23026.8 25120.0 26633.6 26740.5 26856.5 941.8 960.5 969.4 975.7 978.8 12719.9 13145.6 13431.5 13807.7 13849.8 403222.0 403553.0 405104.0 406162.0 406729.0 55526.4 55558.4 55581.7 55599.0 55599.2 1362.1 1430.6 1438.1 1438.4 1441.3 24068.5 25171.7 26295.3 26304.2 26407.7 46018.8 46027.3 46176.0 46244.8 46342.0 374949.0 376909.0 377503.0 377509.0 378200.0 32699.5 33286.8 33298.3 33424.0 33456.0 41291.2 41953.6 42453.0 42685.4 42713.4 26940.6 27535.3 28968.3 34153.5 34888.8 29565.3 33042.2 34000.0 34138.1 35134.5 33941.0 35481.8 35834.3 35844.8 35958.3 27554.7 29402.6 31476.8 31481.5 31661.8 23481.5 23748.5 23931.8 23959.0 24076.9 17:48:43 INFO - PROCESS | 1638 | 17:48:43 INFO - PROCESS | 1638 | [#2] jquery.html Cycles:180 Average:40846.02 Median:22162.17 stddev:113041.60 (510.1%) stddev-sans-first:113317.87 17:48:43 INFO - PROCESS | 1638 | Values: 378.1 393.2 411.6 418.4 442.2 11694.2 20389.3 20554.1 21179.9 21249.2 21106.0 21474.8 21733.9 22009.3 22315.0 6071.7 6228.8 6348.6 6521.3 6600.6 6460.2 6485.3 6536.6 6554.8 6581.5 6556.7 6557.3 7183.4 7492.9 7634.8 6444.8 7105.6 7617.7 7692.1 7705.3 7499.3 7510.5 7511.5 7522.1 7551.7 28674.7 29122.7 29855.6 29906.4 30239.9 2807.5 2810.8 2864.2 2864.3 2865.3 15756.8 16480.6 16515.3 16705.8 17223.1 1886.4 2016.7 2038.0 2054.0 2070.2 134810.0 141323.0 142695.3 142844.3 146696.0 16513.5 22820.7 22965.5 23376.0 23443.6 40092.6 40694.8 40963.8 40978.0 41009.0 8519.6 10664.6 10700.4 10917.0 10938.9 8420.6 8430.6 8449.9 8612.4 8622.3 9157.3 10771.7 11009.6 11115.2 11155.7 3864.4 4372.9 4392.2 4504.7 4521.5 842.4 852.4 854.3 903.7 907.3 19515.9 20579.0 21100.7 21314.8 21367.8 886.2 903.9 905.6 918.9 921.5 10030.5 10966.5 10999.5 11036.9 11125.9 469514.0 703782.5 719278.0 720784.0 721784.0 145835.3 152697.2 154959.0 158928.0 164886.0 1257.4 1294.1 1297.7 1319.7 1324.6 14828.5 19281.6 19282.1 19512.9 19599.8 61899.4 62206.1 62329.7 62585.7 64108.4 88199.1 88907.6 90536.6 90726.0 92351.5 11169.7 11215.8 11669.8 11672.7 11729.6 12371.1 12619.1 12700.3 12722.9 12805.1 10315.4 10544.9 10574.6 10627.4 10670.0 8171.6 10522.7 10539.6 10930.5 11002.4 10726.4 10733.5 10833.3 10874.1 11017.0 10661.4 10963.7 10998.6 11342.8 11473.0 8888.0 10232.5 10486.1 10665.9 10731.9 17:48:43 INFO - PROCESS | 1638 | 17:48:43 INFO - PROCESS | 1638 | [#3] mootools.html Cycles:180 Average:6433.55 Median:3726.09 stddev:3939.92 (105.7%) stddev-sans-first:3933.77 17:48:43 INFO - PROCESS | 1638 | Values: 1533.4 1534.1 1553.4 1565.5 1565.9 9110.0 10165.8 10701.1 10705.1 10710.2 10176.2 10555.0 10605.8 10651.9 10654.2 2270.3 2312.8 2313.5 2314.8 2317.8 2267.8 2307.5 2309.9 2312.6 2315.7 2259.1 2277.9 2283.8 2287.9 2288.6 2179.9 2195.5 2201.2 2201.8 2206.2 2214.6 2281.2 2284.1 2285.3 2288.3 10613.7 10658.8 10673.6 10680.4 10687.8 5431.8 5605.2 5606.8 5607.9 5615.4 3255.6 3349.4 3562.2 3565.6 3566.2 1166.9 1209.2 1754.7 1785.3 1863.9 12817.4 14398.9 14548.6 14695.8 14751.3 4499.8 4595.4 4617.0 4624.3 4635.3 11188.9 11206.7 11229.5 11233.4 11235.0 5556.1 5556.3 5558.2 5558.7 5564.5 4973.3 5072.2 5089.0 5147.5 5159.6 3565.5 3702.6 3718.8 3759.3 3794.0 911.0 981.5 1013.8 1017.6 1026.3 883.8 899.6 914.2 946.4 959.0 6256.8 6383.5 6590.8 6742.8 6770.8 956.8 988.3 991.8 1020.4 1033.1 3733.3 4023.5 4081.9 4275.4 4339.4 11653.3 12306.3 12729.2 12893.2 13134.5 12686.4 12812.6 12980.2 12998.5 13041.6 7883.7 8298.2 8460.5 9498.0 9739.8 6204.8 6236.0 6386.3 6461.4 6500.5 11536.5 11750.7 11890.9 11901.5 12009.5 9980.8 12067.5 12197.9 12248.2 12253.5 7637.4 7659.7 7952.2 8303.0 8322.3 8298.4 9862.8 9873.5 9932.9 9937.7 8662.6 8742.2 8812.6 8954.8 8959.8 8478.8 8569.7 8627.9 8691.8 8692.4 7576.5 7658.6 7682.8 7752.8 7756.2 5761.4 5886.6 5902.3 5974.2 5997.8 5924.9 5929.9 5941.9 5946.3 6010.9 17:48:43 INFO - PROCESS | 1638 | 17:48:43 INFO - PROCESS | 1638 | [#4] prototype.html Cycles:180 Average:4475.44 Median:4714.39 stddev:1248.77 (26.5%) stddev-sans-first:1213.60 17:48:43 INFO - PROCESS | 1638 | Values: 366.7 367.0 367.1 374.4 378.9 4999.4 5003.4 5229.7 5236.9 5280.5 4151.9 4326.7 4589.7 4731.9 5075.7 3948.8 4065.0 4111.8 4229.8 4260.0 4233.4 4246.3 4246.9 4288.2 4349.0 4257.6 4258.9 4301.6 4311.7 4316.2 4089.3 4177.2 4207.2 4216.5 4272.7 3264.9 3455.6 3513.9 3698.5 3758.2 4433.7 4504.1 4625.5 4966.7 5016.4 4546.0 4634.9 4662.9 4679.2 4871.5 4932.4 5159.5 5332.5 5421.3 5484.9 4372.6 4378.3 4378.9 4390.4 4396.5 4755.8 4852.8 5248.4 5451.3 5854.8 3908.6 4393.0 4410.8 4421.8 4423.3 3880.5 3893.1 4432.6 4448.2 4523.5 4324.9 4400.6 4823.4 4874.9 4897.2 4710.3 4967.5 5458.9 5465.1 5534.6 1376.1 1417.6 1458.1 1516.1 1538.0 1003.7 1029.8 1082.6 1097.6 1163.8 4465.0 4569.4 4837.9 5148.3 5211.6 4877.6 5142.5 5178.9 5182.3 5761.7 4190.5 4264.9 4654.0 5066.3 5179.9 2655.9 2718.5 2920.3 2932.3 2951.7 5071.8 5490.8 5823.4 5853.6 5872.5 4718.4 5015.5 5508.9 5686.8 5810.5 4599.6 4868.1 4943.1 5334.1 5883.8 4644.7 5501.7 5635.9 5679.5 5702.5 4573.4 5194.3 5419.9 5578.6 5652.6 4637.1 5864.9 5867.4 5867.9 5871.5 4128.6 4168.5 4209.9 4365.0 4476.9 4893.5 5038.6 5303.7 5491.6 5731.9 4323.3 4561.3 5208.4 5516.9 5521.5 5062.9 5519.2 5520.5 5534.9 5537.6 4528.7 5011.5 5348.8 5386.5 5414.2 4592.8 4897.2 4902.8 5143.4 5505.9 4724.4 5143.1 5199.5 5377.7 5419.8 17:48:43 INFO - PROCESS | 1638 | 17:48:43 INFO - PROCESS | 1638 | [#5] yui.html Cycles:180 Average:20012.55 Median:3642.14 stddev:29180.90 (801.2%) stddev-sans-first:29226.80 17:48:43 INFO - PROCESS | 1638 | Values: 718.6 725.5 755.3 824.6 884.5 14824.7 15519.0 15845.4 15855.3 15865.5 13881.6 14434.6 14618.2 14645.6 14650.9 945.9 957.9 976.4 979.3 981.8 957.4 973.8 974.6 977.0 977.9 1031.6 1033.1 1033.2 1033.2 1036.9 1026.6 1027.1 1027.3 1027.6 1027.9 761.4 763.0 763.6 765.3 767.2 15565.1 15826.1 15980.2 16096.0 16271.0 13627.9 13665.2 13766.2 13797.0 13915.2 11633.6 11729.4 11833.2 11867.2 12124.0 3443.9 3526.8 3544.4 3638.7 3645.6 94723.0 100590.0 104758.0 106547.5 110112.0 10544.2 10592.1 10595.0 10601.8 11046.1 18647.9 22339.8 22525.1 22609.2 23102.7 7583.6 7699.8 7817.4 7945.0 8074.4 4133.8 4162.7 4190.4 4214.4 4219.3 3477.1 3538.5 3582.2 3583.0 3586.2 633.3 640.6 644.6 646.1 654.6 665.2 672.4 689.5 697.5 707.2 8711.0 9081.0 9541.9 10050.7 10111.3 650.8 652.5 687.3 687.9 703.5 4829.9 4840.6 4852.3 4859.8 4898.6 103314.0 103477.5 104062.0 105414.9 107291.5 59460.0 87258.6 88377.0 89934.0 91151.6 77681.6 78934.0 79361.6 80238.0 81284.7 7406.9 8099.8 9409.6 9510.6 9533.1 47390.3 48086.5 52118.0 53082.7 53627.2 64321.4 66025.7 66902.0 67169.0 67843.7 11418.7 11664.7 11699.8 11760.8 11761.9 12400.7 12620.0 12709.0 12921.2 12951.2 11400.5 11577.7 11704.9 11930.0 12272.8 11470.5 11556.3 11558.0 11673.4 11942.9 11618.9 11672.6 11796.4 12220.1 12423.8 8066.4 9819.2 9832.7 9853.9 10814.5 7706.5 8504.9 9175.3 9794.8 9872.4 17:48:43 INFO - PROCESS | 1638 | -------- Summary: end -------- 17:48:43 INFO - PROCESS | 1638 | 17:48:43 INFO - TEST-INFO | 1638: exit 0 17:48:43 INFO - TEST-OK | dromaeo_css | took 1122300ms 17:48:43 INFO - TEST-START | kraken 17:48:43 INFO - operating with platform_type : mac_ 17:48:43 INFO - Initialising browser for kraken test... 17:48:43 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpN6TqnL/profile http://localhost:49243/getInfo.html) 17:48:46 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 17:48:46 INFO - PROCESS | 1647 | colorDepth:24 17:48:46 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 17:48:46 INFO - PROCESS | 1647 | __metrics 17:48:46 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 17:48:46 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:48:46 INFO - TEST-INFO | 1647: exit 0 17:48:46 INFO - Browser initialized. 17:48:46 INFO - Running cycle 1/1 for kraken test... 17:48:46 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/tmpN6TqnL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:48:59 INFO - PROCESS | 1648 | RSS: Main: 232165376 17:48:59 INFO - PROCESS | 1648 | 17:49:02 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 17:49:03 INFO - PROCESS | 1648 | RSS: Main: 284311552 17:49:03 INFO - PROCESS | 1648 | 17:49:05 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 17:49:06 INFO - PROCESS | 1648 | RSS: Main: 285966336 17:49:06 INFO - PROCESS | 1648 | 17:49:09 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 17:49:10 INFO - PROCESS | 1648 | RSS: Main: 377323520 17:49:10 INFO - PROCESS | 1648 | 17:49:12 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 17:49:13 INFO - PROCESS | 1648 | RSS: Main: 280616960 17:49:13 INFO - PROCESS | 1648 | 17:49:15 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:49:15 INFO - PROCESS | 1648 | RSS: Main: 282218496 17:49:15 INFO - PROCESS | 1648 | 17:49:18 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 17:49:19 INFO - PROCESS | 1648 | RSS: Main: 323497984 17:49:19 INFO - PROCESS | 1648 | 17:49:22 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 17:49:23 INFO - PROCESS | 1648 | RSS: Main: 327524352 17:49:23 INFO - PROCESS | 1648 | 17:49:26 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 17:49:26 INFO - PROCESS | 1648 | RSS: Main: 325263360 17:49:26 INFO - PROCESS | 1648 | 17:49:28 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:49:29 INFO - PROCESS | 1648 | RSS: Main: 301981696 17:49:29 INFO - PROCESS | 1648 | 17:49:30 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:49:31 INFO - PROCESS | 1648 | RSS: Main: 306118656 17:49:31 INFO - PROCESS | 1648 | 17:49:33 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:49:34 INFO - PROCESS | 1648 | RSS: Main: 313614336 17:49:34 INFO - PROCESS | 1648 | 17:49:37 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:49:38 INFO - PROCESS | 1648 | RSS: Main: 326074368 17:49:38 INFO - PROCESS | 1648 | 17:49:41 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:49:41 INFO - PROCESS | 1648 | RSS: Main: 320499712 17:49:41 INFO - PROCESS | 1648 | 17:49:43 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 17:49:43 INFO - PROCESS | 1648 | RSS: Main: 365023232 17:49:43 INFO - PROCESS | 1648 | 17:49:43 INFO - PROCESS | 1648 | __start_tp_report 17:49:43 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 17:49:43 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 17:49:43 INFO - PROCESS | 1648 | |i|pagename|runs| 17:49:43 INFO - PROCESS | 1648 | |0;ai-astar;120;166;171;116;115;114;114;114;113;114 17:49:43 INFO - PROCESS | 1648 | |1;audio-beat-detection;134;111;109;143;111;109;110;107;129;109 17:49:43 INFO - PROCESS | 1648 | |2;audio-dft;183;182;184;184;186;179;184;187;186;186 17:49:43 INFO - PROCESS | 1648 | |3;audio-fft;82;60;62;92;76;85;86;68;78;59 17:49:43 INFO - PROCESS | 1648 | |4;audio-oscillator;88;70;90;93;101;100;92;68;69;83 17:49:43 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;87;87;86;86;88;87;87;87;88;87 17:49:43 INFO - PROCESS | 1648 | |6;imaging-darkroom;94;93;94;93;94;95;93;94;95;93 17:49:43 INFO - PROCESS | 1648 | |7;imaging-desaturate;85;83;84;83;84;84;85;84;84;84 17:49:43 INFO - PROCESS | 1648 | |8;json-parse-financial;62;60;62;60;61;61;61;61;61;60 17:49:43 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;53;53;63;61;63;58;56;57;58;57 17:49:43 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;88;89;88;104;101;88;90;88;85;103 17:49:43 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;142;181;152;142;139;138;139;141;179;156 17:49:43 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;171;171;169;146;207;232;169;170;169;170 17:49:43 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;67;68;67;68;66;66;67;67;66;66 17:49:43 INFO - PROCESS | 1648 | __end_tp_report 17:49:43 INFO - PROCESS | 1648 | __start_cc_report 17:49:43 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,2157 17:49:43 INFO - PROCESS | 1648 | __end_cc_report 17:49:43 INFO - PROCESS | 1648 | __startTimestamp1488937783972__endTimestamp 17:49:43 INFO - PROCESS | 1648 | 17:49:43 INFO - PROCESS | 1648 | ------- Summary: start ------- 17:49:43 INFO - PROCESS | 1648 | Number of tests: 14 17:49:43 INFO - PROCESS | 1648 | 17:49:43 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:125.70 Median:115.50 stddev:22.67 (19.6%) stddev-sans-first:23.95 17:49:43 INFO - PROCESS | 1648 | Values: 120.0 166.0 171.0 116.0 115.0 114.0 114.0 114.0 113.0 114.0 17:49:43 INFO - PROCESS | 1648 | 17:49:43 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:117.20 Median:111.00 stddev:13.00 (11.7%) stddev-sans-first:12.29 17:49:43 INFO - PROCESS | 1648 | Values: 134.0 111.0 109.0 143.0 111.0 109.0 110.0 107.0 129.0 109.0 17:49:43 INFO - PROCESS | 1648 | 17:49:43 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:184.10 Median:185.00 stddev:2.38 (1.3%) stddev-sans-first:2.49 17:49:43 INFO - PROCESS | 1648 | Values: 183.0 182.0 184.0 184.0 186.0 179.0 184.0 187.0 186.0 186.0 17:49:43 INFO - PROCESS | 1648 | 17:49:43 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:74.80 Median:80.00 stddev:11.87 (14.8%) stddev-sans-first:12.30 17:49:43 INFO - PROCESS | 1648 | Values: 82.0 60.0 62.0 92.0 76.0 85.0 86.0 68.0 78.0 59.0 17:49:43 INFO - PROCESS | 1648 | 17:49:43 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:85.40 Median:85.50 stddev:12.47 (14.6%) stddev-sans-first:13.20 17:49:43 INFO - PROCESS | 1648 | Values: 88.0 70.0 90.0 93.0 101.0 100.0 92.0 68.0 69.0 83.0 17:49:43 INFO - PROCESS | 1648 | 17:49:43 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:87.00 Median:87.00 stddev:0.67 (0.8%) stddev-sans-first:0.71 17:49:43 INFO - PROCESS | 1648 | Values: 87.0 87.0 86.0 86.0 88.0 87.0 87.0 87.0 88.0 87.0 17:49:43 INFO - PROCESS | 1648 | 17:49:43 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 17:49:43 INFO - PROCESS | 1648 | Values: 94.0 93.0 94.0 93.0 94.0 95.0 93.0 94.0 95.0 93.0 17:49:43 INFO - PROCESS | 1648 | 17:49:43 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:84.00 Median:84.00 stddev:0.67 (0.8%) stddev-sans-first:0.60 17:49:43 INFO - PROCESS | 1648 | Values: 85.0 83.0 84.0 83.0 84.0 84.0 85.0 84.0 84.0 84.0 17:49:43 INFO - PROCESS | 1648 | 17:49:43 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:60.90 Median:61.00 stddev:0.74 (1.2%) stddev-sans-first:0.67 17:49:43 INFO - PROCESS | 1648 | Values: 62.0 60.0 62.0 60.0 61.0 61.0 61.0 61.0 61.0 60.0 17:49:43 INFO - PROCESS | 1648 | 17:49:43 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:57.90 Median:58.00 stddev:3.57 (6.2%) stddev-sans-first:3.32 17:49:43 INFO - PROCESS | 1648 | Values: 53.0 53.0 63.0 61.0 63.0 58.0 56.0 57.0 58.0 57.0 17:49:43 INFO - PROCESS | 1648 | 17:49:43 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:92.40 Median:88.00 stddev:7.23 (8.2%) stddev-sans-first:7.49 17:49:43 INFO - PROCESS | 1648 | Values: 88.0 89.0 88.0 104.0 101.0 88.0 90.0 88.0 85.0 103.0 17:49:43 INFO - PROCESS | 1648 | 17:49:43 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:150.90 Median:147.00 stddev:16.43 (11.2%) stddev-sans-first:17.11 17:49:43 INFO - PROCESS | 1648 | Values: 142.0 181.0 152.0 142.0 139.0 138.0 139.0 141.0 179.0 156.0 17:49:43 INFO - PROCESS | 1648 | 17:49:43 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:177.40 Median:170.50 stddev:24.14 (14.2%) stddev-sans-first:25.50 17:49:43 INFO - PROCESS | 1648 | Values: 171.0 171.0 169.0 146.0 207.0 232.0 169.0 170.0 169.0 170.0 17:49:43 INFO - PROCESS | 1648 | 17:49:43 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:67.00 stddev:0.79 (1.2%) stddev-sans-first:0.83 17:49:43 INFO - PROCESS | 1648 | Values: 67.0 68.0 67.0 68.0 66.0 66.0 67.0 67.0 66.0 66.0 17:49:43 INFO - PROCESS | 1648 | -------- Summary: end -------- 17:49:43 INFO - PROCESS | 1648 | 17:49:44 INFO - TEST-INFO | 1648: exit 0 17:49:44 INFO - TEST-OK | kraken | took 61131ms 17:49:44 INFO - SUITE-END | took 1183s 17:49:45 INFO - Completed test suite (00:19:43) 17:49:45 INFO - javascript benchmark 17:49:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7521.787240210136, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3338.582677165354, 3358.798472091676, 3368.595768507779, 3376.662333766622, 3429.6570342965692, 5686.346070201928, 5757.568182386317, 5783.710814459276, 5868.64788112713, 5897.616654917428, 5794.0729483282685, 5872.0, 5879.353271140171, 5898.911516327258, 5947.018741907591, 4347.41309923161, 5227.2159176123505, 5309.8938021239555, 5321.8403447896435, 5324.307839980797, 4428.623566996793, 5361.490658387447, 5411.512963833255, 5428.4300148484435, 5482.205080263379, 5173.198154286091, 5205.895882082337, 5281.498257665516, 5287.947120528823, 5374.811881584145, 5274.0, 5287.656302340336, 5289.418164001957, 5291.444398338196, 5300.893982120336, 5179.48205179479, 5216.113260745645, 5239.764210610531, 5242.056429842627, 5245.26566280721, 5737.827865164052, 5742.569307301927, 5747.885042299131, 5755.510781583571, 5758.625689330222, 6268.811935641938, 6273.811785646438, 6292.370762923717, 6292.968535157295, 6296.1500197473215, 5243.554297884684, 6210.1616281801835, 6268.623882567015, 6332.1135041094285, 6345.175127233476, 6094.299155597075, 6098.32918378978, 6102.21659592427, 6103.664298463583, 6142.692865356715, 6344.49244060474, 6387.265464471645, 6398.104265402847, 6400.519961002943, 6411.647359395185, 6138.848241798344, 6163.722632481549, 6180.845478863064, 6365.61806291624, 6378.330275321117, 6298.7480500780375, 6318.462930650946, 6332.936670633327, 6351.333110023474, 6358.300586935434, 6213.937860621426, 6346.555741098171, 6375.681215939185, 6376.84057898547, 6389.712462939179, 6140.412224875342, 6325.620462772248, 6379.71291291893, 6387.329330420332, 6387.361263873669, 4978.925316120261, 5051.621128415383, 5054.848354549369, 5063.949360506422, 5093.490650934951, 4545.36364908913, 4551.499335073139, 4587.3807036050375, 4593.219152744042, 4598.149342371605, 5797.246357973437, 5798.10129429939, 5800.4199580042505, 5800.4489573490455, 5802.65184088956, 5768.875069361434, 6230.719617617218, 6326.5255105867245, 6328.367163283727, 6332.271788744261, 4440.911181776346, 5332.813351532755, 5753.367129615739, 5785.595008349375, 5804.680742559115, 5621.0444224481935, 5626.859328516738, 5636.718164091779, 5640.097584386478, 5658.85852853682, 6429.903551446639, 6471.611703297817, 6473.255575608771, 6476.579022363437, 6488.805335839932, 6230.376962303733, 6276.968615156895, 6327.651979141191, 6334.714937827901, 6339.0, 6307.842303942438, 6309.684515774285, 6314.715837787218, 6320.304766475776, 6322.114903913548, 5999.820005399845, 6198.442140207403, 6210.285817130907, 6257.186565746424, 6287.622742635456, 5772.9711351442975, 6309.3690630936535, 6322.968385158045, 6329.525285603506, 6334.809955701337, 6170.598911070945, 6306.621602703853, 6318.241810982711, 6322.0516922462, 6344.555881088279, 5849.678267695318, 6095.1466794647895, 6139.492138333381, 6299.716512757029, 6322.905156422749, 5994.550408719277, 6011.158437818796, 6014.669193194416, 6015.909761353496, 6016.699165041818, 5761.48146666802, 6134.957077261001, 6136.978641397139, 6281.842953926006, 6301.149344838388, 5138.486151384981, 6153.169322141453, 6154.692265386802, 6158.32258451561, 6168.19813424252], "value": 5766.803615930857, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [778.3189709004621, 869.1482347299644, 877.9692710755124, 880.8326417980584, 881.7927786970057, 28720.28199295016, 29155.562666559992, 29205.707942920566, 29237.415251695005, 40601.59398406022, 34855.651443485556, 40377.59622403775, 41521.16957660845, 41603.58396416035, 41653.0, 9196.448213107218, 9345.579448924815, 9357.532123393838, 9364.578593963253, 9400.952995235015, 7304.48868579197, 7503.699852005913, 9151.176394124528, 9297.023812499692, 9307.115823996743, 7470.738524151656, 7528.849423011537, 9152.359334846564, 11151.665450036471, 11329.150313726463, 11056.11551075912, 11141.0, 11142.052925501343, 11143.331400115978, 11164.385958772264, 10863.0, 10925.016748492673, 10933.726656833564, 10942.835857462145, 10970.670879873616, 24481.510369792504, 27326.5901011485, 28485.72714092882, 28488.86044558215, 38769.61230387716, 3192.808431494118, 3781.829817658212, 3816.2939856126704, 3830.4445855351096, 3983.541892682321, 28061.298467538272, 28345.149645510668, 28602.0, 28979.710202897913, 29216.707832921824, 2984.5985146787575, 3072.0937323489625, 3173.698498642625, 3189.872405103793, 3194.744420446382, 322187.0, 322584.0, 322591.74082591786, 324187.75812242046, 324204.37897810596, 42640.29438822474, 50559.0, 51066.744666277176, 51068.0, 51108.74445627748, 52898.73550632299, 53017.0, 53067.46932530625, 53114.734426327625, 53301.46698533043, 13643.249621270726, 13797.965152613595, 13815.930920345334, 13828.446862125402, 13852.238126902916, 11744.823827642593, 11750.647480575597, 11759.706007349714, 11764.470598823074, 11769.0, 11760.88239117615, 12034.277943323254, 12401.25592464455, 12505.687357816127, 12594.055445841599, 4819.3012013258585, 5601.691906945076, 5604.955540013939, 5607.495325420732, 5628.465295796893, 826.7809030606894, 847.7244895409017, 854.7563944275852, 870.2288563131299, 886.7073865624458, 23026.769732302797, 25120.0, 26633.600495992574, 26740.46519069608, 26856.462870742474, 941.7833898203452, 960.4525420510382, 969.4328817641758, 975.6536429567543, 978.7748817771952, 12719.918806901516, 13145.60563183106, 13431.529896453578, 13807.723845523033, 13849.792253116211, 403222.0, 403553.0, 405103.9744801257, 406162.0, 406729.0, 55526.444735552126, 55558.444415556136, 55581.72209138928, 55599.0, 55599.166012509035, 1362.087401441037, 1430.592281199853, 1438.079629037417, 1438.4174409364225, 1441.3369849868968, 24068.51862962766, 25171.74828251694, 26295.342616434744, 26304.210873673055, 26407.735922640528, 46018.76990615026, 46027.3095903555, 46176.0, 46244.76877615591, 46342.0, 374949.0, 376909.0, 377503.0, 377509.0, 378200.0, 32699.509507357885, 33286.83356583298, 33298.33403331968, 33424.0, 33456.0, 41291.1741765169, 41953.580464194965, 42453.0, 42685.35971960485, 42713.359299611155, 26940.595891062043, 27535.31161720973, 28968.275793105342, 34153.48769768406, 34888.825555872056, 29565.26086847846, 33042.17394565059, 34000.0, 34138.14654633654, 35134.472982904765, 33941.0, 35481.75813846503, 35834.28331433409, 35844.820775895954, 35958.28083438264, 27554.724452755217, 29402.558961615166, 31476.842615786776, 31481.527777083822, 31661.8416907914, 23481.530369392858, 23748.45219328524, 23931.803409829092, 23959.04163833427, 24076.87961560181], "value": 17910.72088690183, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.1472778883617, 393.1704104339842, 411.59252340183207, 418.38079642129645, 442.1532764755493, 11694.239874408167, 20389.2863749769, 20554.075066622, 21179.894100529513, 21249.15003399866, 21106.0, 21474.785252147474, 21733.891330543363, 22009.33971980839, 22315.0, 6071.696415179245, 6228.813135605939, 6348.619082855021, 6521.315261897504, 6600.570962887421, 6460.192475940507, 6485.254195767477, 6536.60780353178, 6554.80335589933, 6581.506387020969, 6556.737730490775, 6557.3442655734525, 7183.42532597391, 7492.887606685904, 7634.809129771745, 6444.77549265638, 7105.573665580082, 7617.733379331725, 7692.115406728214, 7705.267999540035, 7499.275166711687, 7510.474266801326, 7511.474196806225, 7522.13495448025, 7551.69793208271, 28674.713252867412, 29122.70877291221, 29855.552166717516, 29906.40187196244, 30239.941602043822, 2807.508685979966, 2810.8172968756967, 2864.212341606054, 2864.3125649844096, 2865.2693563141474, 15756.76364854528, 16480.587985300463, 16515.33938642453, 16705.828242328542, 17223.052732099728, 1886.4340697790608, 2016.7176595276674, 2037.9796202037937, 2053.9589208215752, 2070.2029718558465, 134810.0, 141323.0, 142695.28652356775, 142844.28577857045, 146696.0, 16513.504594862174, 22820.74485903258, 22965.54068918646, 23376.0, 23443.648345274836, 40092.596759113876, 40694.79652601777, 40963.7951810239, 40978.0, 41008.97477563025, 8519.616617252239, 10664.573417063231, 10700.411477368663, 10917.0, 10938.890611093946, 8420.600128963217, 8430.620622072021, 8449.873251901226, 8612.397132200686, 8622.26710729595, 9157.313201509913, 10771.676849694522, 11009.559617615367, 11115.166362522843, 11155.705053554278, 3864.401017842239, 4372.912541749147, 4392.231359512072, 4504.729716217037, 4521.547845215452, 842.372432537751, 852.4416507187802, 854.3293514591016, 903.6701603914655, 907.3467103685336, 19515.902420487808, 20579.0, 21100.683489747666, 21314.78685213159, 21367.78632213658, 886.2466903132286, 903.8689390038408, 905.6422713028317, 918.8851393575803, 921.5162039928957, 10030.498475076363, 10966.451677416097, 10999.505022274017, 11036.896310368898, 11125.888741112485, 469514.0, 703782.4810875913, 719278.0, 720783.9608019578, 721784.0, 145835.2708236452, 152697.23651381893, 154959.0, 158928.0, 164886.0, 1257.4278703190027, 1294.0876681939399, 1297.7469393468184, 1319.7096638739463, 1324.6224825924564, 14828.481003165269, 19281.61436771285, 19282.107683847535, 19512.9024354883, 19599.80400196037, 61899.38100618936, 62206.114212619046, 62329.688351557954, 62585.68707156435, 64108.35891641024, 88199.11800882166, 88907.55546222227, 90536.64195037211, 90726.0, 92351.53824230836, 11169.72075698114, 11215.775684486101, 11669.76660466803, 11672.70818229551, 11729.589464368706, 12371.13402061847, 12619.116661833583, 12700.301483418501, 12722.872771272168, 12805.118848259068, 10315.432651203955, 10544.947275263574, 10574.629887954192, 10627.36235825853, 10669.986351296615, 8171.55056471876, 10522.684319470429, 10539.578416863545, 10930.45347732626, 11002.394868282321, 10726.356418614909, 10733.516991735547, 10833.349999000086, 10874.130069594255, 11017.0, 10661.413622250851, 10963.671089867317, 10998.615048473264, 11342.773144537228, 11473.0, 8888.0, 10232.53953572106, 10486.108680762221, 10665.89334106649, 10731.89268107309], "value": 11566.872990746699, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1533.4479587348553, 1534.1102160746768, 1553.3864123671144, 1565.5146904459614, 1565.8590726834586, 9110.0, 10165.796684066314, 10701.090407315378, 10705.090067344265, 10710.196735244848, 10176.236782241325, 10555.0, 10605.78788424231, 10651.946740266307, 10654.200934929891, 2270.3075561953597, 2312.7571604981486, 2313.4910319729634, 2314.8032417244553, 2317.8377513574055, 2267.7505474397803, 2307.48081681622, 2309.861408315498, 2312.5721741477796, 2315.733690625574, 2259.0963614554144, 2277.851939623919, 2283.7602051784575, 2287.9199228027023, 2288.5766133265315, 2179.934601961944, 2195.5279614882797, 2201.1635578480077, 2201.768814274494, 2206.150632006673, 2214.55708858229, 2281.1673739085113, 2284.0635339510886, 2285.3486756274383, 2288.2677543186187, 10613.681589552325, 10658.786824263549, 10673.573057077707, 10680.35917844924, 10687.786244275148, 5431.83704488866, 5605.215269862222, 5606.775728970836, 5607.887842243133, 5615.382307946123, 3255.641879393265, 3349.4138525757894, 3562.2163124112653, 3565.5899571549344, 3566.1797786509246, 1166.8716441191461, 1209.1656756837754, 1754.736789481588, 1785.3305010621018, 1863.850891928656, 12817.423215955305, 14398.85601143996, 14548.563543093724, 14695.77956330656, 14751.336189871481, 4499.752513611717, 4595.40259766235, 4616.976915115403, 4624.329472226508, 4635.3278774578175, 11188.888111118948, 11206.663800086011, 11229.494672739746, 11233.382163980896, 11235.0, 5556.111022236423, 5556.277683901148, 5558.194061861008, 5558.749856256478, 5564.527015203753, 4973.32860063894, 5072.213806859869, 5089.0, 5147.510986456281, 5159.638825282194, 3565.4651802229873, 3702.648248416396, 3718.8326525305883, 3759.3045286622064, 3794.0, 910.961503885571, 981.5043403081398, 1013.8124446977333, 1017.623479312659, 1026.3226270661328, 883.7525492862009, 899.6401439424152, 914.2046419614977, 946.4205446363734, 958.990410095904, 6256.843578910563, 6383.521235907326, 6590.80227593173, 6742.797716068526, 6770.815107356193, 956.799072194833, 988.3378136648463, 991.8395477291587, 1020.3928662445833, 1033.1373303291684, 3733.34132550097, 4023.5372932113182, 4081.918361632751, 4275.40144379787, 4339.435873336446, 11653.30080195191, 12306.323152226714, 12729.172603780724, 12893.161944473766, 13134.540291089957, 12686.365681715877, 12812.55156069533, 12980.221186728826, 12998.480060797652, 13041.608751737464, 7883.7240696575345, 8298.170182981774, 8460.492370457792, 9498.0, 9739.805203896025, 6204.751809927733, 6236.0, 6386.265579458236, 6461.38616831419, 6500.544961852814, 11536.538538458368, 11750.70623234426, 11890.881091189323, 11901.523939042341, 12009.459574319351, 9980.8023037236, 12067.517299307929, 12197.939010304892, 12248.203866748632, 12253.509859605516, 7637.427192960439, 7659.731909383145, 7952.165022672536, 8303.0, 8322.250997410261, 8298.419110662197, 9862.753431164278, 9873.506324683593, 9932.900670993198, 9937.65218217359, 8662.566871656267, 8742.213200811957, 8812.647494100163, 8954.820903581762, 8959.820803584022, 8478.788030299045, 8569.742907712778, 8627.91372086271, 8691.782705432162, 8692.391532592657, 7576.469647124648, 7658.6170691464085, 7682.8079298018, 7752.7674169775, 7756.224377562198, 5761.366249712612, 5886.58793884424, 5902.321233058254, 5974.2233509643465, 5997.790077347272, 5924.911126333194, 5929.851753706192, 5941.851453713692, 5946.345901950695, 6010.879782404415], "value": 4973.255711319411, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [366.7084667689187, 366.96146904575016, 367.11891460494826, 374.3598446656216, 378.93179227739006, 4999.425066117397, 5003.399592048954, 5229.686218826873, 5236.895262094756, 5280.4983526564965, 4151.937720934188, 4326.653867690585, 4589.678722489427, 4731.90536189276, 5075.670081444703, 3948.8420463181437, 4064.979675101628, 4111.794410279489, 4229.788510574459, 4259.957400425987, 4233.375307309472, 4246.299360605496, 4246.936295955563, 4288.185244803493, 4348.977990172307, 4257.616814486695, 4258.893527661802, 4301.569843015689, 4311.676624253178, 4316.223079845627, 4089.3457046872504, 4177.248095342837, 4207.221663992156, 4216.47294088239, 4272.658187345005, 3264.9388948591804, 3455.6026057003514, 3513.8945831624837, 3698.4822124902535, 3758.1919887224103, 4433.667474939392, 4504.121696269229, 4625.491195968474, 4966.726830024347, 5016.372953380827, 4545.999880026389, 4634.930476042862, 4662.94830274678, 4679.245283018868, 4871.512848715136, 4932.383452068491, 5159.529534082806, 5332.546733527654, 5421.322334708161, 5484.945150548483, 4372.5627437256335, 4378.321360189176, 4378.934315985231, 4390.429244198266, 4396.450443694538, 4755.833545825914, 4852.805887764485, 5248.3701955765555, 5451.291332126798, 5854.813808127209, 3908.609139086069, 4392.978035109804, 4410.757408342572, 4421.756803375781, 4423.270160423494, 3880.5343358797127, 3893.065664240562, 4432.623227025674, 4448.221561226773, 4523.457185137739, 4324.875532361546, 4400.625946794495, 4823.445303790109, 4874.8781280467565, 4897.188040425065, 4710.3405523226775, 4967.5032496750755, 5458.890822183614, 5465.125579907196, 5534.612577119644, 1376.105531404575, 1417.6172433442912, 1458.1469840143634, 1516.052467207995, 1537.9769303460457, 1003.7490627343165, 1029.7528593137592, 1082.6373164989816, 1097.550004498168, 1163.836163836164, 4465.0, 4569.383133277031, 4837.927431088537, 5148.253503242009, 5211.635185537052, 4877.634347341536, 5142.485751424902, 5178.896422071537, 5182.331099483769, 5761.711914404347, 4190.497140343117, 4264.87205383839, 4653.952860606337, 5066.301599832143, 5179.896402072013, 2655.907043253477, 2718.497078040569, 2920.2845302900923, 2932.255308091682, 2951.719586639266, 5071.847844564669, 5490.835274941758, 5823.359430462646, 5853.560982926298, 5872.530197584183, 4718.433787945469, 5015.473375295542, 5508.889822203533, 5686.772529098873, 5810.50610698087, 4599.609033232079, 4868.079152508467, 4943.060818444484, 5334.146536554133, 5883.823485295534, 4644.744539050384, 5501.669899806025, 5635.9009993052605, 5679.5172410345585, 5702.543796496353, 4573.428321459817, 5194.337811900155, 5419.891602168013, 5578.581606379619, 5652.63257888236, 4637.078640456491, 5864.853378665567, 5867.442592953663, 5867.882642347044, 5871.530277577869, 4128.616913333946, 4168.458100446923, 4209.852655157055, 4364.9524114213, 4476.865694029184, 4893.510648935078, 5038.622103342191, 5303.655262407931, 5491.572191230229, 5731.942680573307, 4323.329883868006, 4561.25629345477, 5208.374995000624, 5516.9448305518035, 5521.475459831309, 5062.924056139234, 5519.199716041232, 5520.475554822286, 5534.91697624544, 5537.640053396677, 4528.728276303433, 5011.523905228997, 5348.769782949866, 5386.48828361305, 5414.187871819258, 4592.770361481846, 4897.167481528078, 4902.779374928065, 5143.3570803649545, 5505.889882202254, 4724.362211101457, 5143.125668636266, 5199.480051994921, 5377.650452720561, 5419.810306639249], "value": 4110.019453826303, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [718.6406796601699, 725.5465334166146, 755.2824816424395, 824.5588610093599, 884.4648987362646, 14824.703505929889, 15519.0, 15845.366185352586, 15855.286512106954, 15865.524034278962, 13881.583552493415, 14434.5669629911, 14618.195999220039, 14645.560633181021, 14650.853491465083, 945.8723072385209, 957.9185769209626, 976.3702411944328, 979.2998006425404, 981.813455443467, 957.3537861943161, 973.8149751547219, 974.5614473486924, 976.9853452198223, 977.8630991661173, 1031.587365053977, 1033.1270076785104, 1033.1837848100029, 1033.188946676859, 1036.9014943580348, 1026.6098882424706, 1027.1012863744224, 1027.2757705817419, 1027.5941003303728, 1027.9383237005804, 761.4137114421919, 762.9923700762977, 763.6220071064803, 765.2729906588763, 767.2021098058013, 15565.066096034274, 15826.129562874037, 15980.200989950456, 16096.0, 16271.0, 13627.931860340635, 13665.18008919468, 13766.24285664288, 13797.0, 13915.23466209358, 11633.592824251195, 11729.4135293235, 11833.171677982544, 11867.169298149132, 12124.0, 3443.8794642187654, 3526.8236588170744, 3544.3620148373284, 3638.6907112895437, 3645.580758212813, 94723.0, 100589.98820023632, 104758.0, 106547.46726266397, 110112.0, 10544.209184311054, 10592.117725645861, 10595.0, 10601.787964240671, 11046.057573209955, 18647.906760466383, 22339.776602234095, 22525.098996040302, 22609.208677696202, 23102.65346019811, 7583.62081895903, 7699.846003079907, 7817.374610031184, 7944.960275198702, 8074.394420418492, 4133.759698569717, 4162.708610397303, 4190.434401053115, 4214.4099826024385, 4219.3249080147025, 3477.0611934777467, 3538.5046093546925, 3582.2119133791048, 3582.964170358315, 3586.246888153517, 633.3349982518338, 640.5836206465834, 644.5939058393183, 646.0825627608807, 654.5516321319911, 665.1685393258427, 672.3612568060264, 689.4725534965755, 697.5291678117251, 707.2432497227917, 8710.956445217733, 9080.954595226982, 9541.856872146924, 10050.74873128163, 10111.292209545261, 650.8340373204802, 652.5464801962685, 687.3229868579546, 687.9312068793181, 703.4759104467205, 4829.9034019319415, 4840.564349208517, 4852.296417019513, 4859.781309841065, 4898.559129678346, 103313.96686033043, 103477.48261258796, 104062.0, 105414.89170216552, 107291.46354268178, 59460.0, 87258.56370718233, 88377.0, 89934.0, 91151.63272550917, 77681.61159194168, 78934.0, 79361.60319198483, 80238.0, 81284.68437840504, 7406.888896666662, 8099.797505062421, 9409.576569054272, 9510.619575216913, 9533.067141226345, 47390.28914566353, 48086.519134809605, 52118.0, 53082.73458632682, 53627.19559206693, 64321.35678643341, 66025.66987165033, 66902.0, 67168.99246511208, 67843.66078169577, 11418.657440276806, 11664.6500604982, 11699.766004680028, 11760.764784704086, 11761.88238117608, 12400.689982750504, 12620.0, 12709.0, 12921.202436831893, 12951.158174718614, 11400.48697808584, 11577.710557236136, 11704.94147529257, 11930.0, 12272.75454490923, 11470.483828227583, 11556.306621602731, 11558.017568506772, 11673.35796531165, 11942.940285298519, 11618.915338051838, 11672.591459298883, 11796.351200684045, 12220.144589878622, 12423.75152496927, 8066.435349525477, 9819.214462843098, 9832.705018849447, 9853.901460985298, 10814.45927703596, 7706.451275356344, 8504.927907912943, 9175.28400997597, 9794.804103918024, 9872.40765554069], "value": 7415.410269738861, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1458.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [120.0, 166.0, 171.0, 116.0, 115.0, 114.0, 114.0, 114.0, 113.0, 114.0], "value": 125.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 111.0, 109.0, 143.0, 111.0, 109.0, 110.0, 107.0, 129.0, 109.0], "value": 117.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [183.0, 182.0, 184.0, 184.0, 186.0, 179.0, 184.0, 187.0, 186.0, 186.0], "value": 184.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 60.0, 62.0, 92.0, 76.0, 85.0, 86.0, 68.0, 78.0, 59.0], "value": 74.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 70.0, 90.0, 93.0, 101.0, 100.0, 92.0, 68.0, 69.0, 83.0], "value": 85.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 87.0, 86.0, 86.0, 88.0, 87.0, 87.0, 87.0, 88.0, 87.0], "value": 87.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 94.0, 93.0, 94.0, 95.0, 93.0, 94.0, 95.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 84.0, 83.0, 84.0, 84.0, 85.0, 84.0, 84.0, 84.0], "value": 84.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 60.0, 62.0, 60.0, 61.0, 61.0, 61.0, 61.0, 61.0, 60.0], "value": 60.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 63.0, 61.0, 63.0, 58.0, 56.0, 57.0, 58.0, 57.0], "value": 57.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 89.0, 88.0, 104.0, 101.0, 88.0, 90.0, 88.0, 85.0, 103.0], "value": 92.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 181.0, 152.0, 142.0, 139.0, 138.0, 139.0, 141.0, 179.0, 156.0], "value": 150.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 171.0, 169.0, 146.0, 207.0, 232.0, 169.0, 170.0, 169.0, 170.0], "value": 177.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 68.0, 66.0, 66.0, 67.0, 67.0, 66.0, 66.0], "value": 66.8, "unit": "score"}]}]} 17:49:45 INFO - Return code: 0 17:49:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:49:45 ERROR - # TBPL SUCCESS # 17:49:45 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:49:45 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:49:45 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:49:45 INFO - 2017-03-07 17:49:45.333 screenresolution[1652:10050] starting screenresolution argv=screenresolution get 17:49:45 INFO - 2017-03-07 17:49:45.336 screenresolution[1652:10050] Display 0: 1600x1200x32@60 17:49:45 INFO - 2017-03-07 17:49:45.343 screenresolution[1653:10053] starting screenresolution argv=screenresolution list 17:49:45 INFO - Available Modes on Display 0 17:49:45 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:49:45 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:49:45 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:49:45 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:49:45 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:49:45 INFO - Intel Iris: 17:49:45 INFO - Chipset Model: Intel Iris 17:49:45 INFO - Type: GPU 17:49:45 INFO - Bus: Built-In 17:49:45 INFO - VRAM (Dynamic, Max): 1536 MB 17:49:45 INFO - Vendor: Intel (0x8086) 17:49:45 INFO - Device ID: 0x0a2e 17:49:45 INFO - Revision ID: 0x0009 17:49:45 INFO - Displays: 17:49:45 INFO - Display: 17:49:45 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:49:45 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:49:45 INFO - Display Serial Number: 1600x1200 60 17:49:45 INFO - Main Display: Yes 17:49:45 INFO - Mirror: Off 17:49:45 INFO - Online: Yes 17:49:45 INFO - Rotation: Supported 17:49:45 INFO - Return code: 0 17:49:45 INFO - Running post-action listener: _resource_record_post_action 17:49:45 INFO - [mozharness: 2017-03-08 01:49:45.580981Z] Finished run-tests step (success) 17:49:45 INFO - Running post-run listener: _resource_record_post_run 17:49:45 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 44839936; Write bytes: 513651200; Read time: 562; Write time: 2090 17:49:45 INFO - TinderboxPrint: CPU usage
54.0% 17:49:45 INFO - TinderboxPrint: I/O read bytes / time
44,839,936 / 562 17:49:45 INFO - TinderboxPrint: I/O write bytes / time
513,651,200 / 2,090 17:49:45 INFO - TinderboxPrint: CPU idle
2,215.7 (46.0%) 17:49:45 INFO - TinderboxPrint: CPU system
960.8 (19.9%) 17:49:45 INFO - TinderboxPrint: CPU user
1,641.2 (34.1%) 17:49:45 INFO - TinderboxPrint: Swap in / out
254,087,168 / 0 17:49:45 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203856384; Write bytes: 204191232; Read time: 15538; Write time: 463 17:49:45 INFO - run-tests - Wall time: 1185s; CPU: 54.0%; Read bytes: 42660864; Write bytes: 298687488; Read time: 536; Write time: 1599 17:49:46 INFO - Running post-run listener: _upload_blobber_files 17:49:46 INFO - Blob upload gear active. 17:49:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:49:46 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 17:49:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 17:49:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 17:49:46 INFO - (blobuploader) - INFO - Open directory for files ... 17:49:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:49:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:49:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:49:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:49:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:49:47 INFO - (blobuploader) - INFO - Done attempting. 17:49:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:49:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:49:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:49:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:49:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:49:48 INFO - (blobuploader) - INFO - Done attempting. 17:49:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 17:49:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:49:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:49:49 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 17:49:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:49:49 INFO - (blobuploader) - INFO - Done attempting. 17:49:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:49:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:49:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:49:51 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:49:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:49:51 INFO - (blobuploader) - INFO - Done attempting. 17:49:51 INFO - (blobuploader) - INFO - Iteration through files over. 17:49:51 INFO - Return code: 0 17:49:51 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:49:51 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:49:51 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e219192eede2f712b89e9b19884e08ca3e8b54b0375613462f2f1a98f0e05b2af8a4ba7e5547fe4af0b8b5e0d7e6cd0e1f6da632f26d872e811f76186b921cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6234cfcd35756ede2e91b106c4a2174a4def609298fd0b4f6f72b3652b1b9e6ac941a648e446593a6069bea0e2440b3f419626abc5b7337e7f7ff7716d9af144", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33dcc589fb0727c111da5b31191f841ae27ab7620f0fcbbc5642a9c0dc7d97a1362aae9cd40eb2555768adec52e8f6604f3c5dc1da0df26fde74abb8f1155928", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2901774e725df37b3b510e575985c4b38eb7321922eddd883a4f82580a6db7bb68bbb0fabbc75f3d258140a0a9edb8fe146a84971f5654e5d6c248b2830c120f"} 17:49:51 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:49:51 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:49:51 INFO - Contents: 17:49:51 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e219192eede2f712b89e9b19884e08ca3e8b54b0375613462f2f1a98f0e05b2af8a4ba7e5547fe4af0b8b5e0d7e6cd0e1f6da632f26d872e811f76186b921cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6234cfcd35756ede2e91b106c4a2174a4def609298fd0b4f6f72b3652b1b9e6ac941a648e446593a6069bea0e2440b3f419626abc5b7337e7f7ff7716d9af144", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33dcc589fb0727c111da5b31191f841ae27ab7620f0fcbbc5642a9c0dc7d97a1362aae9cd40eb2555768adec52e8f6604f3c5dc1da0df26fde74abb8f1155928", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2901774e725df37b3b510e575985c4b38eb7321922eddd883a4f82580a6db7bb68bbb0fabbc75f3d258140a0a9edb8fe146a84971f5654e5d6c248b2830c120f"} 17:49:51 INFO - Running post-run listener: copy_logs_to_upload_dir 17:49:51 INFO - Copying logs to upload dir... 17:49:51 INFO - mkdir: /builds/slave/test/build/upload/logs 17:49:51 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.901210 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-03-07 17:49:51.734392) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-07 17:49:51.737952) ========= 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.KfMhwnGMPF/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.RnsgGYn4wq/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e219192eede2f712b89e9b19884e08ca3e8b54b0375613462f2f1a98f0e05b2af8a4ba7e5547fe4af0b8b5e0d7e6cd0e1f6da632f26d872e811f76186b921cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6234cfcd35756ede2e91b106c4a2174a4def609298fd0b4f6f72b3652b1b9e6ac941a648e446593a6069bea0e2440b3f419626abc5b7337e7f7ff7716d9af144", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33dcc589fb0727c111da5b31191f841ae27ab7620f0fcbbc5642a9c0dc7d97a1362aae9cd40eb2555768adec52e8f6604f3c5dc1da0df26fde74abb8f1155928", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2901774e725df37b3b510e575985c4b38eb7321922eddd883a4f82580a6db7bb68bbb0fabbc75f3d258140a0a9edb8fe146a84971f5654e5d6c248b2830c120f"} build_url:https://queue.taskcluster.net/v1/task/cZuJhUXmRee3oY-OaQ6_0g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010880 build_url: 'https://queue.taskcluster.net/v1/task/cZuJhUXmRee3oY-OaQ6_0g/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1e219192eede2f712b89e9b19884e08ca3e8b54b0375613462f2f1a98f0e05b2af8a4ba7e5547fe4af0b8b5e0d7e6cd0e1f6da632f26d872e811f76186b921cb", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6234cfcd35756ede2e91b106c4a2174a4def609298fd0b4f6f72b3652b1b9e6ac941a648e446593a6069bea0e2440b3f419626abc5b7337e7f7ff7716d9af144", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/33dcc589fb0727c111da5b31191f841ae27ab7620f0fcbbc5642a9c0dc7d97a1362aae9cd40eb2555768adec52e8f6604f3c5dc1da0df26fde74abb8f1155928", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2901774e725df37b3b510e575985c4b38eb7321922eddd883a4f82580a6db7bb68bbb0fabbc75f3d258140a0a9edb8fe146a84971f5654e5d6c248b2830c120f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-07 17:49:51.772006) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-07 17:49:51.772295) ========= 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.KfMhwnGMPF/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.RnsgGYn4wq/Listeners TMPDIR=/var/folders/tg/r664rfr17rsdq6gszpzv8rzm00000w/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.005280 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-07 17:49:51.821919) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-07 17:49:51.822223) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-07 17:49:51.822559) ========= ========= Total master_lag: 0.18 =========