builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0238 starttime: 1467388517.23 results: success (0) buildid: 20160701065031 builduid: c767f5fb4f57427c8722dbadfbf73505 revision: 5e6976a28642d4d159071e14fd3251d76b9c46fa ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 08:55:17.231470) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-01 08:55:17.231974) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 08:55:17.232347) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-01 08:55:17.254893) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 08:55:17.255294) ========= 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.sWKrININ2N/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.rNZ0btBGJu/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 --2016-07-01 08:55:17-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 10.2M=0.001s 2016-07-01 08:55:17 (10.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147762 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 08:55:17.431228) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 08:55:17.431546) ========= 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.sWKrININ2N/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.rNZ0btBGJu/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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.020859 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 08:55:17.480359) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 08:55:17.480848) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5e6976a28642d4d159071e14fd3251d76b9c46fa --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 5e6976a28642d4d159071e14fd3251d76b9c46fa --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sWKrININ2N/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.rNZ0btBGJu/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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 2016-07-01 08:55:17,564 truncating revision to first 12 chars 2016-07-01 08:55:17,564 Setting DEBUG logging. 2016-07-01 08:55:17,564 attempt 1/10 2016-07-01 08:55:17,564 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/5e6976a28642?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-01 08:55:19,042 unpacking tar archive at: mozilla-beta-5e6976a28642/testing/mozharness/ program finished with exit code 0 elapsedTime=1.738972 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-01 08:55:19.245305) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 08:55:19.245662) ========= script_repo_revision: 5e6976a28642d4d159071e14fd3251d76b9c46fa ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-01 08:55:19.246093) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 08:55:19.246375) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-01 08:55:19.264479) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-01 08:55:19.264862) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.sWKrININ2N/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.rNZ0btBGJu/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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:55:19 INFO - MultiFileLogger online at 20160701 08:55:19 in /builds/slave/test 08:55:19 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 08:55:19 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:55:19 INFO - {'append_to_log': False, 08:55:19 INFO - 'base_work_dir': '/builds/slave/test', 08:55:19 INFO - 'blob_upload_branch': 'Mozilla-Beta', 08:55:19 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:55:19 INFO - 'branch': 'Mozilla-Beta', 08:55:19 INFO - 'buildbot_json_path': 'buildprops.json', 08:55:19 INFO - 'config_files': ('talos/mac_config.py',), 08:55:19 INFO - 'default_actions': ('clobber', 08:55:19 INFO - 'read-buildbot-config', 08:55:19 INFO - 'download-and-extract', 08:55:19 INFO - 'populate-webroot', 08:55:19 INFO - 'create-virtualenv', 08:55:19 INFO - 'install', 08:55:19 INFO - 'run-tests'), 08:55:19 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:55:19 INFO - 'download_minidump_stackwalk': True, 08:55:19 INFO - 'download_symbols': 'ondemand', 08:55:19 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:55:19 INFO - 'tooltool.py': '/tools/tooltool.py', 08:55:19 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:55:19 INFO - '/tools/misc-python/virtualenv.py')}, 08:55:19 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:55:19 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:55:19 INFO - 'installer_path': 'installer.exe', 08:55:19 INFO - 'log_level': 'info', 08:55:19 INFO - 'log_name': 'talos', 08:55:19 INFO - 'log_to_console': True, 08:55:19 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 08:55:19 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 08:55:19 INFO - 'opt_config_files': (), 08:55:19 INFO - 'pip_index': False, 08:55:19 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:55:19 INFO - 'cmd': ('bash', 08:55:19 INFO - '-c', 08:55:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:55:19 INFO - 'enabled': True, 08:55:19 INFO - 'halt_on_failure': False, 08:55:19 INFO - 'name': 'check_screen_resolution'},), 08:55:19 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 08:55:19 INFO - 'cmd': ('bash', 08:55:19 INFO - '-c', 08:55:19 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 08:55:19 INFO - 'enabled': True, 08:55:19 INFO - 'halt_on_failure': False, 08:55:19 INFO - 'name': 'check_screen_resolution'},), 08:55:19 INFO - 'run_cmd_checks_enabled': True, 08:55:19 INFO - 'sps_profile': False, 08:55:19 INFO - 'sps_profile_interval': 0, 08:55:19 INFO - 'suite': 'dromaeojs-e10s', 08:55:19 INFO - 'system_bits': '32', 08:55:19 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:55:19 INFO - 'title': 't-yosemite-r7-0238', 08:55:19 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:55:19 INFO - 'use_talos_json': True, 08:55:19 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:55:19 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:55:19 INFO - 'work_dir': 'build'} 08:55:19 INFO - ##### 08:55:19 INFO - ##### Running clobber step. 08:55:19 INFO - ##### 08:55:19 INFO - Running pre-action listener: _resource_record_pre_action 08:55:19 INFO - Running main action method: clobber 08:55:19 INFO - rmtree: /builds/slave/test/build 08:55:19 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:55:20 INFO - Running post-action listener: _resource_record_post_action 08:55:20 INFO - ##### 08:55:20 INFO - ##### Running read-buildbot-config step. 08:55:20 INFO - ##### 08:55:20 INFO - Running pre-action listener: _resource_record_pre_action 08:55:20 INFO - Running main action method: read_buildbot_config 08:55:20 INFO - Using buildbot properties: 08:55:20 INFO - { 08:55:20 INFO - "project": "", 08:55:20 INFO - "product": "firefox", 08:55:20 INFO - "script_repo_revision": "production", 08:55:20 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 08:55:20 INFO - "repository": "", 08:55:20 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 08:55:20 INFO - "buildid": "20160701065031", 08:55:20 INFO - "pgo_build": "False", 08:55:20 INFO - "basedir": "/builds/slave/test", 08:55:20 INFO - "buildnumber": 15, 08:55:20 INFO - "slavename": "t-yosemite-r7-0238", 08:55:20 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 08:55:20 INFO - "platform": "yosemite_r7", 08:55:20 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 08:55:20 INFO - "branch": "mozilla-beta", 08:55:20 INFO - "repo_path": "releases/mozilla-beta", 08:55:20 INFO - "revision": "5e6976a28642d4d159071e14fd3251d76b9c46fa", 08:55:20 INFO - "stage_platform": "macosx64", 08:55:20 INFO - "builduid": "c767f5fb4f57427c8722dbadfbf73505", 08:55:20 INFO - "slavebuilddir": "test" 08:55:20 INFO - } 08:55:20 INFO - Found installer url https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 08:55:20 INFO - Running post-action listener: _resource_record_post_action 08:55:20 INFO - ##### 08:55:20 INFO - ##### Running download-and-extract step. 08:55:20 INFO - ##### 08:55:20 INFO - Running pre-action listener: _resource_record_pre_action 08:55:20 INFO - Running main action method: download_and_extract 08:55:20 INFO - mkdir: /builds/slave/test/build/tests 08:55:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:20 INFO - https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 08:55:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 08:55:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 08:55:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 08:55:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 08:55:21 INFO - Downloaded 1165 bytes. 08:55:21 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 08:55:21 INFO - Using the following test package requirements: 08:55:21 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 08:55:21 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:55:21 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 08:55:21 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:55:21 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 08:55:21 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 08:55:21 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:55:21 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 08:55:21 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 08:55:21 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:55:21 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 08:55:21 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:55:21 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 08:55:21 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:55:21 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 08:55:21 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 08:55:21 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 08:55:21 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 08:55:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:21 INFO - https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:55:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:55:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:55:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 08:55:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 08:55:23 INFO - Downloaded 18351381 bytes. 08:55:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:55:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:55:26 INFO - Return code: 0 08:55:26 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 08:55:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:26 INFO - https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 08:55:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:55:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 08:55:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 08:55:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 08:55:41 INFO - Downloaded 18351381 bytes. 08:55:41 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:55:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 08:55:45 INFO - Return code: 0 08:55:45 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:45 INFO - https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 08:55:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 08:55:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 08:55:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 08:55:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 08:55:46 INFO - Downloaded 10840145 bytes. 08:55:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 08:55:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 08:55:46 INFO - Return code: 0 08:55: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:46 INFO - https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 08:55:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:55:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:55:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 08:55:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 08:55:49 INFO - Downloaded 86192349 bytes. 08:55:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:55:49 INFO - mkdir: /builds/slave/test/properties 08:55:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:55:49 INFO - Writing to file /builds/slave/test/properties/build_url 08:55:49 INFO - Contents: 08:55:49 INFO - build_url:https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 08:55:51 INFO - Running post-action listener: _resource_record_post_action 08:55:51 INFO - Running post-action listener: set_extra_try_arguments 08:55:51 INFO - ##### 08:55:51 INFO - ##### Running populate-webroot step. 08:55:51 INFO - ##### 08:55:51 INFO - Running pre-action listener: _resource_record_pre_action 08:55:51 INFO - Running main action method: populate_webroot 08:55:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:55:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:55:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:55:51 INFO - '--tppagecycles', 08:55:51 INFO - '7'], 08:55:51 INFO - 'tests': ['tsvgm']}}, 08:55:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:55:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:55:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:55:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:55:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:55:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:55:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:51 INFO - 'talos_options': ['--disable-e10s'], 08:55:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:55:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:55:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:51 INFO - 'talos_options': ['--disable-e10s'], 08:55:51 INFO - 'tests': ['damp', 'tps']}, 08:55:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:51 INFO - 'tests': ['damp', 'tps']}, 08:55:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:55:51 INFO - 'tests': ['dromaeo_dom']}, 08:55:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:55:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:55:51 INFO - 'tests': ['a11yr', 08:55:51 INFO - 'ts_paint', 08:55:51 INFO - 'tpaint', 08:55:51 INFO - 'sessionrestore', 08:55:51 INFO - 'sessionrestore_no_auto_restore', 08:55:51 INFO - 'tabpaint']}, 08:55:51 INFO - 'other-e10s': {'tests': ['a11yr', 08:55:51 INFO - 'ts_paint', 08:55:51 INFO - 'tpaint', 08:55:51 INFO - 'sessionrestore', 08:55:51 INFO - 'sessionrestore_no_auto_restore', 08:55:51 INFO - 'tabpaint']}, 08:55:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:55:51 INFO - 'ts_paint', 08:55:51 INFO - 'tpaint', 08:55:51 INFO - 'sessionrestore', 08:55:51 INFO - 'sessionrestore_no_auto_restore', 08:55:51 INFO - 'tabpaint']}, 08:55:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:55:51 INFO - 'ts_paint', 08:55:51 INFO - 'tpaint', 08:55:51 INFO - 'sessionrestore', 08:55:51 INFO - 'sessionrestore_no_auto_restore', 08:55:51 INFO - 'tabpaint']}, 08:55:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:55:51 INFO - 'tests': ['a11yr', 08:55:51 INFO - 'ts_paint', 08:55:51 INFO - 'tpaint', 08:55:51 INFO - 'sessionrestore', 08:55:51 INFO - 'sessionrestore_no_auto_restore', 08:55:51 INFO - 'tabpaint']}, 08:55:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:55:51 INFO - 'tests': ['a11yr', 08:55:51 INFO - 'ts_paint', 08:55:51 INFO - 'tpaint', 08:55:51 INFO - 'sessionrestore', 08:55:51 INFO - 'sessionrestore_no_auto_restore', 08:55:51 INFO - 'tabpaint']}, 08:55:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:55:51 INFO - 'tests': ['tsvgx', 08:55:51 INFO - 'tsvgr_opacity', 08:55:51 INFO - 'tart', 08:55:51 INFO - 'tscrollx', 08:55:51 INFO - 'cart']}, 08:55:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:55:51 INFO - 'tsvgr_opacity', 08:55:51 INFO - 'tart', 08:55:51 INFO - 'tscrollx', 08:55:51 INFO - 'cart']}, 08:55:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:51 INFO - 'talos_options': ['--disable-e10s'], 08:55:51 INFO - 'tests': ['tp5o']}, 08:55:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:51 INFO - 'tests': ['tp5o']}, 08:55:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:51 INFO - 'talos_options': ['--disable-e10s', 08:55:51 INFO - '--xperf_path', 08:55:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:55:51 INFO - 'tests': ['tp5n']}, 08:55:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:55:51 INFO - 'talos_options': ['--xperf_path', 08:55:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:55:51 INFO - 'tests': ['tp5n']}}, 08:55:51 INFO - 'talos.zip': {'path': '', 08:55:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:55:51 INFO - Running post-action listener: _resource_record_post_action 08:55:51 INFO - ##### 08:55:51 INFO - ##### Running create-virtualenv step. 08:55:51 INFO - ##### 08:55:51 INFO - Running pre-action listener: _resource_record_pre_action 08:55:51 INFO - Running main action method: create_virtualenv 08:55:51 INFO - Creating virtualenv /builds/slave/test/build/venv 08:55:51 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:55:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:55:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:55:51 INFO - Using real prefix '/tools/python27' 08:55:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:55:52 INFO - Installing distribute.............................................................................................................................................................................................done. 08:55:54 INFO - Installing pip.................done. 08:55:54 INFO - Return code: 0 08:55:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:55:54 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:54 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:54 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 0x10db24a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db34420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4a2d88e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c3e00>, '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 0x10d82cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9beb20>, '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.sWKrININ2N/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.rNZ0btBGJu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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:55:54 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:55:54 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:55:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWKrININ2N/Render', 08:55:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:54 INFO - 'HOME': '/Users/cltbld', 08:55:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:54 INFO - 'LOGNAME': 'cltbld', 08:55:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:54 INFO - 'MOZ_NO_REMOTE': '1', 08:55:54 INFO - 'NO_EM_RESTART': '1', 08:55:54 INFO - 'PAGER': '/bin/cat', 08:55:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:54 INFO - 'PWD': '/builds/slave/test', 08:55:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:54 INFO - 'SHELL': '/bin/bash', 08:55:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rNZ0btBGJu/Listeners', 08:55:54 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 08:55:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:54 INFO - 'USER': 'cltbld', 08:55:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:54 INFO - 'XPC_FLAGS': '0x0', 08:55:54 INFO - 'XPC_SERVICE_NAME': '0', 08:55:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:55 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:55:55 INFO - Cleaning up... 08:55:55 INFO - Return code: 0 08:55:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 08:55:55 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:55 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:55 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>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db24a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db34420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4a2d88e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c3e00>, '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 0x10d82cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9beb20>, '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.sWKrININ2N/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.rNZ0btBGJu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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:55:55 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>=0.7.1'] in /builds/slave/test/build 08:55:55 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>=0.7.1 08:55:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWKrININ2N/Render', 08:55:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:55 INFO - 'HOME': '/Users/cltbld', 08:55:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:55 INFO - 'LOGNAME': 'cltbld', 08:55:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:55 INFO - 'MOZ_NO_REMOTE': '1', 08:55:55 INFO - 'NO_EM_RESTART': '1', 08:55:55 INFO - 'PAGER': '/bin/cat', 08:55:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:55 INFO - 'PWD': '/builds/slave/test', 08:55:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:55 INFO - 'SHELL': '/bin/bash', 08:55:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rNZ0btBGJu/Listeners', 08:55:55 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 08:55:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:55 INFO - 'USER': 'cltbld', 08:55:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:55 INFO - 'XPC_FLAGS': '0x0', 08:55:55 INFO - 'XPC_SERVICE_NAME': '0', 08:55:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:55 INFO - Downloading/unpacking psutil>=0.7.1 08:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:55:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:55:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:55:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:55:58 INFO - Installing collected packages: psutil 08:55:58 INFO - Running setup.py install for psutil 08:55:58 INFO - building 'psutil._psutil_osx' extension 08:55:58 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:55:58 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:55:58 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:55:58 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:55:58 INFO - building 'psutil._psutil_posix' extension 08:55:58 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:55:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 08:55:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 08:55:59 INFO - ^ 08:55:59 INFO - 1 warning generated. 08:55:59 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:55:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:55:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:55:59 INFO - Successfully installed psutil 08:55:59 INFO - Cleaning up... 08:55:59 INFO - Return code: 0 08:55:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 08:55:59 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:55:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:59 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:55:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:55:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:55:59 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.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db24a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db34420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4a2d88e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c3e00>, '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 0x10d82cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9beb20>, '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.sWKrININ2N/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.rNZ0btBGJu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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:55:59 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.0.0'] in /builds/slave/test/build 08:55:59 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.0.0 08:55:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWKrININ2N/Render', 08:55:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:55:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:55:59 INFO - 'HOME': '/Users/cltbld', 08:55:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:55:59 INFO - 'LOGNAME': 'cltbld', 08:55:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:55:59 INFO - 'MOZ_NO_REMOTE': '1', 08:55:59 INFO - 'NO_EM_RESTART': '1', 08:55:59 INFO - 'PAGER': '/bin/cat', 08:55:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:55:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:55:59 INFO - 'PWD': '/builds/slave/test', 08:55:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:55:59 INFO - 'SHELL': '/bin/bash', 08:55:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rNZ0btBGJu/Listeners', 08:55:59 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 08:55:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:55:59 INFO - 'USER': 'cltbld', 08:55:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:55:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:55:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:55:59 INFO - 'XPC_FLAGS': '0x0', 08:55:59 INFO - 'XPC_SERVICE_NAME': '0', 08:55:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:55:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:55:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 08:55: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:55: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:55: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:55: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:55: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:55: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:56:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 08:56:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:56:02 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 08:56:02 INFO - Installing collected packages: mozsystemmonitor 08:56:02 INFO - Running setup.py install for mozsystemmonitor 08:56:02 INFO - Successfully installed mozsystemmonitor 08:56:02 INFO - Cleaning up... 08:56:02 INFO - Return code: 0 08:56:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10db24a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db34420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4a2d88e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c3e00>, '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 0x10d82cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9beb20>, '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.sWKrININ2N/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.rNZ0btBGJu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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:56:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:56:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:56:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWKrININ2N/Render', 08:56:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:02 INFO - 'HOME': '/Users/cltbld', 08:56:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:02 INFO - 'LOGNAME': 'cltbld', 08:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:02 INFO - 'MOZ_NO_REMOTE': '1', 08:56:02 INFO - 'NO_EM_RESTART': '1', 08:56:02 INFO - 'PAGER': '/bin/cat', 08:56:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:02 INFO - 'PWD': '/builds/slave/test', 08:56:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:02 INFO - 'SHELL': '/bin/bash', 08:56:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rNZ0btBGJu/Listeners', 08:56:02 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 08:56:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:02 INFO - 'USER': 'cltbld', 08:56:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:02 INFO - 'XPC_FLAGS': '0x0', 08:56:02 INFO - 'XPC_SERVICE_NAME': '0', 08:56:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:02 INFO - Downloading/unpacking blobuploader==1.2.4 08:56:02 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:56:02 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:56:02 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:56:02 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:56:02 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:56:02 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:56:04 INFO - Downloading blobuploader-1.2.4.tar.gz 08:56:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:56:05 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:56:05 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:56:05 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:56:05 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:56:05 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:56:05 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:56:05 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:56:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:56:05 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:56:05 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:56:05 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:56:05 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:56:05 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:56:05 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:56:05 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:56:06 INFO - Downloading docopt-0.6.1.tar.gz 08:56:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:56:06 INFO - Installing collected packages: blobuploader, requests, docopt 08:56:06 INFO - Running setup.py install for blobuploader 08:56:06 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:56:06 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:56:06 INFO - Running setup.py install for requests 08:56:06 INFO - Running setup.py install for docopt 08:56:07 INFO - Successfully installed blobuploader requests docopt 08:56:07 INFO - Cleaning up... 08:56:07 INFO - Return code: 0 08:56:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:07 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:07 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 0x10db24a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db34420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4a2d88e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c3e00>, '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 0x10d82cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9beb20>, '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.sWKrININ2N/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.rNZ0btBGJu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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:56:07 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:56:07 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:56:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWKrININ2N/Render', 08:56:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:07 INFO - 'HOME': '/Users/cltbld', 08:56:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:07 INFO - 'LOGNAME': 'cltbld', 08:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:07 INFO - 'MOZ_NO_REMOTE': '1', 08:56:07 INFO - 'NO_EM_RESTART': '1', 08:56:07 INFO - 'PAGER': '/bin/cat', 08:56:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:07 INFO - 'PWD': '/builds/slave/test', 08:56:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:07 INFO - 'SHELL': '/bin/bash', 08:56:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rNZ0btBGJu/Listeners', 08:56:07 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 08:56:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:07 INFO - 'USER': 'cltbld', 08:56:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:07 INFO - 'XPC_FLAGS': '0x0', 08:56:07 INFO - 'XPC_SERVICE_NAME': '0', 08:56:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:56:07 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-oRYe15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:56:07 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-b5jdbD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:56:07 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-lvMk9b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:56:07 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-YV02wy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:56:07 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-HC3pYS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:56:07 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-AH02pc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:56:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:56:07 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-Ws1UG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:56:08 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-V74bn7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:56:08 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-BnNj7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:56:08 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-gLzfF7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:56:08 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-vMWKuo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:56:08 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-QEP_tc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:56:08 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-N4nDRE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:56:08 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-i4CuH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:08 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-qX5Kbm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:56:08 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-hqrto7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:56:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:56:09 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-nXTou1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:56:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:56:09 INFO - Running setup.py install for manifestparser 08:56:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:56:09 INFO - Running setup.py install for mozcrash 08:56:09 INFO - Running setup.py install for mozdebug 08:56:09 INFO - Running setup.py install for mozdevice 08:56:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:56:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:56:09 INFO - Running setup.py install for mozfile 08:56:09 INFO - Running setup.py install for mozhttpd 08:56:09 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:56:09 INFO - Running setup.py install for mozinfo 08:56:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:56:10 INFO - Running setup.py install for mozInstall 08:56:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:56:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:56:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:56:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:56:10 INFO - Running setup.py install for mozleak 08:56:10 INFO - Running setup.py install for mozlog 08:56:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:56:10 INFO - Running setup.py install for moznetwork 08:56:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:56:10 INFO - Running setup.py install for mozprocess 08:56:10 INFO - Running setup.py install for mozprofile 08:56:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:56:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:56:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:56:11 INFO - Running setup.py install for mozrunner 08:56:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:56:11 INFO - Running setup.py install for mozscreenshot 08:56:11 INFO - Running setup.py install for moztest 08:56:11 INFO - Running setup.py install for mozversion 08:56:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:56:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:56:11 INFO - Cleaning up... 08:56:11 INFO - Return code: 0 08:56:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:11 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 0x10db24a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db34420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4a2d88e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c3e00>, '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 0x10d82cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9beb20>, '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.sWKrININ2N/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.rNZ0btBGJu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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:56:11 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:56:11 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:56:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWKrININ2N/Render', 08:56:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:11 INFO - 'HOME': '/Users/cltbld', 08:56:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:11 INFO - 'LOGNAME': 'cltbld', 08:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:11 INFO - 'MOZ_NO_REMOTE': '1', 08:56:11 INFO - 'NO_EM_RESTART': '1', 08:56:11 INFO - 'PAGER': '/bin/cat', 08:56:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:11 INFO - 'PWD': '/builds/slave/test', 08:56:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:11 INFO - 'SHELL': '/bin/bash', 08:56:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rNZ0btBGJu/Listeners', 08:56:11 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 08:56:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:11 INFO - 'USER': 'cltbld', 08:56:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:11 INFO - 'XPC_FLAGS': '0x0', 08:56:11 INFO - 'XPC_SERVICE_NAME': '0', 08:56:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:56:11 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-yRE6mV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:56:12 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:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:56:12 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-0t6cz5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:56:12 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-SrNVIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:56:12 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:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:56:12 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-PR23Ie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:56:12 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-lXqTEi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:56:12 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:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:56:12 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-4vd7BO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:56:12 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:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:56:12 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-X67FnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:56:12 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:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:56:12 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-G2UIPZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:56:12 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:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:56:12 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-eXEEJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:56:12 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:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:56:12 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-uFA9jB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:56:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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:56:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:56:12 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-Agidw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:56:13 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:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:56:13 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-H9IkJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:56:13 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-pijW_J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:56:13 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:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:56:13 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-kBa94B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:13 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-5ytLGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:56:13 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:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:56:13 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-5NKF1p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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:56:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:56:13 INFO - Running setup.py (path:/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/pip-2kqlNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:56:13 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:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:56:13 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:56:13 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:56:13 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:56:13 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:56:13 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:16 INFO - Downloading blessings-1.6.tar.gz 08:56:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:56:16 INFO - Installing collected packages: blessings 08:56:16 INFO - Running setup.py install for blessings 08:56:16 INFO - Successfully installed blessings 08:56:16 INFO - Cleaning up... 08:56:16 INFO - Return code: 0 08:56:16 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:56:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:56:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:56:16 INFO - Reading from file tmpfile_stdout 08:56:16 INFO - Current package versions: 08:56:16 INFO - blessings == 1.6 08:56:16 INFO - blobuploader == 1.2.4 08:56:16 INFO - docopt == 0.6.1 08:56:16 INFO - manifestparser == 1.1 08:56:16 INFO - mozInstall == 1.12 08:56:16 INFO - mozcrash == 0.17 08:56:16 INFO - mozdebug == 0.1 08:56:16 INFO - mozdevice == 0.48 08:56:16 INFO - mozfile == 1.2 08:56:16 INFO - mozhttpd == 0.7 08:56:16 INFO - mozinfo == 0.9 08:56:16 INFO - mozleak == 0.1 08:56:16 INFO - mozlog == 3.1 08:56:16 INFO - moznetwork == 0.27 08:56:16 INFO - mozprocess == 0.22 08:56:16 INFO - mozprofile == 0.28 08:56:16 INFO - mozrunner == 6.11 08:56:16 INFO - mozscreenshot == 0.1 08:56:16 INFO - mozsystemmonitor == 0.0 08:56:16 INFO - moztest == 0.7 08:56:16 INFO - mozversion == 1.4 08:56:16 INFO - psutil == 3.1.1 08:56:16 INFO - requests == 1.2.3 08:56:16 INFO - wsgiref == 0.1.2 08:56:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:56: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56: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 0x10db24a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db34420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4a2d88e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c3e00>, '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 0x10d82cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9beb20>, '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.sWKrININ2N/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.rNZ0btBGJu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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:56: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:56: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:56:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWKrININ2N/Render', 08:56:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:16 INFO - 'HOME': '/Users/cltbld', 08:56:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:16 INFO - 'LOGNAME': 'cltbld', 08:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:16 INFO - 'MOZ_NO_REMOTE': '1', 08:56:16 INFO - 'NO_EM_RESTART': '1', 08:56:16 INFO - 'PAGER': '/bin/cat', 08:56:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:16 INFO - 'PWD': '/builds/slave/test', 08:56:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:16 INFO - 'SHELL': '/bin/bash', 08:56:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rNZ0btBGJu/Listeners', 08:56:16 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 08:56:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:16 INFO - 'USER': 'cltbld', 08:56:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:16 INFO - 'XPC_FLAGS': '0x0', 08:56:16 INFO - 'XPC_SERVICE_NAME': '0', 08:56:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56: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:56: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:56: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:56: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:56: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:56: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:56: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:56: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:56: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:56: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:56: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:56:16 INFO - Cleaning up... 08:56:17 INFO - Return code: 0 08:56:17 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:56:17 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:17 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:17 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db24a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db34420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4a2d88e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c3e00>, '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 0x10d82cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9beb20>, '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.sWKrININ2N/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.rNZ0btBGJu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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:56:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:56:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:56:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWKrININ2N/Render', 08:56:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:17 INFO - 'HOME': '/Users/cltbld', 08:56:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:17 INFO - 'LOGNAME': 'cltbld', 08:56:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:17 INFO - 'MOZ_NO_REMOTE': '1', 08:56:17 INFO - 'NO_EM_RESTART': '1', 08:56:17 INFO - 'PAGER': '/bin/cat', 08:56:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:17 INFO - 'PWD': '/builds/slave/test', 08:56:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:17 INFO - 'SHELL': '/bin/bash', 08:56:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rNZ0btBGJu/Listeners', 08:56:17 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 08:56:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:17 INFO - 'USER': 'cltbld', 08:56:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:17 INFO - 'XPC_FLAGS': '0x0', 08:56:17 INFO - 'XPC_SERVICE_NAME': '0', 08:56:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:17 INFO - Downloading/unpacking jsonschema 08:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:19 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:56:19 INFO - Downloading/unpacking functools32 (from jsonschema) 08:56:19 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:56:19 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:56:19 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:56:19 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:56:19 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:56:19 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:56:20 INFO - Downloading functools32-3.2.3-2.tar.gz 08:56:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:56:20 INFO - warning: no files found matching '*.txt' 08:56:20 INFO - no previously-included directories found matching 'build' 08:56:20 INFO - no previously-included directories found matching 'dist' 08:56:20 INFO - no previously-included directories found matching '.git*' 08:56:20 INFO - Installing collected packages: jsonschema, functools32 08:56:20 INFO - Running setup.py install for functools32 08:56:20 INFO - warning: no files found matching '*.txt' 08:56:20 INFO - no previously-included directories found matching 'build' 08:56:20 INFO - no previously-included directories found matching 'dist' 08:56:20 INFO - no previously-included directories found matching '.git*' 08:56:20 INFO - Successfully installed jsonschema functools32 08:56:20 INFO - Cleaning up... 08:56:20 INFO - Return code: 0 08:56:20 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 08:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:56:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:56:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:56:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10db24a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10db34420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe4a2d88e70>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c3e00>, '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 0x10d82cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9beb20>, '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.sWKrININ2N/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.rNZ0btBGJu/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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:56:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 08:56:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 08:56:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWKrININ2N/Render', 08:56:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:20 INFO - 'HOME': '/Users/cltbld', 08:56:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:20 INFO - 'LOGNAME': 'cltbld', 08:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:20 INFO - 'MOZ_NO_REMOTE': '1', 08:56:20 INFO - 'NO_EM_RESTART': '1', 08:56:20 INFO - 'PAGER': '/bin/cat', 08:56:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:20 INFO - 'PWD': '/builds/slave/test', 08:56:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:20 INFO - 'SHELL': '/bin/bash', 08:56:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rNZ0btBGJu/Listeners', 08:56:20 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 08:56:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:20 INFO - 'USER': 'cltbld', 08:56:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:20 INFO - 'XPC_FLAGS': '0x0', 08:56:20 INFO - 'XPC_SERVICE_NAME': '0', 08:56:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:56:21 INFO - Downloading/unpacking flake8 08:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:56:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:56:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:56:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 08:56:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 08:56:24 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:56:24 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:56:24 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:56:24 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:56:24 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:56:24 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:56:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 08:56:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 08:56:24 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:56:24 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:56:24 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:56:24 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:56:24 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:56:24 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:56:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 08:56:24 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:56:24 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:56:24 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:56:24 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:56:24 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:56:24 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:56:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 08:56:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:56:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:56:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:56:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:56:25 INFO - no previously-included directories found matching 'docs/_build' 08:56:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 08:56:25 INFO - Running setup.py install for pep8 08:56:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 08:56:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 08:56:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 08:56:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 08:56:25 INFO - no previously-included directories found matching 'docs/_build' 08:56:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 08:56:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 08:56:25 INFO - Cleaning up... 08:56:25 INFO - Return code: 0 08:56:25 INFO - Running post-action listener: _resource_record_post_action 08:56:25 INFO - Running post-action listener: _start_resource_monitoring 08:56:25 INFO - Starting resource monitoring. 08:56:25 INFO - ##### 08:56:25 INFO - ##### Running install step. 08:56:25 INFO - ##### 08:56:25 INFO - Running pre-action listener: _resource_record_pre_action 08:56:25 INFO - Running main action method: install 08:56:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:56:25 INFO - Reading from file tmpfile_stdout 08:56:25 INFO - Detecting whether we're running mozinstall >=1.0... 08:56:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:56:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:56:26 INFO - Reading from file tmpfile_stdout 08:56:26 INFO - Output received: 08:56:26 INFO - Usage: mozinstall [options] installer 08:56:26 INFO - Options: 08:56:26 INFO - -h, --help show this help message and exit 08:56:26 INFO - -d DEST, --destination=DEST 08:56:26 INFO - Directory to install application into. [default: 08:56:26 INFO - "/builds/slave/test"] 08:56:26 INFO - --app=APP Application being installed. [default: firefox] 08:56:26 INFO - mkdir: /builds/slave/test/build/application 08:56:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 08:56:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 08:56:47 INFO - Reading from file tmpfile_stdout 08:56:47 INFO - Output received: 08:56:47 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 08:56:47 INFO - Running post-action listener: _resource_record_post_action 08:56:47 INFO - ##### 08:56:47 INFO - ##### Running run-tests step. 08:56:47 INFO - ##### 08:56:47 INFO - Running pre-action listener: _resource_record_pre_action 08:56:47 INFO - Running main action method: run_tests 08:56:47 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:56:47 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:56:47 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:56:47 INFO - 2016-07-01 08:56:47.986 screenresolution[1948:13333] starting screenresolution argv=screenresolution get 08:56:47 INFO - 2016-07-01 08:56:47.989 screenresolution[1948:13333] Display 0: 1600x1200x32@60 08:56:47 INFO - 2016-07-01 08:56:47.994 screenresolution[1949:13335] starting screenresolution argv=screenresolution list 08:56:47 INFO - Available Modes on Display 0 08:56:47 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:56:47 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:56:47 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:56:47 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:56:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:56:48 INFO - Intel Iris: 08:56:48 INFO - Chipset Model: Intel Iris 08:56:48 INFO - Type: GPU 08:56:48 INFO - Bus: Built-In 08:56:48 INFO - VRAM (Dynamic, Max): 1536 MB 08:56:48 INFO - Vendor: Intel (0x8086) 08:56:48 INFO - Device ID: 0x0a2e 08:56:48 INFO - Revision ID: 0x0009 08:56:48 INFO - Displays: 08:56:48 INFO - Display: 08:56:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:56:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:56:48 INFO - Display Serial Number: 1600x1200 60 08:56:48 INFO - Main Display: Yes 08:56:48 INFO - Mirror: Off 08:56:48 INFO - Online: Yes 08:56:48 INFO - Rotation: Supported 08:56:48 INFO - Return code: 0 08:56:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:56:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:56:48 INFO - Python 2.7.3 08:56:48 INFO - Return code: 0 08:56:48 INFO - grabbing minidump binary from tooltool 08:56:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:56:48 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: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d9c3e00>, '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 0x10d82cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d9beb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:56:48 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:56:48 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:56:48 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:56:48 INFO - Return code: 0 08:56:48 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 08:56:48 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:56:48 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:56:48 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 08:56:48 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:56:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 08:56:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 08:56:49 INFO - Return code: 0 08:56:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0238', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0238 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:56:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.sWKrININ2N/Render', 08:56:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 08:56:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 08:56:49 INFO - 'HOME': '/Users/cltbld', 08:56:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 08:56:49 INFO - 'LOGNAME': 'cltbld', 08:56:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:56:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 08:56:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:56:49 INFO - 'MOZ_NO_REMOTE': '1', 08:56:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:56:49 INFO - 'NO_EM_RESTART': '1', 08:56:49 INFO - 'PAGER': '/bin/cat', 08:56:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 08:56:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:56:49 INFO - 'PWD': '/builds/slave/test', 08:56:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:56:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 08:56:49 INFO - 'SHELL': '/bin/bash', 08:56:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.rNZ0btBGJu/Listeners', 08:56:49 INFO - 'TMPDIR': '/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/', 08:56:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 08:56:49 INFO - 'USER': 'cltbld', 08:56:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 08:56:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 08:56:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:56:49 INFO - 'XPC_FLAGS': '0x0', 08:56:49 INFO - 'XPC_SERVICE_NAME': '0', 08:56:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 08:56:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0238', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:56:49 INFO - mozversion application_buildid: 20160701065031 08:56:49 INFO - mozversion application_changeset: 5e6976a28642d4d159071e14fd3251d76b9c46fa 08:56:49 INFO - mozversion application_display_name: Firefox 08:56:49 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:56:49 INFO - mozversion application_name: Firefox 08:56:49 INFO - mozversion application_remotingname: firefox 08:56:49 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 08:56:49 INFO - mozversion application_vendor: Mozilla 08:56:49 INFO - mozversion application_version: 48.0 08:56:49 INFO - mozversion platform_buildid: 20160701065031 08:56:49 INFO - mozversion platform_changeset: 5e6976a28642d4d159071e14fd3251d76b9c46fa 08:56:49 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 08:56:49 INFO - mozversion platform_version: 48.0 08:56:49 INFO - using testdate: 1467388609 08:56:49 INFO - actual date: 1467388609 08:56:49 INFO - starting webserver on 'localhost:49509' 08:56:49 INFO - SUITE-START | Running 2 tests 08:56:49 INFO - TEST-START | dromaeo_css 08:56:49 INFO - operating with platform_type : mac_ 08:56:49 INFO - Initialising browser for dromaeo_css test... 08:56:49 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpY0qbez/profile http://localhost:49509/getInfo.html) 08:56:52 INFO - PROCESS | 1967 | __metrics Screen width/height:1600/1200 08:56:52 INFO - PROCESS | 1967 | colorDepth:24 08:56:52 INFO - PROCESS | 1967 | Browser inner width/height: 1024/689 08:56:52 INFO - PROCESS | 1967 | __metrics 08:56:52 ERROR - PROCESS | 1967 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 08:56:53 INFO - TEST-INFO | 1967: exit 0 08:56:53 INFO - Browser initialized. 08:56:53 INFO - Running cycle 1/1 for dromaeo_css test... 08:56:53 INFO - TEST-INFO | started process 1971 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpY0qbez/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:57:05 INFO - PROCESS | 1971 | RSS: Main: 171421696 08:57:05 INFO - PROCESS | 1971 | 08:57:54 INFO - PROCESS | 1971 | 1467388674718 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:00:04 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:49509/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49509/tests/dromaeo/cssquery-ext.html) 09:00:05 INFO - PROCESS | 1971 | RSS: Main: 182108160 09:00:05 INFO - PROCESS | 1971 | 09:03:07 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:49509/tests/dromaeo/cssquery-ext.html (next: http://localhost:49509/tests/dromaeo/cssquery-jquery.html) 09:03:08 INFO - PROCESS | 1971 | RSS: Main: 192626688 09:03:08 INFO - PROCESS | 1971 | 09:06:10 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:49509/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49509/tests/dromaeo/cssquery-mootools.html) 09:06:10 INFO - PROCESS | 1971 | RSS: Main: 194752512 09:06:10 INFO - PROCESS | 1971 | 09:09:12 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:49509/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49509/tests/dromaeo/cssquery-prototype.html) 09:09:13 INFO - PROCESS | 1971 | RSS: Main: 198287360 09:09:13 INFO - PROCESS | 1971 | 09:12:15 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:49509/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49509/tests/dromaeo/cssquery-yui.html) 09:12:16 INFO - PROCESS | 1971 | RSS: Main: 197545984 09:12:16 INFO - PROCESS | 1971 | 09:15:18 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:49509/tests/dromaeo/cssquery-yui.html (next: http://localhost:49509/tests/dromaeo/cssquery-dojo.html) 09:15:18 INFO - PROCESS | 1971 | RSS: Main: 203337728 09:15:18 INFO - PROCESS | 1971 | 09:15:18 INFO - PROCESS | 1971 | __start_tp_report 09:15:18 INFO - PROCESS | 1971 | _x_x_mozilla_page_load 09:15:18 INFO - PROCESS | 1971 | _x_x_mozilla_page_load_details 09:15:18 INFO - PROCESS | 1971 | |i|pagename|runs| 09:15:18 INFO - PROCESS | 1971 | |0;dojo.html;3486.6164721880596;3553.6624020718023;3583.695385892199;3599.3521166190076;3614.7469677122613;5679.8580035499135;5695.971520142393;5714.371419143896;5722.456366645162;5756.8272951811405;4795.712257264567;5526.557875369971;5675.347335056459;5753.536724065685;5780.855478613026;5136.460671629481;5144.614153938451;5185.637005409623;5200.817971371002;5236.31927849379;4547.909041819178;4983.07813054586;5151.665141765792;5176.818811341604;5268.9473105269035;5208.114620514521;5213.921791173136;5224.164133738603;5239.842804715865;5301.761420736076;5032.320636714034;5201.297824793643;5202.3497062867145;5260.526552610264;5266.947330526703;5049.974750126225;5095.082885080684;5139.254808052849;5167.0957582422925;5200.713960732158;4545.545445455461;5447.128459446509;5543.223948647193;5593.972030139864;5614.3543492498475;6029.186059881948;6107.969460152715;6113.510919126459;6130.448259656608;6132.632042077445;6147.077938309245;6150.415710507495;6151;6193.009118541012;6248.406401391906;5847.8245652630485;5932.3177834548715;5933.169356290123;5938.10928360745;5941.8811623767715;5182.663126896739;6122.020476723703;6308;6341.270753863272;6341.556091073673;6102.72537735803;6110.877782444326;6111.297200821873;6126.356732543108;6142.201513803177;6160.948817957534;6213.565050446516;6218.81343559694;6224.253089629274;6228.065790131516;6041.78853740117;6074.331823499411;6103.6948152592195;6127.433875357673;6147.5553244987395;6104.328523862371;6116.633002019893;6118.282140153729;6129.754809807558;6133.233345831771;4920.163572192736;4961.975190124026;4964.304997300381;4972.7513624318635;4974.228994505857;4362.781860906942;4380.802863871133;4387.319965405367;4475.037866858641;4541.931871021938;5848.561357898089;5946.732397042144;6025.9096113558335;6038.969805150946;6057.3336932937345;5200.7919683213;6177.752889884444;6207.193064901534;6222.377762223832;6235.00239961604;5797.913031304533;5839.970800145972;5912.615679980873;5950.702464876826;5968.820935371946;5394.487523685322;5428.321459817523;5430.104032834538;5448.482394172547;5460.808871689551;6238.126662267377;6445.9355406446275;6446.613203207822;6454.935450645527;6458.741650333934;5039.748012599429;5128.256402821645;6112.388761123852;6127.448529632355;6133.233345831771;6340.334264902119;6382.106505089198;6387.945988911778;6440.903386449113;6442.323556026549;6005.729742161526;6070;6129.785457508966;6134.447899689049;6135.877282454415;6135.44703110649;6207.875842483216;6212.937870621417;6214.471769899428;6244.438000579969;6017.608855424559;6058.273007238983;6094.573379863367;6110.541709371903;6121.204243448323;5002.949970500248;5663.773449061991;6017.157597936205;6081.331053584014;6107.969460152671;5816.302043754777;5974.551908606785;5990.910136348046;5997.760089596367;6044.7279872406725;4690.554397332248;5845.883082338414;6040.365761595145;6072.544559157993;6087.391260874055;4101.343784994506;5398.325209348832;5965.850853728692;6050.42520960508;6105.114758360101 09:15:18 INFO - PROCESS | 1971 | |1;ext.html;523.110711789957;545.6971380883608;580.3673995345073;588.3087372337503;643.9034144878268;32652.346953060955;41586;41613.16773664525;41644;41756.95607609811;44007;45203.86990325244;45249.7737511312;45302.32046519296;45342.773286133604;9757;9857.55640996157;9957.800843983152;9963.701088967342;9990.800183996316;9866.062724041205;9948.801023979517;10000.099991000809;10013.94993025034;10019.699409017705;9859.30984831062;9914.603415863357;9925.007499250089;9927.751806204831;9955.651552195675;9955.75110622233;9994.35036722618;10000.349977251455;10012.849807252896;10018.949905250463;9881.555330010167;9922.156616687591;9990.850137247948;10000.849987250198;10019.248556358303;40206.79896600528;40630.984225394306;40900.79549602263;41261.587384126076;41484.37773433401;2831.8017738758294;2944.646642402904;3247.675232476757;3317.1872891141825;3432.7940323580665;30362;30513.542296865566;31945.84027079873;31999;32774.50838237428;2745.409736906575;2791.1905547391234;2839.2759846239283;2858.9142325730263;2933.325335172901;388352;389229;389888.99999999715;397539;397843;38811.02972425712;69755.65122174357;70941;71173.93239101418;74794.25205747873;34629.13427164341;38481.23037539233;39395.818125455706;39493.40759888604;39508.407373889415;14178;16309.021458712516;16909.40817071421;17005.91497042507;17012.149392530326;12818.038647101504;13732.382042807898;14075.155490670593;14425.85574144245;14454.349554270084;8555;8662.177093176138;8752.124787521198;8810.515421651871;8908.465492070496;3680.8652877141817;3706.777593344408;3759.2481503698823;3764.0401697567495;3802.3535998880257;992.0971915556809;1013.7820368620781;1044.1803184500131;1092.7978324010085;1104.1442881766695;31838.681613183573;32663;33140.88969836053;34120.82939585286;34176.48735268973;1084.7776205877776;1128.1344641113353;1130.711668524521;1154.7286387698884;1170.9238899471507;15319.92340038315;15438.996465229724;15576.376944922304;15633.687326253412;15882.364705411654;552059;660402;661573;671938;674410;64024.719505610556;64234.67882660557;65213.69572608616;65249;65413;1464.5679524540287;1581.1856893699753;1589.2292238264433;1599.4961587100026;1610.6054016765734;28571.42857142887;29620.703792962657;32241;32351.838240808644;32510.34979300448;55836.72081639566;57154.14268785888;57537.712311438176;57733.42266577281;57942;467902;498897.01102988503;521849;524455;526509;28626.713732862405;29205.85397073001;29217.7078229215;29536.704632953395;29672.554911676772;43268.567314327716;46991.825204370165;48859.755701221264;50166.49833501764;50321.496785033145;39560;39803.2039359217;40184.19631607293;40643;40673;38731.1452967541;39561.80219099001;40054.198916020934;40289.395659064554;40660;33607.83196084004;37988.81005594954;38151.04622384463;39668.801655991534;39888.80055599703;31567;31809.5228571567;33079.50380744339;33450.49824252687;33600.143987761316;24409.63385549254;25745.227643170736;26141.869290654187;26423.207303780917;26614.467710646066 09:15:18 INFO - PROCESS | 1971 | |2;jquery.html;409.60063937660783;414.49845686719067;415.27741729390857;419.515459644111;419.6852360729453;19975.800241997593;20729.06719197636;20823.16707331707;21185.152593896266;22332.8883355583;21296.787032129672;21629;22131.561448505836;22655;22668.773312266872;5726.370099289085;6128.172696685935;6238.064290356438;6252.968260237056;6277.901367260734;5222.92165617516;6070.696465176746;6079.756809727605;6154.199954005973;6204.13142160098;5891.764329426839;6080.756769729228;6217.098520714494;6218;6233.7818176363835;5875.559333049996;6126.7855625053135;6206.472449841746;6215.0055991041445;6226.066090086523;5430.239766432703;5451.454854514517;5455.208994695747;5457.126859702428;5458.863528411782;27154.32114197141;27401;27701.584476232874;27773.305667358276;27818.72181278202;2176.379731776436;2257.7177852768405;2389.2951579284154;2469.3703105707928;2753.2428582139873;15426.537203883789;15508.689826203525;15554.377824886991;15770.290336934866;16016;1797.2361746257789;1824.3067634299014;1832.3128826689992;1836.8530517558563;1873.644007638558;106494;106740.46629766801;107739.46130269299;110176.4491177547;111066.44466777696;9599.760005999766;11252.324860508395;11374;11716.121290903217;11938.403079845973;14393.568192954228;14442.422303107967;14478.565643030515;14517;14540.200288983995;8951.910480895238;9073.45559266446;9270.768230794283;9270.953645231732;9326.347155699172;9468.857967130498;9593.760155996157;9613.759656008655;9627.181689556326;9690.418574885529;7007.404370628452;7139.928600713926;7140.500164988401;7149.857002860018;7150.892736608955;1929.758780152481;1963.959101676114;1965.8722183058055;1973.1712680674152;1999.5501012272414;1000.2048371544639;1080.308602494404;1109.9223054386116;1121.5906194239044;1147.8966892979504;16161;21354.466138346666;22097.889510552664;22132.778672213393;22467.98894049739;1017.4302390661105;1019.9898001019894;1063.4895250279908;1063.9893601064045;1095.1020163466042;10220.591176353011;12025.562545487188;12102.576409825613;12119.030477561773;12372.505099795908;509832;515885;520382;548552;631249;58558.707206463696;63503.41241469;99499;110955;113787.86212137772;986.8421052631688;1036.528379587286;1039.5218199628105;1106.6071544601712;1120.8903185845954;18516.907415463374;18900.716489252398;19243.230270789572;19249.903750481157;19529.316473923343;50475.242871356226;53454.525510687294;53939;54189.729051354494;54696;75397.62301188459;79800.60099699696;80186.5990670043;80560.19439805528;81018.5949070251;7952.562609056557;8165.428420010542;8427.367947403847;8472.068072512142;8490.95754521248;9166.770830729285;12155.270683759003;13119.540816071392;13339.132956357806;13424.194548327132;11287.20989530725;11559.364234967157;11667.883321166679;11677.240979336317;11693.473793679475;7775.339096176662;10423.895761042595;11432.942835286103;11585.768284634092;11775.646730598095;11579.884201158218;11585.420728963349;11660.242084264495;11727.120465964916;11743.119266055252;7972.202779721982;8282.047564530156;8377.952755905511;8434.325253979545;8858.468491890508;7015.684294206875;10036.698899033041;11118.888811112109;11505;11825.46785394642 09:15:18 INFO - PROCESS | 1971 | |3;mootools.html;1618.9352425902962;1632.0534090227666;1982.4350060232837;2047.9078441470142;2088.571842772232;8294.460860044093;8926.86609700855;9033.00636929938;9256.676016339421;9291.442513449198;8863.955680221607;8895.555222238894;8931.687390941319;9054.547272636359;9093.045230250811;2188.518525924294;2495.8128140389454;2509.573372526675;2534.6831646044243;2548.872556372183;2287.5996700577416;2486.204414587333;2522.3478621502854;2593.5590949538623;2602.1803132013356;2430.6232533957264;2454.784881483668;2530.443302473453;2544.427503811646;2552.336392537944;2242.551489702066;2518.8488690678437;2524.8106392020673;2557.9360515987064;2582.9741702583015;2502.9249122526353;2503.0738626708053;2523.1547431610434;2525.734797846218;2537.251510804317;7637.19809420014;8898.866517002185;8957.6864809732;9062.637494500212;9124.863127053099;5558.86102847428;5637.210790489335;5698;5811.79658711943;5825.504832089277;3703.333399988001;3733.4213196954515;3760.1163726524246;3777.471154038437;3801.1827457096856;1044.17510166968;1051.9743250330944;1060.7984482948293;1068.5245065945658;1072.2708558180434;11883.168178227528;11995.94002029993;12041.698957526045;12253.816192757116;12254.754904901853;4280.250956082673;4964.05682920244;5022.694099534075;5090.49095090488;5162.019216348882;10601.787964240826;10650.680479585624;10654.520546575268;10676.62631807883;10690.679279621469;5552.361478429952;5577.637453565587;5728.885422291531;5752.6836024019085;5755.050416681284;3832.597577254348;5029.698218106925;5030.170021946338;5066.949330506648;5120.436751957282;4311.051568654953;4332.1119170569955;4377.868663940087;4411.161879242998;4421.579949904753;1411.0757453867527;1443.0403781485404;1448.5799118255798;1452.4408102880257;1455.0760267230385;735.3492159438828;826.2109685250572;842.6208206307186;846.5978660136386;924.4222361024359;5615.859603509945;6011.458968692838;6011.549133814981;6142;6148.538859585549;957.6073809737974;974.4494360686332;978.9720793167146;1031.7369070887025;1039.0129377091794;3926.54844692864;3950.150717595731;4018.618231268025;4033.838646454109;4059.4925634295714;10591.940805919501;10691.83962240567;10786.78426431467;10805.729856753644;11065.944670276596;10789.352638841694;10819.78360432787;10941.56233750641;10973.561057557608;11028.0074793269;8449.23956843887;8588.184122508477;8607.956960215159;8642.049374568793;8643.870341945001;5052.797888084582;5637.43625637433;5940.851478713067;5954.345022047658;6009.188759517584;9460.337776355589;9499.38254013487;9607.279454041114;9751.756206094904;9775.169110625677;9472.052794720474;9764.755881103029;9899.257555683209;9935.354201976848;10039.196864250696;7025;7458.5151965122095;7675.117361503499;7700.3454706350585;7815;7230.493865429369;7295.197528271779;8423.789405264917;8439.451435656663;8482.533460659723;7422.406207503494;7549.547027178387;7653.693852245848;7750.4867082588;7763.262490063435;6462.095306657166;7535.585542795199;7552.131504877009;7562.130355009244;7665.38676905835;7238.674259658223;7263.782086537412;7263.854722905618;7282.162551306667;7290.744823931137;4928.211486162197;4950.529699678525;4999.400071991385;5026.798928042837;5059;4716;4880.243562247857;5038.244263360525;5044.798208071636;5321.494458026481 09:15:18 INFO - PROCESS | 1971 | |4;prototype.html;332.40997229916894;336.70033670033666;337.09490019298187;343.3065208279275;345.9031471188068;6952.339527744869;6964.129483814523;6991.580505169693;7006.404455621272;7029.472789540792;6083.813656337016;6295.653739044351;6865.038894554754;6871.759488417906;6885.965570172142;4087.305158123126;4823.155947709146;4896;5018.222175562793;5033.874153146164;4980.950190498103;5034.697918124906;5055.46917573655;5058.367704036996;5068.873278168038;4972.25416187573;4990.850274491771;4994.026164897847;5010.549050585447;5020.447750747415;4015.4177644241713;4127.380892866064;4969.4036715594;4997.275395067732;5052.9747351263;4327.567243275679;4328.5455027222315;4334.783260836977;4337.631301339358;4338.1540599583095;6390.6485143317095;6588.93411065888;6606.372394622503;6681.265060843303;6684.197896252432;4986.8753281168265;5829.912551311733;5939.910901336483;5961.970190149065;5966.820995370146;6878.38094571491;7415.369693576053;7416.258374162595;7418.591977441239;7434.479586428952;4886.731229782361;4888;4889.682170658896;4895.0944075345815;4902.28916807061;7605.1634320225285;7892.921070789276;7895.763127106138;7903.407244456689;7930.762077137695;4961.2558116282125;4975.4527002029745;4979.90040199194;4990.750462476862;5012.799488020439;5051;5079.847604571869;5081.949180508148;5089.720065396365;5107.923381149286;5912.935671579071;5925.170476133345;5927.2590926134235;5940.31686356066;5944.940550594439;7450.850982980419;7467.066616672916;7477.887831682529;7493.962530187423;7515.924840751632;1720.7590937268792;1752.3516298969462;1788.7764029496313;1789.3647755047032;1796.2814874050484;942.7643089227693;1133.2973556394923;1141.5662048421548;1143.3711458697683;1149.2816989381636;7015.579065256101;7034.824129396704;7055.3650171484815;7078.504504684725;7085.397741192057;6059.272887253558;7424.331810137113;7599.810004749926;7739.729109481141;7767.495112817762;5587.273654424899;7044.260352662999;7050.788476345718;7108.928910710827;7128.92871071293;4108.8356465741035;4137.110521237888;4140.296149654566;4147.6267135957905;4152.27335216342;8178.263956243966;8186.713465028695;8189.099199088096;8201.753947381589;8215.876761848576;7779.299863012243;8067.878981815277;8072.990876140482;8080.19198080199;8082.19178082187;8140.715074972348;8148.266656000988;8165;8168.366326734558;8209.466384684976;5815.476607105381;7732.652030658522;7755.68977240904;7786.299233069051;7790.298873101448;7606.467547271638;7649.235076492307;7655.311022008046;7682.500637458547;7684.96253005837;7271;7441.293077157661;7841.5299180757875;8173.918260817553;8178.304844088319;5007.674501157413;5014.323066385991;5014.7994080236385;5023.4725353838785;5039.244113382875;7748.612569371621;7751.689932402641;7761.340286075521;7764.883526747216;7767.339776119094;7257.891131633135;7483.550986940801;7485.663145158372;7496.650602891314;7512.286332798375;7461.589612571361;7472.626368681435;7488.251174882468;7543.170251272246;7548.735794247175;7245.166805817187;7309.232530584212;7323.194448610755;7324.523905946096;7357.558546487228;7482.625868706652;7489.251074892685;7492.850142997218;7516.248375162659;7518.473706840468;7101.218865924848;7322.890156647548;7343.632818359168;7351.8529629408185;7391.1869694334655 09:15:18 INFO - PROCESS | 1971 | |5;yui.html;661.5567569728281;716.8064622551911;772.0118248641737;776.7009701265011;786.2726977545768;15489.535313940585;15489.5353139406;15603.141827199499;15718.607034824121;15791.605209869731;14454.783178252308;14491.49279775208;14503.05730127541;14507.782383264259;14533.418663253484;771.8456308738247;781.8514482248384;927.3323207290773;944.1219665710903;967.1199208720066;941.1858742187992;942.9717108486757;948.6015873333216;957.5451660461295;965.9758506037371;991.276368251177;1018.0226982097196;1019.94390308533;1026.9024442677933;1036.295319182959;982.0277924854379;994.2145704893198;1007.8135544924139;1021.509675355826;1031.515187861704;627.1063734178776;718.7843646905907;754.0988518720077;760.2663429790224;762.2758379539459;12726.281951936555;14927.25363731809;15352.848536359817;15380;15626.14056226907;13319.334033298393;13458.865411345958;13551.119177253546;13568;14342.713145737027;10100.89899101007;10131.79736405275;10357.844632330522;10502.474876256156;10761.30051546647;3601.2977469393477;3614.2590768892314;3621.2033352662634;3658.268346330718;3738.12154143776;75636.24363756347;76670;77858;82544.76182857262;82671;9811.852822207673;9960.203183745283;10011.998800119929;10077.899221007696;10217.489125543692;21352.78647213539;21623.56752864934;21805.781942180693;22722.09111635516;23311.300660980196;7831.451798374059;7882.369410447151;8078.636461359253;8166.836663266701;8238.50568965864;4232.470941132358;4241.766702831313;4248.362745588187;4310.396544483712;4346.978265108717;3663.4871118043493;3713.814309284525;3714.1271801126713;3733.533308336458;3737.6449237322413;670.8322919270182;678.8913773796169;681.2812482830562;695.7530076822757;712.8966299886591;604.29901314475;607.7690477618477;616.3220457496718;618.4279541424164;625.8810825943057;7912.434534200893;8551.315894728406;8552.059273479912;8611.268042216481;8650.35122365825;549;595.9046552551571;603.7645318325856;631.3591704420018;659.1990731261541;3922.1175235572337;3965.861194858166;3999.5400528939545;4036.555978842325;4060.0661847775177;90533.54733226291;91849;92775.5361223203;92833.53583232175;96905;79071.20928790754;79779.60110199529;80428.19571804207;81440.59279703564;83528;63568.364316356245;69062;69282.30717692859;73934.6303268491;74132.62933685297;8117.472364296302;8547.61535730906;8777.956110219407;8819.823603528022;8828.896387951507;47918;50860.71126799377;50993.74503127461;51227.71930701762;51489.742551287;67352.98970515544;69204;70046;70364;71851;11038.944805275922;11358.716032099264;11447.427628618369;11493.885061149616;11567.76864462723;11885.524579017088;11968.16222864391;12200.840920112576;12214.328211948428;12446.937765311115;11539.8269025963;11649.1263155262;11650.30098194111;11761.235519691192;11916.880831191576;11146.331220126818;11553.768924621629;11645.88354116448;11746.941265293619;11980.64058078259;10891.836622450828;11188.888111118784;11209.439528023404;11339.262947908359;11455.599054033402;9799.902000979899;9879.357841740264;9945.204383649147;9993.400395976265;10106.696799096038;9406.764830879283;9417.199538039069;9427.622895084394;9499.810003800023;9620.470874101991 09:15:18 INFO - PROCESS | 1971 | __end_tp_report 09:15:18 INFO - PROCESS | 1971 | __start_cc_report 09:15:18 INFO - PROCESS | 1971 | _x_x_mozilla_cycle_collect,402 09:15:18 INFO - PROCESS | 1971 | __end_cc_report 09:15:18 INFO - PROCESS | 1971 | __startTimestamp1467389718463__endTimestamp 09:15:18 INFO - PROCESS | 1971 | 09:15:18 INFO - PROCESS | 1971 | ------- Summary: start ------- 09:15:18 INFO - PROCESS | 1971 | Number of tests: 6 09:15:18 INFO - PROCESS | 1971 | 09:15:18 INFO - PROCESS | 1971 | [#0] dojo.html Cycles:165 Average:5676.42 Median:5965.85 stddev:646.89 (10.8%) stddev-sans-first:625.64 09:15:18 INFO - PROCESS | 1971 | Values: 3486.6 3553.7 3583.7 3599.4 3614.7 5679.9 5696.0 5714.4 5722.5 5756.8 4795.7 5526.6 5675.3 5753.5 5780.9 5136.5 5144.6 5185.6 5200.8 5236.3 4547.9 4983.1 5151.7 5176.8 5268.9 5208.1 5213.9 5224.2 5239.8 5301.8 5032.3 5201.3 5202.3 5260.5 5266.9 5050.0 5095.1 5139.3 5167.1 5200.7 4545.5 5447.1 5543.2 5594.0 5614.4 6029.2 6108.0 6113.5 6130.4 6132.6 6147.1 6150.4 6151.0 6193.0 6248.4 5847.8 5932.3 5933.2 5938.1 5941.9 5182.7 6122.0 6308.0 6341.3 6341.6 6102.7 6110.9 6111.3 6126.4 6142.2 6160.9 6213.6 6218.8 6224.3 6228.1 6041.8 6074.3 6103.7 6127.4 6147.6 6104.3 6116.6 6118.3 6129.8 6133.2 4920.2 4962.0 4964.3 4972.8 4974.2 4362.8 4380.8 4387.3 4475.0 4541.9 5848.6 5946.7 6025.9 6039.0 6057.3 5200.8 6177.8 6207.2 6222.4 6235.0 5797.9 5840.0 5912.6 5950.7 5968.8 5394.5 5428.3 5430.1 5448.5 5460.8 6238.1 6445.9 6446.6 6454.9 6458.7 5039.7 5128.3 6112.4 6127.4 6133.2 6340.3 6382.1 6387.9 6440.9 6442.3 6005.7 6070.0 6129.8 6134.4 6135.9 6135.4 6207.9 6212.9 6214.5 6244.4 6017.6 6058.3 6094.6 6110.5 6121.2 5002.9 5663.8 6017.2 6081.3 6108.0 5816.3 5974.6 5990.9 5997.8 6044.7 4690.6 5845.9 6040.4 6072.5 6087.4 4101.3 5398.3 5965.9 6050.4 6105.1 09:15:18 INFO - PROCESS | 1971 | 09:15:18 INFO - PROCESS | 1971 | [#1] ext.html Cycles:180 Average:65652.94 Median:388790.50 stddev:140530.14 (36.1%) stddev-sans-first:140839.29 09:15:18 INFO - PROCESS | 1971 | Values: 523.1 545.7 580.4 588.3 643.9 32652.3 41586.0 41613.2 41644.0 41757.0 44007.0 45203.9 45249.8 45302.3 45342.8 9757.0 9857.6 9957.8 9963.7 9990.8 9866.1 9948.8 10000.1 10013.9 10019.7 9859.3 9914.6 9925.0 9927.8 9955.7 9955.8 9994.4 10000.3 10012.8 10018.9 9881.6 9922.2 9990.9 10000.8 10019.2 40206.8 40631.0 40900.8 41261.6 41484.4 2831.8 2944.6 3247.7 3317.2 3432.8 30362.0 30513.5 31945.8 31999.0 32774.5 2745.4 2791.2 2839.3 2858.9 2933.3 388352.0 389229.0 389889.0 397539.0 397843.0 38811.0 69755.7 70941.0 71173.9 74794.3 34629.1 38481.2 39395.8 39493.4 39508.4 14178.0 16309.0 16909.4 17005.9 17012.1 12818.0 13732.4 14075.2 14425.9 14454.3 8555.0 8662.2 8752.1 8810.5 8908.5 3680.9 3706.8 3759.2 3764.0 3802.4 992.1 1013.8 1044.2 1092.8 1104.1 31838.7 32663.0 33140.9 34120.8 34176.5 1084.8 1128.1 1130.7 1154.7 1170.9 15319.9 15439.0 15576.4 15633.7 15882.4 552059.0 660402.0 661573.0 671938.0 674410.0 64024.7 64234.7 65213.7 65249.0 65413.0 1464.6 1581.2 1589.2 1599.5 1610.6 28571.4 29620.7 32241.0 32351.8 32510.3 55836.7 57154.1 57537.7 57733.4 57942.0 467902.0 498897.0 521849.0 524455.0 526509.0 28626.7 29205.9 29217.7 29536.7 29672.6 43268.6 46991.8 48859.8 50166.5 50321.5 39560.0 39803.2 40184.2 40643.0 40673.0 38731.1 39561.8 40054.2 40289.4 40660.0 33607.8 37988.8 38151.0 39668.8 39888.8 31567.0 31809.5 33079.5 33450.5 33600.1 24409.6 25745.2 26141.9 26423.2 26614.5 09:15:18 INFO - PROCESS | 1971 | 09:15:18 INFO - PROCESS | 1971 | [#2] jquery.html Cycles:180 Average:32718.11 Median:12362.85 stddev:90710.52 (733.7%) stddev-sans-first:90932.55 09:15:18 INFO - PROCESS | 1971 | Values: 409.6 414.5 415.3 419.5 419.7 19975.8 20729.1 20823.2 21185.2 22332.9 21296.8 21629.0 22131.6 22655.0 22668.8 5726.4 6128.2 6238.1 6253.0 6277.9 5222.9 6070.7 6079.8 6154.2 6204.1 5891.8 6080.8 6217.1 6218.0 6233.8 5875.6 6126.8 6206.5 6215.0 6226.1 5430.2 5451.5 5455.2 5457.1 5458.9 27154.3 27401.0 27701.6 27773.3 27818.7 2176.4 2257.7 2389.3 2469.4 2753.2 15426.5 15508.7 15554.4 15770.3 16016.0 1797.2 1824.3 1832.3 1836.9 1873.6 106494.0 106740.5 107739.5 110176.4 111066.4 9599.8 11252.3 11374.0 11716.1 11938.4 14393.6 14442.4 14478.6 14517.0 14540.2 8951.9 9073.5 9270.8 9271.0 9326.3 9468.9 9593.8 9613.8 9627.2 9690.4 7007.4 7139.9 7140.5 7149.9 7150.9 1929.8 1964.0 1965.9 1973.2 1999.6 1000.2 1080.3 1109.9 1121.6 1147.9 16161.0 21354.5 22097.9 22132.8 22468.0 1017.4 1020.0 1063.5 1064.0 1095.1 10220.6 12025.6 12102.6 12119.0 12372.5 509832.0 515885.0 520382.0 548552.0 631249.0 58558.7 63503.4 99499.0 110955.0 113787.9 986.8 1036.5 1039.5 1106.6 1120.9 18516.9 18900.7 19243.2 19249.9 19529.3 50475.2 53454.5 53939.0 54189.7 54696.0 75397.6 79800.6 80186.6 80560.2 81018.6 7952.6 8165.4 8427.4 8472.1 8491.0 9166.8 12155.3 13119.5 13339.1 13424.2 11287.2 11559.4 11667.9 11677.2 11693.5 7775.3 10423.9 11432.9 11585.8 11775.6 11579.9 11585.4 11660.2 11727.1 11743.1 7972.2 8282.0 8378.0 8434.3 8858.5 7015.7 10036.7 11118.9 11505.0 11825.5 09:15:18 INFO - PROCESS | 1971 | 09:15:18 INFO - PROCESS | 1971 | [#3] mootools.html Cycles:180 Average:5846.66 Median:5041.52 stddev:3217.51 (63.8%) stddev-sans-first:3210.85 09:15:18 INFO - PROCESS | 1971 | Values: 1618.9 1632.1 1982.4 2047.9 2088.6 8294.5 8926.9 9033.0 9256.7 9291.4 8864.0 8895.6 8931.7 9054.5 9093.0 2188.5 2495.8 2509.6 2534.7 2548.9 2287.6 2486.2 2522.3 2593.6 2602.2 2430.6 2454.8 2530.4 2544.4 2552.3 2242.6 2518.8 2524.8 2557.9 2583.0 2502.9 2503.1 2523.2 2525.7 2537.3 7637.2 8898.9 8957.7 9062.6 9124.9 5558.9 5637.2 5698.0 5811.8 5825.5 3703.3 3733.4 3760.1 3777.5 3801.2 1044.2 1052.0 1060.8 1068.5 1072.3 11883.2 11995.9 12041.7 12253.8 12254.8 4280.3 4964.1 5022.7 5090.5 5162.0 10601.8 10650.7 10654.5 10676.6 10690.7 5552.4 5577.6 5728.9 5752.7 5755.1 3832.6 5029.7 5030.2 5066.9 5120.4 4311.1 4332.1 4377.9 4411.2 4421.6 1411.1 1443.0 1448.6 1452.4 1455.1 735.3 826.2 842.6 846.6 924.4 5615.9 6011.5 6011.5 6142.0 6148.5 957.6 974.4 979.0 1031.7 1039.0 3926.5 3950.2 4018.6 4033.8 4059.5 10591.9 10691.8 10786.8 10805.7 11065.9 10789.4 10819.8 10941.6 10973.6 11028.0 8449.2 8588.2 8608.0 8642.0 8643.9 5052.8 5637.4 5940.9 5954.3 6009.2 9460.3 9499.4 9607.3 9751.8 9775.2 9472.1 9764.8 9899.3 9935.4 10039.2 7025.0 7458.5 7675.1 7700.3 7815.0 7230.5 7295.2 8423.8 8439.5 8482.5 7422.4 7549.5 7653.7 7750.5 7763.3 6462.1 7535.6 7552.1 7562.1 7665.4 7238.7 7263.8 7263.9 7282.2 7290.7 4928.2 4950.5 4999.4 5026.8 5059.0 4716.0 4880.2 5038.2 5044.8 5321.5 09:15:18 INFO - PROCESS | 1971 | 09:15:18 INFO - PROCESS | 1971 | [#4] prototype.html Cycles:180 Average:6076.56 Median:6998.99 stddev:1967.72 (28.1%) stddev-sans-first:1925.43 09:15:18 INFO - PROCESS | 1971 | Values: 332.4 336.7 337.1 343.3 345.9 6952.3 6964.1 6991.6 7006.4 7029.5 6083.8 6295.7 6865.0 6871.8 6886.0 4087.3 4823.2 4896.0 5018.2 5033.9 4981.0 5034.7 5055.5 5058.4 5068.9 4972.3 4990.9 4994.0 5010.5 5020.4 4015.4 4127.4 4969.4 4997.3 5053.0 4327.6 4328.5 4334.8 4337.6 4338.2 6390.6 6588.9 6606.4 6681.3 6684.2 4986.9 5829.9 5939.9 5962.0 5966.8 6878.4 7415.4 7416.3 7418.6 7434.5 4886.7 4888.0 4889.7 4895.1 4902.3 7605.2 7892.9 7895.8 7903.4 7930.8 4961.3 4975.5 4979.9 4990.8 5012.8 5051.0 5079.8 5081.9 5089.7 5107.9 5912.9 5925.2 5927.3 5940.3 5944.9 7450.9 7467.1 7477.9 7494.0 7515.9 1720.8 1752.4 1788.8 1789.4 1796.3 942.8 1133.3 1141.6 1143.4 1149.3 7015.6 7034.8 7055.4 7078.5 7085.4 6059.3 7424.3 7599.8 7739.7 7767.5 5587.3 7044.3 7050.8 7108.9 7128.9 4108.8 4137.1 4140.3 4147.6 4152.3 8178.3 8186.7 8189.1 8201.8 8215.9 7779.3 8067.9 8073.0 8080.2 8082.2 8140.7 8148.3 8165.0 8168.4 8209.5 5815.5 7732.7 7755.7 7786.3 7790.3 7606.5 7649.2 7655.3 7682.5 7685.0 7271.0 7441.3 7841.5 8173.9 8178.3 5007.7 5014.3 5014.8 5023.5 5039.2 7748.6 7751.7 7761.3 7764.9 7767.3 7257.9 7483.6 7485.7 7496.7 7512.3 7461.6 7472.6 7488.3 7543.2 7548.7 7245.2 7309.2 7323.2 7324.5 7357.6 7482.6 7489.3 7492.9 7516.2 7518.5 7101.2 7322.9 7343.6 7351.9 7391.2 09:15:18 INFO - PROCESS | 1971 | 09:15:18 INFO - PROCESS | 1971 | [#5] yui.html Cycles:180 Average:18603.80 Median:26019.37 stddev:25907.19 (99.6%) stddev-sans-first:25944.84 09:15:18 INFO - PROCESS | 1971 | Values: 661.6 716.8 772.0 776.7 786.3 15489.5 15489.5 15603.1 15718.6 15791.6 14454.8 14491.5 14503.1 14507.8 14533.4 771.8 781.9 927.3 944.1 967.1 941.2 943.0 948.6 957.5 966.0 991.3 1018.0 1019.9 1026.9 1036.3 982.0 994.2 1007.8 1021.5 1031.5 627.1 718.8 754.1 760.3 762.3 12726.3 14927.3 15352.8 15380.0 15626.1 13319.3 13458.9 13551.1 13568.0 14342.7 10100.9 10131.8 10357.8 10502.5 10761.3 3601.3 3614.3 3621.2 3658.3 3738.1 75636.2 76670.0 77858.0 82544.8 82671.0 9811.9 9960.2 10012.0 10077.9 10217.5 21352.8 21623.6 21805.8 22722.1 23311.3 7831.5 7882.4 8078.6 8166.8 8238.5 4232.5 4241.8 4248.4 4310.4 4347.0 3663.5 3713.8 3714.1 3733.5 3737.6 670.8 678.9 681.3 695.8 712.9 604.3 607.8 616.3 618.4 625.9 7912.4 8551.3 8552.1 8611.3 8650.4 549.0 595.9 603.8 631.4 659.2 3922.1 3965.9 3999.5 4036.6 4060.1 90533.5 91849.0 92775.5 92833.5 96905.0 79071.2 79779.6 80428.2 81440.6 83528.0 63568.4 69062.0 69282.3 73934.6 74132.6 8117.5 8547.6 8778.0 8819.8 8828.9 47918.0 50860.7 50993.7 51227.7 51489.7 67353.0 69204.0 70046.0 70364.0 71851.0 11038.9 11358.7 11447.4 11493.9 11567.8 11885.5 11968.2 12200.8 12214.3 12446.9 11539.8 11649.1 11650.3 11761.2 11916.9 11146.3 11553.8 11645.9 11746.9 11980.6 10891.8 11188.9 11209.4 11339.3 11455.6 9799.9 9879.4 9945.2 9993.4 10106.7 9406.8 9417.2 9427.6 9499.8 9620.5 09:15:18 INFO - PROCESS | 1971 | -------- Summary: end -------- 09:15:18 INFO - PROCESS | 1971 | 09:15:18 INFO - TEST-INFO | 1971: exit 0 09:15:18 INFO - TEST-OK | dromaeo_css | took 1109385ms 09:15:18 INFO - TEST-START | kraken 09:15:19 INFO - operating with platform_type : mac_ 09:15:19 INFO - Initialising browser for kraken test... 09:15:19 INFO - TEST-INFO | started process 1976 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpSGVkfx/profile http://localhost:49509/getInfo.html) 09:15:21 INFO - PROCESS | 1976 | __metrics Screen width/height:1600/1200 09:15:21 INFO - PROCESS | 1976 | colorDepth:24 09:15:21 INFO - PROCESS | 1976 | Browser inner width/height: 1024/689 09:15:21 INFO - PROCESS | 1976 | __metrics 09:15:21 ERROR - PROCESS | 1976 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2931: TypeError: this.tabs is undefined 09:15:22 INFO - TEST-INFO | 1976: exit 0 09:15:22 INFO - Browser initialized. 09:15:22 INFO - Running cycle 1/1 for kraken test... 09:15:22 INFO - TEST-INFO | started process 1980 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/T/tmpSGVkfx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:15:34 INFO - PROCESS | 1980 | RSS: Main: 171069440 09:15:34 INFO - PROCESS | 1980 | 09:15:37 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49509/tests/kraken/driver.html?testName=audio-beat-detection) 09:15:38 INFO - PROCESS | 1980 | RSS: Main: 183644160 09:15:38 INFO - PROCESS | 1980 | 09:15:40 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49509/tests/kraken/driver.html?testName=audio-dft) 09:15:41 INFO - PROCESS | 1980 | RSS: Main: 192860160 09:15:41 INFO - PROCESS | 1980 | 09:15:44 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49509/tests/kraken/driver.html?testName=audio-fft) 09:15:45 INFO - PROCESS | 1980 | RSS: Main: 196505600 09:15:45 INFO - PROCESS | 1980 | 09:15:47 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49509/tests/kraken/driver.html?testName=audio-oscillator) 09:15:48 INFO - PROCESS | 1980 | RSS: Main: 197693440 09:15:48 INFO - PROCESS | 1980 | 09:15:50 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49509/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:15:50 INFO - PROCESS | 1980 | RSS: Main: 198885376 09:15:50 INFO - PROCESS | 1980 | 09:15:53 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49509/tests/kraken/driver.html?testName=imaging-darkroom) 09:15:54 INFO - PROCESS | 1980 | RSS: Main: 197898240 09:15:54 INFO - PROCESS | 1980 | 09:15:56 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49509/tests/kraken/driver.html?testName=imaging-desaturate) 09:15:57 INFO - PROCESS | 1980 | RSS: Main: 198025216 09:15:57 INFO - PROCESS | 1980 | 09:16:00 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49509/tests/kraken/driver.html?testName=json-parse-financial) 09:16:01 INFO - PROCESS | 1980 | RSS: Main: 198717440 09:16:01 INFO - PROCESS | 1980 | 09:16:02 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49509/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:16:03 INFO - PROCESS | 1980 | RSS: Main: 198062080 09:16:03 INFO - PROCESS | 1980 | 09:16:05 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49509/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:16:05 INFO - PROCESS | 1980 | RSS: Main: 197931008 09:16:05 INFO - PROCESS | 1980 | 09:16:08 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49509/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:16:08 INFO - PROCESS | 1980 | RSS: Main: 198447104 09:16:08 INFO - PROCESS | 1980 | 09:16:11 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:16:12 INFO - PROCESS | 1980 | RSS: Main: 198017024 09:16:12 INFO - PROCESS | 1980 | 09:16:15 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:16:15 INFO - PROCESS | 1980 | RSS: Main: 197963776 09:16:15 INFO - PROCESS | 1980 | 09:16:17 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49509/tests/kraken/driver.html?testName=ai-astar) 09:16:17 INFO - PROCESS | 1980 | RSS: Main: 199692288 09:16:17 INFO - PROCESS | 1980 | 09:16:17 INFO - PROCESS | 1980 | __start_tp_report 09:16:17 INFO - PROCESS | 1980 | _x_x_mozilla_page_load 09:16:17 INFO - PROCESS | 1980 | _x_x_mozilla_page_load_details 09:16:17 INFO - PROCESS | 1980 | |i|pagename|runs| 09:16:17 INFO - PROCESS | 1980 | |0;ai-astar;112;110;124;169;174;132;117;119;117;116 09:16:17 INFO - PROCESS | 1980 | |1;audio-beat-detection;154;122;146;159;112;134;150;191;175;108 09:16:17 INFO - PROCESS | 1980 | |2;audio-dft;192;201;198;200;248;267;197;198;194;198 09:16:17 INFO - PROCESS | 1980 | |3;audio-fft;67;106;110;172;56;56;56;66;130;86 09:16:17 INFO - PROCESS | 1980 | |4;audio-oscillator;78;82;127;77;80;105;122;81;80;123 09:16:17 INFO - PROCESS | 1980 | |5;imaging-gaussian-blur;89;86;89;75;134;130;94;87;90;86 09:16:17 INFO - PROCESS | 1980 | |6;imaging-darkroom;94;94;94;95;96;96;94;108;149;95 09:16:17 INFO - PROCESS | 1980 | |7;imaging-desaturate;90;93;120;134;91;90;90;92;89;89 09:16:17 INFO - PROCESS | 1980 | |8;json-parse-financial;59;63;65;66;67;64;64;98;93;87 09:16:17 INFO - PROCESS | 1980 | |9;json-stringify-tinderbox;63;67;73;68;76;71;73;67;63;65 09:16:17 INFO - PROCESS | 1980 | |10;stanford-crypto-aes;92;70;99;105;107;104;113;72;100;108 09:16:17 INFO - PROCESS | 1980 | |11;stanford-crypto-ccm;131;127;115;146;149;142;149;149;127;172 09:16:17 INFO - PROCESS | 1980 | |12;stanford-crypto-pbkdf2;153;162;151;195;217;160;203;220;167;166 09:16:17 INFO - PROCESS | 1980 | |13;stanford-crypto-sha256-iterative;72;97;97;81;65;67;65;67;69;65 09:16:17 INFO - PROCESS | 1980 | __end_tp_report 09:16:17 INFO - PROCESS | 1980 | __start_cc_report 09:16:17 INFO - PROCESS | 1980 | _x_x_mozilla_cycle_collect,1050 09:16:17 INFO - PROCESS | 1980 | __end_cc_report 09:16:17 INFO - PROCESS | 1980 | __startTimestamp1467389777713__endTimestamp 09:16:17 INFO - PROCESS | 1980 | 09:16:17 INFO - PROCESS | 1980 | ------- Summary: start ------- 09:16:17 INFO - PROCESS | 1980 | Number of tests: 14 09:16:17 INFO - PROCESS | 1980 | 09:16:17 INFO - PROCESS | 1980 | [#0] ai-astar Cycles:10 Average:129.00 Median:121.50 stddev:23.25 (19.1%) stddev-sans-first:23.84 09:16:17 INFO - PROCESS | 1980 | Values: 112.0 110.0 124.0 169.0 174.0 132.0 117.0 119.0 117.0 116.0 09:16:17 INFO - PROCESS | 1980 | 09:16:17 INFO - PROCESS | 1980 | [#1] audio-beat-detection Cycles:10 Average:145.10 Median:152.00 stddev:26.72 (17.6%) stddev-sans-first:28.15 09:16:17 INFO - PROCESS | 1980 | Values: 154.0 122.0 146.0 159.0 112.0 134.0 150.0 191.0 175.0 108.0 09:16:17 INFO - PROCESS | 1980 | 09:16:17 INFO - PROCESS | 1980 | [#2] audio-dft Cycles:10 Average:209.30 Median:199.00 stddev:25.93 (13.0%) stddev-sans-first:26.73 09:16:17 INFO - PROCESS | 1980 | Values: 192.0 201.0 198.0 200.0 248.0 267.0 197.0 198.0 194.0 198.0 09:16:17 INFO - PROCESS | 1980 | 09:16:17 INFO - PROCESS | 1980 | [#3] audio-fft Cycles:10 Average:90.50 Median:56.00 stddev:38.83 (69.3%) stddev-sans-first:40.24 09:16:17 INFO - PROCESS | 1980 | Values: 67.0 106.0 110.0 172.0 56.0 56.0 56.0 66.0 130.0 86.0 09:16:17 INFO - PROCESS | 1980 | 09:16:17 INFO - PROCESS | 1980 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:79.00 stddev:21.25 (26.9%) stddev-sans-first:21.57 09:16:17 INFO - PROCESS | 1980 | Values: 78.0 82.0 127.0 77.0 80.0 105.0 122.0 81.0 80.0 123.0 09:16:17 INFO - PROCESS | 1980 | 09:16:17 INFO - PROCESS | 1980 | [#5] imaging-gaussian-blur Cycles:10 Average:96.00 Median:88.00 stddev:19.61 (22.3%) stddev-sans-first:20.63 09:16:17 INFO - PROCESS | 1980 | Values: 89.0 86.0 89.0 75.0 134.0 130.0 94.0 87.0 90.0 86.0 09:16:17 INFO - PROCESS | 1980 | 09:16:17 INFO - PROCESS | 1980 | [#6] imaging-darkroom Cycles:10 Average:101.50 Median:94.50 stddev:17.22 (18.2%) stddev-sans-first:18.05 09:16:17 INFO - PROCESS | 1980 | Values: 94.0 94.0 94.0 95.0 96.0 96.0 94.0 108.0 149.0 95.0 09:16:17 INFO - PROCESS | 1980 | 09:16:17 INFO - PROCESS | 1980 | [#7] imaging-desaturate Cycles:10 Average:97.80 Median:90.00 stddev:15.79 (17.5%) stddev-sans-first:16.49 09:16:17 INFO - PROCESS | 1980 | Values: 90.0 93.0 120.0 134.0 91.0 90.0 90.0 92.0 89.0 89.0 09:16:17 INFO - PROCESS | 1980 | 09:16:17 INFO - PROCESS | 1980 | [#8] json-parse-financial Cycles:10 Average:72.60 Median:66.50 stddev:14.25 (21.4%) stddev-sans-first:14.23 09:16:17 INFO - PROCESS | 1980 | Values: 59.0 63.0 65.0 66.0 67.0 64.0 64.0 98.0 93.0 87.0 09:16:17 INFO - PROCESS | 1980 | 09:16:17 INFO - PROCESS | 1980 | [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.50 stddev:4.48 (6.4%) stddev-sans-first:4.27 09:16:17 INFO - PROCESS | 1980 | Values: 63.0 67.0 73.0 68.0 76.0 71.0 73.0 67.0 63.0 65.0 09:16:17 INFO - PROCESS | 1980 | 09:16:17 INFO - PROCESS | 1980 | [#10] stanford-crypto-aes Cycles:10 Average:97.00 Median:91.50 stddev:14.84 (16.2%) stddev-sans-first:15.63 09:16:17 INFO - PROCESS | 1980 | Values: 92.0 70.0 99.0 105.0 107.0 104.0 113.0 72.0 100.0 108.0 09:16:17 INFO - PROCESS | 1980 | 09:16:17 INFO - PROCESS | 1980 | [#11] stanford-crypto-ccm Cycles:10 Average:140.70 Median:147.50 stddev:16.15 (10.9%) stddev-sans-first:16.74 09:16:17 INFO - PROCESS | 1980 | Values: 131.0 127.0 115.0 146.0 149.0 142.0 149.0 149.0 127.0 172.0 09:16:17 INFO - PROCESS | 1980 | 09:16:17 INFO - PROCESS | 1980 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:179.40 Median:181.00 stddev:26.62 (14.7%) stddev-sans-first:26.47 09:16:17 INFO - PROCESS | 1980 | Values: 153.0 162.0 151.0 195.0 217.0 160.0 203.0 220.0 167.0 166.0 09:16:17 INFO - PROCESS | 1980 | 09:16:17 INFO - PROCESS | 1980 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:74.50 Median:70.50 stddev:12.80 (18.2%) stddev-sans-first:13.54 09:16:17 INFO - PROCESS | 1980 | Values: 72.0 97.0 97.0 81.0 65.0 67.0 65.0 67.0 69.0 65.0 09:16:17 INFO - PROCESS | 1980 | -------- Summary: end -------- 09:16:17 INFO - PROCESS | 1980 | 09:16:18 INFO - TEST-INFO | 1980: exit 0 09:16:18 INFO - TEST-OK | kraken | took 59606ms 09:16:18 INFO - SUITE-END | took 1168s 09:16:18 INFO - Completed test suite (00:19:29) 09:16:18 INFO - javascript benchmark 09:16:18 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3486.6164721880596, 3553.6624020718023, 3583.695385892199, 3599.3521166190076, 3614.7469677122613, 5679.8580035499135, 5695.971520142393, 5714.371419143896, 5722.456366645162, 5756.8272951811405, 4795.712257264567, 5526.557875369971, 5675.347335056459, 5753.536724065685, 5780.855478613026, 5136.460671629481, 5144.614153938451, 5185.637005409623, 5200.817971371002, 5236.31927849379, 4547.909041819178, 4983.07813054586, 5151.665141765792, 5176.818811341604, 5268.9473105269035, 5208.114620514521, 5213.921791173136, 5224.164133738603, 5239.842804715865, 5301.761420736076, 5032.320636714034, 5201.297824793643, 5202.3497062867145, 5260.526552610264, 5266.947330526703, 5049.974750126225, 5095.082885080684, 5139.254808052849, 5167.0957582422925, 5200.713960732158, 4545.545445455461, 5447.128459446509, 5543.223948647193, 5593.972030139864, 5614.3543492498475, 6029.186059881948, 6107.969460152715, 6113.510919126459, 6130.448259656608, 6132.632042077445, 6147.077938309245, 6150.415710507495, 6151.0, 6193.009118541012, 6248.406401391906, 5847.8245652630485, 5932.3177834548715, 5933.169356290123, 5938.10928360745, 5941.8811623767715, 5182.663126896739, 6122.020476723703, 6308.0, 6341.270753863272, 6341.556091073673, 6102.72537735803, 6110.877782444326, 6111.297200821873, 6126.356732543108, 6142.201513803177, 6160.948817957534, 6213.565050446516, 6218.81343559694, 6224.253089629274, 6228.065790131516, 6041.78853740117, 6074.331823499411, 6103.6948152592195, 6127.433875357673, 6147.5553244987395, 6104.328523862371, 6116.633002019893, 6118.282140153729, 6129.754809807558, 6133.233345831771, 4920.163572192736, 4961.975190124026, 4964.304997300381, 4972.7513624318635, 4974.228994505857, 4362.781860906942, 4380.802863871133, 4387.319965405367, 4475.037866858641, 4541.931871021938, 5848.561357898089, 5946.732397042144, 6025.9096113558335, 6038.969805150946, 6057.3336932937345, 5200.7919683213, 6177.752889884444, 6207.193064901534, 6222.377762223832, 6235.00239961604, 5797.913031304533, 5839.970800145972, 5912.615679980873, 5950.702464876826, 5968.820935371946, 5394.487523685322, 5428.321459817523, 5430.104032834538, 5448.482394172547, 5460.808871689551, 6238.126662267377, 6445.9355406446275, 6446.613203207822, 6454.935450645527, 6458.741650333934, 5039.748012599429, 5128.256402821645, 6112.388761123852, 6127.448529632355, 6133.233345831771, 6340.334264902119, 6382.106505089198, 6387.945988911778, 6440.903386449113, 6442.323556026549, 6005.729742161526, 6070.0, 6129.785457508966, 6134.447899689049, 6135.877282454415, 6135.44703110649, 6207.875842483216, 6212.937870621417, 6214.471769899428, 6244.438000579969, 6017.608855424559, 6058.273007238983, 6094.573379863367, 6110.541709371903, 6121.204243448323, 5002.949970500248, 5663.773449061991, 6017.157597936205, 6081.331053584014, 6107.969460152671, 5816.302043754777, 5974.551908606785, 5990.910136348046, 5997.760089596367, 6044.7279872406725, 4690.554397332248, 5845.883082338414, 6040.365761595145, 6072.544559157993, 6087.391260874055, 4101.343784994506, 5398.325209348832, 5965.850853728692, 6050.42520960508, 6105.114758360101], "value": 5640.735651230396, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [523.110711789957, 545.6971380883608, 580.3673995345073, 588.3087372337503, 643.9034144878268, 32652.346953060955, 41586.0, 41613.16773664525, 41644.0, 41756.95607609811, 44007.0, 45203.86990325244, 45249.7737511312, 45302.32046519296, 45342.773286133604, 9757.0, 9857.55640996157, 9957.800843983152, 9963.701088967342, 9990.800183996316, 9866.062724041205, 9948.801023979517, 10000.099991000809, 10013.94993025034, 10019.699409017705, 9859.30984831062, 9914.603415863357, 9925.007499250089, 9927.751806204831, 9955.651552195675, 9955.75110622233, 9994.35036722618, 10000.349977251455, 10012.849807252896, 10018.949905250463, 9881.555330010167, 9922.156616687591, 9990.850137247948, 10000.849987250198, 10019.248556358303, 40206.79896600528, 40630.984225394306, 40900.79549602263, 41261.587384126076, 41484.37773433401, 2831.8017738758294, 2944.646642402904, 3247.675232476757, 3317.1872891141825, 3432.7940323580665, 30362.0, 30513.542296865566, 31945.84027079873, 31999.0, 32774.50838237428, 2745.409736906575, 2791.1905547391234, 2839.2759846239283, 2858.9142325730263, 2933.325335172901, 388352.0, 389229.0, 389888.99999999715, 397539.0, 397843.0, 38811.02972425712, 69755.65122174357, 70941.0, 71173.93239101418, 74794.25205747873, 34629.13427164341, 38481.23037539233, 39395.818125455706, 39493.40759888604, 39508.407373889415, 14178.0, 16309.021458712516, 16909.40817071421, 17005.91497042507, 17012.149392530326, 12818.038647101504, 13732.382042807898, 14075.155490670593, 14425.85574144245, 14454.349554270084, 8555.0, 8662.177093176138, 8752.124787521198, 8810.515421651871, 8908.465492070496, 3680.8652877141817, 3706.777593344408, 3759.2481503698823, 3764.0401697567495, 3802.3535998880257, 992.0971915556809, 1013.7820368620781, 1044.1803184500131, 1092.7978324010085, 1104.1442881766695, 31838.681613183573, 32663.0, 33140.88969836053, 34120.82939585286, 34176.48735268973, 1084.7776205877776, 1128.1344641113353, 1130.711668524521, 1154.7286387698884, 1170.9238899471507, 15319.92340038315, 15438.996465229724, 15576.376944922304, 15633.687326253412, 15882.364705411654, 552059.0, 660402.0, 661573.0, 671938.0, 674410.0, 64024.719505610556, 64234.67882660557, 65213.69572608616, 65249.0, 65413.0, 1464.5679524540287, 1581.1856893699753, 1589.2292238264433, 1599.4961587100026, 1610.6054016765734, 28571.42857142887, 29620.703792962657, 32241.0, 32351.838240808644, 32510.34979300448, 55836.72081639566, 57154.14268785888, 57537.712311438176, 57733.42266577281, 57942.0, 467902.0, 498897.01102988503, 521849.0, 524455.0, 526509.0, 28626.713732862405, 29205.85397073001, 29217.7078229215, 29536.704632953395, 29672.554911676772, 43268.567314327716, 46991.825204370165, 48859.755701221264, 50166.49833501764, 50321.496785033145, 39560.0, 39803.2039359217, 40184.19631607293, 40643.0, 40673.0, 38731.1452967541, 39561.80219099001, 40054.198916020934, 40289.395659064554, 40660.0, 33607.83196084004, 37988.81005594954, 38151.04622384463, 39668.801655991534, 39888.80055599703, 31567.0, 31809.5228571567, 33079.50380744339, 33450.49824252687, 33600.143987761316, 24409.63385549254, 25745.227643170736, 26141.869290654187, 26423.207303780917, 26614.467710646066], "value": 19379.902246853635, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [409.60063937660783, 414.49845686719067, 415.27741729390857, 419.515459644111, 419.6852360729453, 19975.800241997593, 20729.06719197636, 20823.16707331707, 21185.152593896266, 22332.8883355583, 21296.787032129672, 21629.0, 22131.561448505836, 22655.0, 22668.773312266872, 5726.370099289085, 6128.172696685935, 6238.064290356438, 6252.968260237056, 6277.901367260734, 5222.92165617516, 6070.696465176746, 6079.756809727605, 6154.199954005973, 6204.13142160098, 5891.764329426839, 6080.756769729228, 6217.098520714494, 6218.0, 6233.7818176363835, 5875.559333049996, 6126.7855625053135, 6206.472449841746, 6215.0055991041445, 6226.066090086523, 5430.239766432703, 5451.454854514517, 5455.208994695747, 5457.126859702428, 5458.863528411782, 27154.32114197141, 27401.0, 27701.584476232874, 27773.305667358276, 27818.72181278202, 2176.379731776436, 2257.7177852768405, 2389.2951579284154, 2469.3703105707928, 2753.2428582139873, 15426.537203883789, 15508.689826203525, 15554.377824886991, 15770.290336934866, 16016.0, 1797.2361746257789, 1824.3067634299014, 1832.3128826689992, 1836.8530517558563, 1873.644007638558, 106494.0, 106740.46629766801, 107739.46130269299, 110176.4491177547, 111066.44466777696, 9599.760005999766, 11252.324860508395, 11374.0, 11716.121290903217, 11938.403079845973, 14393.568192954228, 14442.422303107967, 14478.565643030515, 14517.0, 14540.200288983995, 8951.910480895238, 9073.45559266446, 9270.768230794283, 9270.953645231732, 9326.347155699172, 9468.857967130498, 9593.760155996157, 9613.759656008655, 9627.181689556326, 9690.418574885529, 7007.404370628452, 7139.928600713926, 7140.500164988401, 7149.857002860018, 7150.892736608955, 1929.758780152481, 1963.959101676114, 1965.8722183058055, 1973.1712680674152, 1999.5501012272414, 1000.2048371544639, 1080.308602494404, 1109.9223054386116, 1121.5906194239044, 1147.8966892979504, 16161.0, 21354.466138346666, 22097.889510552664, 22132.778672213393, 22467.98894049739, 1017.4302390661105, 1019.9898001019894, 1063.4895250279908, 1063.9893601064045, 1095.1020163466042, 10220.591176353011, 12025.562545487188, 12102.576409825613, 12119.030477561773, 12372.505099795908, 509832.0, 515885.0, 520382.0, 548552.0, 631249.0, 58558.707206463696, 63503.41241469, 99499.0, 110955.0, 113787.86212137772, 986.8421052631688, 1036.528379587286, 1039.5218199628105, 1106.6071544601712, 1120.8903185845954, 18516.907415463374, 18900.716489252398, 19243.230270789572, 19249.903750481157, 19529.316473923343, 50475.242871356226, 53454.525510687294, 53939.0, 54189.729051354494, 54696.0, 75397.62301188459, 79800.60099699696, 80186.5990670043, 80560.19439805528, 81018.5949070251, 7952.562609056557, 8165.428420010542, 8427.367947403847, 8472.068072512142, 8490.95754521248, 9166.770830729285, 12155.270683759003, 13119.540816071392, 13339.132956357806, 13424.194548327132, 11287.20989530725, 11559.364234967157, 11667.883321166679, 11677.240979336317, 11693.473793679475, 7775.339096176662, 10423.895761042595, 11432.942835286103, 11585.768284634092, 11775.646730598095, 11579.884201158218, 11585.420728963349, 11660.242084264495, 11727.120465964916, 11743.119266055252, 7972.202779721982, 8282.047564530156, 8377.952755905511, 8434.325253979545, 8858.468491890508, 7015.684294206875, 10036.698899033041, 11118.888811112109, 11505.0, 11825.46785394642], "value": 9963.910771333747, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1618.9352425902962, 1632.0534090227666, 1982.4350060232837, 2047.9078441470142, 2088.571842772232, 8294.460860044093, 8926.86609700855, 9033.00636929938, 9256.676016339421, 9291.442513449198, 8863.955680221607, 8895.555222238894, 8931.687390941319, 9054.547272636359, 9093.045230250811, 2188.518525924294, 2495.8128140389454, 2509.573372526675, 2534.6831646044243, 2548.872556372183, 2287.5996700577416, 2486.204414587333, 2522.3478621502854, 2593.5590949538623, 2602.1803132013356, 2430.6232533957264, 2454.784881483668, 2530.443302473453, 2544.427503811646, 2552.336392537944, 2242.551489702066, 2518.8488690678437, 2524.8106392020673, 2557.9360515987064, 2582.9741702583015, 2502.9249122526353, 2503.0738626708053, 2523.1547431610434, 2525.734797846218, 2537.251510804317, 7637.19809420014, 8898.866517002185, 8957.6864809732, 9062.637494500212, 9124.863127053099, 5558.86102847428, 5637.210790489335, 5698.0, 5811.79658711943, 5825.504832089277, 3703.333399988001, 3733.4213196954515, 3760.1163726524246, 3777.471154038437, 3801.1827457096856, 1044.17510166968, 1051.9743250330944, 1060.7984482948293, 1068.5245065945658, 1072.2708558180434, 11883.168178227528, 11995.94002029993, 12041.698957526045, 12253.816192757116, 12254.754904901853, 4280.250956082673, 4964.05682920244, 5022.694099534075, 5090.49095090488, 5162.019216348882, 10601.787964240826, 10650.680479585624, 10654.520546575268, 10676.62631807883, 10690.679279621469, 5552.361478429952, 5577.637453565587, 5728.885422291531, 5752.6836024019085, 5755.050416681284, 3832.597577254348, 5029.698218106925, 5030.170021946338, 5066.949330506648, 5120.436751957282, 4311.051568654953, 4332.1119170569955, 4377.868663940087, 4411.161879242998, 4421.579949904753, 1411.0757453867527, 1443.0403781485404, 1448.5799118255798, 1452.4408102880257, 1455.0760267230385, 735.3492159438828, 826.2109685250572, 842.6208206307186, 846.5978660136386, 924.4222361024359, 5615.859603509945, 6011.458968692838, 6011.549133814981, 6142.0, 6148.538859585549, 957.6073809737974, 974.4494360686332, 978.9720793167146, 1031.7369070887025, 1039.0129377091794, 3926.54844692864, 3950.150717595731, 4018.618231268025, 4033.838646454109, 4059.4925634295714, 10591.940805919501, 10691.83962240567, 10786.78426431467, 10805.729856753644, 11065.944670276596, 10789.352638841694, 10819.78360432787, 10941.56233750641, 10973.561057557608, 11028.0074793269, 8449.23956843887, 8588.184122508477, 8607.956960215159, 8642.049374568793, 8643.870341945001, 5052.797888084582, 5637.43625637433, 5940.851478713067, 5954.345022047658, 6009.188759517584, 9460.337776355589, 9499.38254013487, 9607.279454041114, 9751.756206094904, 9775.169110625677, 9472.052794720474, 9764.755881103029, 9899.257555683209, 9935.354201976848, 10039.196864250696, 7025.0, 7458.5151965122095, 7675.117361503499, 7700.3454706350585, 7815.0, 7230.493865429369, 7295.197528271779, 8423.789405264917, 8439.451435656663, 8482.533460659723, 7422.406207503494, 7549.547027178387, 7653.693852245848, 7750.4867082588, 7763.262490063435, 6462.095306657166, 7535.585542795199, 7552.131504877009, 7562.130355009244, 7665.38676905835, 7238.674259658223, 7263.782086537412, 7263.854722905618, 7282.162551306667, 7290.744823931137, 4928.211486162197, 4950.529699678525, 4999.400071991385, 5026.798928042837, 5059.0, 4716.0, 4880.243562247857, 5038.244263360525, 5044.798208071636, 5321.494458026481], "value": 4737.061952961645, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.40997229916894, 336.70033670033666, 337.09490019298187, 343.3065208279275, 345.9031471188068, 6952.339527744869, 6964.129483814523, 6991.580505169693, 7006.404455621272, 7029.472789540792, 6083.813656337016, 6295.653739044351, 6865.038894554754, 6871.759488417906, 6885.965570172142, 4087.305158123126, 4823.155947709146, 4896.0, 5018.222175562793, 5033.874153146164, 4980.950190498103, 5034.697918124906, 5055.46917573655, 5058.367704036996, 5068.873278168038, 4972.25416187573, 4990.850274491771, 4994.026164897847, 5010.549050585447, 5020.447750747415, 4015.4177644241713, 4127.380892866064, 4969.4036715594, 4997.275395067732, 5052.9747351263, 4327.567243275679, 4328.5455027222315, 4334.783260836977, 4337.631301339358, 4338.1540599583095, 6390.6485143317095, 6588.93411065888, 6606.372394622503, 6681.265060843303, 6684.197896252432, 4986.8753281168265, 5829.912551311733, 5939.910901336483, 5961.970190149065, 5966.820995370146, 6878.38094571491, 7415.369693576053, 7416.258374162595, 7418.591977441239, 7434.479586428952, 4886.731229782361, 4888.0, 4889.682170658896, 4895.0944075345815, 4902.28916807061, 7605.1634320225285, 7892.921070789276, 7895.763127106138, 7903.407244456689, 7930.762077137695, 4961.2558116282125, 4975.4527002029745, 4979.90040199194, 4990.750462476862, 5012.799488020439, 5051.0, 5079.847604571869, 5081.949180508148, 5089.720065396365, 5107.923381149286, 5912.935671579071, 5925.170476133345, 5927.2590926134235, 5940.31686356066, 5944.940550594439, 7450.850982980419, 7467.066616672916, 7477.887831682529, 7493.962530187423, 7515.924840751632, 1720.7590937268792, 1752.3516298969462, 1788.7764029496313, 1789.3647755047032, 1796.2814874050484, 942.7643089227693, 1133.2973556394923, 1141.5662048421548, 1143.3711458697683, 1149.2816989381636, 7015.579065256101, 7034.824129396704, 7055.3650171484815, 7078.504504684725, 7085.397741192057, 6059.272887253558, 7424.331810137113, 7599.810004749926, 7739.729109481141, 7767.495112817762, 5587.273654424899, 7044.260352662999, 7050.788476345718, 7108.928910710827, 7128.92871071293, 4108.8356465741035, 4137.110521237888, 4140.296149654566, 4147.6267135957905, 4152.27335216342, 8178.263956243966, 8186.713465028695, 8189.099199088096, 8201.753947381589, 8215.876761848576, 7779.299863012243, 8067.878981815277, 8072.990876140482, 8080.19198080199, 8082.19178082187, 8140.715074972348, 8148.266656000988, 8165.0, 8168.366326734558, 8209.466384684976, 5815.476607105381, 7732.652030658522, 7755.68977240904, 7786.299233069051, 7790.298873101448, 7606.467547271638, 7649.235076492307, 7655.311022008046, 7682.500637458547, 7684.96253005837, 7271.0, 7441.293077157661, 7841.5299180757875, 8173.918260817553, 8178.304844088319, 5007.674501157413, 5014.323066385991, 5014.7994080236385, 5023.4725353838785, 5039.244113382875, 7748.612569371621, 7751.689932402641, 7761.340286075521, 7764.883526747216, 7767.339776119094, 7257.891131633135, 7483.550986940801, 7485.663145158372, 7496.650602891314, 7512.286332798375, 7461.589612571361, 7472.626368681435, 7488.251174882468, 7543.170251272246, 7548.735794247175, 7245.166805817187, 7309.232530584212, 7323.194448610755, 7324.523905946096, 7357.558546487228, 7482.625868706652, 7489.251074892685, 7492.850142997218, 7516.248375162659, 7518.473706840468, 7101.218865924848, 7322.890156647548, 7343.632818359168, 7351.8529629408185, 7391.1869694334655], "value": 5418.022735907328, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.5567569728281, 716.8064622551911, 772.0118248641737, 776.7009701265011, 786.2726977545768, 15489.535313940585, 15489.5353139406, 15603.141827199499, 15718.607034824121, 15791.605209869731, 14454.783178252308, 14491.49279775208, 14503.05730127541, 14507.782383264259, 14533.418663253484, 771.8456308738247, 781.8514482248384, 927.3323207290773, 944.1219665710903, 967.1199208720066, 941.1858742187992, 942.9717108486757, 948.6015873333216, 957.5451660461295, 965.9758506037371, 991.276368251177, 1018.0226982097196, 1019.94390308533, 1026.9024442677933, 1036.295319182959, 982.0277924854379, 994.2145704893198, 1007.8135544924139, 1021.509675355826, 1031.515187861704, 627.1063734178776, 718.7843646905907, 754.0988518720077, 760.2663429790224, 762.2758379539459, 12726.281951936555, 14927.25363731809, 15352.848536359817, 15380.0, 15626.14056226907, 13319.334033298393, 13458.865411345958, 13551.119177253546, 13568.0, 14342.713145737027, 10100.89899101007, 10131.79736405275, 10357.844632330522, 10502.474876256156, 10761.30051546647, 3601.2977469393477, 3614.2590768892314, 3621.2033352662634, 3658.268346330718, 3738.12154143776, 75636.24363756347, 76670.0, 77858.0, 82544.76182857262, 82671.0, 9811.852822207673, 9960.203183745283, 10011.998800119929, 10077.899221007696, 10217.489125543692, 21352.78647213539, 21623.56752864934, 21805.781942180693, 22722.09111635516, 23311.300660980196, 7831.451798374059, 7882.369410447151, 8078.636461359253, 8166.836663266701, 8238.50568965864, 4232.470941132358, 4241.766702831313, 4248.362745588187, 4310.396544483712, 4346.978265108717, 3663.4871118043493, 3713.814309284525, 3714.1271801126713, 3733.533308336458, 3737.6449237322413, 670.8322919270182, 678.8913773796169, 681.2812482830562, 695.7530076822757, 712.8966299886591, 604.29901314475, 607.7690477618477, 616.3220457496718, 618.4279541424164, 625.8810825943057, 7912.434534200893, 8551.315894728406, 8552.059273479912, 8611.268042216481, 8650.35122365825, 549.0, 595.9046552551571, 603.7645318325856, 631.3591704420018, 659.1990731261541, 3922.1175235572337, 3965.861194858166, 3999.5400528939545, 4036.555978842325, 4060.0661847775177, 90533.54733226291, 91849.0, 92775.5361223203, 92833.53583232175, 96905.0, 79071.20928790754, 79779.60110199529, 80428.19571804207, 81440.59279703564, 83528.0, 63568.364316356245, 69062.0, 69282.30717692859, 73934.6303268491, 74132.62933685297, 8117.472364296302, 8547.61535730906, 8777.956110219407, 8819.823603528022, 8828.896387951507, 47918.0, 50860.71126799377, 50993.74503127461, 51227.71930701762, 51489.742551287, 67352.98970515544, 69204.0, 70046.0, 70364.0, 71851.0, 11038.944805275922, 11358.716032099264, 11447.427628618369, 11493.885061149616, 11567.76864462723, 11885.524579017088, 11968.16222864391, 12200.840920112576, 12214.328211948428, 12446.937765311115, 11539.8269025963, 11649.1263155262, 11650.30098194111, 11761.235519691192, 11916.880831191576, 11146.331220126818, 11553.768924621629, 11645.88354116448, 11746.941265293619, 11980.64058078259, 10891.836622450828, 11188.888111118784, 11209.439528023404, 11339.262947908359, 11455.599054033402, 9799.902000979899, 9879.357841740264, 9945.204383649147, 9993.400395976265, 10106.696799096038, 9406.764830879283, 9417.199538039069, 9427.622895084394, 9499.810003800023, 9620.470874101991], "value": 7123.267525665722, "unit": "score"}], "name": "dromaeo_css", "value": 7641.820813978079, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 110.0, 124.0, 169.0, 174.0, 132.0, 117.0, 119.0, 117.0, 116.0], "value": 129.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 122.0, 146.0, 159.0, 112.0, 134.0, 150.0, 191.0, 175.0, 108.0], "value": 145.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [192.0, 201.0, 198.0, 200.0, 248.0, 267.0, 197.0, 198.0, 194.0, 198.0], "value": 209.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 106.0, 110.0, 172.0, 56.0, 56.0, 56.0, 66.0, 130.0, 86.0], "value": 90.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 82.0, 127.0, 77.0, 80.0, 105.0, 122.0, 81.0, 80.0, 123.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 75.0, 134.0, 130.0, 94.0, 87.0, 90.0, 86.0], "value": 96.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 95.0, 96.0, 96.0, 94.0, 108.0, 149.0, 95.0], "value": 101.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 93.0, 120.0, 134.0, 91.0, 90.0, 90.0, 92.0, 89.0, 89.0], "value": 97.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 63.0, 65.0, 66.0, 67.0, 64.0, 64.0, 98.0, 93.0, 87.0], "value": 72.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 73.0, 68.0, 76.0, 71.0, 73.0, 67.0, 63.0, 65.0], "value": 68.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 70.0, 99.0, 105.0, 107.0, 104.0, 113.0, 72.0, 100.0, 108.0], "value": 97.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 127.0, 115.0, 146.0, 149.0, 142.0, 149.0, 149.0, 127.0, 172.0], "value": 140.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 162.0, 151.0, 195.0, 217.0, 160.0, 203.0, 220.0, 167.0, 166.0], "value": 179.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 97.0, 97.0, 81.0, 65.0, 67.0, 65.0, 67.0, 69.0, 65.0], "value": 74.5, "unit": "score"}], "name": "kraken", "value": 1597.5, "alertThreshold": 2.0}]} 09:16:18 INFO - Return code: 0 09:16:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:16:19 ERROR - # TBPL SUCCESS # 09:16:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:16:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:16:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:16:19 INFO - 2016-07-01 09:16:19.062 screenresolution[1985:16067] starting screenresolution argv=screenresolution get 09:16:19 INFO - 2016-07-01 09:16:19.065 screenresolution[1985:16067] Display 0: 1600x1200x32@60 09:16:19 INFO - 2016-07-01 09:16:19.071 screenresolution[1986:16070] starting screenresolution argv=screenresolution list 09:16:19 INFO - Available Modes on Display 0 09:16:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:16:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:16:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:16:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:16:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:16:19 INFO - Intel Iris: 09:16:19 INFO - Chipset Model: Intel Iris 09:16:19 INFO - Type: GPU 09:16:19 INFO - Bus: Built-In 09:16:19 INFO - VRAM (Dynamic, Max): 1536 MB 09:16:19 INFO - Vendor: Intel (0x8086) 09:16:19 INFO - Device ID: 0x0a2e 09:16:19 INFO - Revision ID: 0x0009 09:16:19 INFO - Displays: 09:16:19 INFO - Display: 09:16:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:16:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:16:19 INFO - Display Serial Number: 1600x1200 60 09:16:19 INFO - Main Display: Yes 09:16:19 INFO - Mirror: Off 09:16:19 INFO - Online: Yes 09:16:19 INFO - Rotation: Supported 09:16:19 INFO - Return code: 0 09:16:19 INFO - Running post-action listener: _resource_record_post_action 09:16:19 INFO - Running post-run listener: _resource_record_post_run 09:16:20 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 1171456; Write bytes: 493705216; Read time: 13; Write time: 1550 09:16:20 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 191107584; Write bytes: 186628096; Read time: 17668; Write time: 416 09:16:20 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 1146880; Write bytes: 296288256; Read time: 12; Write time: 1100 09:16:20 INFO - Running post-run listener: _upload_blobber_files 09:16:20 INFO - Blob upload gear active. 09:16:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:16: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 09:16: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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:16: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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:16:20 INFO - (blobuploader) - INFO - Open directory for files ... 09:16:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:16:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:16:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:21 INFO - (blobuploader) - INFO - Done attempting. 09:16:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:16:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:16:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:16:23 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:16:23 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:16:23 INFO - (blobuploader) - INFO - Done attempting. 09:16:23 INFO - (blobuploader) - INFO - Iteration through files over. 09:16:23 INFO - Return code: 0 09:16:23 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:16:23 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:16:23 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d3b0970a8502fac32ecb18eb56f8595b6560308a26eb1a53d838de5e42ffb320838842a6f59ec3df98d0deb206d40fffb553002dd85411d3e3506d3417b11233", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d12a04098cf23945276916a0534f6838e7820bdc09ee9de05db59ec4023e74c257f62b495b199a33da4c88bc309236dc1eb8ef594d0f4458e3a006b51960877f"} 09:16:23 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:16:23 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:16:23 INFO - Contents: 09:16:23 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d3b0970a8502fac32ecb18eb56f8595b6560308a26eb1a53d838de5e42ffb320838842a6f59ec3df98d0deb206d40fffb553002dd85411d3e3506d3417b11233", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d12a04098cf23945276916a0534f6838e7820bdc09ee9de05db59ec4023e74c257f62b495b199a33da4c88bc309236dc1eb8ef594d0f4458e3a006b51960877f"} 09:16:23 INFO - Running post-run listener: copy_logs_to_upload_dir 09:16:23 INFO - Copying logs to upload dir... 09:16:23 INFO - mkdir: /builds/slave/test/build/upload/logs 09:16:23 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.202958 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2016-07-01 09:16:23.517251) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 09:16:23.520792) ========= 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.sWKrININ2N/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.rNZ0btBGJu/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d3b0970a8502fac32ecb18eb56f8595b6560308a26eb1a53d838de5e42ffb320838842a6f59ec3df98d0deb206d40fffb553002dd85411d3e3506d3417b11233", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d12a04098cf23945276916a0534f6838e7820bdc09ee9de05db59ec4023e74c257f62b495b199a33da4c88bc309236dc1eb8ef594d0f4458e3a006b51960877f"} build_url:https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011256 build_url: 'https://queue.taskcluster.net/v1/task/UprlyqxXQxabVTUrl23fzg/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d3b0970a8502fac32ecb18eb56f8595b6560308a26eb1a53d838de5e42ffb320838842a6f59ec3df98d0deb206d40fffb553002dd85411d3e3506d3417b11233", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d12a04098cf23945276916a0534f6838e7820bdc09ee9de05db59ec4023e74c257f62b495b199a33da4c88bc309236dc1eb8ef594d0f4458e3a006b51960877f"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-01 09:16:23.556930) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 09:16:23.557559) ========= 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.sWKrININ2N/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.rNZ0btBGJu/Listeners TMPDIR=/var/folders/ry/9wyjbbwd6d76l2z511wzcdbh00000w/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.005233 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-01 09:16:23.608528) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 09:16:23.608929) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-01 09:16:23.609347) ========= ========= Total master_lag: 0.20 =========