builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0029 starttime: 1489163275.99 results: success (0) buildid: 20170310065428 builduid: f446337c98714a41a516b506f70d363a revision: 528e9dbbb882 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 08:27:55.991426) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 08:27:55.991954) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 08:27:55.992285) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 08:27:56.019919) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 08:27:56.020245) ========= 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.kvonCuYj4y/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.QhH7KfDbUz/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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-10 08:27:56-- 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% 8.90M=0.001s 2017-03-10 08:27:56 (8.90 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.135671 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 08:27:56.180713) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 08:27:56.181087) ========= 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.kvonCuYj4y/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.QhH7KfDbUz/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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.027236 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 08:27:56.230759) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-10 08:27:56.231126) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 528e9dbbb882 --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 528e9dbbb882 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.kvonCuYj4y/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.QhH7KfDbUz/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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-10 08:27:56,334 Setting DEBUG logging. 2017-03-10 08:27:56,334 attempt 1/10 2017-03-10 08:27:56,334 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/528e9dbbb882?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-10 08:27:58,599 unpacking tar archive at: mozilla-central-528e9dbbb882/testing/mozharness/ program finished with exit code 0 elapsedTime=2.528919 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2017-03-10 08:27:58.789411) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 08:27:58.789828) ========= script_repo_revision: 528e9dbbb882 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 08:27:58.790310) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 08:27:58.790633) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 08:27:58.811576) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-03-10 08:27:58.812290) ========= /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.kvonCuYj4y/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.QhH7KfDbUz/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 08:27:59 INFO - MultiFileLogger online at 20170310 08:27:59 in /builds/slave/test 08:27:59 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 08:27:59 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:27:59 INFO - {'append_to_log': False, 08:27:59 INFO - 'base_work_dir': '/builds/slave/test', 08:27:59 INFO - 'blob_upload_branch': 'Firefox', 08:27:59 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:27:59 INFO - 'branch': 'Firefox', 08:27:59 INFO - 'buildbot_json_path': 'buildprops.json', 08:27:59 INFO - 'config_files': ('talos/mac_config.py',), 08:27:59 INFO - 'default_actions': ('clobber', 08:27:59 INFO - 'read-buildbot-config', 08:27:59 INFO - 'download-and-extract', 08:27:59 INFO - 'populate-webroot', 08:27:59 INFO - 'create-virtualenv', 08:27:59 INFO - 'install', 08:27:59 INFO - 'run-tests'), 08:27:59 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:27:59 INFO - 'download_minidump_stackwalk': True, 08:27:59 INFO - 'download_symbols': 'ondemand', 08:27:59 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:27:59 INFO - 'tooltool.py': '/tools/tooltool.py', 08:27:59 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:27:59 INFO - '/tools/misc-python/virtualenv.py')}, 08:27:59 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:27:59 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:27:59 INFO - 'gecko_profile': False, 08:27:59 INFO - 'gecko_profile_interval': 0, 08:27:59 INFO - 'installer_path': 'installer.exe', 08:27:59 INFO - 'log_level': 'info', 08:27:59 INFO - 'log_name': 'talos', 08:27:59 INFO - 'log_to_console': True, 08:27:59 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:27:59 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:27:59 INFO - 'opt_config_files': (), 08:27:59 INFO - 'pip_index': False, 08:27:59 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:27:59 INFO - 'cmd': ('bash', 08:27:59 INFO - '-c', 08:27:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:27:59 INFO - 'enabled': True, 08:27:59 INFO - 'halt_on_failure': False, 08:27:59 INFO - 'name': 'check_screen_resolution'},), 08:27:59 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:27:59 INFO - 'cmd': ('bash', 08:27:59 INFO - '-c', 08:27:59 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:27:59 INFO - 'enabled': True, 08:27:59 INFO - 'halt_on_failure': False, 08:27:59 INFO - 'name': 'check_screen_resolution'},), 08:27:59 INFO - 'run_cmd_checks_enabled': True, 08:27:59 INFO - 'suite': 'dromaeojs', 08:27:59 INFO - 'system_bits': '32', 08:27:59 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:27:59 INFO - 'title': 't-yosemite-r7-0029', 08:27:59 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:27:59 INFO - 'use_talos_json': True, 08:27:59 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:27:59 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:27:59 INFO - 'work_dir': 'build'} 08:27:59 INFO - [mozharness: 2017-03-10 16:27:59.028059Z] Running clobber step. 08:27:59 INFO - Running pre-action listener: _resource_record_pre_action 08:27:59 INFO - Running main action method: clobber 08:27:59 INFO - rmtree: /builds/slave/test/build 08:27:59 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:28:01 INFO - Running post-action listener: _resource_record_post_action 08:28:01 INFO - [mozharness: 2017-03-10 16:28:01.562897Z] Finished clobber step (success) 08:28:01 INFO - [mozharness: 2017-03-10 16:28:01.563027Z] Running read-buildbot-config step. 08:28:01 INFO - Running pre-action listener: _resource_record_pre_action 08:28:01 INFO - Running main action method: read_buildbot_config 08:28:01 INFO - Using buildbot properties: 08:28:01 INFO - { 08:28:01 INFO - "project": "", 08:28:01 INFO - "product": "firefox", 08:28:01 INFO - "script_repo_revision": "production", 08:28:01 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 08:28:01 INFO - "repository": "", 08:28:01 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 08:28:01 INFO - "buildid": "20170310065428", 08:28:01 INFO - "stage_platform": "macosx64", 08:28:01 INFO - "basedir": "/builds/slave/test", 08:28:01 INFO - "nightly_build": "True", 08:28:01 INFO - "buildnumber": 12, 08:28:01 INFO - "slavename": "t-yosemite-r7-0029", 08:28:01 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 08:28:01 INFO - "platform": "yosemite_r7", 08:28:01 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 08:28:01 INFO - "branch": "mozilla-central", 08:28:01 INFO - "repo_path": "mozilla-central", 08:28:01 INFO - "revision": "528e9dbbb882", 08:28:01 INFO - "pgo_build": "False", 08:28:01 INFO - "builduid": "f446337c98714a41a516b506f70d363a", 08:28:01 INFO - "slavebuilddir": "test" 08:28:01 INFO - } 08:28:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/FiSactJITVirTqYN7bWjJw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 08:28:01 INFO - Running post-action listener: _resource_record_post_action 08:28:01 INFO - [mozharness: 2017-03-10 16:28:01.566552Z] Finished read-buildbot-config step (success) 08:28:01 INFO - [mozharness: 2017-03-10 16:28:01.566683Z] Running download-and-extract step. 08:28:01 INFO - Running pre-action listener: _resource_record_pre_action 08:28:01 INFO - Running main action method: download_and_extract 08:28:01 INFO - mkdir: /builds/slave/test/build/tests 08:28: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')]} 08:28:01 INFO - trying https://queue.taskcluster.net/v1/task/FiSactJITVirTqYN7bWjJw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 08:28:01 INFO - Downloading https://queue.taskcluster.net/v1/task/FiSactJITVirTqYN7bWjJw/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 08:28:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FiSactJITVirTqYN7bWjJw/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 08:28:02 INFO - Downloaded 1199 bytes. 08:28:02 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 08:28:02 INFO - Using the following test package requirements: 08:28:02 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 08:28:02 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:28:02 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 08:28:02 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:28:02 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 08:28:02 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:28:02 INFO - u'jsshell-mac.zip'], 08:28:02 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:28:02 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 08:28:02 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 08:28:02 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:28:02 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 08:28:02 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:28:02 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 08:28:02 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:28:02 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 08:28:02 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 08:28:02 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 08:28:02 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 08:28:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FiSactJITVirTqYN7bWjJw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 08:28:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FiSactJITVirTqYN7bWjJw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:28:02 INFO - Fetch https://queue.taskcluster.net/v1/task/FiSactJITVirTqYN7bWjJw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 08:28:04 INFO - Expected file size: 51788689 08:28:04 INFO - Obtained file size: 51788689 08:28:20 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 08:28:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FiSactJITVirTqYN7bWjJw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 08:28:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FiSactJITVirTqYN7bWjJw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 08:28:20 INFO - Fetch https://queue.taskcluster.net/v1/task/FiSactJITVirTqYN7bWjJw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 08:28:22 INFO - Expected file size: 51788689 08:28:22 INFO - Obtained file size: 51788689 08:28:37 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FiSactJITVirTqYN7bWjJw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 08:28:37 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FiSactJITVirTqYN7bWjJw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 08:28:37 INFO - Fetch https://queue.taskcluster.net/v1/task/FiSactJITVirTqYN7bWjJw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 08:28:39 INFO - Expected file size: 14404424 08:28:39 INFO - Obtained file size: 14404424 08:28: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')]} 08:28:40 INFO - trying https://queue.taskcluster.net/v1/task/FiSactJITVirTqYN7bWjJw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:28:40 INFO - Downloading https://queue.taskcluster.net/v1/task/FiSactJITVirTqYN7bWjJw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 08:28:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FiSactJITVirTqYN7bWjJw/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 08:28:42 INFO - Downloaded 75022005 bytes. 08:28:42 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FiSactJITVirTqYN7bWjJw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:28:42 INFO - mkdir: /builds/slave/test/properties 08:28:42 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:28:42 INFO - Writing to file /builds/slave/test/properties/build_url 08:28:42 INFO - Contents: 08:28:42 INFO - build_url:https://queue.taskcluster.net/v1/task/FiSactJITVirTqYN7bWjJw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 08:28:42 INFO - Running post-action listener: _resource_record_post_action 08:28:42 INFO - Running post-action listener: set_extra_try_arguments 08:28:42 INFO - [mozharness: 2017-03-10 16:28:42.811509Z] Finished download-and-extract step (success) 08:28:42 INFO - [mozharness: 2017-03-10 16:28:42.811611Z] Running populate-webroot step. 08:28:42 INFO - Running pre-action listener: _resource_record_pre_action 08:28:42 INFO - Running main action method: populate_webroot 08:28:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:28:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:28:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:28:42 INFO - '--tppagecycles', 08:28:42 INFO - '7'], 08:28:42 INFO - 'tests': ['tsvgm']}}, 08:28:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:28:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:28:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:28:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:28:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:28:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:28:42 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 08:28:42 INFO - 'talos_options': ['--disable-e10s'], 08:28:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:28:42 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 08:28:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:28:42 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 08:28:42 INFO - 'talos_options': ['--disable-e10s'], 08:28:42 INFO - 'tests': ['damp', 'tps']}, 08:28:42 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 08:28:42 INFO - 'tests': ['damp', 'tps']}, 08:28:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:28:42 INFO - 'tests': ['dromaeo_dom']}, 08:28:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:28:42 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:28:42 INFO - 'tests': ['basic_compositor_video']}, 08:28:42 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:28:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:28:42 INFO - 'tests': ['a11yr', 08:28:42 INFO - 'ts_paint', 08:28:42 INFO - 'tpaint', 08:28:42 INFO - 'sessionrestore', 08:28:42 INFO - 'sessionrestore_no_auto_restore', 08:28:42 INFO - 'tabpaint']}, 08:28:42 INFO - 'other-e10s': {'tests': ['a11yr', 08:28:42 INFO - 'ts_paint', 08:28:42 INFO - 'tpaint', 08:28:42 INFO - 'sessionrestore', 08:28:42 INFO - 'sessionrestore_no_auto_restore', 08:28:42 INFO - 'tabpaint']}, 08:28:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:28:42 INFO - 'ts_paint', 08:28:42 INFO - 'tpaint', 08:28:42 INFO - 'sessionrestore', 08:28:42 INFO - 'sessionrestore_no_auto_restore', 08:28:42 INFO - 'tabpaint']}, 08:28:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:28:42 INFO - 'ts_paint', 08:28:42 INFO - 'tpaint', 08:28:42 INFO - 'sessionrestore', 08:28:42 INFO - 'sessionrestore_no_auto_restore', 08:28:42 INFO - 'tabpaint']}, 08:28:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:28:42 INFO - 'tests': ['a11yr', 08:28:42 INFO - 'ts_paint', 08:28:42 INFO - 'tpaint', 08:28:42 INFO - 'sessionrestore', 08:28:42 INFO - 'sessionrestore_no_auto_restore', 08:28:42 INFO - 'tabpaint']}, 08:28:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:28:42 INFO - 'tests': ['a11yr', 08:28:42 INFO - 'ts_paint', 08:28:42 INFO - 'tpaint', 08:28:42 INFO - 'sessionrestore', 08:28:42 INFO - 'sessionrestore_no_auto_restore', 08:28:42 INFO - 'tabpaint']}, 08:28:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:28:42 INFO - 'tests': ['tsvgx', 08:28:42 INFO - 'tsvgr_opacity', 08:28:42 INFO - 'tart', 08:28:42 INFO - 'tscrollx', 08:28:42 INFO - 'cart', 08:28:42 INFO - 'tsvg_static']}, 08:28:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:28:42 INFO - 'tsvgr_opacity', 08:28:42 INFO - 'tart', 08:28:42 INFO - 'tscrollx', 08:28:42 INFO - 'cart', 08:28:42 INFO - 'tsvg_static']}, 08:28:42 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 08:28:42 INFO - 'talos_options': ['--disable-e10s'], 08:28:42 INFO - 'tests': ['tp5o']}, 08:28:42 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 08:28:42 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 08:28:42 INFO - 'talos_options': ['--disable-e10s', 08:28:42 INFO - '--xperf_path', 08:28:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:28:42 INFO - 'tests': ['tp5n']}, 08:28:42 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 08:28:42 INFO - 'talos_options': ['--xperf_path', 08:28:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:28:42 INFO - 'tests': ['tp5n']}}, 08:28:42 INFO - 'talos.zip': {'path': '', 08:28:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:28:42 INFO - Running post-action listener: _resource_record_post_action 08:28:42 INFO - [mozharness: 2017-03-10 16:28:42.830107Z] Finished populate-webroot step (success) 08:28:42 INFO - [mozharness: 2017-03-10 16:28:42.830242Z] Running create-virtualenv step. 08:28:42 INFO - Running pre-action listener: _resource_record_pre_action 08:28:42 INFO - Running main action method: create_virtualenv 08:28:42 INFO - Creating virtualenv /builds/slave/test/build/venv 08:28:42 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 08:28:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:28:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:28:42 INFO - Using real prefix '/tools/python27' 08:28:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:28:43 INFO - Installing distribute.............................................................................................................................................................................................done. 08:28:46 INFO - Installing pip.................done. 08:28:46 INFO - Return code: 0 08:28:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 08:28:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 08:28:46 INFO - Reading from file tmpfile_stdout 08:28:46 INFO - Output received: 08:28:46 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) 08:28:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:28:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1012ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc203da2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010bbd30>, '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 0x100fe2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010b0be8>, '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.kvonCuYj4y/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.QhH7KfDbUz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 08:28:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:28:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:28:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kvonCuYj4y/Render', 08:28:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:28:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:28:47 INFO - 'HOME': '/Users/cltbld', 08:28:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:28:47 INFO - 'LOGNAME': 'cltbld', 08:28:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:47 INFO - 'MOZ_NO_REMOTE': '1', 08:28:47 INFO - 'NO_EM_RESTART': '1', 08:28:47 INFO - 'PAGER': '/bin/cat', 08:28:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:28:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:47 INFO - 'PWD': '/builds/slave/test', 08:28:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:28:47 INFO - 'SHELL': '/bin/bash', 08:28:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QhH7KfDbUz/Listeners', 08:28:47 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 08:28:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:28:47 INFO - 'USER': 'cltbld', 08:28:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:28:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:28:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:47 INFO - 'XPC_FLAGS': '0x0', 08:28:47 INFO - 'XPC_SERVICE_NAME': '0', 08:28:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:28:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:47 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 08:28:47 INFO - Cleaning up... 08:28:47 INFO - Return code: 0 08:28:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:28:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:28:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:48 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 0x1012ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc203da2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010bbd30>, '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 0x100fe2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010b0be8>, '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.kvonCuYj4y/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.QhH7KfDbUz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 08:28:48 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 08:28:48 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 08:28:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kvonCuYj4y/Render', 08:28:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:28:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:28:48 INFO - 'HOME': '/Users/cltbld', 08:28:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:28:48 INFO - 'LOGNAME': 'cltbld', 08:28:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:48 INFO - 'MOZ_NO_REMOTE': '1', 08:28:48 INFO - 'NO_EM_RESTART': '1', 08:28:48 INFO - 'PAGER': '/bin/cat', 08:28:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:28:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:48 INFO - 'PWD': '/builds/slave/test', 08:28:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:28:48 INFO - 'SHELL': '/bin/bash', 08:28:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QhH7KfDbUz/Listeners', 08:28:48 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 08:28:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:28:48 INFO - 'USER': 'cltbld', 08:28:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:28:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:28:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:48 INFO - 'XPC_FLAGS': '0x0', 08:28:48 INFO - 'XPC_SERVICE_NAME': '0', 08:28:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:28:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:48 INFO - Downloading/unpacking psutil>=3.1.1 08:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:28:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:28:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:28:52 INFO - Installing collected packages: psutil 08:28:52 INFO - Running setup.py install for psutil 08:28:52 INFO - building 'psutil._psutil_osx' extension 08:28:52 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 08:28:53 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 08:28:53 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 08:28:53 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 08:28:53 INFO - building 'psutil._psutil_posix' extension 08:28:53 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 08:28:53 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:28:53 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:28:53 INFO - ^ 08:28:53 INFO - 1 warning generated. 08:28:53 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 08:28:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:28:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:28:53 INFO - Successfully installed psutil 08:28:53 INFO - Cleaning up... 08:28:53 INFO - Return code: 0 08:28:53 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:28:53 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')]} 08:28:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:53 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')]} 08:28:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:53 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 0x1012ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc203da2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010bbd30>, '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 0x100fe2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010b0be8>, '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.kvonCuYj4y/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.QhH7KfDbUz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 08:28:53 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 08:28:53 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 08:28:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kvonCuYj4y/Render', 08:28:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:28:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:28:53 INFO - 'HOME': '/Users/cltbld', 08:28:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:28:53 INFO - 'LOGNAME': 'cltbld', 08:28:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:53 INFO - 'MOZ_NO_REMOTE': '1', 08:28:53 INFO - 'NO_EM_RESTART': '1', 08:28:53 INFO - 'PAGER': '/bin/cat', 08:28:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:28:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:53 INFO - 'PWD': '/builds/slave/test', 08:28:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:28:53 INFO - 'SHELL': '/bin/bash', 08:28:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QhH7KfDbUz/Listeners', 08:28:53 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 08:28:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:28:53 INFO - 'USER': 'cltbld', 08:28:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:28:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:28:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:53 INFO - 'XPC_FLAGS': '0x0', 08:28:53 INFO - 'XPC_SERVICE_NAME': '0', 08:28:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:28:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:28:54 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 08:28:54 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 08:28:54 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 08:28:54 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 08:28:54 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 08:28:54 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 08:28:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:28:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:28:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:28:56 INFO - Installing collected packages: mozsystemmonitor 08:28:56 INFO - Running setup.py install for mozsystemmonitor 08:28:57 INFO - Successfully installed mozsystemmonitor 08:28:57 INFO - Cleaning up... 08:28:57 INFO - Return code: 0 08:28:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:28:57 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')]} 08:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:28:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:57 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')]} 08:28:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:28:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:28:57 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 0x1012ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc203da2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010bbd30>, '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 0x100fe2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010b0be8>, '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.kvonCuYj4y/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.QhH7KfDbUz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 08:28:57 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 08:28:57 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 08:28:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kvonCuYj4y/Render', 08:28:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:28:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:28:57 INFO - 'HOME': '/Users/cltbld', 08:28:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:28:57 INFO - 'LOGNAME': 'cltbld', 08:28:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:28:57 INFO - 'MOZ_NO_REMOTE': '1', 08:28:57 INFO - 'NO_EM_RESTART': '1', 08:28:57 INFO - 'PAGER': '/bin/cat', 08:28:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:28:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:28:57 INFO - 'PWD': '/builds/slave/test', 08:28:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:28:57 INFO - 'SHELL': '/bin/bash', 08:28:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QhH7KfDbUz/Listeners', 08:28:57 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 08:28:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:28:57 INFO - 'USER': 'cltbld', 08:28:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:28:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:28:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:28:57 INFO - 'XPC_FLAGS': '0x0', 08:28:57 INFO - 'XPC_SERVICE_NAME': '0', 08:28:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:28:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:28:57 INFO - Downloading/unpacking jsonschema==2.5.1 08:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:59 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:28:59 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:28:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:28:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:28:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:00 INFO - Downloading functools32-3.2.3-2.tar.gz 08:29:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:29:00 INFO - warning: no files found matching '*.txt' 08:29:00 INFO - no previously-included directories found matching 'build' 08:29:00 INFO - no previously-included directories found matching 'dist' 08:29:00 INFO - no previously-included directories found matching '.git*' 08:29:00 INFO - Installing collected packages: jsonschema, functools32 08:29:00 INFO - Running setup.py install for functools32 08:29:00 INFO - warning: no files found matching '*.txt' 08:29:00 INFO - no previously-included directories found matching 'build' 08:29:00 INFO - no previously-included directories found matching 'dist' 08:29:00 INFO - no previously-included directories found matching '.git*' 08:29:00 INFO - Successfully installed jsonschema functools32 08:29:00 INFO - Cleaning up... 08:29:00 INFO - Return code: 0 08:29:00 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1012ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc203da2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010bbd30>, '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 0x100fe2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010b0be8>, '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.kvonCuYj4y/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.QhH7KfDbUz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 08:29:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:29:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:29:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kvonCuYj4y/Render', 08:29:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:29:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:29:00 INFO - 'HOME': '/Users/cltbld', 08:29:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:29:00 INFO - 'LOGNAME': 'cltbld', 08:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:00 INFO - 'MOZ_NO_REMOTE': '1', 08:29:00 INFO - 'NO_EM_RESTART': '1', 08:29:00 INFO - 'PAGER': '/bin/cat', 08:29:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:00 INFO - 'PWD': '/builds/slave/test', 08:29:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:29:00 INFO - 'SHELL': '/bin/bash', 08:29:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QhH7KfDbUz/Listeners', 08:29:00 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 08:29:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:29:00 INFO - 'USER': 'cltbld', 08:29:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:29:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:00 INFO - 'XPC_FLAGS': '0x0', 08:29:00 INFO - 'XPC_SERVICE_NAME': '0', 08:29:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:29:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:00 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:29:00 INFO - Cleaning up... 08:29:00 INFO - Return code: 0 08:29:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1012ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc203da2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010bbd30>, '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 0x100fe2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010b0be8>, '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.kvonCuYj4y/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.QhH7KfDbUz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 08:29:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:29:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:29:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kvonCuYj4y/Render', 08:29:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:29:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:29:00 INFO - 'HOME': '/Users/cltbld', 08:29:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:29:00 INFO - 'LOGNAME': 'cltbld', 08:29:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:00 INFO - 'MOZ_NO_REMOTE': '1', 08:29:00 INFO - 'NO_EM_RESTART': '1', 08:29:00 INFO - 'PAGER': '/bin/cat', 08:29:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:29:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:00 INFO - 'PWD': '/builds/slave/test', 08:29:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:29:00 INFO - 'SHELL': '/bin/bash', 08:29:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QhH7KfDbUz/Listeners', 08:29:00 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 08:29:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:29:00 INFO - 'USER': 'cltbld', 08:29:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:29:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:29:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:00 INFO - 'XPC_FLAGS': '0x0', 08:29:00 INFO - 'XPC_SERVICE_NAME': '0', 08:29:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:29:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:01 INFO - Downloading/unpacking blobuploader==1.2.4 08:29:01 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 08:29:01 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 08:29:01 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 08:29:01 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 08:29:01 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 08:29:01 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 08:29:03 INFO - Downloading blobuploader-1.2.4.tar.gz 08:29:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:29:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:29:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:29:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:29:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:29:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:29:04 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 08:29:04 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 08:29:04 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 08:29:04 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 08:29:04 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 08:29:04 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 08:29:05 INFO - Downloading docopt-0.6.1.tar.gz 08:29:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:29:05 INFO - Installing collected packages: blobuploader, requests, docopt 08:29:05 INFO - Running setup.py install for blobuploader 08:29:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:29:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:29:05 INFO - Running setup.py install for requests 08:29:05 INFO - Running setup.py install for docopt 08:29:05 INFO - Successfully installed blobuploader requests docopt 08:29:05 INFO - Cleaning up... 08:29:06 INFO - Return code: 0 08:29:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:06 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 0x1012ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc203da2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010bbd30>, '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 0x100fe2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010b0be8>, '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.kvonCuYj4y/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.QhH7KfDbUz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 08:29:06 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 08:29:06 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 08:29:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kvonCuYj4y/Render', 08:29:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:29:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:29:06 INFO - 'HOME': '/Users/cltbld', 08:29:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:29:06 INFO - 'LOGNAME': 'cltbld', 08:29:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:06 INFO - 'MOZ_NO_REMOTE': '1', 08:29:06 INFO - 'NO_EM_RESTART': '1', 08:29:06 INFO - 'PAGER': '/bin/cat', 08:29:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:29:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:06 INFO - 'PWD': '/builds/slave/test', 08:29:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:29:06 INFO - 'SHELL': '/bin/bash', 08:29:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QhH7KfDbUz/Listeners', 08:29:06 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 08:29:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:29:06 INFO - 'USER': 'cltbld', 08:29:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:29:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:29:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:06 INFO - 'XPC_FLAGS': '0x0', 08:29:06 INFO - 'XPC_SERVICE_NAME': '0', 08:29:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:29:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:29:06 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-3CxvoX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:29:06 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-0HpNOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:29:06 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-BRNuRi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:29:06 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-y3Tqoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:29:06 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-S2NRQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:29:06 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Ca2rv9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:29:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:29:06 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-XbEzbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:29:07 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Pg6Y0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:29:07 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-NwpbGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:29:07 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-XWTckp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:29:07 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-jVyhtO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:29:07 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-TA18l9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:29:07 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-1MDjdN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:29:07 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Z_M1Xf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:07 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-zn6BI3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:29:07 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-6dczNo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:29:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:29:08 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-2iD8fM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:29:08 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:29:08 INFO - Running setup.py install for manifestparser 08:29:08 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:29:08 INFO - Running setup.py install for mozcrash 08:29:08 INFO - Running setup.py install for mozdebug 08:29:08 INFO - Running setup.py install for mozdevice 08:29:08 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:29:08 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:29:08 INFO - Running setup.py install for mozfile 08:29:08 INFO - Running setup.py install for mozhttpd 08:29:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:29:09 INFO - Running setup.py install for mozinfo 08:29:09 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:29:09 INFO - Running setup.py install for mozInstall 08:29:09 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:29:09 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:29:09 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:29:09 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:29:09 INFO - Running setup.py install for mozleak 08:29:09 INFO - Running setup.py install for mozlog 08:29:09 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:29:09 INFO - Running setup.py install for moznetwork 08:29:09 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:29:09 INFO - Running setup.py install for mozprocess 08:29:09 INFO - Running setup.py install for mozprofile 08:29:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:29:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:29:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:29:10 INFO - Running setup.py install for mozrunner 08:29:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:29:10 INFO - Running setup.py install for mozscreenshot 08:29:10 INFO - Running setup.py install for moztest 08:29:10 INFO - Running setup.py install for mozversion 08:29:10 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:29:10 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:29:10 INFO - Cleaning up... 08:29:10 INFO - Return code: 0 08:29:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:29:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:10 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 0x1012ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc203da2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010bbd30>, '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 0x100fe2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010b0be8>, '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.kvonCuYj4y/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.QhH7KfDbUz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 08:29:10 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 08:29:10 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 08:29:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kvonCuYj4y/Render', 08:29:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:29:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:29:10 INFO - 'HOME': '/Users/cltbld', 08:29:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:29:10 INFO - 'LOGNAME': 'cltbld', 08:29:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:10 INFO - 'MOZ_NO_REMOTE': '1', 08:29:10 INFO - 'NO_EM_RESTART': '1', 08:29:10 INFO - 'PAGER': '/bin/cat', 08:29:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:29:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:10 INFO - 'PWD': '/builds/slave/test', 08:29:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:29:10 INFO - 'SHELL': '/bin/bash', 08:29:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QhH7KfDbUz/Listeners', 08:29:10 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 08:29:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:29:10 INFO - 'USER': 'cltbld', 08:29:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:29:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:29:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:10 INFO - 'XPC_FLAGS': '0x0', 08:29:10 INFO - 'XPC_SERVICE_NAME': '0', 08:29:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:29:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:29:10 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-JU_RPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:29:11 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)) 08:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:29:11 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-i4Vv4Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:29:11 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)) 08:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:29:11 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-01Shjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:29:11 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)) 08:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:29:11 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-y0gtH_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:29:11 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)) 08:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:29:11 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-u6Fq9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:29:11 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)) 08:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:29:11 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-I0pmqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:29:11 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)) 08:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:29:11 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-_HH7wc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:29:11 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)) 08:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:29:11 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-OHkM7I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:29:11 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)) 08:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:29:11 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-EZwApH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:29:11 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)) 08:29:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:29:11 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Riy26L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:29:12 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)) 08:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:29:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-NI8_Zh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:29:12 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)) 08:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:29:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-FSHIC5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:29:12 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)) 08:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:29:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-Ctbgy8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:29:12 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)) 08:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:29:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-9IiROA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:29:12 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)) 08:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-xZBsbc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:29:12 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)) 08:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:29:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-giL_az-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:29:12 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)) 08:29:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:29:12 INFO - Running setup.py (path:/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/pip-v2PKlG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:29:12 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)) 08:29:12 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)) 08:29:12 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)) 08:29:12 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)) 08:29:12 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)) 08:29:12 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)) 08:29:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:29:12 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 08:29:12 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 08:29:12 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 08:29:12 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 08:29:12 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 08:29:12 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 08:29:15 INFO - Downloading blessings-1.6.tar.gz 08:29:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:29:15 INFO - Installing collected packages: blessings 08:29:15 INFO - Running setup.py install for blessings 08:29:15 INFO - Successfully installed blessings 08:29:15 INFO - Cleaning up... 08:29:15 INFO - Return code: 0 08:29:15 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:29:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:29:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:29:16 INFO - Reading from file tmpfile_stdout 08:29:16 INFO - Current package versions: 08:29:16 INFO - blessings == 1.6 08:29:16 INFO - blobuploader == 1.2.4 08:29:16 INFO - docopt == 0.6.1 08:29:16 INFO - functools32 == 3.2.3-2 08:29:16 INFO - jsonschema == 2.5.1 08:29:16 INFO - manifestparser == 1.1 08:29:16 INFO - mozInstall == 1.12 08:29:16 INFO - mozcrash == 1.0 08:29:16 INFO - mozdebug == 0.1 08:29:16 INFO - mozdevice == 0.49 08:29:16 INFO - mozfile == 1.2 08:29:16 INFO - mozhttpd == 0.7 08:29:16 INFO - mozinfo == 0.9 08:29:16 INFO - mozleak == 0.1 08:29:16 INFO - mozlog == 3.4 08:29:16 INFO - moznetwork == 0.27 08:29:16 INFO - mozprocess == 0.25 08:29:16 INFO - mozprofile == 0.28 08:29:16 INFO - mozrunner == 6.13 08:29:16 INFO - mozscreenshot == 0.1 08:29:16 INFO - mozsystemmonitor == 0.3 08:29:16 INFO - moztest == 0.8 08:29:16 INFO - mozversion == 1.4 08:29:16 INFO - psutil == 3.1.1 08:29:16 INFO - requests == 1.2.3 08:29:16 INFO - wsgiref == 0.1.2 08:29:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08: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')]} 08:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:29:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:16 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 0x1012ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc203da2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010bbd30>, '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 0x100fe2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010b0be8>, '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.kvonCuYj4y/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.QhH7KfDbUz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 08:29:16 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 08:29:16 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 08:29:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kvonCuYj4y/Render', 08:29:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:29:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:29:16 INFO - 'HOME': '/Users/cltbld', 08:29:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:29:16 INFO - 'LOGNAME': 'cltbld', 08:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:16 INFO - 'MOZ_NO_REMOTE': '1', 08:29:16 INFO - 'NO_EM_RESTART': '1', 08:29:16 INFO - 'PAGER': '/bin/cat', 08:29:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:16 INFO - 'PWD': '/builds/slave/test', 08:29:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:29:16 INFO - 'SHELL': '/bin/bash', 08:29:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QhH7KfDbUz/Listeners', 08:29:16 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 08:29:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:29:16 INFO - 'USER': 'cltbld', 08:29:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:29:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:16 INFO - 'XPC_FLAGS': '0x0', 08:29:16 INFO - 'XPC_SERVICE_NAME': '0', 08:29:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:29:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:16 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)) 08:29:16 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)) 08:29:16 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)) 08:29:16 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)) 08:29:16 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)) 08:29:16 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)) 08:29:16 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)) 08:29:16 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)) 08:29:16 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)) 08:29:16 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)) 08:29:16 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)) 08:29:16 INFO - Cleaning up... 08:29:16 INFO - Return code: 0 08:29:16 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08: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')]} 08:29:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:29:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08: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')]} 08:29:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:29:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:29:16 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 0x1012ddb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1012e0768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc203da2ed0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1010bbd30>, '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 0x100fe2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010b0be8>, '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.kvonCuYj4y/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.QhH7KfDbUz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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 08:29:16 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 08:29:16 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 08:29:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kvonCuYj4y/Render', 08:29:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:29:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:29:16 INFO - 'HOME': '/Users/cltbld', 08:29:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:29:16 INFO - 'LOGNAME': 'cltbld', 08:29:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:16 INFO - 'MOZ_NO_REMOTE': '1', 08:29:16 INFO - 'NO_EM_RESTART': '1', 08:29:16 INFO - 'PAGER': '/bin/cat', 08:29:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:29:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:16 INFO - 'PWD': '/builds/slave/test', 08:29:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:29:16 INFO - 'SHELL': '/bin/bash', 08:29:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QhH7KfDbUz/Listeners', 08:29:16 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 08:29:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:29:16 INFO - 'USER': 'cltbld', 08:29:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:29:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:29:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:16 INFO - 'XPC_FLAGS': '0x0', 08:29:16 INFO - 'XPC_SERVICE_NAME': '0', 08:29:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:29:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:29:16 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:29:16 INFO - Cleaning up... 08:29:16 INFO - Return code: 0 08:29:16 INFO - Running post-action listener: _resource_record_post_action 08:29:16 INFO - Running post-action listener: _start_resource_monitoring 08:29:16 INFO - Starting resource monitoring. 08:29:16 INFO - [mozharness: 2017-03-10 16:29:16.709663Z] Finished create-virtualenv step (success) 08:29:16 INFO - [mozharness: 2017-03-10 16:29:16.710609Z] Running install step. 08:29:16 INFO - Running pre-action listener: _resource_record_pre_action 08:29:16 INFO - Running main action method: install 08:29:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:29:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:29:16 INFO - Reading from file tmpfile_stdout 08:29:16 INFO - Detecting whether we're running mozinstall >=1.0... 08:29:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:29:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:29:17 INFO - Reading from file tmpfile_stdout 08:29:17 INFO - Output received: 08:29:17 INFO - Usage: mozinstall [options] installer 08:29:17 INFO - Options: 08:29:17 INFO - -h, --help show this help message and exit 08:29:17 INFO - -d DEST, --destination=DEST 08:29:17 INFO - Directory to install application into. [default: 08:29:17 INFO - "/builds/slave/test"] 08:29:17 INFO - --app=APP Application being installed. [default: firefox] 08:29:17 INFO - mkdir: /builds/slave/test/build/application 08:29:17 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'] 08:29:17 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 08:29:37 INFO - Reading from file tmpfile_stdout 08:29:37 INFO - Output received: 08:29:37 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 08:29:37 INFO - Running post-action listener: _resource_record_post_action 08:29:37 INFO - [mozharness: 2017-03-10 16:29:37.209197Z] Finished install step (success) 08:29:37 INFO - [mozharness: 2017-03-10 16:29:37.209367Z] Running run-tests step. 08:29:37 INFO - Running pre-action listener: _resource_record_pre_action 08:29:37 INFO - Running main action method: run_tests 08:29:37 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:29:37 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:29:37 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:29:37 INFO - 2017-03-10 08:29:37.224 screenresolution[1622:7493] starting screenresolution argv=screenresolution get 08:29:37 INFO - 2017-03-10 08:29:37.227 screenresolution[1622:7493] Display 0: 1600x1200x32@60 08:29:37 INFO - 2017-03-10 08:29:37.232 screenresolution[1623:7495] starting screenresolution argv=screenresolution list 08:29:37 INFO - Available Modes on Display 0 08:29:37 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:29:37 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:29:37 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:29:37 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:29:37 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:29:37 INFO - Intel Iris: 08:29:37 INFO - Chipset Model: Intel Iris 08:29:37 INFO - Type: GPU 08:29:37 INFO - Bus: Built-In 08:29:37 INFO - VRAM (Dynamic, Max): 1536 MB 08:29:37 INFO - Vendor: Intel (0x8086) 08:29:37 INFO - Device ID: 0x0a2e 08:29:37 INFO - Revision ID: 0x0009 08:29:37 INFO - Displays: 08:29:37 INFO - Display: 08:29:37 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:29:37 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:29:37 INFO - Display Serial Number: 1600x1200 60 08:29:37 INFO - Main Display: Yes 08:29:37 INFO - Mirror: Off 08:29:37 INFO - Online: Yes 08:29:37 INFO - Rotation: Supported 08:29:37 INFO - Return code: 0 08:29:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:29:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:29:37 INFO - Python 2.7.3 08:29:37 INFO - Return code: 0 08:29:37 INFO - grabbing minidump binary from tooltool 08:29:37 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')]} 08:29:37 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 0x1010bbd30>, '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 0x100fe2db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1010b0be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:29:37 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 08:29:37 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 08:29:37 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 08:29:37 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:29:37 INFO - Return code: 0 08:29:37 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:29:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:29:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:29:37 INFO - ENV: RUST_BACKTRACE is now 1 08:29:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:29:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:29:37 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FiSactJITVirTqYN7bWjJw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--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 08:29:37 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FiSactJITVirTqYN7bWjJw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0029 --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 08:29:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.kvonCuYj4y/Render', 08:29:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:29:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:29:37 INFO - 'HOME': '/Users/cltbld', 08:29:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:29:37 INFO - 'LOGNAME': 'cltbld', 08:29:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:29:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:29:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:29:37 INFO - 'MOZ_NO_REMOTE': '1', 08:29:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:29:37 INFO - 'NO_EM_RESTART': '1', 08:29:37 INFO - 'PAGER': '/bin/cat', 08:29:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:29:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:29:37 INFO - 'PWD': '/builds/slave/test', 08:29:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:29:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:29:37 INFO - 'RUST_BACKTRACE': '1', 08:29:37 INFO - 'SHELL': '/bin/bash', 08:29:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QhH7KfDbUz/Listeners', 08:29:37 INFO - 'TMPDIR': '/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/', 08:29:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:29:37 INFO - 'USER': 'cltbld', 08:29:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:29:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:29:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:29:37 INFO - 'XPC_FLAGS': '0x0', 08:29:37 INFO - 'XPC_SERVICE_NAME': '0', 08:29:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:29:37 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FiSactJITVirTqYN7bWjJw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0029', '--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 08:29:37 INFO - mozversion application_buildid: 20170310065428 08:29:37 INFO - mozversion application_changeset: 528e9dbbb882db0b32792d44b5be9cc539afa1a8 08:29:37 INFO - mozversion application_display_name: Nightly 08:29:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:29:37 INFO - mozversion application_name: Firefox 08:29:37 INFO - mozversion application_remotingname: firefox 08:29:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 08:29:37 INFO - mozversion application_vendor: Mozilla 08:29:37 INFO - mozversion application_version: 55.0a1 08:29:37 INFO - mozversion platform_buildid: 20170310065428 08:29:37 INFO - mozversion platform_changeset: 528e9dbbb882db0b32792d44b5be9cc539afa1a8 08:29:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 08:29:37 INFO - mozversion platform_version: 55.0a1 08:29:37 INFO - using testdate: 1489163377 08:29:37 INFO - actual date: 1489163377 08:29:37 INFO - starting webserver on 'localhost:49244' 08:29:37 INFO - SUITE-START | Running 2 tests 08:29:37 INFO - TEST-START | dromaeo_css 08:29:37 INFO - operating with platform_type : mac_ 08:29:37 INFO - Initialising browser for dromaeo_css test... 08:29:37 INFO - TEST-INFO | started process 1633 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmp35NCOp/profile http://localhost:49244/getInfo.html) 08:29:40 INFO - PROCESS | 1633 | __metrics Screen width/height:1600/1200 08:29:40 INFO - PROCESS | 1633 | colorDepth:24 08:29:40 INFO - PROCESS | 1633 | Browser inner width/height: 1024/689 08:29:40 INFO - PROCESS | 1633 | __metrics 08:29:40 INFO - PROCESS | 1633 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:29:40 INFO - PROCESS | 1633 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:29:41 INFO - TEST-INFO | 1633: exit 0 08:29:41 INFO - Browser initialized. 08:29:41 INFO - Running cycle 1/1 for dromaeo_css test... 08:29:41 INFO - TEST-INFO | started process 1636 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmp35NCOp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:29:53 INFO - PROCESS | 1636 | RSS: Main: 233082880 08:29:53 INFO - PROCESS | 1636 | 08:32:57 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49244/tests/dromaeo/cssquery-ext.html) 08:33:00 INFO - PROCESS | 1636 | RSS: Main: 456458240 08:33:00 INFO - PROCESS | 1636 | 08:34:43 INFO - PROCESS | 1636 | ************************* 08:34:43 INFO - PROCESS | 1636 | A coding exception was thrown and uncaught in a Task. 08:34:43 INFO - PROCESS | 1636 | 08:34:43 ERROR - PROCESS | 1636 | Full message: TypeError: NetworkError when attempting to fetch resource. 08:34:43 INFO - PROCESS | 1636 | Full stack: 08:34:43 INFO - PROCESS | 1636 | ************************* 08:36:03 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-ext.html (next: http://localhost:49244/tests/dromaeo/cssquery-jquery.html) 08:36:04 INFO - PROCESS | 1636 | RSS: Main: 370724864 08:36:04 INFO - PROCESS | 1636 | 08:39:06 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49244/tests/dromaeo/cssquery-mootools.html) 08:39:07 INFO - PROCESS | 1636 | RSS: Main: 359501824 08:39:07 INFO - PROCESS | 1636 | 08:42:09 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49244/tests/dromaeo/cssquery-prototype.html) 08:42:10 INFO - PROCESS | 1636 | RSS: Main: 357793792 08:42:10 INFO - PROCESS | 1636 | 08:45:14 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49244/tests/dromaeo/cssquery-yui.html) 08:45:14 INFO - PROCESS | 1636 | RSS: Main: 343379968 08:45:14 INFO - PROCESS | 1636 | 08:48:17 INFO - PROCESS | 1636 | Cycle 1(1): loaded http://localhost:49244/tests/dromaeo/cssquery-yui.html (next: http://localhost:49244/tests/dromaeo/cssquery-dojo.html) 08:48:18 INFO - PROCESS | 1636 | RSS: Main: 518033408 08:48:18 INFO - PROCESS | 1636 | 08:48:18 INFO - PROCESS | 1636 | __start_tp_report 08:48:18 INFO - PROCESS | 1636 | _x_x_mozilla_page_load 08:48:18 INFO - PROCESS | 1636 | _x_x_mozilla_page_load_details 08:48:18 INFO - PROCESS | 1636 | |i|pagename|runs| 08:48:18 INFO - PROCESS | 1636 | |0;dojo.html;3400.7109395701364;3413.5903691556987;3427.8457469413875;3439.8796042138524;3488.4244099723546;5686.402927692595;5796.594238403313;5911.379305172959;5997.820065398034;6022.096685497172;5787;5821.941780582193;5826.067829147337;5832.941670583293;5841.3282472515675;5176.58587313016;5224.79100835968;5242.292290540785;5287.127623942045;5307.416184219733;5336.6531175473665;5357.357117145929;5360.16917377807;5365.3293338332705;5369.060414427459;5306.071437498423;5309.814156504523;5331.280277162592;5334.786608535654;5337.706426146579;5156.865489592321;5319.946800531984;5332.546733527654;5332.9733351333;5334.359876814788;4627.9768601156775;5181.922271165936;5284.603654725911;5287.154055351164;5330.573554115662;5960.791372301992;6030.758769649209;6055.636661800306;6063;6064.878702425971;6266.968665156691;6293.181886354791;6305.621662700207;6309.621422714652;6312.210973628296;6201;6244.281907580641;6270.65511396873;6304.87390252197;6322.968385158091;4349.847755328548;5871.884341975011;5987.700614969234;5996.370381110008;6000.969995149996;6378.043293505918;6451.838704032437;6469;6472.514561407913;6474.643894585749;6316.147320111818;6321.241451025906;6334.144890439824;6337.2395312562785;6338.619682819046;6126.039906489408;6199.876002480015;6245.313015568284;6295.087212354183;6296.496280297565;6250.062490626351;6275.717592708339;6285.120083188357;6289.40250676185;6291.559590828598;5155.690658560498;5449.100898351807;6215.098810672427;6269.529785266123;6273.278572964076;4309.655227581786;5024.974875125601;5034.622403319692;5049.368828896388;5136.948630513722;4381.3208952612395;4387.583179597933;4395.27477966132;4395.494518130456;4451.376807246988;5868.23712917318;5871.588988770745;5880.26496687914;5900.380460051632;5904.76380944766;6224.719887605069;6261.78083767066;6271.153394291803;6276.717547710364;6281.748730050838;5865.501432378295;5868.061110222344;5874.060150375919;5879.823605291848;5880.294364676266;5537.612367134262;5555.805546805843;5557.3886872444;5566.081596536607;5566.304211973504;6219.720112594944;6304.590201636879;6334.588251763621;6400.007998760199;6419.261784894797;6303.369663033844;6309.905351419824;6314.652694101868;6329.367063293634;6331.303556608861;6459.870802584016;6472.708728107153;6477.093206950936;6482.35176482348;6527.706253218522;6109.083637454418;6144.41628045335;6168.814935551761;6316.305206427382;6336.144620476177;4484.618807401407;6243.968780156252;6277.560570760185;6281.96859015702;6282.120503129657;5804.390538993345;6178.536609754196;6197.628142311476;6289.213848268966;6318.6840657965995;6200.844978875384;6254.593451425642;6259.96870015647;6280.9685951569945;6292.465140463112;4640.605548528278;5936.13925980739;6110.847228819137;6131.601445906002;6132.049532322497;6123.465646421035;6123.465646421035;6135.875804921915;6140.718981675666;6148.354422785722;5937.524998000236;5984.820455386345;5995.250593675791;6001.099835024781;6003 08:48:18 INFO - PROCESS | 1636 | |1;ext.html;646.8641585267094;729.8613263479939;787.1931270447794;794.8171920458294;796.5300472721093;27179.728202717968;37645.68240111597;38089.42865857014;38214;38221.80889095557;39457;39603.40594891079;39626.60373396265;39648.405273920915;39775.40336894942;8914.598843052063;9082.909170908306;9094.49980251086;9096.454212747256;9125.954370228174;7225.060742103519;7449.366803821682;7482.176960534337;7519.624018799038;7523.360514356286;10648;10898.945505272462;11014.889851101507;11038.448077596127;11060.944695276512;10699.518521666543;10804.891951080468;10811.729706757395;10814.783704325948;10838.078763305128;7091.290870912919;9025.638974441015;10543.736406589896;10564.207684423698;10611.734706632318;27051.782669779906;27119.457610847672;27167.728322716914;27214.727852721615;37006.814965925;3718.9442158367647;3830.4445855351096;3839.8080095995088;3885.30064588374;3905.3946638271113;27721.306967325778;27762.722372776214;27764.16707498778;27820.582691259646;27875.02437414701;3042.0721679887624;3132.4518209313505;3182.5862637857163;3215.8070515769127;3229.951550726741;310380;313987;314701;314780;316258;48399.75800121047;48491.5150848487;48590.27114593284;48604.513954860704;48664.75667621639;50486;50531.73670658189;50625.98748025092;50669.746651266505;50675.986480270185;14153.646158846112;14284.214368209849;14299.85700143006;14306.499272525412;14317.35571899267;11624.94187529057;11632.53469861196;11643.88356116428;11659.650210493699;11725.237859539102;9658.227341812639;12146.271223726604;12188.939055304667;12231.694207644701;12264.81602775959;5219.451957544479;5251.474852514718;5261.342332208474;5274.841754747364;5285.550728188147;857.6920196699957;911.3392790227165;934.8971613122551;939.9718008459757;960.1118964957526;23620.291391258288;24622.753772462045;27360.716713994447;27410.5888411674;27426.76579553925;882.1839798186652;1002.7042022603349;1020.2501161646184;1023.8976102389851;1047.4448542272607;12134.757304853854;13373.39819708096;13810.37853296604;14157.362918668685;14159.85840141606;380743;447414;448177;448905;449517;53298.20052699213;53366.73316633392;53397.46602533925;53442.73278633582;53830.73084634552;1201.8257352683638;1331.088204579866;1396.57404491629;1396.8952328575397;1403.9157650541204;19730.80269197347;28811.711882880903;29808.403831922806;29888.333574172786;29907.908345930777;49862.50137498578;50040.49959500504;50131.24803127883;50215.47198864124;50421.49578504168;459900.70049649535;459970;460411;460890;461176;32890.684372624826;32980.1754956128;33051.66948330486;33116.1720956978;33190;33208.50187247145;41969.58030419657;42036.738897833115;42425.36361954511;42553.36169957515;24549;31385.372292553566;32289.51565726563;32315;33976;33531.497027544116;33625;33655.66344336525;34860;35121.82439087788;34718.47922281118;35483.82258088693;35564;35593.1101722459;35674;28082.85958570194;29146.7085329144;30198.62119992633;30258.54612180863;30279.69720302769;22117.889410552845;22704.545909081397;23375.41561460977;23377.649335260325;23415.297541073796 08:48:18 INFO - PROCESS | 1636 | |2;jquery.html;362.58698362398235;368.963103689631;374.5935659809107;394.2961813163504;436.98401217170067;14192.929035354822;14233.359498822552;17285;21883;22542.54914901701;21757.25941924646;21846.781532184672;22640.754758488278;23635;23878.40303992401;6043.939560604382;6125.111858780474;6175.691215439232;6731.56244844086;6794.165575294667;6542.247641521239;6730.798076057726;6894.896576551356;6896.931030689679;6904.930950690504;6748.527603067787;6849.7602583909575;6850.48621353398;6853.485988550854;6857.931420685779;6836.965815170917;6840.65796710165;7373.926260737431;7769.223077692185;7999.160088190714;7398.630068496554;7629.771106866803;7730;7750.379969602418;7752.7674169775;29768.851155744298;30145.69854301473;30363.392732145454;30759.846200768854;31218.063458096294;2879.2370021944203;2943.690912454183;2972.3758010817755;2996.6703662597097;3109.362580670957;16521.91739041297;17448.38930637434;17702.380416685482;17738.29046838125;18425.815741842544;1799.5718156911105;1998.4504261328252;2033.766116896561;2035.837133029369;2054.9178032878667;160447;162567.1871640646;166308;168882.1555892225;169946;19327.710084348746;23046.8847655764;23321.7667823323;23682.881585592306;23941.7605823943;42126;42259.36610950838;42301.36547951783;42357.788211058745;42445.57554424416;8694.869666943383;10342;10466.790664186674;10693.732656683489;10947.069499092508;8520.147985201555;8541.402101852935;8579.356548258906;8750.518721470253;8756.343274254456;8896.729569806399;10243.026912443305;10943.890561094287;11070.833937490945;11074.944625276821;4190.895227619273;4255.3616957456625;4295.72077814941;4306.590873866978;4312.223799716081;1000.1598657128047;1032.8863824979246;1051.2588625019343;1053.8788039375418;1084.5282302198568;23355.53288934246;23368.766312337;23826;23870.641940370908;23916.162934297216;1034.3897100710617;1044.8380501022355;1058.9682309530726;1091.4870011094772;1095.5727266366123;10384.051246744628;11427.371494567878;12213.389330533439;12290.692732681575;12302.876971230353;681808;690183;693957;699122.5833545804;720376;94681.0531894686;154141;154248.68626970606;158810;160546;1174.36584244507;1278.8465384153776;1299.9675008124684;1325.1504379776763;1337.8260826092546;19361.709574356115;19708;20539;20639.587208256053;20789.272375466786;43559;44655.385060944005;62522;62901.37098628955;63618;88027.55986220027;88971.11028889887;90063;91304;92929;11043.83434248503;11800.226946667697;11917.463714132711;11934.52261909514;12287.631371058882;11965.880341196826;12047.74710828089;12062.819057713965;13311.400986955416;13712.725745485233;11109.833352499558;11163.609273675707;11367.431628418712;11417.1437142213;11561.595344162914;11366.033887119687;11568.479418426023;11632.835820895523;11724.531018759155;11786.76426471483;10414.313558898375;11083.612073577386;11375.829362559734;11976.700582485508;12001.979831714052;9316.813663726824;11741.884520970494;11825.881741182822;12186.329751863732;12190.390480475764;10695.839562406414;11283.830742538705;11356.148288878201;11639.127065469955;11652.475638596114 08:48:18 INFO - PROCESS | 1636 | |3;mootools.html;1289.0847498276223;1543.0433131458497;1574.551252892925;1606.2450648195352;1608.6782643471306;8135.959320203398;9600.1359877611;9889.40663560185;10602.098821600164;11032.834507482374;10692.679219623404;10779.730506737336;10789.83815242772;10790.946045269762;10791.19066070044;2091.9853870872616;2260.8191344692386;2309.872956987365;2332.9883350583223;2349.6358064499946;1868.224686754995;1975.841932645392;2003.5692326149874;2086.259377920839;2100.4223838444395;2022.0698478699817;2254.323702889135;2334.6147885598857;2336.077249486452;2343.8359314847967;2332.5101728637005;2332.5801355756043;2342.941426464335;2349.565330413879;2353;2244.438890277431;2329;2337.3338598499345;2338.6024375856146;2340.169239919821;10301.433421161833;10398.480075996169;10409.375437473776;10412.3752574845;10413.635522756667;4735.455422626407;5815.709214539256;5850.882982340329;5858.384869588717;5878.470937615635;3272.640009598942;3357.2278375973665;3493.877714279988;3556.893293201208;3569.6787289144104;1150.9539618415254;1154.417019405195;1194.8984336331423;1199.7540504196618;1210;15305.46430874914;15521.611959700986;15558.533244002698;15562;15706.371745130182;4738.07607516531;4759.976200118977;4855.44162421319;4863.051704917507;4946.950530494649;12547.811782823264;12567.434465448894;12578.874211257953;12599.118061735591;12620.990320774315;5868.67722275279;5868.794592189253;5870.530357571384;5880.441358070976;5887.970560147258;4814.494478079821;5082.2122571001555;5148.176291793295;5161.845144645667;5185.637005409585;3544.7518673692593;3857.556381016163;3932.2528719543197;4012.61880121388;4021.859234926822;1048.528162326956;1054.5887104029434;1056.392574269798;1058.1323314881722;1060.6340812419703;781.7576551269125;911.8404279251105;934.8083642853198;950.4154944709093;953.8839557717487;6540.345965403517;6543.9345606544275;6754.18949726036;6809.863802723918;6850.623215723183;1007.7077647482295;1026.6406757634918;1039.1738567838586;1061.124572227915;1071.0414179309475;4214.346776249687;4217.219814334358;4279.957200428018;4388.1223755249075;4426.44669416323;13345.266010369523;13748.793768093487;13777.724445511234;13777.862221377858;13794.93102534481;13387.06290559671;13579.728405431835;13630.182189068688;13752.724945501033;13754.587362379145;8306.753986901893;9814.901850981541;9995.250356223312;10019.398836069859;10023.148032417326;6339.461145802658;6645.335466453316;6701.765438209639;6847.486438517031;6937.445004399737;10195.439250841275;10796.56813727442;10807.081398080936;11208.943955280172;12042.096842736655;11830.053595712494;12214.206076604993;12282.692932676755;12289.877101228873;12302.077344199042;9002.279817614444;9182.816343673223;9381.85927211106;9400.717978460658;9441.811163776549;10176.389416634729;10194.184465242912;10302;10303.587856485656;10322.432266225429;8937.776555586162;9076.31927605419;9137.725868223964;9146.679866204651;9349.065093490597;8782.473051616924;8824.117588241124;8842.24840888506;8880.955595221982;9146.576157318183;7826.804329891798;7997.200279971957;7997.280244777998;8007.559584222924;8012.559309238048;5224.58203343724;5539.529140023144;5681.687507187145;5766.452187042224;5956.183364073999;5812.68030258323;5829.417058294137;6025.276966764016;6057.969710151421;6199.597026193283 08:48:18 INFO - PROCESS | 1636 | |4;prototype.html;368.8543025504924;377.8450835157586;386.6520131881308;387.0884068019815;391.94120881867724;4063.4108054332105;4578.54214578542;4883.658143929926;4930.013997200565;5043.672161309512;4018.7990600469934;4488.775561221934;4843.709377437347;4906.852794416164;5021.221710634857;4148.838325268915;4156.771377574225;4160.750354978711;4205.158968206356;4205.327147656376;4178.537511870836;4178.621055051825;4215.283401821683;4230.703850730435;4253.2769429197115;3439.63883792202;3608.1057444841404;4052.9594704053025;4105.856295029675;4203.85286514972;4085.4280400743623;4104.42538044674;4114.794260286973;4138.255114079465;4164.250434921712;3012.4276387486307;3330.6669333066743;3642.6357364263627;3797;3802.182530755873;4491.708038977488;4635.496831710906;4639.814407423699;4860.927086093711;4932.778024988848;3948.486696729407;4239.442599205866;4281.801095693211;4794.086061786662;4799.376081109468;4943.058879966415;4983.25586044885;5307.867303317409;5341.252224688546;5397.514223719884;3946.427767973628;4225.640820530259;4287.399764033006;4295.398644189816;4309.922519370158;4988.7505624718615;5008.799648014112;5193.818216362409;5228.353068783283;5637.577181711388;3705.5182826232417;4236.512801027921;4332.783360831946;4337.024169561823;4372.759498227564;4152.998916565594;4395.780210989437;4431.268840641258;4438.60052595268;4442.3336499524685;3894.668953139015;4503.819847206075;4780.259059845729;4803.823063349501;4821.397325334333;4787.3776409066595;5198.610104242197;5315.654482458628;5315.8570907255125;5349.384820745586;1344.1666166976538;1352.4252192818012;1465.6482444213311;1470.713210923881;1477.1580199286304;974.8927617962019;1032.8863824979246;1044.7984817459983;1097.5445190246119;1130.3669944830922;4338.897688152986;4408.801603927831;4503.959827116749;4999.750212319499;5122.538971492583;4733.384659994179;4962.652614316963;5467.425920278313;5498.422665620053;5521.779128834802;4547.977260113678;4653.534136746914;4819.469858315582;4943.629227807929;5088.440271570198;2606.4656745367156;2671.666041744782;2846.018123747304;2848.843313617771;2870.583765354054;5154.92267615986;5201.141811601044;5578.97210513953;5696.547380417966;5741.138829175574;4971.6768410053955;4983.90032199354;5493.670379777226;5640.746166422521;5690.573207009491;4815.858361808771;5090.821821236313;5717.285339332583;5755.8561035974435;5806.171056117394;4498.470520023207;4779.3199236588325;4840.104580652591;5283.5773138149625;5542.9168562472405;4876.29293752411;5133.460986596503;5157.690538567698;5168.046444470058;5439.619226654097;5008.899822003613;5495.560355171657;5665.376808551138;5695.601307908572;5736.6558006519745;4043.797810109424;4324.524302326805;4328.588784065509;4330.935035974526;4337.375887587964;4756.5492524780275;4878.5853202476765;4990.525900039491;5050.787810925425;5185.896282074413;4415.751711328434;4509.647105868292;4707.4821769606;4847.5394837490385;5019.498050194951;4667.439907211156;5123.820666276662;5300.337457817773;5307.893842123059;5313.814016509558;4368.347709689171;4748.92876606858;5198.2202669599865;5295.311609490742;5301.204819277139;4873.616471046297;4989.501049894981;5429.344050064768;5432.6468779529205;5442.374126975448;4637.373954516097;4816.831410900601;4911.4106307243355;5253.842384728464;5280.445553216857 08:48:18 INFO - PROCESS | 1636 | |5;yui.html;713.3686687281761;716.2550947015104;739.9852002959941;816.5060138616136;878;15103.773443398359;15675.529734107995;15946.441874534394;15947.92026039871;15949.68100637988;14039.298035098229;14412.711745765078;14436.278186090705;14590.562283131523;14610.19643919584;912.8083102548472;948.4593781544522;952.6665667016558;952.8046750416148;953.0374321934827;938.3947353956728;949.1694767078806;953.408886490377;962.5043102802027;980.0101897083925;1026.2508368890676;1029.5058371981454;1030.587764894041;1031.092638478142;1034.1158309645257;1023.488255872064;1024.2318261304022;1025.0262250861638;1026.5021464589668;1027.4143738069304;762.1730422491603;763.2520130272364;765.8238605120854;766.1380946435261;768.1703759939252;15740.842591574052;16046.75929861053;16112.516624501284;16188.676226475405;16297.103659298733;14462.927685361507;14543.200123993176;14596.197209153492;14656.267186640625;14689.559313220621;11620.360880151673;11724.648260552198;11806.173567850254;12021.459034343476;12259.570915018021;3614.9873640259293;3733.3653278942643;3883.59222281662;3897.4933258676474;3897.7661340319673;104139;106923;107244;108724;109243;10640.46797660114;11103.278286911325;11307.886921130683;11329.94335028336;11960.820587691192;24660.506789864103;24671;24679;24902.252932412055;25014;7680.80797980055;7989.3209077229085;8050.879236811453;8055.315298199602;8163.755087347389;4140.523839758466;4247.766372849523;4416.757078360721;4443.022535042285;4483.955160448419;3509.701675357572;3621.927561448809;3622.4747411625167;3625.3655610268097;3625.492431059654;610.3228050992803;633.4077637408946;634.1724050114552;637.4199478474566;641.1024565608186;559.829252078112;560.1877277946912;573.9655620662774;582.3652219081222;587.3949831673383;8057.838843223103;10676.466176691134;10800.541926839933;10866.45667716611;11380;520.2752874222018;557.345119484612;604.585858686801;644.3170239546096;684.710930106969;4172.102997855475;4345.630621397154;4876.860030237922;4914.725292200031;4931.457539670633;86259.56870215609;91812;92879.2136235914;93542;94722;58231.70884145637;66820;68144.6592767033;81252.59373703094;81393.59303203446;43274.88803676495;66576.6671166641;74136.88794668192;75793;76429;10577.100946419641;10611.363318200623;10691.946540267249;10799.730006749895;10818;48965.0206995851;49981.75009124931;50789;50927.47729159739;51624.70938226574;44391;60835.39164608297;61463.692681538094;62333.68833155987;63093.36906630875;12463.376831158586;13123.343832808512;13665.453381864614;13727.588172354845;14120.50578229757;14504.047330247462;14543.906459613001;14641.121532708072;14651.706965860836;14792.852071479578;13062.020348473712;13195.274259915797;13345.599632011055;13355;13569.86430135686;13684.726305473636;13685.693311906069;14016.369263383376;14194.148351098967;14241.572752817432;13295;13410;13419.731605368033;13490.932545337211;14115.435382584992;10903.945480272549;11072.39101849406;11106.167037472384;11230.94384528072;11628.825567616323;8618.52598107085;9335.346525743133;11039.724006899893;11114;11260.94369528147 08:48:18 INFO - PROCESS | 1636 | __end_tp_report 08:48:18 INFO - PROCESS | 1636 | __start_cc_report 08:48:18 INFO - PROCESS | 1636 | _x_x_mozilla_cycle_collect,2780 08:48:18 INFO - PROCESS | 1636 | __end_cc_report 08:48:18 INFO - PROCESS | 1636 | __startTimestamp1489164498228__endTimestamp 08:48:18 INFO - PROCESS | 1636 | 08:48:18 INFO - PROCESS | 1636 | ------- Summary: start ------- 08:48:18 INFO - PROCESS | 1636 | Number of tests: 6 08:48:18 INFO - PROCESS | 1636 | 08:48:18 INFO - PROCESS | 1636 | [#0] dojo.html Cycles:165 Average:5799.79 Median:6030.76 stddev:679.61 (11.3%) stddev-sans-first:655.12 08:48:18 INFO - PROCESS | 1636 | Values: 3400.7 3413.6 3427.8 3439.9 3488.4 5686.4 5796.6 5911.4 5997.8 6022.1 5787.0 5821.9 5826.1 5832.9 5841.3 5176.6 5224.8 5242.3 5287.1 5307.4 5336.7 5357.4 5360.2 5365.3 5369.1 5306.1 5309.8 5331.3 5334.8 5337.7 5156.9 5319.9 5332.5 5333.0 5334.4 4628.0 5181.9 5284.6 5287.2 5330.6 5960.8 6030.8 6055.6 6063.0 6064.9 6267.0 6293.2 6305.6 6309.6 6312.2 6201.0 6244.3 6270.7 6304.9 6323.0 4349.8 5871.9 5987.7 5996.4 6001.0 6378.0 6451.8 6469.0 6472.5 6474.6 6316.1 6321.2 6334.1 6337.2 6338.6 6126.0 6199.9 6245.3 6295.1 6296.5 6250.1 6275.7 6285.1 6289.4 6291.6 5155.7 5449.1 6215.1 6269.5 6273.3 4309.7 5025.0 5034.6 5049.4 5136.9 4381.3 4387.6 4395.3 4395.5 4451.4 5868.2 5871.6 5880.3 5900.4 5904.8 6224.7 6261.8 6271.2 6276.7 6281.7 5865.5 5868.1 5874.1 5879.8 5880.3 5537.6 5555.8 5557.4 5566.1 5566.3 6219.7 6304.6 6334.6 6400.0 6419.3 6303.4 6309.9 6314.7 6329.4 6331.3 6459.9 6472.7 6477.1 6482.4 6527.7 6109.1 6144.4 6168.8 6316.3 6336.1 4484.6 6244.0 6277.6 6282.0 6282.1 5804.4 6178.5 6197.6 6289.2 6318.7 6200.8 6254.6 6260.0 6281.0 6292.5 4640.6 5936.1 6110.8 6131.6 6132.0 6123.5 6123.5 6135.9 6140.7 6148.4 5937.5 5984.8 5995.3 6001.1 6003.0 08:48:18 INFO - PROCESS | 1636 | 08:48:18 INFO - PROCESS | 1636 | [#1] ext.html Cycles:180 Average:53890.72 Median:33370.00 stddev:108441.49 (325.0%) stddev-sans-first:108672.01 08:48:18 INFO - PROCESS | 1636 | Values: 646.9 729.9 787.2 794.8 796.5 27179.7 37645.7 38089.4 38214.0 38221.8 39457.0 39603.4 39626.6 39648.4 39775.4 8914.6 9082.9 9094.5 9096.5 9126.0 7225.1 7449.4 7482.2 7519.6 7523.4 10648.0 10898.9 11014.9 11038.4 11060.9 10699.5 10804.9 10811.7 10814.8 10838.1 7091.3 9025.6 10543.7 10564.2 10611.7 27051.8 27119.5 27167.7 27214.7 37006.8 3718.9 3830.4 3839.8 3885.3 3905.4 27721.3 27762.7 27764.2 27820.6 27875.0 3042.1 3132.5 3182.6 3215.8 3230.0 310380.0 313987.0 314701.0 314780.0 316258.0 48399.8 48491.5 48590.3 48604.5 48664.8 50486.0 50531.7 50626.0 50669.7 50676.0 14153.6 14284.2 14299.9 14306.5 14317.4 11624.9 11632.5 11643.9 11659.7 11725.2 9658.2 12146.3 12188.9 12231.7 12264.8 5219.5 5251.5 5261.3 5274.8 5285.6 857.7 911.3 934.9 940.0 960.1 23620.3 24622.8 27360.7 27410.6 27426.8 882.2 1002.7 1020.3 1023.9 1047.4 12134.8 13373.4 13810.4 14157.4 14159.9 380743.0 447414.0 448177.0 448905.0 449517.0 53298.2 53366.7 53397.5 53442.7 53830.7 1201.8 1331.1 1396.6 1396.9 1403.9 19730.8 28811.7 29808.4 29888.3 29907.9 49862.5 50040.5 50131.2 50215.5 50421.5 459900.7 459970.0 460411.0 460890.0 461176.0 32890.7 32980.2 33051.7 33116.2 33190.0 33208.5 41969.6 42036.7 42425.4 42553.4 24549.0 31385.4 32289.5 32315.0 33976.0 33531.5 33625.0 33655.7 34860.0 35121.8 34718.5 35483.8 35564.0 35593.1 35674.0 28082.9 29146.7 30198.6 30258.5 30279.7 22117.9 22704.5 23375.4 23377.6 23415.3 08:48:18 INFO - PROCESS | 1636 | 08:48:18 INFO - PROCESS | 1636 | [#2] jquery.html Cycles:180 Average:42253.22 Median:21802.02 stddev:116886.74 (536.1%) stddev-sans-first:117172.32 08:48:18 INFO - PROCESS | 1636 | Values: 362.6 369.0 374.6 394.3 437.0 14192.9 14233.4 17285.0 21883.0 22542.5 21757.3 21846.8 22640.8 23635.0 23878.4 6043.9 6125.1 6175.7 6731.6 6794.2 6542.2 6730.8 6894.9 6896.9 6904.9 6748.5 6849.8 6850.5 6853.5 6857.9 6837.0 6840.7 7373.9 7769.2 7999.2 7398.6 7629.8 7730.0 7750.4 7752.8 29768.9 30145.7 30363.4 30759.8 31218.1 2879.2 2943.7 2972.4 2996.7 3109.4 16521.9 17448.4 17702.4 17738.3 18425.8 1799.6 1998.5 2033.8 2035.8 2054.9 160447.0 162567.2 166308.0 168882.2 169946.0 19327.7 23046.9 23321.8 23682.9 23941.8 42126.0 42259.4 42301.4 42357.8 42445.6 8694.9 10342.0 10466.8 10693.7 10947.1 8520.1 8541.4 8579.4 8750.5 8756.3 8896.7 10243.0 10943.9 11070.8 11074.9 4190.9 4255.4 4295.7 4306.6 4312.2 1000.2 1032.9 1051.3 1053.9 1084.5 23355.5 23368.8 23826.0 23870.6 23916.2 1034.4 1044.8 1059.0 1091.5 1095.6 10384.1 11427.4 12213.4 12290.7 12302.9 681808.0 690183.0 693957.0 699122.6 720376.0 94681.1 154141.0 154248.7 158810.0 160546.0 1174.4 1278.8 1300.0 1325.2 1337.8 19361.7 19708.0 20539.0 20639.6 20789.3 43559.0 44655.4 62522.0 62901.4 63618.0 88027.6 88971.1 90063.0 91304.0 92929.0 11043.8 11800.2 11917.5 11934.5 12287.6 11965.9 12047.7 12062.8 13311.4 13712.7 11109.8 11163.6 11367.4 11417.1 11561.6 11366.0 11568.5 11632.8 11724.5 11786.8 10414.3 11083.6 11375.8 11976.7 12002.0 9316.8 11741.9 11825.9 12186.3 12190.4 10695.8 11283.8 11356.1 11639.1 11652.5 08:48:18 INFO - PROCESS | 1636 | 08:48:18 INFO - PROCESS | 1636 | [#3] mootools.html Cycles:180 Average:6659.77 Median:2346.70 stddev:4191.19 (178.6%) stddev-sans-first:4183.52 08:48:18 INFO - PROCESS | 1636 | Values: 1289.1 1543.0 1574.6 1606.2 1608.7 8136.0 9600.1 9889.4 10602.1 11032.8 10692.7 10779.7 10789.8 10790.9 10791.2 2092.0 2260.8 2309.9 2333.0 2349.6 1868.2 1975.8 2003.6 2086.3 2100.4 2022.1 2254.3 2334.6 2336.1 2343.8 2332.5 2332.6 2342.9 2349.6 2353.0 2244.4 2329.0 2337.3 2338.6 2340.2 10301.4 10398.5 10409.4 10412.4 10413.6 4735.5 5815.7 5850.9 5858.4 5878.5 3272.6 3357.2 3493.9 3556.9 3569.7 1151.0 1154.4 1194.9 1199.8 1210.0 15305.5 15521.6 15558.5 15562.0 15706.4 4738.1 4760.0 4855.4 4863.1 4947.0 12547.8 12567.4 12578.9 12599.1 12621.0 5868.7 5868.8 5870.5 5880.4 5888.0 4814.5 5082.2 5148.2 5161.8 5185.6 3544.8 3857.6 3932.3 4012.6 4021.9 1048.5 1054.6 1056.4 1058.1 1060.6 781.8 911.8 934.8 950.4 953.9 6540.3 6543.9 6754.2 6809.9 6850.6 1007.7 1026.6 1039.2 1061.1 1071.0 4214.3 4217.2 4280.0 4388.1 4426.4 13345.3 13748.8 13777.7 13777.9 13794.9 13387.1 13579.7 13630.2 13752.7 13754.6 8306.8 9814.9 9995.3 10019.4 10023.1 6339.5 6645.3 6701.8 6847.5 6937.4 10195.4 10796.6 10807.1 11208.9 12042.1 11830.1 12214.2 12282.7 12289.9 12302.1 9002.3 9182.8 9381.9 9400.7 9441.8 10176.4 10194.2 10302.0 10303.6 10322.4 8937.8 9076.3 9137.7 9146.7 9349.1 8782.5 8824.1 8842.2 8881.0 9146.6 7826.8 7997.2 7997.3 8007.6 8012.6 5224.6 5539.5 5681.7 5766.5 5956.2 5812.7 5829.4 6025.3 6058.0 6199.6 08:48:18 INFO - PROCESS | 1636 | 08:48:18 INFO - PROCESS | 1636 | [#4] prototype.html Cycles:180 Average:4386.04 Median:4767.93 stddev:1218.15 (25.5%) stddev-sans-first:1183.66 08:48:18 INFO - PROCESS | 1636 | Values: 368.9 377.8 386.7 387.1 391.9 4063.4 4578.5 4883.7 4930.0 5043.7 4018.8 4488.8 4843.7 4906.9 5021.2 4148.8 4156.8 4160.8 4205.2 4205.3 4178.5 4178.6 4215.3 4230.7 4253.3 3439.6 3608.1 4053.0 4105.9 4203.9 4085.4 4104.4 4114.8 4138.3 4164.3 3012.4 3330.7 3642.6 3797.0 3802.2 4491.7 4635.5 4639.8 4860.9 4932.8 3948.5 4239.4 4281.8 4794.1 4799.4 4943.1 4983.3 5307.9 5341.3 5397.5 3946.4 4225.6 4287.4 4295.4 4309.9 4988.8 5008.8 5193.8 5228.4 5637.6 3705.5 4236.5 4332.8 4337.0 4372.8 4153.0 4395.8 4431.3 4438.6 4442.3 3894.7 4503.8 4780.3 4803.8 4821.4 4787.4 5198.6 5315.7 5315.9 5349.4 1344.2 1352.4 1465.6 1470.7 1477.2 974.9 1032.9 1044.8 1097.5 1130.4 4338.9 4408.8 4504.0 4999.8 5122.5 4733.4 4962.7 5467.4 5498.4 5521.8 4548.0 4653.5 4819.5 4943.6 5088.4 2606.5 2671.7 2846.0 2848.8 2870.6 5154.9 5201.1 5579.0 5696.5 5741.1 4971.7 4983.9 5493.7 5640.7 5690.6 4815.9 5090.8 5717.3 5755.9 5806.2 4498.5 4779.3 4840.1 5283.6 5542.9 4876.3 5133.5 5157.7 5168.0 5439.6 5008.9 5495.6 5665.4 5695.6 5736.7 4043.8 4324.5 4328.6 4330.9 4337.4 4756.5 4878.6 4990.5 5050.8 5185.9 4415.8 4509.6 4707.5 4847.5 5019.5 4667.4 5123.8 5300.3 5307.9 5313.8 4368.3 4748.9 5198.2 5295.3 5301.2 4873.6 4989.5 5429.3 5432.6 5442.4 4637.4 4816.8 4911.4 5253.8 5280.4 08:48:18 INFO - PROCESS | 1636 | 08:48:18 INFO - PROCESS | 1636 | [#5] yui.html Cycles:180 Average:19394.70 Median:24958.13 stddev:26738.16 (107.1%) stddev-sans-first:26776.37 08:48:18 INFO - PROCESS | 1636 | Values: 713.4 716.3 740.0 816.5 878.0 15103.8 15675.5 15946.4 15947.9 15949.7 14039.3 14412.7 14436.3 14590.6 14610.2 912.8 948.5 952.7 952.8 953.0 938.4 949.2 953.4 962.5 980.0 1026.3 1029.5 1030.6 1031.1 1034.1 1023.5 1024.2 1025.0 1026.5 1027.4 762.2 763.3 765.8 766.1 768.2 15740.8 16046.8 16112.5 16188.7 16297.1 14462.9 14543.2 14596.2 14656.3 14689.6 11620.4 11724.6 11806.2 12021.5 12259.6 3615.0 3733.4 3883.6 3897.5 3897.8 104139.0 106923.0 107244.0 108724.0 109243.0 10640.5 11103.3 11307.9 11329.9 11960.8 24660.5 24671.0 24679.0 24902.3 25014.0 7680.8 7989.3 8050.9 8055.3 8163.8 4140.5 4247.8 4416.8 4443.0 4484.0 3509.7 3621.9 3622.5 3625.4 3625.5 610.3 633.4 634.2 637.4 641.1 559.8 560.2 574.0 582.4 587.4 8057.8 10676.5 10800.5 10866.5 11380.0 520.3 557.3 604.6 644.3 684.7 4172.1 4345.6 4876.9 4914.7 4931.5 86259.6 91812.0 92879.2 93542.0 94722.0 58231.7 66820.0 68144.7 81252.6 81393.6 43274.9 66576.7 74136.9 75793.0 76429.0 10577.1 10611.4 10691.9 10799.7 10818.0 48965.0 49981.8 50789.0 50927.5 51624.7 44391.0 60835.4 61463.7 62333.7 63093.4 12463.4 13123.3 13665.5 13727.6 14120.5 14504.0 14543.9 14641.1 14651.7 14792.9 13062.0 13195.3 13345.6 13355.0 13569.9 13684.7 13685.7 14016.4 14194.1 14241.6 13295.0 13410.0 13419.7 13490.9 14115.4 10903.9 11072.4 11106.2 11230.9 11628.8 8618.5 9335.3 11039.7 11114.0 11260.9 08:48:18 INFO - PROCESS | 1636 | -------- Summary: end -------- 08:48:18 INFO - PROCESS | 1636 | 08:48:18 INFO - TEST-INFO | 1636: exit 0 08:48:18 INFO - TEST-OK | dromaeo_css | took 1121127ms 08:48:18 INFO - TEST-START | kraken 08:48:18 INFO - operating with platform_type : mac_ 08:48:18 INFO - Initialising browser for kraken test... 08:48:18 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpJjr6FF/profile http://localhost:49244/getInfo.html) 08:48:21 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 08:48:21 INFO - PROCESS | 1647 | colorDepth:24 08:48:21 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 08:48:21 INFO - PROCESS | 1647 | __metrics 08:48:21 INFO - PROCESS | 1647 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:48:21 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] 08:48:22 INFO - TEST-INFO | 1647: exit 0 08:48:22 INFO - Browser initialized. 08:48:22 INFO - Running cycle 1/1 for kraken test... 08:48:22 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/T/tmpJjr6FF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:48:34 INFO - PROCESS | 1649 | RSS: Main: 233185280 08:48:34 INFO - PROCESS | 1649 | 08:48:37 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection) 08:48:37 INFO - PROCESS | 1649 | RSS: Main: 285196288 08:48:37 INFO - PROCESS | 1649 | 08:48:40 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-dft) 08:48:41 INFO - PROCESS | 1649 | RSS: Main: 286830592 08:48:41 INFO - PROCESS | 1649 | 08:48:44 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-fft) 08:48:45 INFO - PROCESS | 1649 | RSS: Main: 378003456 08:48:45 INFO - PROCESS | 1649 | 08:48:47 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator) 08:48:47 INFO - PROCESS | 1649 | RSS: Main: 281120768 08:48:47 INFO - PROCESS | 1649 | 08:48:49 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:48:50 INFO - PROCESS | 1649 | RSS: Main: 283951104 08:48:50 INFO - PROCESS | 1649 | 08:48:53 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom) 08:48:54 INFO - PROCESS | 1649 | RSS: Main: 324669440 08:48:54 INFO - PROCESS | 1649 | 08:48:57 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate) 08:48:57 INFO - PROCESS | 1649 | RSS: Main: 329154560 08:48:57 INFO - PROCESS | 1649 | 08:49:00 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial) 08:49:01 INFO - PROCESS | 1649 | RSS: Main: 329854976 08:49:01 INFO - PROCESS | 1649 | 08:49:02 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:49:03 INFO - PROCESS | 1649 | RSS: Main: 303341568 08:49:03 INFO - PROCESS | 1649 | 08:49:05 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:49:05 INFO - PROCESS | 1649 | RSS: Main: 308166656 08:49:05 INFO - PROCESS | 1649 | 08:49:08 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:49:08 INFO - PROCESS | 1649 | RSS: Main: 310190080 08:49:08 INFO - PROCESS | 1649 | 08:49:11 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:49:12 INFO - PROCESS | 1649 | RSS: Main: 325525504 08:49:12 INFO - PROCESS | 1649 | 08:49:15 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:49:16 INFO - PROCESS | 1649 | RSS: Main: 318906368 08:49:16 INFO - PROCESS | 1649 | 08:49:17 INFO - PROCESS | 1649 | Cycle 1(1): loaded http://localhost:49244/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49244/tests/kraken/driver.html?testName=ai-astar) 08:49:18 INFO - PROCESS | 1649 | RSS: Main: 364183552 08:49:18 INFO - PROCESS | 1649 | 08:49:18 INFO - PROCESS | 1649 | __start_tp_report 08:49:18 INFO - PROCESS | 1649 | _x_x_mozilla_page_load 08:49:18 INFO - PROCESS | 1649 | _x_x_mozilla_page_load_details 08:49:18 INFO - PROCESS | 1649 | |i|pagename|runs| 08:49:18 INFO - PROCESS | 1649 | |0;ai-astar;114;115;113;114;114;114;114;114;114;112 08:49:18 INFO - PROCESS | 1649 | |1;audio-beat-detection;153;112;109;150;113;111;110;110;127;110 08:49:18 INFO - PROCESS | 1649 | |2;audio-dft;186;184;184;186;236;244;180;184;183;184 08:49:18 INFO - PROCESS | 1649 | |3;audio-fft;81;61;59;88;63;58;61;59;75;60 08:49:18 INFO - PROCESS | 1649 | |4;audio-oscillator;91;70;88;70;69;69;85;70;69;86 08:49:18 INFO - PROCESS | 1649 | |5;imaging-gaussian-blur;87;93;134;86;86;87;87;87;88;86 08:49:18 INFO - PROCESS | 1649 | |6;imaging-darkroom;125;94;95;95;94;94;95;93;95;93 08:49:18 INFO - PROCESS | 1649 | |7;imaging-desaturate;81;84;86;83;86;83;86;83;84;84 08:49:18 INFO - PROCESS | 1649 | |8;json-parse-financial;63;60;60;57;60;61;62;60;60;60 08:49:18 INFO - PROCESS | 1649 | |9;json-stringify-tinderbox;53;54;64;66;58;58;57;57;57;58 08:49:18 INFO - PROCESS | 1649 | |10;stanford-crypto-aes;87;86;76;87;96;104;104;84;85;87 08:49:18 INFO - PROCESS | 1649 | |11;stanford-crypto-ccm;138;138;144;139;138;138;139;140;175;140 08:49:18 INFO - PROCESS | 1649 | |12;stanford-crypto-pbkdf2;171;170;179;230;173;168;172;172;165;159 08:49:18 INFO - PROCESS | 1649 | |13;stanford-crypto-sha256-iterative;67;67;67;67;67;66;64;66;64;65 08:49:18 INFO - PROCESS | 1649 | __end_tp_report 08:49:18 INFO - PROCESS | 1649 | __start_cc_report 08:49:18 INFO - PROCESS | 1649 | _x_x_mozilla_cycle_collect,2104 08:49:18 INFO - PROCESS | 1649 | __end_cc_report 08:49:18 INFO - PROCESS | 1649 | __startTimestamp1489164558065__endTimestamp 08:49:18 INFO - PROCESS | 1649 | 08:49:18 INFO - PROCESS | 1649 | ------- Summary: start ------- 08:49:18 INFO - PROCESS | 1649 | Number of tests: 14 08:49:18 INFO - PROCESS | 1649 | 08:49:18 INFO - PROCESS | 1649 | [#0] ai-astar Cycles:10 Average:113.80 Median:114.00 stddev:0.79 (0.7%) stddev-sans-first:0.83 08:49:18 INFO - PROCESS | 1649 | Values: 114.0 115.0 113.0 114.0 114.0 114.0 114.0 114.0 114.0 112.0 08:49:18 INFO - PROCESS | 1649 | 08:49:18 INFO - PROCESS | 1649 | [#1] audio-beat-detection Cycles:10 Average:120.50 Median:112.50 stddev:17.16 (15.3%) stddev-sans-first:13.59 08:49:18 INFO - PROCESS | 1649 | Values: 153.0 112.0 109.0 150.0 113.0 111.0 110.0 110.0 127.0 110.0 08:49:18 INFO - PROCESS | 1649 | 08:49:18 INFO - PROCESS | 1649 | [#2] audio-dft Cycles:10 Average:195.10 Median:185.00 stddev:23.80 (12.9%) stddev-sans-first:25.01 08:49:18 INFO - PROCESS | 1649 | Values: 186.0 184.0 184.0 186.0 236.0 244.0 180.0 184.0 183.0 184.0 08:49:18 INFO - PROCESS | 1649 | 08:49:18 INFO - PROCESS | 1649 | [#3] audio-fft Cycles:10 Average:66.50 Median:62.00 stddev:10.77 (17.4%) stddev-sans-first:10.07 08:49:18 INFO - PROCESS | 1649 | Values: 81.0 61.0 59.0 88.0 63.0 58.0 61.0 59.0 75.0 60.0 08:49:18 INFO - PROCESS | 1649 | 08:49:18 INFO - PROCESS | 1649 | [#4] audio-oscillator Cycles:10 Average:76.70 Median:77.50 stddev:9.43 (12.2%) stddev-sans-first:8.46 08:49:18 INFO - PROCESS | 1649 | Values: 91.0 70.0 88.0 70.0 69.0 69.0 85.0 70.0 69.0 86.0 08:49:18 INFO - PROCESS | 1649 | 08:49:18 INFO - PROCESS | 1649 | [#5] imaging-gaussian-blur Cycles:10 Average:92.10 Median:87.00 stddev:14.87 (17.1%) stddev-sans-first:15.65 08:49:18 INFO - PROCESS | 1649 | Values: 87.0 93.0 134.0 86.0 86.0 87.0 87.0 87.0 88.0 86.0 08:49:18 INFO - PROCESS | 1649 | 08:49:18 INFO - PROCESS | 1649 | [#6] imaging-darkroom Cycles:10 Average:97.30 Median:94.50 stddev:9.76 (10.3%) stddev-sans-first:0.83 08:49:18 INFO - PROCESS | 1649 | Values: 125.0 94.0 95.0 95.0 94.0 94.0 95.0 93.0 95.0 93.0 08:49:18 INFO - PROCESS | 1649 | 08:49:18 INFO - PROCESS | 1649 | [#7] imaging-desaturate Cycles:10 Average:84.00 Median:84.00 stddev:1.63 (1.9%) stddev-sans-first:1.32 08:49:18 INFO - PROCESS | 1649 | Values: 81.0 84.0 86.0 83.0 86.0 83.0 86.0 83.0 84.0 84.0 08:49:18 INFO - PROCESS | 1649 | 08:49:18 INFO - PROCESS | 1649 | [#8] json-parse-financial Cycles:10 Average:60.30 Median:60.00 stddev:1.57 (2.6%) stddev-sans-first:1.32 08:49:18 INFO - PROCESS | 1649 | Values: 63.0 60.0 60.0 57.0 60.0 61.0 62.0 60.0 60.0 60.0 08:49:18 INFO - PROCESS | 1649 | 08:49:18 INFO - PROCESS | 1649 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.00 stddev:3.99 (6.9%) stddev-sans-first:3.77 08:49:18 INFO - PROCESS | 1649 | Values: 53.0 54.0 64.0 66.0 58.0 58.0 57.0 57.0 57.0 58.0 08:49:18 INFO - PROCESS | 1649 | 08:49:18 INFO - PROCESS | 1649 | [#10] stanford-crypto-aes Cycles:10 Average:89.60 Median:86.50 stddev:8.98 (10.4%) stddev-sans-first:9.48 08:49:18 INFO - PROCESS | 1649 | Values: 87.0 86.0 76.0 87.0 96.0 104.0 104.0 84.0 85.0 87.0 08:49:18 INFO - PROCESS | 1649 | 08:49:18 INFO - PROCESS | 1649 | [#11] stanford-crypto-ccm Cycles:10 Average:142.90 Median:139.50 stddev:11.43 (8.2%) stddev-sans-first:11.98 08:49:18 INFO - PROCESS | 1649 | Values: 138.0 138.0 144.0 139.0 138.0 138.0 139.0 140.0 175.0 140.0 08:49:18 INFO - PROCESS | 1649 | 08:49:18 INFO - PROCESS | 1649 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.90 Median:172.00 stddev:19.72 (11.5%) stddev-sans-first:20.84 08:49:18 INFO - PROCESS | 1649 | Values: 171.0 170.0 179.0 230.0 173.0 168.0 172.0 172.0 165.0 159.0 08:49:18 INFO - PROCESS | 1649 | 08:49:18 INFO - PROCESS | 1649 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.00 Median:67.00 stddev:1.25 (1.9%) stddev-sans-first:1.27 08:49:18 INFO - PROCESS | 1649 | Values: 67.0 67.0 67.0 67.0 67.0 66.0 64.0 66.0 64.0 65.0 08:49:18 INFO - PROCESS | 1649 | -------- Summary: end -------- 08:49:18 INFO - PROCESS | 1649 | 08:49:18 INFO - TEST-INFO | 1649: exit 0 08:49:18 INFO - TEST-OK | kraken | took 60035ms 08:49:18 INFO - SUITE-END | took 1181s 08:49:19 INFO - Completed test suite (00:19:41) 08:49:19 INFO - javascript benchmark 08:49:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7586.250900027236, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3400.7109395701364, 3413.5903691556987, 3427.8457469413875, 3439.8796042138524, 3488.4244099723546, 5686.402927692595, 5796.594238403313, 5911.379305172959, 5997.820065398034, 6022.096685497172, 5787.0, 5821.941780582193, 5826.067829147337, 5832.941670583293, 5841.3282472515675, 5176.58587313016, 5224.79100835968, 5242.292290540785, 5287.127623942045, 5307.416184219733, 5336.6531175473665, 5357.357117145929, 5360.16917377807, 5365.3293338332705, 5369.060414427459, 5306.071437498423, 5309.814156504523, 5331.280277162592, 5334.786608535654, 5337.706426146579, 5156.865489592321, 5319.946800531984, 5332.546733527654, 5332.9733351333, 5334.359876814788, 4627.9768601156775, 5181.922271165936, 5284.603654725911, 5287.154055351164, 5330.573554115662, 5960.791372301992, 6030.758769649209, 6055.636661800306, 6063.0, 6064.878702425971, 6266.968665156691, 6293.181886354791, 6305.621662700207, 6309.621422714652, 6312.210973628296, 6201.0, 6244.281907580641, 6270.65511396873, 6304.87390252197, 6322.968385158091, 4349.847755328548, 5871.884341975011, 5987.700614969234, 5996.370381110008, 6000.969995149996, 6378.043293505918, 6451.838704032437, 6469.0, 6472.514561407913, 6474.643894585749, 6316.147320111818, 6321.241451025906, 6334.144890439824, 6337.2395312562785, 6338.619682819046, 6126.039906489408, 6199.876002480015, 6245.313015568284, 6295.087212354183, 6296.496280297565, 6250.062490626351, 6275.717592708339, 6285.120083188357, 6289.40250676185, 6291.559590828598, 5155.690658560498, 5449.100898351807, 6215.098810672427, 6269.529785266123, 6273.278572964076, 4309.655227581786, 5024.974875125601, 5034.622403319692, 5049.368828896388, 5136.948630513722, 4381.3208952612395, 4387.583179597933, 4395.27477966132, 4395.494518130456, 4451.376807246988, 5868.23712917318, 5871.588988770745, 5880.26496687914, 5900.380460051632, 5904.76380944766, 6224.719887605069, 6261.78083767066, 6271.153394291803, 6276.717547710364, 6281.748730050838, 5865.501432378295, 5868.061110222344, 5874.060150375919, 5879.823605291848, 5880.294364676266, 5537.612367134262, 5555.805546805843, 5557.3886872444, 5566.081596536607, 5566.304211973504, 6219.720112594944, 6304.590201636879, 6334.588251763621, 6400.007998760199, 6419.261784894797, 6303.369663033844, 6309.905351419824, 6314.652694101868, 6329.367063293634, 6331.303556608861, 6459.870802584016, 6472.708728107153, 6477.093206950936, 6482.35176482348, 6527.706253218522, 6109.083637454418, 6144.41628045335, 6168.814935551761, 6316.305206427382, 6336.144620476177, 4484.618807401407, 6243.968780156252, 6277.560570760185, 6281.96859015702, 6282.120503129657, 5804.390538993345, 6178.536609754196, 6197.628142311476, 6289.213848268966, 6318.6840657965995, 6200.844978875384, 6254.593451425642, 6259.96870015647, 6280.9685951569945, 6292.465140463112, 4640.605548528278, 5936.13925980739, 6110.847228819137, 6131.601445906002, 6132.049532322497, 6123.465646421035, 6123.465646421035, 6135.875804921915, 6140.718981675666, 6148.354422785722, 5937.524998000236, 5984.820455386345, 5995.250593675791, 6001.099835024781, 6003.0], "value": 5758.132571441282, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.8641585267094, 729.8613263479939, 787.1931270447794, 794.8171920458294, 796.5300472721093, 27179.728202717968, 37645.68240111597, 38089.42865857014, 38214.0, 38221.80889095557, 39457.0, 39603.40594891079, 39626.60373396265, 39648.405273920915, 39775.40336894942, 8914.598843052063, 9082.909170908306, 9094.49980251086, 9096.454212747256, 9125.954370228174, 7225.060742103519, 7449.366803821682, 7482.176960534337, 7519.624018799038, 7523.360514356286, 10648.0, 10898.945505272462, 11014.889851101507, 11038.448077596127, 11060.944695276512, 10699.518521666543, 10804.891951080468, 10811.729706757395, 10814.783704325948, 10838.078763305128, 7091.290870912919, 9025.638974441015, 10543.736406589896, 10564.207684423698, 10611.734706632318, 27051.782669779906, 27119.457610847672, 27167.728322716914, 27214.727852721615, 37006.814965925, 3718.9442158367647, 3830.4445855351096, 3839.8080095995088, 3885.30064588374, 3905.3946638271113, 27721.306967325778, 27762.722372776214, 27764.16707498778, 27820.582691259646, 27875.02437414701, 3042.0721679887624, 3132.4518209313505, 3182.5862637857163, 3215.8070515769127, 3229.951550726741, 310380.0, 313987.0, 314701.0, 314780.0, 316258.0, 48399.75800121047, 48491.5150848487, 48590.27114593284, 48604.513954860704, 48664.75667621639, 50486.0, 50531.73670658189, 50625.98748025092, 50669.746651266505, 50675.986480270185, 14153.646158846112, 14284.214368209849, 14299.85700143006, 14306.499272525412, 14317.35571899267, 11624.94187529057, 11632.53469861196, 11643.88356116428, 11659.650210493699, 11725.237859539102, 9658.227341812639, 12146.271223726604, 12188.939055304667, 12231.694207644701, 12264.81602775959, 5219.451957544479, 5251.474852514718, 5261.342332208474, 5274.841754747364, 5285.550728188147, 857.6920196699957, 911.3392790227165, 934.8971613122551, 939.9718008459757, 960.1118964957526, 23620.291391258288, 24622.753772462045, 27360.716713994447, 27410.5888411674, 27426.76579553925, 882.1839798186652, 1002.7042022603349, 1020.2501161646184, 1023.8976102389851, 1047.4448542272607, 12134.757304853854, 13373.39819708096, 13810.37853296604, 14157.362918668685, 14159.85840141606, 380743.0, 447414.0, 448177.0, 448905.0, 449517.0, 53298.20052699213, 53366.73316633392, 53397.46602533925, 53442.73278633582, 53830.73084634552, 1201.8257352683638, 1331.088204579866, 1396.57404491629, 1396.8952328575397, 1403.9157650541204, 19730.80269197347, 28811.711882880903, 29808.403831922806, 29888.333574172786, 29907.908345930777, 49862.50137498578, 50040.49959500504, 50131.24803127883, 50215.47198864124, 50421.49578504168, 459900.70049649535, 459970.0, 460411.0, 460890.0, 461176.0, 32890.684372624826, 32980.1754956128, 33051.66948330486, 33116.1720956978, 33190.0, 33208.50187247145, 41969.58030419657, 42036.738897833115, 42425.36361954511, 42553.36169957515, 24549.0, 31385.372292553566, 32289.51565726563, 32315.0, 33976.0, 33531.497027544116, 33625.0, 33655.66344336525, 34860.0, 35121.82439087788, 34718.47922281118, 35483.82258088693, 35564.0, 35593.1101722459, 35674.0, 28082.85958570194, 29146.7085329144, 30198.62119992633, 30258.54612180863, 30279.69720302769, 22117.889410552845, 22704.545909081397, 23375.41561460977, 23377.649335260325, 23415.297541073796], "value": 17945.15353245405, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [362.58698362398235, 368.963103689631, 374.5935659809107, 394.2961813163504, 436.98401217170067, 14192.929035354822, 14233.359498822552, 17285.0, 21883.0, 22542.54914901701, 21757.25941924646, 21846.781532184672, 22640.754758488278, 23635.0, 23878.40303992401, 6043.939560604382, 6125.111858780474, 6175.691215439232, 6731.56244844086, 6794.165575294667, 6542.247641521239, 6730.798076057726, 6894.896576551356, 6896.931030689679, 6904.930950690504, 6748.527603067787, 6849.7602583909575, 6850.48621353398, 6853.485988550854, 6857.931420685779, 6836.965815170917, 6840.65796710165, 7373.926260737431, 7769.223077692185, 7999.160088190714, 7398.630068496554, 7629.771106866803, 7730.0, 7750.379969602418, 7752.7674169775, 29768.851155744298, 30145.69854301473, 30363.392732145454, 30759.846200768854, 31218.063458096294, 2879.2370021944203, 2943.690912454183, 2972.3758010817755, 2996.6703662597097, 3109.362580670957, 16521.91739041297, 17448.38930637434, 17702.380416685482, 17738.29046838125, 18425.815741842544, 1799.5718156911105, 1998.4504261328252, 2033.766116896561, 2035.837133029369, 2054.9178032878667, 160447.0, 162567.1871640646, 166308.0, 168882.1555892225, 169946.0, 19327.710084348746, 23046.8847655764, 23321.7667823323, 23682.881585592306, 23941.7605823943, 42126.0, 42259.36610950838, 42301.36547951783, 42357.788211058745, 42445.57554424416, 8694.869666943383, 10342.0, 10466.790664186674, 10693.732656683489, 10947.069499092508, 8520.147985201555, 8541.402101852935, 8579.356548258906, 8750.518721470253, 8756.343274254456, 8896.729569806399, 10243.026912443305, 10943.890561094287, 11070.833937490945, 11074.944625276821, 4190.895227619273, 4255.3616957456625, 4295.72077814941, 4306.590873866978, 4312.223799716081, 1000.1598657128047, 1032.8863824979246, 1051.2588625019343, 1053.8788039375418, 1084.5282302198568, 23355.53288934246, 23368.766312337, 23826.0, 23870.641940370908, 23916.162934297216, 1034.3897100710617, 1044.8380501022355, 1058.9682309530726, 1091.4870011094772, 1095.5727266366123, 10384.051246744628, 11427.371494567878, 12213.389330533439, 12290.692732681575, 12302.876971230353, 681808.0, 690183.0, 693957.0, 699122.5833545804, 720376.0, 94681.0531894686, 154141.0, 154248.68626970606, 158810.0, 160546.0, 1174.36584244507, 1278.8465384153776, 1299.9675008124684, 1325.1504379776763, 1337.8260826092546, 19361.709574356115, 19708.0, 20539.0, 20639.587208256053, 20789.272375466786, 43559.0, 44655.385060944005, 62522.0, 62901.37098628955, 63618.0, 88027.55986220027, 88971.11028889887, 90063.0, 91304.0, 92929.0, 11043.83434248503, 11800.226946667697, 11917.463714132711, 11934.52261909514, 12287.631371058882, 11965.880341196826, 12047.74710828089, 12062.819057713965, 13311.400986955416, 13712.725745485233, 11109.833352499558, 11163.609273675707, 11367.431628418712, 11417.1437142213, 11561.595344162914, 11366.033887119687, 11568.479418426023, 11632.835820895523, 11724.531018759155, 11786.76426471483, 10414.313558898375, 11083.612073577386, 11375.829362559734, 11976.700582485508, 12001.979831714052, 9316.813663726824, 11741.884520970494, 11825.881741182822, 12186.329751863732, 12190.390480475764, 10695.839562406414, 11283.830742538705, 11356.148288878201, 11639.127065469955, 11652.475638596114], "value": 11952.424202650287, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1289.0847498276223, 1543.0433131458497, 1574.551252892925, 1606.2450648195352, 1608.6782643471306, 8135.959320203398, 9600.1359877611, 9889.40663560185, 10602.098821600164, 11032.834507482374, 10692.679219623404, 10779.730506737336, 10789.83815242772, 10790.946045269762, 10791.19066070044, 2091.9853870872616, 2260.8191344692386, 2309.872956987365, 2332.9883350583223, 2349.6358064499946, 1868.224686754995, 1975.841932645392, 2003.5692326149874, 2086.259377920839, 2100.4223838444395, 2022.0698478699817, 2254.323702889135, 2334.6147885598857, 2336.077249486452, 2343.8359314847967, 2332.5101728637005, 2332.5801355756043, 2342.941426464335, 2349.565330413879, 2353.0, 2244.438890277431, 2329.0, 2337.3338598499345, 2338.6024375856146, 2340.169239919821, 10301.433421161833, 10398.480075996169, 10409.375437473776, 10412.3752574845, 10413.635522756667, 4735.455422626407, 5815.709214539256, 5850.882982340329, 5858.384869588717, 5878.470937615635, 3272.640009598942, 3357.2278375973665, 3493.877714279988, 3556.893293201208, 3569.6787289144104, 1150.9539618415254, 1154.417019405195, 1194.8984336331423, 1199.7540504196618, 1210.0, 15305.46430874914, 15521.611959700986, 15558.533244002698, 15562.0, 15706.371745130182, 4738.07607516531, 4759.976200118977, 4855.44162421319, 4863.051704917507, 4946.950530494649, 12547.811782823264, 12567.434465448894, 12578.874211257953, 12599.118061735591, 12620.990320774315, 5868.67722275279, 5868.794592189253, 5870.530357571384, 5880.441358070976, 5887.970560147258, 4814.494478079821, 5082.2122571001555, 5148.176291793295, 5161.845144645667, 5185.637005409585, 3544.7518673692593, 3857.556381016163, 3932.2528719543197, 4012.61880121388, 4021.859234926822, 1048.528162326956, 1054.5887104029434, 1056.392574269798, 1058.1323314881722, 1060.6340812419703, 781.7576551269125, 911.8404279251105, 934.8083642853198, 950.4154944709093, 953.8839557717487, 6540.345965403517, 6543.9345606544275, 6754.18949726036, 6809.863802723918, 6850.623215723183, 1007.7077647482295, 1026.6406757634918, 1039.1738567838586, 1061.124572227915, 1071.0414179309475, 4214.346776249687, 4217.219814334358, 4279.957200428018, 4388.1223755249075, 4426.44669416323, 13345.266010369523, 13748.793768093487, 13777.724445511234, 13777.862221377858, 13794.93102534481, 13387.06290559671, 13579.728405431835, 13630.182189068688, 13752.724945501033, 13754.587362379145, 8306.753986901893, 9814.901850981541, 9995.250356223312, 10019.398836069859, 10023.148032417326, 6339.461145802658, 6645.335466453316, 6701.765438209639, 6847.486438517031, 6937.445004399737, 10195.439250841275, 10796.56813727442, 10807.081398080936, 11208.943955280172, 12042.096842736655, 11830.053595712494, 12214.206076604993, 12282.692932676755, 12289.877101228873, 12302.077344199042, 9002.279817614444, 9182.816343673223, 9381.85927211106, 9400.717978460658, 9441.811163776549, 10176.389416634729, 10194.184465242912, 10302.0, 10303.587856485656, 10322.432266225429, 8937.776555586162, 9076.31927605419, 9137.725868223964, 9146.679866204651, 9349.065093490597, 8782.473051616924, 8824.117588241124, 8842.24840888506, 8880.955595221982, 9146.576157318183, 7826.804329891798, 7997.200279971957, 7997.280244777998, 8007.559584222924, 8012.559309238048, 5224.58203343724, 5539.529140023144, 5681.687507187145, 5766.452187042224, 5956.183364073999, 5812.68030258323, 5829.417058294137, 6025.276966764016, 6057.969710151421, 6199.597026193283], "value": 5062.123081538835, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.8543025504924, 377.8450835157586, 386.6520131881308, 387.0884068019815, 391.94120881867724, 4063.4108054332105, 4578.54214578542, 4883.658143929926, 4930.013997200565, 5043.672161309512, 4018.7990600469934, 4488.775561221934, 4843.709377437347, 4906.852794416164, 5021.221710634857, 4148.838325268915, 4156.771377574225, 4160.750354978711, 4205.158968206356, 4205.327147656376, 4178.537511870836, 4178.621055051825, 4215.283401821683, 4230.703850730435, 4253.2769429197115, 3439.63883792202, 3608.1057444841404, 4052.9594704053025, 4105.856295029675, 4203.85286514972, 4085.4280400743623, 4104.42538044674, 4114.794260286973, 4138.255114079465, 4164.250434921712, 3012.4276387486307, 3330.6669333066743, 3642.6357364263627, 3797.0, 3802.182530755873, 4491.708038977488, 4635.496831710906, 4639.814407423699, 4860.927086093711, 4932.778024988848, 3948.486696729407, 4239.442599205866, 4281.801095693211, 4794.086061786662, 4799.376081109468, 4943.058879966415, 4983.25586044885, 5307.867303317409, 5341.252224688546, 5397.514223719884, 3946.427767973628, 4225.640820530259, 4287.399764033006, 4295.398644189816, 4309.922519370158, 4988.7505624718615, 5008.799648014112, 5193.818216362409, 5228.353068783283, 5637.577181711388, 3705.5182826232417, 4236.512801027921, 4332.783360831946, 4337.024169561823, 4372.759498227564, 4152.998916565594, 4395.780210989437, 4431.268840641258, 4438.60052595268, 4442.3336499524685, 3894.668953139015, 4503.819847206075, 4780.259059845729, 4803.823063349501, 4821.397325334333, 4787.3776409066595, 5198.610104242197, 5315.654482458628, 5315.8570907255125, 5349.384820745586, 1344.1666166976538, 1352.4252192818012, 1465.6482444213311, 1470.713210923881, 1477.1580199286304, 974.8927617962019, 1032.8863824979246, 1044.7984817459983, 1097.5445190246119, 1130.3669944830922, 4338.897688152986, 4408.801603927831, 4503.959827116749, 4999.750212319499, 5122.538971492583, 4733.384659994179, 4962.652614316963, 5467.425920278313, 5498.422665620053, 5521.779128834802, 4547.977260113678, 4653.534136746914, 4819.469858315582, 4943.629227807929, 5088.440271570198, 2606.4656745367156, 2671.666041744782, 2846.018123747304, 2848.843313617771, 2870.583765354054, 5154.92267615986, 5201.141811601044, 5578.97210513953, 5696.547380417966, 5741.138829175574, 4971.6768410053955, 4983.90032199354, 5493.670379777226, 5640.746166422521, 5690.573207009491, 4815.858361808771, 5090.821821236313, 5717.285339332583, 5755.8561035974435, 5806.171056117394, 4498.470520023207, 4779.3199236588325, 4840.104580652591, 5283.5773138149625, 5542.9168562472405, 4876.29293752411, 5133.460986596503, 5157.690538567698, 5168.046444470058, 5439.619226654097, 5008.899822003613, 5495.560355171657, 5665.376808551138, 5695.601307908572, 5736.6558006519745, 4043.797810109424, 4324.524302326805, 4328.588784065509, 4330.935035974526, 4337.375887587964, 4756.5492524780275, 4878.5853202476765, 4990.525900039491, 5050.787810925425, 5185.896282074413, 4415.751711328434, 4509.647105868292, 4707.4821769606, 4847.5394837490385, 5019.498050194951, 4667.439907211156, 5123.820666276662, 5300.337457817773, 5307.893842123059, 5313.814016509558, 4368.347709689171, 4748.92876606858, 5198.2202669599865, 5295.311609490742, 5301.204819277139, 4873.616471046297, 4989.501049894981, 5429.344050064768, 5432.6468779529205, 5442.374126975448, 4637.373954516097, 4816.831410900601, 4911.4106307243355, 5253.842384728464, 5280.445553216857], "value": 4032.594980668752, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.3686687281761, 716.2550947015104, 739.9852002959941, 816.5060138616136, 878.0, 15103.773443398359, 15675.529734107995, 15946.441874534394, 15947.92026039871, 15949.68100637988, 14039.298035098229, 14412.711745765078, 14436.278186090705, 14590.562283131523, 14610.19643919584, 912.8083102548472, 948.4593781544522, 952.6665667016558, 952.8046750416148, 953.0374321934827, 938.3947353956728, 949.1694767078806, 953.408886490377, 962.5043102802027, 980.0101897083925, 1026.2508368890676, 1029.5058371981454, 1030.587764894041, 1031.092638478142, 1034.1158309645257, 1023.488255872064, 1024.2318261304022, 1025.0262250861638, 1026.5021464589668, 1027.4143738069304, 762.1730422491603, 763.2520130272364, 765.8238605120854, 766.1380946435261, 768.1703759939252, 15740.842591574052, 16046.75929861053, 16112.516624501284, 16188.676226475405, 16297.103659298733, 14462.927685361507, 14543.200123993176, 14596.197209153492, 14656.267186640625, 14689.559313220621, 11620.360880151673, 11724.648260552198, 11806.173567850254, 12021.459034343476, 12259.570915018021, 3614.9873640259293, 3733.3653278942643, 3883.59222281662, 3897.4933258676474, 3897.7661340319673, 104139.0, 106923.0, 107244.0, 108724.0, 109243.0, 10640.46797660114, 11103.278286911325, 11307.886921130683, 11329.94335028336, 11960.820587691192, 24660.506789864103, 24671.0, 24679.0, 24902.252932412055, 25014.0, 7680.80797980055, 7989.3209077229085, 8050.879236811453, 8055.315298199602, 8163.755087347389, 4140.523839758466, 4247.766372849523, 4416.757078360721, 4443.022535042285, 4483.955160448419, 3509.701675357572, 3621.927561448809, 3622.4747411625167, 3625.3655610268097, 3625.492431059654, 610.3228050992803, 633.4077637408946, 634.1724050114552, 637.4199478474566, 641.1024565608186, 559.829252078112, 560.1877277946912, 573.9655620662774, 582.3652219081222, 587.3949831673383, 8057.838843223103, 10676.466176691134, 10800.541926839933, 10866.45667716611, 11380.0, 520.2752874222018, 557.345119484612, 604.585858686801, 644.3170239546096, 684.710930106969, 4172.102997855475, 4345.630621397154, 4876.860030237922, 4914.725292200031, 4931.457539670633, 86259.56870215609, 91812.0, 92879.2136235914, 93542.0, 94722.0, 58231.70884145637, 66820.0, 68144.6592767033, 81252.59373703094, 81393.59303203446, 43274.88803676495, 66576.6671166641, 74136.88794668192, 75793.0, 76429.0, 10577.100946419641, 10611.363318200623, 10691.946540267249, 10799.730006749895, 10818.0, 48965.0206995851, 49981.75009124931, 50789.0, 50927.47729159739, 51624.70938226574, 44391.0, 60835.39164608297, 61463.692681538094, 62333.68833155987, 63093.36906630875, 12463.376831158586, 13123.343832808512, 13665.453381864614, 13727.588172354845, 14120.50578229757, 14504.047330247462, 14543.906459613001, 14641.121532708072, 14651.706965860836, 14792.852071479578, 13062.020348473712, 13195.274259915797, 13345.599632011055, 13355.0, 13569.86430135686, 13684.726305473636, 13685.693311906069, 14016.369263383376, 14194.148351098967, 14241.572752817432, 13295.0, 13410.0, 13419.731605368033, 13490.932545337211, 14115.435382584992, 10903.945480272549, 11072.39101849406, 11106.167037472384, 11230.94384528072, 11628.825567616323, 8618.52598107085, 9335.346525743133, 11039.724006899893, 11114.0, 11260.94369528147], "value": 7559.9282251224695, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1438.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 113.0, 114.0, 114.0, 114.0, 114.0, 114.0, 114.0, 112.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 112.0, 109.0, 150.0, 113.0, 111.0, 110.0, 110.0, 127.0, 110.0], "value": 120.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 184.0, 184.0, 186.0, 236.0, 244.0, 180.0, 184.0, 183.0, 184.0], "value": 195.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 61.0, 59.0, 88.0, 63.0, 58.0, 61.0, 59.0, 75.0, 60.0], "value": 66.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 88.0, 70.0, 69.0, 69.0, 85.0, 70.0, 69.0, 86.0], "value": 76.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 93.0, 134.0, 86.0, 86.0, 87.0, 87.0, 87.0, 88.0, 86.0], "value": 92.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [125.0, 94.0, 95.0, 95.0, 94.0, 94.0, 95.0, 93.0, 95.0, 93.0], "value": 97.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 84.0, 86.0, 83.0, 86.0, 83.0, 86.0, 83.0, 84.0, 84.0], "value": 84.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 60.0, 60.0, 57.0, 60.0, 61.0, 62.0, 60.0, 60.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 64.0, 66.0, 58.0, 58.0, 57.0, 57.0, 57.0, 58.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 76.0, 87.0, 96.0, 104.0, 104.0, 84.0, 85.0, 87.0], "value": 89.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 138.0, 144.0, 139.0, 138.0, 138.0, 139.0, 140.0, 175.0, 140.0], "value": 142.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 179.0, 230.0, 173.0, 168.0, 172.0, 172.0, 165.0, 159.0], "value": 175.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 67.0, 67.0, 66.0, 64.0, 66.0, 64.0, 65.0], "value": 66.0, "unit": "score"}]}]} 08:49:19 INFO - Return code: 0 08:49:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:49:19 ERROR - # TBPL SUCCESS # 08:49:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:49:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:49:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:49:19 INFO - 2017-03-10 08:49:19.398 screenresolution[1653:10157] starting screenresolution argv=screenresolution get 08:49:19 INFO - 2017-03-10 08:49:19.401 screenresolution[1653:10157] Display 0: 1600x1200x32@60 08:49:19 INFO - 2017-03-10 08:49:19.407 screenresolution[1654:10160] starting screenresolution argv=screenresolution list 08:49:19 INFO - Available Modes on Display 0 08:49:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:49:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:49:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:49:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:49:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:49:19 INFO - Intel Iris: 08:49:19 INFO - Chipset Model: Intel Iris 08:49:19 INFO - Type: GPU 08:49:19 INFO - Bus: Built-In 08:49:19 INFO - VRAM (Dynamic, Max): 1536 MB 08:49:19 INFO - Vendor: Intel (0x8086) 08:49:19 INFO - Device ID: 0x0a2e 08:49:19 INFO - Revision ID: 0x0009 08:49:19 INFO - Displays: 08:49:19 INFO - Display: 08:49:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:49:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:49:19 INFO - Display Serial Number: 1600x1200 60 08:49:19 INFO - Main Display: Yes 08:49:19 INFO - Mirror: Off 08:49:19 INFO - Online: Yes 08:49:19 INFO - Rotation: Supported 08:49:19 INFO - Return code: 0 08:49:19 INFO - Running post-action listener: _resource_record_post_action 08:49:19 INFO - [mozharness: 2017-03-10 16:49:19.643628Z] Finished run-tests step (success) 08:49:19 INFO - Running post-run listener: _resource_record_post_run 08:49:19 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 39252992; Write bytes: 512046080; Read time: 379; Write time: 2176 08:49:19 INFO - TinderboxPrint: CPU usage
54.2% 08:49:19 INFO - TinderboxPrint: I/O read bytes / time
39,252,992 / 379 08:49:19 INFO - TinderboxPrint: I/O write bytes / time
512,046,080 / 2,176 08:49:19 INFO - TinderboxPrint: CPU idle
2,204.2 (45.8%) 08:49:19 INFO - TinderboxPrint: CPU system
959.3 (19.9%) 08:49:19 INFO - TinderboxPrint: CPU user
1,646.2 (34.2%) 08:49:19 INFO - TinderboxPrint: Swap in / out
248,487,936 / 0 08:49:19 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205445632; Write bytes: 202123264; Read time: 15777; Write time: 393 08:49:19 INFO - run-tests - Wall time: 1182s; CPU: 54.0%; Read bytes: 37250048; Write bytes: 299142144; Read time: 357; Write time: 1753 08:49:20 INFO - Running post-run listener: _upload_blobber_files 08:49:20 INFO - Blob upload gear active. 08:49:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:49:20 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 08:49:20 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'] 08:49:20 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 08:49:20 INFO - (blobuploader) - INFO - Open directory for files ... 08:49:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:49:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:49:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:49:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:49:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:49:21 INFO - (blobuploader) - INFO - Done attempting. 08:49:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:49:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:49:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:49:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:49:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:49:22 INFO - (blobuploader) - INFO - Done attempting. 08:49:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:49:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:49:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:49:23 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:49:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:49:23 INFO - (blobuploader) - INFO - Done attempting. 08:49:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:49:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:49:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:49:25 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:49:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:49:25 INFO - (blobuploader) - INFO - Done attempting. 08:49:25 INFO - (blobuploader) - INFO - Iteration through files over. 08:49:25 INFO - Return code: 0 08:49:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:49:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:49:25 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/715ec67413f969b677bcff0213a002e6b93916e135d2881a582c8ecfc3f351ea7d3d2be3ed35e68e857bb7a3d99e8c3b322fee7662e68bf7bedf328953631e6e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dcbc8ccce3974b7050a7cb7e40b6311bdacd54c3fa0defb9cf3ccae53e1db200623f7e44c496164eb1114adfc601eb4551fbb391a6b99300528d1e4986d62372", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0875bbb2bd113bd7605a928344bb5a8051e171456b7cad32ee0e0b09109d5c31c25db2cc6266c3825a51a9dccfeecf009e5712938c9ee297fcf35866f5c54b5d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eaa1c05c51aec2cdb3bc248b4b087b2f340323dd1defa0af50f5696645fc29623e44a0c23e185db1057c8b509e6a89bac9a762cb9d8e3d8cb461146c33c86182"} 08:49:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:49:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:49:25 INFO - Contents: 08:49:25 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/715ec67413f969b677bcff0213a002e6b93916e135d2881a582c8ecfc3f351ea7d3d2be3ed35e68e857bb7a3d99e8c3b322fee7662e68bf7bedf328953631e6e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dcbc8ccce3974b7050a7cb7e40b6311bdacd54c3fa0defb9cf3ccae53e1db200623f7e44c496164eb1114adfc601eb4551fbb391a6b99300528d1e4986d62372", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0875bbb2bd113bd7605a928344bb5a8051e171456b7cad32ee0e0b09109d5c31c25db2cc6266c3825a51a9dccfeecf009e5712938c9ee297fcf35866f5c54b5d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eaa1c05c51aec2cdb3bc248b4b087b2f340323dd1defa0af50f5696645fc29623e44a0c23e185db1057c8b509e6a89bac9a762cb9d8e3d8cb461146c33c86182"} 08:49:25 INFO - Running post-run listener: copy_logs_to_upload_dir 08:49:25 INFO - Copying logs to upload dir... 08:49:25 INFO - mkdir: /builds/slave/test/build/upload/logs 08:49:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.934499 ========= master_lag: 1.12 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 28 secs) (at 2017-03-10 08:49:26.866126) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 08:49:26.870107) ========= 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.kvonCuYj4y/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.QhH7KfDbUz/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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/715ec67413f969b677bcff0213a002e6b93916e135d2881a582c8ecfc3f351ea7d3d2be3ed35e68e857bb7a3d99e8c3b322fee7662e68bf7bedf328953631e6e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dcbc8ccce3974b7050a7cb7e40b6311bdacd54c3fa0defb9cf3ccae53e1db200623f7e44c496164eb1114adfc601eb4551fbb391a6b99300528d1e4986d62372", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0875bbb2bd113bd7605a928344bb5a8051e171456b7cad32ee0e0b09109d5c31c25db2cc6266c3825a51a9dccfeecf009e5712938c9ee297fcf35866f5c54b5d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eaa1c05c51aec2cdb3bc248b4b087b2f340323dd1defa0af50f5696645fc29623e44a0c23e185db1057c8b509e6a89bac9a762cb9d8e3d8cb461146c33c86182"} build_url:https://queue.taskcluster.net/v1/task/FiSactJITVirTqYN7bWjJw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011256 build_url: 'https://queue.taskcluster.net/v1/task/FiSactJITVirTqYN7bWjJw/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/715ec67413f969b677bcff0213a002e6b93916e135d2881a582c8ecfc3f351ea7d3d2be3ed35e68e857bb7a3d99e8c3b322fee7662e68bf7bedf328953631e6e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dcbc8ccce3974b7050a7cb7e40b6311bdacd54c3fa0defb9cf3ccae53e1db200623f7e44c496164eb1114adfc601eb4551fbb391a6b99300528d1e4986d62372", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0875bbb2bd113bd7605a928344bb5a8051e171456b7cad32ee0e0b09109d5c31c25db2cc6266c3825a51a9dccfeecf009e5712938c9ee297fcf35866f5c54b5d", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/eaa1c05c51aec2cdb3bc248b4b087b2f340323dd1defa0af50f5696645fc29623e44a0c23e185db1057c8b509e6a89bac9a762cb9d8e3d8cb461146c33c86182"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 08:49:26.905774) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 08:49:26.906100) ========= 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.kvonCuYj4y/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.QhH7KfDbUz/Listeners TMPDIR=/var/folders/3z/sl2t9zqs0cxgfh9f4pkbmnbh00000w/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.004770 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 08:49:26.954586) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 08:49:26.954913) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 08:49:26.955252) ========= ========= Total master_lag: 1.26 =========