builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0147 starttime: 1463507744.68 results: success (0) buildid: 20160516203739 builduid: 35109f84dca34c5782941e77d47db877 revision: b9598d922a0ba3957d4cf178a03b877d76354fb1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:44.682543) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:44.682885) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:44.683156) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:44.733385) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:44.733634) ========= 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.MNBDWm8e7d/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.86Jz5UaVOc/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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-05-17 10:55:44-- 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% 161M=0s 2016-05-17 10:55:45 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.479124 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:45.236013) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:45.240299) ========= 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.MNBDWm8e7d/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.86Jz5UaVOc/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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.020086 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:45.348726) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-17 10:55:45.349070) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b9598d922a0ba3957d4cf178a03b877d76354fb1 --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 b9598d922a0ba3957d4cf178a03b877d76354fb1 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MNBDWm8e7d/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.86Jz5UaVOc/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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-05-17 10:55:45,346 truncating revision to first 12 chars 2016-05-17 10:55:45,346 Setting DEBUG logging. 2016-05-17 10:55:45,347 attempt 1/10 2016-05-17 10:55:45,347 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b9598d922a0b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-05-17 10:55:47,194 unpacking tar archive at: mozilla-beta-b9598d922a0b/testing/mozharness/ program finished with exit code 0 elapsedTime=2.100329 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-05-17 10:55:47.471975) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:47.472275) ========= script_repo_revision: b9598d922a0ba3957d4cf178a03b877d76354fb1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:47.475680) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:47.475985) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-05-17 10:55:47.491639) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 34 secs) (at 2016-05-17 10:55:47.491916) ========= /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.MNBDWm8e7d/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.86Jz5UaVOc/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 10:55:47 INFO - MultiFileLogger online at 20160517 10:55:47 in /builds/slave/test 10:55:47 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 10:55:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:55:47 INFO - {'append_to_log': False, 10:55:47 INFO - 'base_work_dir': '/builds/slave/test', 10:55:47 INFO - 'blob_upload_branch': 'Mozilla-Beta', 10:55:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:55:47 INFO - 'branch': 'Mozilla-Beta', 10:55:47 INFO - 'buildbot_json_path': 'buildprops.json', 10:55:47 INFO - 'config_files': ('talos/mac_config.py',), 10:55:47 INFO - 'default_actions': ('clobber', 10:55:47 INFO - 'read-buildbot-config', 10:55:47 INFO - 'download-and-extract', 10:55:47 INFO - 'populate-webroot', 10:55:47 INFO - 'create-virtualenv', 10:55:47 INFO - 'install', 10:55:47 INFO - 'run-tests'), 10:55:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:55:47 INFO - 'download_minidump_stackwalk': True, 10:55:47 INFO - 'download_symbols': 'ondemand', 10:55:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:55:47 INFO - 'tooltool.py': '/tools/tooltool.py', 10:55:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:55:47 INFO - '/tools/misc-python/virtualenv.py')}, 10:55:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:55:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:55:47 INFO - 'installer_path': 'installer.exe', 10:55:47 INFO - 'log_level': 'info', 10:55:47 INFO - 'log_name': 'talos', 10:55:47 INFO - 'log_to_console': True, 10:55:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:55:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:55:47 INFO - 'opt_config_files': (), 10:55:47 INFO - 'pip_index': False, 10:55:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:55:47 INFO - 'cmd': ('bash', 10:55:47 INFO - '-c', 10:55:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:55:47 INFO - 'enabled': True, 10:55:47 INFO - 'halt_on_failure': False, 10:55:47 INFO - 'name': 'check_screen_resolution'},), 10:55:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:55:47 INFO - 'cmd': ('bash', 10:55:47 INFO - '-c', 10:55:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:55:47 INFO - 'enabled': True, 10:55:47 INFO - 'halt_on_failure': False, 10:55:47 INFO - 'name': 'check_screen_resolution'},), 10:55:47 INFO - 'run_cmd_checks_enabled': True, 10:55:47 INFO - 'sps_profile': False, 10:55:47 INFO - 'sps_profile_interval': 0, 10:55:47 INFO - 'suite': 'dromaeojs-e10s', 10:55:47 INFO - 'system_bits': '32', 10:55:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:55:47 INFO - 'title': 't-yosemite-r7-0147', 10:55:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:55:47 INFO - 'use_talos_json': True, 10:55:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:55:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:55:47 INFO - 'work_dir': 'build'} 10:55:47 INFO - ##### 10:55:47 INFO - ##### Running clobber step. 10:55:47 INFO - ##### 10:55:47 INFO - Running pre-action listener: _resource_record_pre_action 10:55:47 INFO - Running main action method: clobber 10:55:47 INFO - rmtree: /builds/slave/test/build 10:55:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:55:48 INFO - Running post-action listener: _resource_record_post_action 10:55:48 INFO - ##### 10:55:48 INFO - ##### Running read-buildbot-config step. 10:55:48 INFO - ##### 10:55:48 INFO - Running pre-action listener: _resource_record_pre_action 10:55:48 INFO - Running main action method: read_buildbot_config 10:55:48 INFO - Using buildbot properties: 10:55:48 INFO - { 10:55:48 INFO - "project": "", 10:55:48 INFO - "product": "firefox", 10:55:48 INFO - "script_repo_revision": "production", 10:55:48 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 10:55:48 INFO - "repository": "", 10:55:48 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 10:55:48 INFO - "buildid": "20160516203739", 10:55:48 INFO - "pgo_build": "False", 10:55:48 INFO - "basedir": "/builds/slave/test", 10:55:48 INFO - "buildnumber": 28, 10:55:48 INFO - "slavename": "t-yosemite-r7-0147", 10:55:48 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 10:55:48 INFO - "platform": "yosemite_r7", 10:55:48 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 10:55:48 INFO - "branch": "mozilla-beta", 10:55:48 INFO - "repo_path": "releases/mozilla-beta", 10:55:48 INFO - "revision": "b9598d922a0ba3957d4cf178a03b877d76354fb1", 10:55:48 INFO - "stage_platform": "macosx64", 10:55:48 INFO - "builduid": "35109f84dca34c5782941e77d47db877", 10:55:48 INFO - "slavebuilddir": "test" 10:55:48 INFO - } 10:55:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg. 10:55:48 INFO - Running post-action listener: _resource_record_post_action 10:55:48 INFO - ##### 10:55:48 INFO - ##### Running download-and-extract step. 10:55:48 INFO - ##### 10:55:48 INFO - Running pre-action listener: _resource_record_pre_action 10:55:48 INFO - Running main action method: download_and_extract 10:55:48 INFO - mkdir: /builds/slave/test/build/tests 10:55: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')]} 10:55:48 INFO - https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 10:55:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 10:55:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json 10:55:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 10:55:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json'}, attempt #1 10:56:05 INFO - Downloaded 1241 bytes. 10:56:05 INFO - Reading from file /builds/slave/test/build/firefox-47.0.en-US.mac.test_packages.json 10:56:05 INFO - Using the following test package requirements: 10:56:05 INFO - {u'common': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:56:05 INFO - u'cppunittest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:56:05 INFO - u'firefox-47.0.en-US.mac.cppunittest.tests.zip'], 10:56:05 INFO - u'gtest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:56:05 INFO - u'firefox-47.0.en-US.mac.gtest.tests.zip'], 10:56:05 INFO - u'jittest': [u'firefox-47.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 10:56:05 INFO - u'mochitest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:56:05 INFO - u'firefox-47.0.en-US.mac.mochitest.tests.zip'], 10:56:05 INFO - u'mozbase': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:56:05 INFO - u'reftest': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:56:05 INFO - u'firefox-47.0.en-US.mac.reftest.tests.zip'], 10:56:05 INFO - u'talos': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:56:05 INFO - u'firefox-47.0.en-US.mac.talos.tests.zip'], 10:56:05 INFO - u'web-platform': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:56:05 INFO - u'firefox-47.0.en-US.mac.web-platform.tests.zip'], 10:56:05 INFO - u'webapprt': [u'firefox-47.0.en-US.mac.common.tests.zip'], 10:56:05 INFO - u'xpcshell': [u'firefox-47.0.en-US.mac.common.tests.zip', 10:56:05 INFO - u'firefox-47.0.en-US.mac.xpcshell.tests.zip']} 10:56:05 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip'] for test suite category: common 10:56:05 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')]} 10:56:05 INFO - https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:56:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:56:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:56:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 10:56:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 10:56:23 INFO - Downloaded 17747789 bytes. 10:56:23 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:56:23 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:56:26 INFO - Return code: 0 10:56:26 INFO - Downloading packages: [u'firefox-47.0.en-US.mac.common.tests.zip', u'firefox-47.0.en-US.mac.talos.tests.zip'] for test suite category: talos 10:56: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')]} 10:56:26 INFO - https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:56:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:56:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip 10:56:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip 10:56:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip'}, attempt #1 10:56:43 INFO - Downloaded 17747789 bytes. 10:56:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:56:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 10:56:46 INFO - Return code: 0 10:56: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')]} 10:56:46 INFO - https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:56:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 10:56:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip 10:56:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip 10:56:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip'}, attempt #1 10:56:47 INFO - Downloaded 10845194 bytes. 10:56:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:56:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 10:56:47 INFO - Return code: 0 10:56:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:56:47 INFO - https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg matches https://queue.taskcluster.net 10:56:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:56:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:56:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0.en-US.mac.dmg 10:56:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg'}, attempt #1 10:56:50 INFO - Downloaded 88288778 bytes. 10:56:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:56:50 INFO - mkdir: /builds/slave/test/properties 10:56:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:56:50 INFO - Writing to file /builds/slave/test/properties/build_url 10:56:50 INFO - Contents: 10:56:50 INFO - build_url:https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg 10:56:51 WARNING - Can't figure out symbols_url from installer_url: https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg! 10:56:51 INFO - Running post-action listener: _resource_record_post_action 10:56:51 INFO - Running post-action listener: set_extra_try_arguments 10:56:51 INFO - ##### 10:56:51 INFO - ##### Running populate-webroot step. 10:56:51 INFO - ##### 10:56:51 INFO - Running pre-action listener: _resource_record_pre_action 10:56:51 INFO - Running main action method: populate_webroot 10:56:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:56:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:56:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:56:51 INFO - '--tppagecycles', 10:56:51 INFO - '7'], 10:56:51 INFO - 'tests': ['tsvgm']}}, 10:56:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:56:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:56:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:56:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:56:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:56:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:56:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:56:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:51 INFO - 'talos_options': ['--e10s'], 10:56:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:56:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:51 INFO - 'tests': ['damp', 'tps']}, 10:56:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:51 INFO - 'talos_options': ['--e10s'], 10:56:51 INFO - 'tests': ['damp', 'tps']}, 10:56:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:56:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:56:51 INFO - 'other': {'tests': ['a11yr', 10:56:51 INFO - 'ts_paint', 10:56:51 INFO - 'tpaint', 10:56:51 INFO - 'sessionrestore', 10:56:51 INFO - 'sessionrestore_no_auto_restore', 10:56:51 INFO - 'tabpaint']}, 10:56:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:56:51 INFO - 'tests': ['a11yr', 10:56:51 INFO - 'ts_paint', 10:56:51 INFO - 'tpaint', 10:56:51 INFO - 'sessionrestore', 10:56:51 INFO - 'sessionrestore_no_auto_restore', 10:56:51 INFO - 'tabpaint']}, 10:56:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:56:51 INFO - 'tests': ['a11yr', 10:56:51 INFO - 'ts_paint', 10:56:51 INFO - 'tpaint', 10:56:51 INFO - 'sessionrestore', 10:56:51 INFO - 'sessionrestore_no_auto_restore', 10:56:51 INFO - 'tabpaint']}, 10:56:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:56:51 INFO - 'tests': ['a11yr', 10:56:51 INFO - 'ts_paint', 10:56:51 INFO - 'tpaint', 10:56:51 INFO - 'sessionrestore', 10:56:51 INFO - 'sessionrestore_no_auto_restore', 10:56:51 INFO - 'tabpaint']}, 10:56:51 INFO - 'other_l64': {'tests': ['a11yr', 10:56:51 INFO - 'ts_paint', 10:56:51 INFO - 'tpaint', 10:56:51 INFO - 'sessionrestore', 10:56:51 INFO - 'sessionrestore_no_auto_restore', 10:56:51 INFO - 'tabpaint']}, 10:56:51 INFO - 'other_nol64': {'tests': ['a11yr', 10:56:51 INFO - 'ts_paint', 10:56:51 INFO - 'tpaint', 10:56:51 INFO - 'sessionrestore', 10:56:51 INFO - 'sessionrestore_no_auto_restore', 10:56:51 INFO - 'tabpaint']}, 10:56:51 INFO - 'svgr': {'tests': ['tsvgx', 10:56:51 INFO - 'tsvgr_opacity', 10:56:51 INFO - 'tart', 10:56:51 INFO - 'tscrollx', 10:56:51 INFO - 'cart']}, 10:56:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:56:51 INFO - 'tests': ['tsvgx', 10:56:51 INFO - 'tsvgr_opacity', 10:56:51 INFO - 'tart', 10:56:51 INFO - 'tscrollx', 10:56:51 INFO - 'cart']}, 10:56:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:51 INFO - 'tests': ['tp5o']}, 10:56:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:51 INFO - 'talos_options': ['--e10s'], 10:56:51 INFO - 'tests': ['tp5o']}, 10:56:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:51 INFO - 'talos_options': ['--xperf_path', 10:56:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:56:51 INFO - 'tests': ['tp5n']}, 10:56:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:56:51 INFO - 'talos_options': ['--e10s', 10:56:51 INFO - '--xperf_path', 10:56:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:56:51 INFO - 'tests': ['tp5n']}}, 10:56:51 INFO - 'talos.zip': {'path': '', 10:56:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:56:51 INFO - Running post-action listener: _resource_record_post_action 10:56:51 INFO - ##### 10:56:51 INFO - ##### Running create-virtualenv step. 10:56:51 INFO - ##### 10:56:51 INFO - Running pre-action listener: _resource_record_pre_action 10:56:51 INFO - Running main action method: create_virtualenv 10:56:51 INFO - Creating virtualenv /builds/slave/test/build/venv 10:56: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 10:56:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:56:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:56:51 INFO - Using real prefix '/tools/python27' 10:56:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:56:52 INFO - Installing distribute.............................................................................................................................................................................................done. 10:56:55 INFO - Installing pip.................done. 10:56:55 INFO - Return code: 0 10:56:55 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:56: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')]} 10:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56: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')]} 10:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104897a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10489e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82d2c84db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10473bd30>, '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 0x10459fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104732b20>, '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.MNBDWm8e7d/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.86Jz5UaVOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 10:56: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', 'pip>=1.5'] in /builds/slave/test/build 10:56: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 pip>=1.5 10:56:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MNBDWm8e7d/Render', 10:56:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:55 INFO - 'HOME': '/Users/cltbld', 10:56:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:55 INFO - 'LOGNAME': 'cltbld', 10:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:55 INFO - 'MOZ_NO_REMOTE': '1', 10:56:55 INFO - 'NO_EM_RESTART': '1', 10:56:55 INFO - 'PAGER': '/bin/cat', 10:56:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:55 INFO - 'PWD': '/builds/slave/test', 10:56:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:55 INFO - 'SHELL': '/bin/bash', 10:56:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.86Jz5UaVOc/Listeners', 10:56:55 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 10:56:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:55 INFO - 'USER': 'cltbld', 10:56:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:55 INFO - 'XPC_FLAGS': '0x0', 10:56:55 INFO - 'XPC_SERVICE_NAME': '0', 10:56:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56: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 10:56:55 INFO - Cleaning up... 10:56:55 INFO - Return code: 0 10:56:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:56: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')]} 10:56:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:56:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56: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')]} 10:56:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:56:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:56: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 0x104897a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10489e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82d2c84db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10473bd30>, '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 0x10459fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104732b20>, '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.MNBDWm8e7d/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.86Jz5UaVOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 10:56: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 10:56: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 10:56:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MNBDWm8e7d/Render', 10:56:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:56:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:56:55 INFO - 'HOME': '/Users/cltbld', 10:56:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:56:55 INFO - 'LOGNAME': 'cltbld', 10:56:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:56:55 INFO - 'MOZ_NO_REMOTE': '1', 10:56:55 INFO - 'NO_EM_RESTART': '1', 10:56:55 INFO - 'PAGER': '/bin/cat', 10:56:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:56:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:56:55 INFO - 'PWD': '/builds/slave/test', 10:56:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:56:55 INFO - 'SHELL': '/bin/bash', 10:56:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.86Jz5UaVOc/Listeners', 10:56:55 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 10:56:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:56:55 INFO - 'USER': 'cltbld', 10:56:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:56:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:56:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:56:55 INFO - 'XPC_FLAGS': '0x0', 10:56:55 INFO - 'XPC_SERVICE_NAME': '0', 10:56:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:56:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:56:56 INFO - Downloading/unpacking psutil>=0.7.1 10:56:56 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 10:56:56 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 10:56:56 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 10:56:56 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 10:56:56 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 10:56:56 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 10:56:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:56:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:56:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:56:59 INFO - Installing collected packages: psutil 10:56:59 INFO - Running setup.py install for psutil 10:56:59 INFO - building 'psutil._psutil_osx' extension 10:56:59 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 10:56:59 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 10:56:59 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 10:56:59 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 10:56:59 INFO - building 'psutil._psutil_posix' extension 10:56:59 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 10:56:59 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:56:59 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:56:59 INFO - ^ 10:56:59 INFO - 1 warning generated. 10:56: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 10:56:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:56:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:56:59 INFO - Successfully installed psutil 10:56:59 INFO - Cleaning up... 10:57:00 INFO - Return code: 0 10:57:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:57:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104897a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10489e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82d2c84db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10473bd30>, '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 0x10459fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104732b20>, '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.MNBDWm8e7d/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.86Jz5UaVOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 10:57:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 10:57:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 10:57:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MNBDWm8e7d/Render', 10:57:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:00 INFO - 'HOME': '/Users/cltbld', 10:57:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:00 INFO - 'LOGNAME': 'cltbld', 10:57:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:00 INFO - 'MOZ_NO_REMOTE': '1', 10:57:00 INFO - 'NO_EM_RESTART': '1', 10:57:00 INFO - 'PAGER': '/bin/cat', 10:57:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:00 INFO - 'PWD': '/builds/slave/test', 10:57:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:00 INFO - 'SHELL': '/bin/bash', 10:57:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.86Jz5UaVOc/Listeners', 10:57:00 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 10:57:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:00 INFO - 'USER': 'cltbld', 10:57:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:00 INFO - 'XPC_FLAGS': '0x0', 10:57:00 INFO - 'XPC_SERVICE_NAME': '0', 10:57:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:57:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:57: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) 10:57:02 INFO - Installing collected packages: mozsystemmonitor 10:57:02 INFO - Running setup.py install for mozsystemmonitor 10:57:02 INFO - Successfully installed mozsystemmonitor 10:57:02 INFO - Cleaning up... 10:57:03 INFO - Return code: 0 10:57:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:57:03 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')]} 10:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:03 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')]} 10:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:03 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 0x104897a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10489e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82d2c84db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10473bd30>, '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 0x10459fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104732b20>, '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.MNBDWm8e7d/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.86Jz5UaVOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 10:57:03 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 10:57:03 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 10:57:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MNBDWm8e7d/Render', 10:57:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:03 INFO - 'HOME': '/Users/cltbld', 10:57:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:03 INFO - 'LOGNAME': 'cltbld', 10:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:03 INFO - 'MOZ_NO_REMOTE': '1', 10:57:03 INFO - 'NO_EM_RESTART': '1', 10:57:03 INFO - 'PAGER': '/bin/cat', 10:57:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:03 INFO - 'PWD': '/builds/slave/test', 10:57:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:03 INFO - 'SHELL': '/bin/bash', 10:57:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.86Jz5UaVOc/Listeners', 10:57:03 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 10:57:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:03 INFO - 'USER': 'cltbld', 10:57:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:03 INFO - 'XPC_FLAGS': '0x0', 10:57:03 INFO - 'XPC_SERVICE_NAME': '0', 10:57:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:03 INFO - Downloading/unpacking blobuploader==1.2.4 10:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:05 INFO - Downloading blobuploader-1.2.4.tar.gz 10:57:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:57:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:57:06 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 10:57:06 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 10:57:06 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 10:57:06 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 10:57:06 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 10:57:06 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 10:57:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:57:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:57:06 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 10:57:06 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 10:57:06 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 10:57:06 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 10:57:06 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 10:57:06 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 10:57:07 INFO - Downloading docopt-0.6.1.tar.gz 10:57:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:57:07 INFO - Installing collected packages: blobuploader, requests, docopt 10:57:07 INFO - Running setup.py install for blobuploader 10:57:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:57:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:57:07 INFO - Running setup.py install for requests 10:57:07 INFO - Running setup.py install for docopt 10:57:07 INFO - Successfully installed blobuploader requests docopt 10:57:07 INFO - Cleaning up... 10:57:08 INFO - Return code: 0 10:57:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:57:08 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')]} 10:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:08 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')]} 10:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:08 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 0x104897a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10489e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82d2c84db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10473bd30>, '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 0x10459fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104732b20>, '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.MNBDWm8e7d/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.86Jz5UaVOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 10:57:08 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 10:57:08 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 10:57:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MNBDWm8e7d/Render', 10:57:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:08 INFO - 'HOME': '/Users/cltbld', 10:57:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:08 INFO - 'LOGNAME': 'cltbld', 10:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:08 INFO - 'MOZ_NO_REMOTE': '1', 10:57:08 INFO - 'NO_EM_RESTART': '1', 10:57:08 INFO - 'PAGER': '/bin/cat', 10:57:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:08 INFO - 'PWD': '/builds/slave/test', 10:57:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:08 INFO - 'SHELL': '/bin/bash', 10:57:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.86Jz5UaVOc/Listeners', 10:57:08 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 10:57:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:08 INFO - 'USER': 'cltbld', 10:57:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:08 INFO - 'XPC_FLAGS': '0x0', 10:57:08 INFO - 'XPC_SERVICE_NAME': '0', 10:57:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:57:08 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-4TrVvQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:57:08 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-tfji5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:57:08 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-bVSb4R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:57:08 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-tOBVPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:57:08 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-pye5H_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:57:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:57:08 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-EDyz4a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:57:09 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-W4ryM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:57:09 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-2uVIJq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:57:09 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-tSHo3X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:57:09 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-EZTxZJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:57:09 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-E2aa9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:57:09 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-Dz46g3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:57:09 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-MJrwHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:57:09 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-6G9w9Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:09 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-GwdvR5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:57:09 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-WvVIC2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:57:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:57:10 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-8GyATI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:57:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:57:10 INFO - Running setup.py install for manifestparser 10:57:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:57:10 INFO - Running setup.py install for mozcrash 10:57:10 INFO - Running setup.py install for mozdebug 10:57:10 INFO - Running setup.py install for mozdevice 10:57:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:57:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:57:10 INFO - Running setup.py install for mozfile 10:57:10 INFO - Running setup.py install for mozhttpd 10:57:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:57:11 INFO - Running setup.py install for mozinfo 10:57:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:57:11 INFO - Running setup.py install for mozInstall 10:57:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:57:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:57:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:57:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:57:11 INFO - Running setup.py install for mozleak 10:57:11 INFO - Running setup.py install for mozlog 10:57:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:57:11 INFO - Running setup.py install for moznetwork 10:57:11 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:57:11 INFO - Running setup.py install for mozprocess 10:57:11 INFO - Running setup.py install for mozprofile 10:57:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:57:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:57:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:57:12 INFO - Running setup.py install for mozrunner 10:57:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:57:12 INFO - Running setup.py install for mozscreenshot 10:57:12 INFO - Running setup.py install for moztest 10:57:12 INFO - Running setup.py install for mozversion 10:57:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:57:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:57:12 INFO - Cleaning up... 10:57:12 INFO - Return code: 0 10:57:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:57:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:57:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x104897a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10489e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82d2c84db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10473bd30>, '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 0x10459fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104732b20>, '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.MNBDWm8e7d/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.86Jz5UaVOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 10:57:12 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 10:57:12 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 10:57:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MNBDWm8e7d/Render', 10:57:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:12 INFO - 'HOME': '/Users/cltbld', 10:57:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:12 INFO - 'LOGNAME': 'cltbld', 10:57:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:12 INFO - 'MOZ_NO_REMOTE': '1', 10:57:12 INFO - 'NO_EM_RESTART': '1', 10:57:12 INFO - 'PAGER': '/bin/cat', 10:57:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:12 INFO - 'PWD': '/builds/slave/test', 10:57:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:12 INFO - 'SHELL': '/bin/bash', 10:57:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.86Jz5UaVOc/Listeners', 10:57:12 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 10:57:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:12 INFO - 'USER': 'cltbld', 10:57:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:12 INFO - 'XPC_FLAGS': '0x0', 10:57:12 INFO - 'XPC_SERVICE_NAME': '0', 10:57:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:57:12 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-c047C8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:57:13 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)) 10:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:57:13 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-MkGQ4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:57:13 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)) 10:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:57:13 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-1G3UGX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:57:13 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)) 10:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:57:13 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-T07hLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:57:13 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)) 10:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:57:13 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-OfflSj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:57:13 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)) 10:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:57:13 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-hEvjsS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:57:13 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)) 10:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:57:13 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-o5Q9S8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:57:13 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)) 10:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:57:13 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-f01GdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:57:13 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)) 10:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:57:13 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-0dxsNz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:57:13 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)) 10:57:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:57:13 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-V0KgJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:57:14 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)) 10:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:57:14 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-gVXaxU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:57:14 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)) 10:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:57:14 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-6grtx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:57:14 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)) 10:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:57:14 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-MGJrHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:57:14 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)) 10:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:57:14 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-hevxJS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:57:14 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)) 10:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:14 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-6f5wbt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:57:14 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)) 10:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:57:14 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-pfxuUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:57:14 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)) 10:57:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:57:14 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-1rQ4KX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:57:14 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)) 10:57:14 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)) 10:57:14 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)) 10:57:14 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)) 10:57:14 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)) 10:57:14 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)) 10:57:14 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:57:14 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 10:57:14 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 10:57:14 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 10:57:14 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 10:57:14 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 10:57:14 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 10:57:17 INFO - Downloading blessings-1.6.tar.gz 10:57:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:57:17 INFO - Installing collected packages: blessings 10:57:17 INFO - Running setup.py install for blessings 10:57:17 INFO - Successfully installed blessings 10:57:17 INFO - Cleaning up... 10:57:17 INFO - Return code: 0 10:57:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:57:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:57:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:57:17 INFO - Reading from file tmpfile_stdout 10:57:17 INFO - Current package versions: 10:57:17 INFO - blessings == 1.6 10:57:17 INFO - blobuploader == 1.2.4 10:57:17 INFO - docopt == 0.6.1 10:57:17 INFO - manifestparser == 1.1 10:57:17 INFO - mozInstall == 1.12 10:57:17 INFO - mozcrash == 0.17 10:57:17 INFO - mozdebug == 0.1 10:57:17 INFO - mozdevice == 0.48 10:57:17 INFO - mozfile == 1.2 10:57:17 INFO - mozhttpd == 0.7 10:57:17 INFO - mozinfo == 0.9 10:57:17 INFO - mozleak == 0.1 10:57:17 INFO - mozlog == 3.1 10:57:17 INFO - moznetwork == 0.27 10:57:17 INFO - mozprocess == 0.22 10:57:17 INFO - mozprofile == 0.28 10:57:17 INFO - mozrunner == 6.11 10:57:17 INFO - mozscreenshot == 0.1 10:57:17 INFO - mozsystemmonitor == 0.0 10:57:17 INFO - moztest == 0.7 10:57:17 INFO - mozversion == 1.4 10:57:17 INFO - psutil == 3.1.1 10:57:17 INFO - requests == 1.2.3 10:57:17 INFO - wsgiref == 0.1.2 10:57:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:57: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')]} 10:57:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57: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')]} 10:57:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:17 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 0x104897a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10489e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82d2c84db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10473bd30>, '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 0x10459fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104732b20>, '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.MNBDWm8e7d/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.86Jz5UaVOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 10:57:17 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 10:57:17 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 10:57:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MNBDWm8e7d/Render', 10:57:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:17 INFO - 'HOME': '/Users/cltbld', 10:57:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:17 INFO - 'LOGNAME': 'cltbld', 10:57:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:17 INFO - 'MOZ_NO_REMOTE': '1', 10:57:17 INFO - 'NO_EM_RESTART': '1', 10:57:17 INFO - 'PAGER': '/bin/cat', 10:57:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:17 INFO - 'PWD': '/builds/slave/test', 10:57:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:17 INFO - 'SHELL': '/bin/bash', 10:57:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.86Jz5UaVOc/Listeners', 10:57:17 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 10:57:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:17 INFO - 'USER': 'cltbld', 10:57:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:17 INFO - 'XPC_FLAGS': '0x0', 10:57:17 INFO - 'XPC_SERVICE_NAME': '0', 10:57:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:18 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)) 10:57:18 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)) 10:57:18 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)) 10:57:18 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)) 10:57:18 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)) 10:57:18 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)) 10:57:18 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)) 10:57:18 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)) 10:57:18 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)) 10:57:18 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)) 10:57:18 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)) 10:57:18 INFO - Cleaning up... 10:57:18 INFO - Return code: 0 10:57:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:57:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 10:57:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:18 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 0x104897a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10489e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82d2c84db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10473bd30>, '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 0x10459fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104732b20>, '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.MNBDWm8e7d/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.86Jz5UaVOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 10:57:18 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 10:57:18 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 10:57:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MNBDWm8e7d/Render', 10:57:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:18 INFO - 'HOME': '/Users/cltbld', 10:57:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:18 INFO - 'LOGNAME': 'cltbld', 10:57:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:18 INFO - 'MOZ_NO_REMOTE': '1', 10:57:18 INFO - 'NO_EM_RESTART': '1', 10:57:18 INFO - 'PAGER': '/bin/cat', 10:57:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:18 INFO - 'PWD': '/builds/slave/test', 10:57:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:18 INFO - 'SHELL': '/bin/bash', 10:57:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.86Jz5UaVOc/Listeners', 10:57:18 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 10:57:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:18 INFO - 'USER': 'cltbld', 10:57:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:18 INFO - 'XPC_FLAGS': '0x0', 10:57:18 INFO - 'XPC_SERVICE_NAME': '0', 10:57:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:18 INFO - Downloading/unpacking jsonschema 10:57:18 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 10:57:18 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 10:57:18 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 10:57:18 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 10:57:18 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 10:57:18 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 10:57:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:57:20 INFO - Downloading/unpacking functools32 (from jsonschema) 10:57:20 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 10:57:20 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 10:57:20 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 10:57:20 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 10:57:20 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 10:57:20 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 10:57:21 INFO - Downloading functools32-3.2.3-2.tar.gz 10:57:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:57:21 INFO - warning: no files found matching '*.txt' 10:57:21 INFO - no previously-included directories found matching 'build' 10:57:21 INFO - no previously-included directories found matching 'dist' 10:57:21 INFO - no previously-included directories found matching '.git*' 10:57:21 INFO - Installing collected packages: jsonschema, functools32 10:57:21 INFO - Running setup.py install for functools32 10:57:21 INFO - warning: no files found matching '*.txt' 10:57:21 INFO - no previously-included directories found matching 'build' 10:57:21 INFO - no previously-included directories found matching 'dist' 10:57:21 INFO - no previously-included directories found matching '.git*' 10:57:21 INFO - Successfully installed jsonschema functools32 10:57:21 INFO - Cleaning up... 10:57:21 INFO - Return code: 0 10:57:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:57: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')]} 10:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57: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')]} 10:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:57:21 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 0x104897a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10489e4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f82d2c84db0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10473bd30>, '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 0x10459fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104732b20>, '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.MNBDWm8e7d/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.86Jz5UaVOc/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 10:57:21 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 10:57:21 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 10:57:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MNBDWm8e7d/Render', 10:57:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:21 INFO - 'HOME': '/Users/cltbld', 10:57:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:21 INFO - 'LOGNAME': 'cltbld', 10:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:21 INFO - 'MOZ_NO_REMOTE': '1', 10:57:21 INFO - 'NO_EM_RESTART': '1', 10:57:21 INFO - 'PAGER': '/bin/cat', 10:57:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:21 INFO - 'PWD': '/builds/slave/test', 10:57:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:21 INFO - 'SHELL': '/bin/bash', 10:57:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.86Jz5UaVOc/Listeners', 10:57:21 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 10:57:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:21 INFO - 'USER': 'cltbld', 10:57:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:21 INFO - 'XPC_FLAGS': '0x0', 10:57:21 INFO - 'XPC_SERVICE_NAME': '0', 10:57:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:57:21 INFO - Downloading/unpacking flake8 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:57:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:57:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57: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 10:57:25 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:57:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:57:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:57:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:57:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:57:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:57:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:57:25 INFO - no previously-included directories found matching 'docs/_build' 10:57:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:57:25 INFO - Running setup.py install for pep8 10:57:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:57:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:57:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:57:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:57:25 INFO - no previously-included directories found matching 'docs/_build' 10:57:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:57:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:57:25 INFO - Cleaning up... 10:57:25 INFO - Return code: 0 10:57:25 INFO - Running post-action listener: _resource_record_post_action 10:57:25 INFO - Running post-action listener: _start_resource_monitoring 10:57:25 INFO - Starting resource monitoring. 10:57:25 INFO - ##### 10:57:25 INFO - ##### Running install step. 10:57:25 INFO - ##### 10:57:25 INFO - Running pre-action listener: _resource_record_pre_action 10:57:25 INFO - Running main action method: install 10:57:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:57:26 INFO - Reading from file tmpfile_stdout 10:57:26 INFO - Detecting whether we're running mozinstall >=1.0... 10:57:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:57:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:57:26 INFO - Reading from file tmpfile_stdout 10:57:26 INFO - Output received: 10:57:26 INFO - Usage: mozinstall [options] installer 10:57:26 INFO - Options: 10:57:26 INFO - -h, --help show this help message and exit 10:57:26 INFO - -d DEST, --destination=DEST 10:57:26 INFO - Directory to install application into. [default: 10:57:26 INFO - "/builds/slave/test"] 10:57:26 INFO - --app=APP Application being installed. [default: firefox] 10:57:26 INFO - mkdir: /builds/slave/test/build/application 10:57:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 10:57:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0.en-US.mac.dmg --destination /builds/slave/test/build/application 10:57:48 INFO - Reading from file tmpfile_stdout 10:57:48 INFO - Output received: 10:57:48 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 10:57:48 INFO - Running post-action listener: _resource_record_post_action 10:57:48 INFO - ##### 10:57:48 INFO - ##### Running run-tests step. 10:57:48 INFO - ##### 10:57:48 INFO - Running pre-action listener: _resource_record_pre_action 10:57:48 INFO - Running main action method: run_tests 10:57:48 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:57:48 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:57:48 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:57:48 INFO - 2016-05-17 10:57:48.685 screenresolution[6468:117483] starting screenresolution argv=screenresolution get 10:57:48 INFO - 2016-05-17 10:57:48.687 screenresolution[6468:117483] Display 0: 1600x1200x32@60 10:57:48 INFO - 2016-05-17 10:57:48.693 screenresolution[6469:117486] starting screenresolution argv=screenresolution list 10:57:48 INFO - Available Modes on Display 0 10:57:48 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:57:48 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:57:48 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:57:48 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:57:48 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:57:48 INFO - Intel Iris: 10:57:48 INFO - Chipset Model: Intel Iris 10:57:48 INFO - Type: GPU 10:57:48 INFO - Bus: Built-In 10:57:48 INFO - VRAM (Dynamic, Max): 1536 MB 10:57:48 INFO - Vendor: Intel (0x8086) 10:57:48 INFO - Device ID: 0x0a2e 10:57:48 INFO - Revision ID: 0x0009 10:57:48 INFO - Displays: 10:57:48 INFO - Display: 10:57:48 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:57:48 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:57:48 INFO - Display Serial Number: 1600x1200 60 10:57:48 INFO - Main Display: Yes 10:57:48 INFO - Mirror: Off 10:57:48 INFO - Online: Yes 10:57:48 INFO - Rotation: Supported 10:57:48 INFO - Return code: 0 10:57:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:57:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:57:48 INFO - Python 2.7.3 10:57:48 INFO - Return code: 0 10:57:48 INFO - grabbing minidump binary from tooltool 10:57: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')]} 10:57: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 0x10473bd30>, '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 0x10459fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104732b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:57: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 10:57: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 10:57:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:57:49 INFO - Return code: 0 10:57:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:57:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:57:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:57:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:57:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:57:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:57:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:57:50 INFO - Return code: 0 10:57:50 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', '--title', 't-yosemite-r7-0147', '--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 10:57:50 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 --title t-yosemite-r7-0147 --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 10:57:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MNBDWm8e7d/Render', 10:57:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:57:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:57:50 INFO - 'HOME': '/Users/cltbld', 10:57:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:57:50 INFO - 'LOGNAME': 'cltbld', 10:57:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:57:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:57:50 INFO - 'MOZ_NO_REMOTE': '1', 10:57:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:57:50 INFO - 'NO_EM_RESTART': '1', 10:57:50 INFO - 'PAGER': '/bin/cat', 10:57:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:57:50 INFO - 'PWD': '/builds/slave/test', 10:57:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:57:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:57:50 INFO - 'SHELL': '/bin/bash', 10:57:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.86Jz5UaVOc/Listeners', 10:57:50 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 10:57:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:57:50 INFO - 'USER': 'cltbld', 10:57:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:57:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:57:50 INFO - 'XPC_FLAGS': '0x0', 10:57:50 INFO - 'XPC_SERVICE_NAME': '0', 10:57:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:57:50 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', '--title', 't-yosemite-r7-0147', '--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 10:57:50 INFO - mozversion application_buildid: 20160516203739 10:57:50 INFO - mozversion application_changeset: b9598d922a0ba3957d4cf178a03b877d76354fb1 10:57:50 INFO - mozversion application_display_name: Firefox 10:57:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:57:50 INFO - mozversion application_name: Firefox 10:57:50 INFO - mozversion application_remotingname: firefox 10:57:50 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 10:57:50 INFO - mozversion application_vendor: Mozilla 10:57:50 INFO - mozversion application_version: 47.0 10:57:50 INFO - mozversion platform_buildid: 20160516203739 10:57:50 INFO - mozversion platform_changeset: b9598d922a0ba3957d4cf178a03b877d76354fb1 10:57:50 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 10:57:50 INFO - mozversion platform_version: 47.0 10:57:50 INFO - using testdate: 1463507870 10:57:50 INFO - actual date: 1463507870 10:57:50 INFO - starting webserver on 'localhost:64593' 10:57:50 INFO - SUITE-START | Running 2 tests 10:57:50 INFO - TEST-START | dromaeo_css 10:57:50 INFO - operating with platform_type : mac_ 10:57:50 INFO - Initialising browser for dromaeo_css test... 10:57:50 INFO - TEST-INFO | started process 6487 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmpJn95z9/profile http://localhost:64593/getInfo.html) 10:57:53 INFO - PROCESS | 6487 | __metrics Screen width/height:1600/1200 10:57:53 INFO - PROCESS | 6487 | colorDepth:24 10:57:53 INFO - PROCESS | 6487 | Browser inner width/height: 1024/689 10:57:53 INFO - PROCESS | 6487 | __metrics 10:57:53 ERROR - PROCESS | 6487 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 10:57:53 INFO - TEST-INFO | 6487: exit 0 10:57:53 INFO - Browser initialized. 10:57:53 INFO - Running cycle 1/1 for dromaeo_css test... 10:57:53 INFO - TEST-INFO | started process 6492 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmpJn95z9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:58:05 INFO - PROCESS | 6492 | RSS: Main: 167817216 10:58:05 INFO - PROCESS | 6492 | 10:58:55 INFO - PROCESS | 6492 | 1463507935122 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] 11:01:05 INFO - PROCESS | 6492 | Cycle 1(1): loaded http://localhost:64593/tests/dromaeo/cssquery-dojo.html (next: http://localhost:64593/tests/dromaeo/cssquery-ext.html) 11:01:06 INFO - PROCESS | 6492 | RSS: Main: 178245632 11:01:06 INFO - PROCESS | 6492 | 11:04:08 INFO - PROCESS | 6492 | Cycle 1(1): loaded http://localhost:64593/tests/dromaeo/cssquery-ext.html (next: http://localhost:64593/tests/dromaeo/cssquery-jquery.html) 11:04:09 INFO - PROCESS | 6492 | RSS: Main: 189714432 11:04:09 INFO - PROCESS | 6492 | 11:07:10 INFO - PROCESS | 6492 | Cycle 1(1): loaded http://localhost:64593/tests/dromaeo/cssquery-jquery.html (next: http://localhost:64593/tests/dromaeo/cssquery-mootools.html) 11:07:11 INFO - PROCESS | 6492 | RSS: Main: 192081920 11:07:11 INFO - PROCESS | 6492 | 11:10:13 INFO - PROCESS | 6492 | Cycle 1(1): loaded http://localhost:64593/tests/dromaeo/cssquery-mootools.html (next: http://localhost:64593/tests/dromaeo/cssquery-prototype.html) 11:10:13 INFO - PROCESS | 6492 | RSS: Main: 195100672 11:10:13 INFO - PROCESS | 6492 | 11:13:16 INFO - PROCESS | 6492 | Cycle 1(1): loaded http://localhost:64593/tests/dromaeo/cssquery-prototype.html (next: http://localhost:64593/tests/dromaeo/cssquery-yui.html) 11:13:16 INFO - PROCESS | 6492 | RSS: Main: 194838528 11:13:16 INFO - PROCESS | 6492 | 11:16:18 INFO - PROCESS | 6492 | Cycle 1(1): loaded http://localhost:64593/tests/dromaeo/cssquery-yui.html (next: http://localhost:64593/tests/dromaeo/cssquery-dojo.html) 11:16:19 INFO - PROCESS | 6492 | RSS: Main: 199921664 11:16:19 INFO - PROCESS | 6492 | 11:16:19 INFO - PROCESS | 6492 | __start_tp_report 11:16:19 INFO - PROCESS | 6492 | _x_x_mozilla_page_load 11:16:19 INFO - PROCESS | 6492 | _x_x_mozilla_page_load_details 11:16:19 INFO - PROCESS | 6492 | |i|pagename|runs| 11:16:19 INFO - PROCESS | 6492 | |0;dojo.html;3613.385724426849;3616.927661446771;3638.6543278388576;3639.4358874374466;3671.853125874965;5075.705695047763;5465.152901300305;5805.912911306334;5817.73820178092;5817.825465236045;5755.0504166812425;5787.536997040237;5834.5040671542865;5834.766609335621;5852.912206316898;5213.973930130344;5264.631475796696;5301.41684414716;5302.840914772543;5308.70802105884;4358.673099517533;4674.158651442739;5034.144195486776;5187.844364669066;5286.841394758163;3977.6618987385964;4280.400743895857;5264.394594621629;5267.736613169345;5336.653117547347;5296.205569164617;5301.973490132544;5329.014132385521;5343.599230057761;5346.572274218053;4984.601231901439;5051.444341122474;5285.550728188108;5291.497307755757;5309.256704061435;4058.594140585947;5524.502794748451;5737.483626473596;5789.218455508537;5822.417758224186;6215.689215539205;6227.906581401283;6235.314115447297;6239.65681887496;6241;6229.221347331583;6247.187865577492;6251.249850018027;6270.247570291549;6272.1219029335925;5739.426057394269;5901;5942.286925568917;5953.791617293374;6026.969865150646;6248.909059172649;6290.21372328459;6324.494040476751;6328.462080723098;6339.904901426482;6224.221972253468;6265.8746825063245;6266.060090986389;6271.184745983084;6277.7175027123885;6118.131909153847;6211.627302361782;6240.93904036315;6285.968570157212;6289.528285378615;6200.81397558074;6217.875642487125;6234.719437625227;6237.656928868865;6239;6143.170671959318;6176.197094377702;6215.098810672427;6244.75020999164;6253.6560489173535;4361.193179261847;4643.86068417948;4907.3620429343955;4919.016196760591;4986.326845875833;4490.371348011281;4503.392042074278;4526.072155208174;4537.863864084083;4548.113117942035;5841.328247251536;5946.67293298864;5962.135490353961;5978.103284507271;6036.094585812163;6198.876022479525;6256.593321434092;6261.342559031327;6263.552877457057;6264.310925798159;5981.162637230791;5995.760169593167;6012.098185272244;6023.969880150571;6053.152558641794;4217.936730949038;5344.9732751336;5417.5395091416885;5455.945440545624;5466.726663666801;6256.374362563707;6338.492920566344;6383.042543618494;6407.359264073649;6431.099646049651;6229;6279.183706118358;6279.591826531261;6296.275928268308;6301.495880329471;5222.582193424441;5480.6437581557075;6298.968505157628;6378.936210637834;6412.967935160481;6161.661108639068;6223.906641400292;6228.252609686685;6230.657313847601;6235.501159907287;5504.4770746778995;6076.72654730547;6232.875342493216;6238.532110091852;6249.875002500015;6058.666773327509;6144.924638188209;6181.406957570089;6184.690765461619;6256.155419018374;5353.955978584138;6055.939440605537;6132.693365331805;6149.72326245329;6165.753369865155;5911.467967882912;6000.51995840323;6034.879302414015;6040;6043.667598282137;4885.4870238624435;6083.117947897442;6168.629882207082;6188.783392581238;6233.96883015582;6011.918119031486;6060.636361818305;6091.543134265036;6106.236720409949;6118.785842495491 11:16:19 INFO - PROCESS | 6492 | |1;ext.html;500.0524007006725;520.3937412913958;521.6504941689069;616.002417224675;665.5973136252567;38674.22651546971;40188.39717404237;40205;40292.59707402929;40319.798401008025;41370;41837.16325673485;41841.790791046005;41989.160216795644;41998;9511.6195352186;9652.613895444174;9683.467409292487;9695;9725.854112188288;8000.9199908000755;9191.264698824078;9507.524623768819;9798.608055677765;9832.508374581279;9664.855027174597;9748.073932976391;9751.609935602568;9804.509774511282;9838.754031149243;9703.514824258795;9735.221182305399;9850;9853.605855765762;9863;9731.12419882214;9871.753206169831;9877.209823214125;9904.90095099047;9928.106470417697;40048.79975600103;40518.79740601307;40919.795401022806;40959.7952010241;40987;3176.9205769855707;3312.668733126692;3339.7662163648556;3357.3621012007884;3754.624537546251;24322;29784.255393615116;30347.241318966982;30460.390792184255;30720.078397648107;2738.424930764522;2753.9586906196423;2769.5430254008065;2802.579613058037;2957.142428695676;462898;466322;471036.99999999657;472194;472931;47747.761261194166;48582.27126593104;75935.24064759392;76147.23852761512;76229;47268.5273147271;47541.76229118832;47557;47612.28581571279;47787.28319075217;17459;17643.55891102733;17821.7326740099;17826.46520604384;17829.643407131785;13775.448982040807;13944.302784860716;14093.224872632103;14268.357923893449;14360.066595671247;15348.693026139637;15530.456434024754;15723.371065157495;15842.920785396;15934.9203253983;6596.307387724316;6659.134312539436;6684.2981486944145;6721.092652491851;6722.865542689216;955.7371722776293;1041.286718597763;1044.8589440425596;1076.6608518316705;1181.5230961298378;30604.84697576498;30640;31205.063848084596;31304.21739456486;32728;1025.9989530622897;1027.9331843430152;1098.9450527473593;1107.7205827269518;1125.3754166437707;13229.536966206137;16942.576435588962;16966.660666786596;17073;17116.229769660396;434934;518452;521109;523320;532877;50331;60881.69559152176;61366.69316653388;61887.69056154691;62078;1404.6067101211677;1550.1861522700447;1573;1574.5119013105973;1687.864970802333;30560.84719576388;32658.51012234866;32722.50916236306;32746.50880236846;33252.33495330031;55739;55861.72069139628;56124;56438.71780641235;56439.43560564506;478379;478936;479331;481401;484674;33162.83418582891;33717.157071073416;34148.487772683926;35003.124921877155;35390.11524711903;46105.847353816425;46717.065658685955;47410.81472963204;48141;48338.791530212024;38496.2300753989;38680;38782.80608596939;38893;39194.80402597969;37934.810325948194;38326.04184895288;38496.84509464721;38671.22657546777;38688.6131138685;38218.42672359861;38377.80811095927;38967.415488767125;39526;39676.008099797735;33637.495437567966;34697.479537806445;34795.65204347924;34832.30335393328;35012;22367.731011852324;25893.482130357665;25995.870020649774;26295;26676.466470670865 11:16:19 INFO - PROCESS | 6492 | |2;jquery.html;333.00099700897294;361.57334345472367;374.49256257770713;376.8002958432031;380.4692454026633;20370.89814550927;20836.479088022807;21277.255296064643;21884.781152188472;22028.77971220287;21559.1376344946;21657;21860.23489177879;22162.22432214873;22258.220962266325;5965.821025369235;5984.473959140413;6208.689565521729;6225.782097626584;6251.281102673182;6031.668258245794;6118.3269840317525;6136.631802091866;6141.447269745722;6148.077788331741;5770.682612456313;6056.091586262074;6064.696765161746;6088.391160883898;6105.786297479589;5111.821086261982;5970.492508136814;6002.699865006733;6110.114033465123;6128.233970753656;4490.326451032372;5196.168613021936;5197.116490196638;5276.287701160332;5331.866703332409;25508.74491255082;25823.48353032929;25992.610110848353;26129.08548200804;26445.471090578274;2172.283146561631;2185.617516934546;2252.177955046396;2305.827062970284;2389.80881529479;15112.28743992594;15467.922660386626;15499.380024798995;15537.922310388489;15775.684486310325;1784.97322540162;1838.8712790104564;1845.64932662795;1859.3399343233227;1897.5161333859915;103820;105440.47279763629;105465.47267263691;108226;108386.45806770994;11200.103991680646;11327.546898124148;11422.086233101332;11432.771344573062;11551.942240288745;13547.525836595672;13548.661283467794;13567.728645427036;13862;13887.513937012156;9130.360874738704;9159.633614655473;9166.037566055602;9183.678571249975;9252.352335336596;9480.90519094814;9567.282453815991;9581.041895810364;9627.759306017406;9668.661596844076;4894.26586012094;5349.518543331119;6309.706510165405;6368.77709280173;6385.393387628168;1548.2877876177085;1726;1769.78762548495;1860.2558976409543;1867.4677716850633;917.5458148216676;920.052346083535;1006.582268358623;1062.9149668026694;1073.3238060022136;21353.932303385078;21905.890470547864;22089.558208835733;22208.88895555544;22278.77721222767;1054.0513537816028;1060.1042119409087;1067.4716015572342;1089.6622047165404;1100.312304809494;11725.003374713246;11840.28958262507;12045.578404755792;12156.331401772988;12161;585082.0745896328;621567;628433;674967;680060;102250;105673.47163264135;105892.94107058985;105970;106522.46738766256;1072.485207100596;1081.8972197641212;1087.6465148826505;1091.7543552700579;1094.4254266510145;18982.525436864187;19502.21991120396;19543.21827126899;19598.902005489883;19737.605247895248;46367.304490433344;47133.82165445754;48150.277745834544;49350.50649493459;49791.75104124456;65945.67027164834;69255;70002;70201.64899175472;78651.60674196592;8204.261616454547;8295.336373090018;8309.542975136426;8422.578871056545;8445.1977062179;12966.351682415652;13536.984726145776;13670.453181872614;13696.31518424055;13975.951803614566;11639.47622357013;11682.649520514398;11788.23376480526;11866.525338986688;11979.940100299442;9437;11732.061435085343;11760.117991150526;11806.631546327913;11971.820422693841;12058.75882482363;12153.939230303791;12208.694782630506;12265.509379625071;12268.509259629514;8399.370047246603;8435.620397082022;8472.957635211784;8483.36374771907;8600;11312.20814542974;11856.525738970344;11889.940550297193;11943;11954.462049207981 11:16:19 INFO - PROCESS | 6492 | |3;mootools.html;1555.3078879898446;1663.0437498438394;1986.3345779163978;2071.8135367816903;2108.683697445382;8286.75139745807;8895;8905.154010369013;9095.590698418562;9106.225970792482;7318.780436586898;8819;8825.029246782864;8856.645734170625;9006.639734410615;2546.9235922922344;2562.06484633109;2577.6262441945905;2589.1455819579587;2591.883365248568;2530.4180038591135;2573.98327660574;2576.7423257674177;2577.2525967469505;2580.87095645217;2525.368657835541;2541.466292078666;2555.718870924197;2591.857447840368;2607.1266125847865;2563.4488584954233;2573.137998770405;2589.313831834556;2591.740825917412;2598.8310759800743;2169.990954206286;2538.7588179122954;2550.961735573968;2574.382148284417;2574.4336246025846;7606.771796846048;9042.86435703465;9078.182963533247;9108.22580080694;9140.497272650002;4505.414296141514;5609.102543593006;5610.831675049755;5708.943845388616;5763.991301522216;3125.7186853183093;3641.217138315275;3731.6268373162466;3733.3653278942375;3810.961890381116;1067.4716015572264;1098.3794156301744;1098.8296813993843;1100.873399559053;1100.9229353945227;11969.94015029928;12284.201526900812;12347.567835125728;12381.814272785916;12462.252264864137;4599.839005634787;4779.928301075487;5023.422306434733;5109.20807274873;5156.458571849977;10427.165826733843;10484.737881553023;10486.842697359545;10512.737181570368;10520.684379468628;5537.1140617501815;5579.191017302468;5595.832125036255;5648.435156484401;5715.971420142872;4683.601893838993;5014.5737612303365;5051.318072060299;5130.538251557377;5167.509086636764;4009.298372784751;4072.4095006223934;4082.408050832613;4097.057676734308;4121.010957370209;1370.5751217122724;1373.2447154065223;1377.7106807570322;1380.4892189889806;1381.550995926328;1206.776746301937;1395.1629022586367;1437.2454461407845;1439.5393474088191;1458.6936743283818;7613.6573854176695;8302.252797248277;8390.160983901562;8431.241188293083;8457.069722330538;506.17493485618206;530.8699368654704;537.0655060195232;540.00638824563;541.8672425255837;4918.606511479073;5220.634555581149;6214.25428948529;6237.220347456568;6329.145565348711;10375.481225938824;10671.733206669895;10989.670309890716;10998.230123891251;11114.110871130451;10576.841347379795;10605.151587872951;10650.041496265374;10873;10899.509522071367;8480.406371554056;8587.355948303903;8676.826463470821;8678.17557332065;8681.869771953427;7811.96094019549;7915.366770658448;8067.556284404414;8077.192280771876;8178.1821817817745;9667.758306042124;9667.951660241935;9868.555914983699;9904.356216845881;9989.60041598328;9761.658341957997;10099.04059114383;10142.797144057226;10246.077852993267;10254.128399085863;6758.290379510081;6973.65131743421;7555.206703296075;7647.388208943383;7754.185810490043;8015.719449819461;8099;8135.186481351818;8163.102058773411;8166.305864001389;7336.266373362621;7388.187299397169;7494.850102998019;7566.583837888969;7622.5426474411715;7297.525660832029;7323.340899319087;7397.445191610543;7397.926020739939;7457.701691932262;7807.219278072147;7810.765677029698;7849.058113026474;7854.60726963661;7874.37005039584;6479.611223326616;6536.0522724205675;6586.901196481961;6786.117804685359;7084.114485689289;7210.603416812126;7246.456515761233;7250.238724933806;7310.853782924205;7344.081989751281 11:16:19 INFO - PROCESS | 6492 | |4;prototype.html;341.5883859948762;341.94699821527655;345.1216653616547;346.44395744829535;350.9368313703534;6910.4126149277245;6992.265812089728;6992.650367481619;6995.720171193153;7018.964905175473;6864.053169427574;6954.0959675242275;6957.165140183185;6979.441644668427;7001.439884809216;4845.854624361257;4940.308356830046;5077.64456488046;5095.082885080684;5113.667611605252;5100.974495127519;5183.844484665466;5188.16989281715;5213.635045546814;5255.816046438356;5064.290999260106;5067.923981140286;5086.720230387327;5087.745612719368;5088.1095808233595;4103.8974025649295;5068.771905264272;5079.949200507985;5082.08522465956;5103.668261562986;4337.240982828024;4341.110072435144;4362.105768317519;4362.825486980517;4371.584699453547;5833.095870140135;6336.398042185985;6483.7730679425995;6741.561798483083;6791.626460544668;5948.375420580864;5997.640141591519;6014.6391216527145;6015.0676645120075;6016.037434010537;7521.135069466972;7525.962370188169;7532.510386824839;7545.849083018309;7560.092788865316;4091.734037287567;4677.321788340706;4808.0383923215495;4820.493848145929;4835.202191638376;7135.89296160558;7842.7647170584405;7900.446968712193;7942.841143177162;7946.443748937577;4025.7584544926813;4722.8429034885985;4829.613630909519;4832;4841.95158048415;4941.234108713155;4963.60291176705;4984.925226121611;4995.100881841231;5004.873903371785;4884.291777692215;5102.566281866083;5932.970335148383;5945.286565612154;5963.373845746221;6362.313986793503;7477.962610186914;7489.737859174903;7493.962530187314;7507.436942229355;1677.2536221381613;1705.4457301376854;1735.5314065202324;1736.426979096895;1740.7562941188244;1073.5705717712822;1088.298047759191;1097.5116073347283;1099.8735145458215;1102.7463683352873;5972.610955617701;7095.184053833772;7110.217876033736;7220.819479512949;7246.311600397954;6930.93069069313;7235.312645298688;7741;7777.72777952769;7821.178776228414;7177.959195916563;7204.747833825791;7214.49498535108;7217.855642887218;7223.855522889513;4013.3779264214095;4111.177764447122;4139.730917490354;4145.191687620885;4148.522919864255;8177.223163799429;8182.549959752271;8191.976002999625;8195.139510351328;8205.466644668197;6534.157641425995;8011.078725946474;8035.67857285702;8057.758267251992;8099.271065604124;8123.593820308961;8150.551719655476;8150.877736833952;8161.183881611792;8182.304504117216;7530.9246907532415;7770.961145194238;7843.647035883513;7872.645730942236;7893.210678932061;7600.1639819618695;7615.504992175491;7666.731664391943;7673.232676732282;7684.193159718373;8123.065847427385;8140.308073813792;8176.305014073632;8180.427370084037;8188.959055204924;4901.58336541398;4933.383327084114;4942.75286235694;4949.232868905326;4951.935333903228;7137.678804453708;7744.9157118002395;7767.262110099531;7792.2986931176465;7817.413693973089;6286.52851036165;7524.473286869867;7546.66040028189;7583.658735356812;7606.163322034682;5721.313442386941;6852.588844669336;7447.5531468112085;7521.586312752851;7605.125410577633;7147.677679629285;7386.298301661333;7414;7420.295071968154;7438.070241219848;6107.9083813741945;7525.6989720410575;7527.924720752722;7568.583727894798;7616.162222155448;7388.556686598821;7403.888941665987;7407.925920740724;7408.555486670817;7411.814704632212 11:16:19 INFO - PROCESS | 6492 | |5;yui.html;693.6162356099582;770.2913319745833;786.3473317146766;787.354369417078;795.7374066558036;15078.547643570682;15157.545273641794;15184.848151518481;15455.845441545582;15463.381464741426;14206.431742730305;14229.71540569188;14235.572932812007;14279.857201427983;14560.92719536401;796.0606484348466;948.1656142594508;961.3366776923936;984.5864736810521;990.1385794358918;951.8905325887542;969.7333233360812;975.2636759246759;984.271638987148;987.6197663899414;993.2401712689798;1026.14829691356;1031.4997226345217;1034.4879284754056;1045.7856139491423;1015.2132097624363;1024.5082360466943;1035.8860525342207;1035.9792804143913;1036.3885307668436;733.4865594084109;733.7395224695263;741.6328917185973;747.8093086262968;760.8592410404093;14371.928140359336;14395.568132955923;14642.487512936996;14704;14836.109833409922;10619;13062.934685326607;13078.215307081606;13237.271950042743;13242.602721918262;9128.680496182667;9199.70974443592;9303.883533975966;9483.383580067273;10302.33034852732;3766.6251818086475;4091.3862920561855;4153.982274342806;4167.604077612622;4261.595148460891;80282.59858700728;80477.19522804755;82455.3508929824;86757.56621216853;87468.56265718631;8871.778205544913;9496.857547136799;9642.807143857084;9653.22774178064;9847.359921605215;21927.67108493374;22028.11887524481;22048.88975555112;22073.668894966588;22111.889440552695;7699.26856948589;7818.569978651229;7828.686852525835;7830.765077047698;7935.08746494149;3953.644172024474;4077.9805048737817;4132.855350062733;4141.7100802943505;4157.189348077096;3527.5766907971206;3547.379208638478;3559.839807208682;3597.010822023912;3630.3465376232;688.5971706551724;690.5787469643514;691.5885048396296;692.5879101934341;693.3932808792307;542.4548328929401;585.7815743254022;597.745957967862;610.786224821309;622.8100429368995;8384.455010424303;8452.915470845213;8551.401401901932;8592.140785921358;8660.26387757035;582.8484594005589;605.2918085839578;614.1862032806549;615.5229696984873;635.478907296022;3329.883454079096;3608.6030536640947;3963.801809909493;3987.381955796798;4039.8284497495983;91146;92650;94016;94016;94979.52510237542;81407;81930;82405.17594823975;83579.5821020891;83852;51956.74021629868;69218.65390673115;71989.56020879449;72255;72940.27059729441;7765.53406795594;7929.246721561442;8025.638846252049;8201.95899020501;8262.297704695167;41917.79041104897;51251;51657.74171129271;51901.82087105868;52591.73704131455;66252.668736656;70867.29132708607;71934.64032679803;72526.63736681282;73486.63256683682;11231.38227397501;11394.48724807369;11424.543018279175;11585.82621260665;11623.76752464963;10343.689689309333;12111.091668125102;12324.876751232372;12349.444275007467;12513.124081314221;11591.884081159418;11644.941775291069;11875.584354547549;11978.401079946143;12057.939710301393;11546.307221566733;11578.94210528942;11614.187006909435;11676.357800320724;11757.76484470323;11094.167937404889;11521.790212027952;11578.189526733047;11673;12153.574624888086;10029.949850250701;10073.496325183858;10193.082622564005;10370.222233332379;10384.792304154025;9812.116909478182;9861.950690246504;9893.554790034323;9929.3545919515;10074.597016119566 11:16:19 INFO - PROCESS | 6492 | __end_tp_report 11:16:19 INFO - PROCESS | 6492 | __start_cc_report 11:16:19 INFO - PROCESS | 6492 | _x_x_mozilla_cycle_collect,351 11:16:19 INFO - PROCESS | 6492 | __end_cc_report 11:16:19 INFO - PROCESS | 6492 | __startTimestamp1463508979075__endTimestamp 11:16:19 INFO - PROCESS | 6492 | 11:16:19 INFO - PROCESS | 6492 | ------- Summary: start ------- 11:16:19 INFO - PROCESS | 6492 | Number of tests: 6 11:16:19 INFO - PROCESS | 6492 | 11:16:19 INFO - PROCESS | 6492 | [#0] dojo.html Cycles:165 Average:5735.41 Median:6036.09 stddev:682.74 (11.3%) stddev-sans-first:664.23 11:16:19 INFO - PROCESS | 6492 | Values: 3613.4 3616.9 3638.7 3639.4 3671.9 5075.7 5465.2 5805.9 5817.7 5817.8 5755.1 5787.5 5834.5 5834.8 5852.9 5214.0 5264.6 5301.4 5302.8 5308.7 4358.7 4674.2 5034.1 5187.8 5286.8 3977.7 4280.4 5264.4 5267.7 5336.7 5296.2 5302.0 5329.0 5343.6 5346.6 4984.6 5051.4 5285.6 5291.5 5309.3 4058.6 5524.5 5737.5 5789.2 5822.4 6215.7 6227.9 6235.3 6239.7 6241.0 6229.2 6247.2 6251.2 6270.2 6272.1 5739.4 5901.0 5942.3 5953.8 6027.0 6248.9 6290.2 6324.5 6328.5 6339.9 6224.2 6265.9 6266.1 6271.2 6277.7 6118.1 6211.6 6240.9 6286.0 6289.5 6200.8 6217.9 6234.7 6237.7 6239.0 6143.2 6176.2 6215.1 6244.8 6253.7 4361.2 4643.9 4907.4 4919.0 4986.3 4490.4 4503.4 4526.1 4537.9 4548.1 5841.3 5946.7 5962.1 5978.1 6036.1 6198.9 6256.6 6261.3 6263.6 6264.3 5981.2 5995.8 6012.1 6024.0 6053.2 4217.9 5345.0 5417.5 5455.9 5466.7 6256.4 6338.5 6383.0 6407.4 6431.1 6229.0 6279.2 6279.6 6296.3 6301.5 5222.6 5480.6 6299.0 6378.9 6413.0 6161.7 6223.9 6228.3 6230.7 6235.5 5504.5 6076.7 6232.9 6238.5 6249.9 6058.7 6144.9 6181.4 6184.7 6256.2 5354.0 6055.9 6132.7 6149.7 6165.8 5911.5 6000.5 6034.9 6040.0 6043.7 4885.5 6083.1 6168.6 6188.8 6234.0 6011.9 6060.6 6091.5 6106.2 6118.8 11:16:19 INFO - PROCESS | 6492 | 11:16:19 INFO - PROCESS | 6492 | [#1] ext.html Cycles:180 Average:63499.61 Median:40118.60 stddev:129010.65 (321.6%) stddev-sans-first:129285.84 11:16:19 INFO - PROCESS | 6492 | Values: 500.1 520.4 521.7 616.0 665.6 38674.2 40188.4 40205.0 40292.6 40319.8 41370.0 41837.2 41841.8 41989.2 41998.0 9511.6 9652.6 9683.5 9695.0 9725.9 8000.9 9191.3 9507.5 9798.6 9832.5 9664.9 9748.1 9751.6 9804.5 9838.8 9703.5 9735.2 9850.0 9853.6 9863.0 9731.1 9871.8 9877.2 9904.9 9928.1 40048.8 40518.8 40919.8 40959.8 40987.0 3176.9 3312.7 3339.8 3357.4 3754.6 24322.0 29784.3 30347.2 30460.4 30720.1 2738.4 2754.0 2769.5 2802.6 2957.1 462898.0 466322.0 471037.0 472194.0 472931.0 47747.8 48582.3 75935.2 76147.2 76229.0 47268.5 47541.8 47557.0 47612.3 47787.3 17459.0 17643.6 17821.7 17826.5 17829.6 13775.4 13944.3 14093.2 14268.4 14360.1 15348.7 15530.5 15723.4 15842.9 15934.9 6596.3 6659.1 6684.3 6721.1 6722.9 955.7 1041.3 1044.9 1076.7 1181.5 30604.8 30640.0 31205.1 31304.2 32728.0 1026.0 1027.9 1098.9 1107.7 1125.4 13229.5 16942.6 16966.7 17073.0 17116.2 434934.0 518452.0 521109.0 523320.0 532877.0 50331.0 60881.7 61366.7 61887.7 62078.0 1404.6 1550.2 1573.0 1574.5 1687.9 30560.8 32658.5 32722.5 32746.5 33252.3 55739.0 55861.7 56124.0 56438.7 56439.4 478379.0 478936.0 479331.0 481401.0 484674.0 33162.8 33717.2 34148.5 35003.1 35390.1 46105.8 46717.1 47410.8 48141.0 48338.8 38496.2 38680.0 38782.8 38893.0 39194.8 37934.8 38326.0 38496.8 38671.2 38688.6 38218.4 38377.8 38967.4 39526.0 39676.0 33637.5 34697.5 34795.7 34832.3 35012.0 22367.7 25893.5 25995.9 26295.0 26676.5 11:16:19 INFO - PROCESS | 6492 | 11:16:19 INFO - PROCESS | 6492 | [#2] jquery.html Cycles:180 Average:35343.95 Median:21872.51 stddev:105377.92 (481.8%) stddev-sans-first:105640.74 11:16:19 INFO - PROCESS | 6492 | Values: 333.0 361.6 374.5 376.8 380.5 20370.9 20836.5 21277.3 21884.8 22028.8 21559.1 21657.0 21860.2 22162.2 22258.2 5965.8 5984.5 6208.7 6225.8 6251.3 6031.7 6118.3 6136.6 6141.4 6148.1 5770.7 6056.1 6064.7 6088.4 6105.8 5111.8 5970.5 6002.7 6110.1 6128.2 4490.3 5196.2 5197.1 5276.3 5331.9 25508.7 25823.5 25992.6 26129.1 26445.5 2172.3 2185.6 2252.2 2305.8 2389.8 15112.3 15467.9 15499.4 15537.9 15775.7 1785.0 1838.9 1845.6 1859.3 1897.5 103820.0 105440.5 105465.5 108226.0 108386.5 11200.1 11327.5 11422.1 11432.8 11551.9 13547.5 13548.7 13567.7 13862.0 13887.5 9130.4 9159.6 9166.0 9183.7 9252.4 9480.9 9567.3 9581.0 9627.8 9668.7 4894.3 5349.5 6309.7 6368.8 6385.4 1548.3 1726.0 1769.8 1860.3 1867.5 917.5 920.1 1006.6 1062.9 1073.3 21353.9 21905.9 22089.6 22208.9 22278.8 1054.1 1060.1 1067.5 1089.7 1100.3 11725.0 11840.3 12045.6 12156.3 12161.0 585082.1 621567.0 628433.0 674967.0 680060.0 102250.0 105673.5 105892.9 105970.0 106522.5 1072.5 1081.9 1087.6 1091.8 1094.4 18982.5 19502.2 19543.2 19598.9 19737.6 46367.3 47133.8 48150.3 49350.5 49791.8 65945.7 69255.0 70002.0 70201.6 78651.6 8204.3 8295.3 8309.5 8422.6 8445.2 12966.4 13537.0 13670.5 13696.3 13976.0 11639.5 11682.6 11788.2 11866.5 11979.9 9437.0 11732.1 11760.1 11806.6 11971.8 12058.8 12153.9 12208.7 12265.5 12268.5 8399.4 8435.6 8473.0 8483.4 8600.0 11312.2 11856.5 11889.9 11943.0 11954.5 11:16:19 INFO - PROCESS | 6492 | 11:16:19 INFO - PROCESS | 6492 | [#3] mootools.html Cycles:180 Average:6137.63 Median:5161.98 stddev:3247.48 (62.9%) stddev-sans-first:3238.32 11:16:19 INFO - PROCESS | 6492 | Values: 1555.3 1663.0 1986.3 2071.8 2108.7 8286.8 8895.0 8905.2 9095.6 9106.2 7318.8 8819.0 8825.0 8856.6 9006.6 2546.9 2562.1 2577.6 2589.1 2591.9 2530.4 2574.0 2576.7 2577.3 2580.9 2525.4 2541.5 2555.7 2591.9 2607.1 2563.4 2573.1 2589.3 2591.7 2598.8 2170.0 2538.8 2551.0 2574.4 2574.4 7606.8 9042.9 9078.2 9108.2 9140.5 4505.4 5609.1 5610.8 5708.9 5764.0 3125.7 3641.2 3731.6 3733.4 3811.0 1067.5 1098.4 1098.8 1100.9 1100.9 11969.9 12284.2 12347.6 12381.8 12462.3 4599.8 4779.9 5023.4 5109.2 5156.5 10427.2 10484.7 10486.8 10512.7 10520.7 5537.1 5579.2 5595.8 5648.4 5716.0 4683.6 5014.6 5051.3 5130.5 5167.5 4009.3 4072.4 4082.4 4097.1 4121.0 1370.6 1373.2 1377.7 1380.5 1381.6 1206.8 1395.2 1437.2 1439.5 1458.7 7613.7 8302.3 8390.2 8431.2 8457.1 506.2 530.9 537.1 540.0 541.9 4918.6 5220.6 6214.3 6237.2 6329.1 10375.5 10671.7 10989.7 10998.2 11114.1 10576.8 10605.2 10650.0 10873.0 10899.5 8480.4 8587.4 8676.8 8678.2 8681.9 7812.0 7915.4 8067.6 8077.2 8178.2 9667.8 9668.0 9868.6 9904.4 9989.6 9761.7 10099.0 10142.8 10246.1 10254.1 6758.3 6973.7 7555.2 7647.4 7754.2 8015.7 8099.0 8135.2 8163.1 8166.3 7336.3 7388.2 7494.9 7566.6 7622.5 7297.5 7323.3 7397.4 7397.9 7457.7 7807.2 7810.8 7849.1 7854.6 7874.4 6479.6 6536.1 6586.9 6786.1 7084.1 7210.6 7246.5 7250.2 7310.9 7344.1 11:16:19 INFO - PROCESS | 6492 | 11:16:19 INFO - PROCESS | 6492 | [#4] prototype.html Cycles:180 Average:6078.97 Median:6955.63 stddev:1982.94 (28.5%) stddev-sans-first:1941.17 11:16:19 INFO - PROCESS | 6492 | Values: 341.6 341.9 345.1 346.4 350.9 6910.4 6992.3 6992.7 6995.7 7019.0 6864.1 6954.1 6957.2 6979.4 7001.4 4845.9 4940.3 5077.6 5095.1 5113.7 5101.0 5183.8 5188.2 5213.6 5255.8 5064.3 5067.9 5086.7 5087.7 5088.1 4103.9 5068.8 5079.9 5082.1 5103.7 4337.2 4341.1 4362.1 4362.8 4371.6 5833.1 6336.4 6483.8 6741.6 6791.6 5948.4 5997.6 6014.6 6015.1 6016.0 7521.1 7526.0 7532.5 7545.8 7560.1 4091.7 4677.3 4808.0 4820.5 4835.2 7135.9 7842.8 7900.4 7942.8 7946.4 4025.8 4722.8 4829.6 4832.0 4842.0 4941.2 4963.6 4984.9 4995.1 5004.9 4884.3 5102.6 5933.0 5945.3 5963.4 6362.3 7478.0 7489.7 7494.0 7507.4 1677.3 1705.4 1735.5 1736.4 1740.8 1073.6 1088.3 1097.5 1099.9 1102.7 5972.6 7095.2 7110.2 7220.8 7246.3 6930.9 7235.3 7741.0 7777.7 7821.2 7178.0 7204.7 7214.5 7217.9 7223.9 4013.4 4111.2 4139.7 4145.2 4148.5 8177.2 8182.5 8192.0 8195.1 8205.5 6534.2 8011.1 8035.7 8057.8 8099.3 8123.6 8150.6 8150.9 8161.2 8182.3 7530.9 7771.0 7843.6 7872.6 7893.2 7600.2 7615.5 7666.7 7673.2 7684.2 8123.1 8140.3 8176.3 8180.4 8189.0 4901.6 4933.4 4942.8 4949.2 4951.9 7137.7 7744.9 7767.3 7792.3 7817.4 6286.5 7524.5 7546.7 7583.7 7606.2 5721.3 6852.6 7447.6 7521.6 7605.1 7147.7 7386.3 7414.0 7420.3 7438.1 6107.9 7525.7 7527.9 7568.6 7616.2 7388.6 7403.9 7407.9 7408.6 7411.8 11:16:19 INFO - PROCESS | 6492 | 11:16:19 INFO - PROCESS | 6492 | [#5] yui.html Cycles:180 Average:18659.36 Median:52274.24 stddev:26329.32 (50.4%) stddev-sans-first:26368.62 11:16:19 INFO - PROCESS | 6492 | Values: 693.6 770.3 786.3 787.4 795.7 15078.5 15157.5 15184.8 15455.8 15463.4 14206.4 14229.7 14235.6 14279.9 14560.9 796.1 948.2 961.3 984.6 990.1 951.9 969.7 975.3 984.3 987.6 993.2 1026.1 1031.5 1034.5 1045.8 1015.2 1024.5 1035.9 1036.0 1036.4 733.5 733.7 741.6 747.8 760.9 14371.9 14395.6 14642.5 14704.0 14836.1 10619.0 13062.9 13078.2 13237.3 13242.6 9128.7 9199.7 9303.9 9483.4 10302.3 3766.6 4091.4 4154.0 4167.6 4261.6 80282.6 80477.2 82455.4 86757.6 87468.6 8871.8 9496.9 9642.8 9653.2 9847.4 21927.7 22028.1 22048.9 22073.7 22111.9 7699.3 7818.6 7828.7 7830.8 7935.1 3953.6 4078.0 4132.9 4141.7 4157.2 3527.6 3547.4 3559.8 3597.0 3630.3 688.6 690.6 691.6 692.6 693.4 542.5 585.8 597.7 610.8 622.8 8384.5 8452.9 8551.4 8592.1 8660.3 582.8 605.3 614.2 615.5 635.5 3329.9 3608.6 3963.8 3987.4 4039.8 91146.0 92650.0 94016.0 94016.0 94979.5 81407.0 81930.0 82405.2 83579.6 83852.0 51956.7 69218.7 71989.6 72255.0 72940.3 7765.5 7929.2 8025.6 8202.0 8262.3 41917.8 51251.0 51657.7 51901.8 52591.7 66252.7 70867.3 71934.6 72526.6 73486.6 11231.4 11394.5 11424.5 11585.8 11623.8 10343.7 12111.1 12324.9 12349.4 12513.1 11591.9 11644.9 11875.6 11978.4 12057.9 11546.3 11578.9 11614.2 11676.4 11757.8 11094.2 11521.8 11578.2 11673.0 12153.6 10029.9 10073.5 10193.1 10370.2 10384.8 9812.1 9862.0 9893.6 9929.4 10074.6 11:16:19 INFO - PROCESS | 6492 | -------- Summary: end -------- 11:16:19 INFO - PROCESS | 6492 | 11:16:19 INFO - TEST-INFO | 6492: exit 0 11:16:19 INFO - TEST-OK | dromaeo_css | took 1109148ms 11:16:19 INFO - TEST-START | kraken 11:16:19 INFO - operating with platform_type : mac_ 11:16:19 INFO - Initialising browser for kraken test... 11:16:19 INFO - TEST-INFO | started process 6497 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmp1ORshw/profile http://localhost:64593/getInfo.html) 11:16:22 INFO - PROCESS | 6497 | __metrics Screen width/height:1600/1200 11:16:22 INFO - PROCESS | 6497 | colorDepth:24 11:16:22 INFO - PROCESS | 6497 | Browser inner width/height: 1024/689 11:16:22 INFO - PROCESS | 6497 | __metrics 11:16:22 ERROR - PROCESS | 6497 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2859: TypeError: this.tabs is undefined 11:16:22 INFO - TEST-INFO | 6497: exit 0 11:16:22 INFO - Browser initialized. 11:16:22 INFO - Running cycle 1/1 for kraken test... 11:16:22 INFO - TEST-INFO | started process 6501 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmp1ORshw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:16:34 INFO - PROCESS | 6501 | RSS: Main: 167829504 11:16:34 INFO - PROCESS | 6501 | 11:16:37 INFO - PROCESS | 6501 | Cycle 1(1): loaded http://localhost:64593/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:64593/tests/kraken/driver.html?testName=audio-beat-detection) 11:16:38 INFO - PROCESS | 6501 | RSS: Main: 180060160 11:16:38 INFO - PROCESS | 6501 | 11:16:40 INFO - PROCESS | 6501 | Cycle 1(1): loaded http://localhost:64593/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:64593/tests/kraken/driver.html?testName=audio-dft) 11:16:41 INFO - PROCESS | 6501 | RSS: Main: 189128704 11:16:41 INFO - PROCESS | 6501 | 11:16:44 INFO - PROCESS | 6501 | Cycle 1(1): loaded http://localhost:64593/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:64593/tests/kraken/driver.html?testName=audio-fft) 11:16:45 INFO - PROCESS | 6501 | RSS: Main: 192479232 11:16:45 INFO - PROCESS | 6501 | 11:16:47 INFO - PROCESS | 6501 | Cycle 1(1): loaded http://localhost:64593/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:64593/tests/kraken/driver.html?testName=audio-oscillator) 11:16:47 INFO - PROCESS | 6501 | RSS: Main: 193425408 11:16:47 INFO - PROCESS | 6501 | 11:16:49 INFO - PROCESS | 6501 | Cycle 1(1): loaded http://localhost:64593/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:64593/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:16:50 INFO - PROCESS | 6501 | RSS: Main: 194523136 11:16:50 INFO - PROCESS | 6501 | 11:16:53 INFO - PROCESS | 6501 | Cycle 1(1): loaded http://localhost:64593/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:64593/tests/kraken/driver.html?testName=imaging-darkroom) 11:16:53 INFO - PROCESS | 6501 | RSS: Main: 194785280 11:16:53 INFO - PROCESS | 6501 | 11:16:56 INFO - PROCESS | 6501 | Cycle 1(1): loaded http://localhost:64593/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:64593/tests/kraken/driver.html?testName=imaging-desaturate) 11:16:57 INFO - PROCESS | 6501 | RSS: Main: 194813952 11:16:57 INFO - PROCESS | 6501 | 11:17:00 INFO - PROCESS | 6501 | Cycle 1(1): loaded http://localhost:64593/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:64593/tests/kraken/driver.html?testName=json-parse-financial) 11:17:00 INFO - PROCESS | 6501 | RSS: Main: 194473984 11:17:00 INFO - PROCESS | 6501 | 11:17:02 INFO - PROCESS | 6501 | Cycle 1(1): loaded http://localhost:64593/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:64593/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:17:03 INFO - PROCESS | 6501 | RSS: Main: 194596864 11:17:03 INFO - PROCESS | 6501 | 11:17:04 INFO - PROCESS | 6501 | Cycle 1(1): loaded http://localhost:64593/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:64593/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:17:05 INFO - PROCESS | 6501 | RSS: Main: 194007040 11:17:05 INFO - PROCESS | 6501 | 11:17:07 INFO - PROCESS | 6501 | Cycle 1(1): loaded http://localhost:64593/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:64593/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:17:08 INFO - PROCESS | 6501 | RSS: Main: 194342912 11:17:08 INFO - PROCESS | 6501 | 11:17:10 INFO - PROCESS | 6501 | Cycle 1(1): loaded http://localhost:64593/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:64593/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:17:11 INFO - PROCESS | 6501 | RSS: Main: 194916352 11:17:11 INFO - PROCESS | 6501 | 11:17:13 INFO - PROCESS | 6501 | Cycle 1(1): loaded http://localhost:64593/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:64593/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:17:14 INFO - PROCESS | 6501 | RSS: Main: 194580480 11:17:14 INFO - PROCESS | 6501 | 11:17:16 INFO - PROCESS | 6501 | Cycle 1(1): loaded http://localhost:64593/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:64593/tests/kraken/driver.html?testName=ai-astar) 11:17:16 INFO - PROCESS | 6501 | RSS: Main: 196091904 11:17:16 INFO - PROCESS | 6501 | 11:17:16 INFO - PROCESS | 6501 | __start_tp_report 11:17:16 INFO - PROCESS | 6501 | _x_x_mozilla_page_load 11:17:16 INFO - PROCESS | 6501 | _x_x_mozilla_page_load_details 11:17:16 INFO - PROCESS | 6501 | |i|pagename|runs| 11:17:16 INFO - PROCESS | 6501 | |0;ai-astar;115;112;115;117;115;130;119;161;170;115 11:17:16 INFO - PROCESS | 6501 | |1;audio-beat-detection;151;124;145;153;115;141;122;152;153;120 11:17:16 INFO - PROCESS | 6501 | |2;audio-dft;191;197;203;233;200;199;200;199;201;197 11:17:16 INFO - PROCESS | 6501 | |3;audio-fft;68;81;68;115;59;57;58;60;129;57 11:17:16 INFO - PROCESS | 6501 | |4;audio-oscillator;88;81;129;79;81;86;122;79;78;124 11:17:16 INFO - PROCESS | 6501 | |5;imaging-gaussian-blur;92;129;89;88;135;130;91;87;89;101 11:17:16 INFO - PROCESS | 6501 | |6;imaging-darkroom;98;103;102;104;130;151;95;96;94;102 11:17:16 INFO - PROCESS | 6501 | |7;imaging-desaturate;91;122;148;153;92;91;92;91;122;87 11:17:16 INFO - PROCESS | 6501 | |8;json-parse-financial;54;61;58;59;60;58;59;59;61;57 11:17:16 INFO - PROCESS | 6501 | |9;json-stringify-tinderbox;64;68;69;69;71;74;73;67;66;69 11:17:16 INFO - PROCESS | 6501 | |10;stanford-crypto-aes;84;81;82;83;84;82;82;83;83;85 11:17:16 INFO - PROCESS | 6501 | |11;stanford-crypto-ccm;133;128;122;140;138;132;135;116;120;130 11:17:16 INFO - PROCESS | 6501 | |12;stanford-crypto-pbkdf2;137;134;137;130;137;136;138;134;134;135 11:17:16 INFO - PROCESS | 6501 | |13;stanford-crypto-sha256-iterative;64;68;67;66;68;65;65;67;66;69 11:17:16 INFO - PROCESS | 6501 | __end_tp_report 11:17:16 INFO - PROCESS | 6501 | __start_cc_report 11:17:16 INFO - PROCESS | 6501 | _x_x_mozilla_cycle_collect,914 11:17:16 INFO - PROCESS | 6501 | __end_cc_report 11:17:16 INFO - PROCESS | 6501 | __startTimestamp1463509036287__endTimestamp 11:17:16 INFO - PROCESS | 6501 | 11:17:16 INFO - PROCESS | 6501 | ------- Summary: start ------- 11:17:16 INFO - PROCESS | 6501 | Number of tests: 14 11:17:16 INFO - PROCESS | 6501 | 11:17:16 INFO - PROCESS | 6501 | [#0] ai-astar Cycles:10 Average:126.90 Median:118.00 stddev:21.03 (17.8%) stddev-sans-first:21.86 11:17:16 INFO - PROCESS | 6501 | Values: 115.0 112.0 115.0 117.0 115.0 130.0 119.0 161.0 170.0 115.0 11:17:16 INFO - PROCESS | 6501 | 11:17:16 INFO - PROCESS | 6501 | [#1] audio-beat-detection Cycles:10 Average:137.60 Median:148.00 stddev:15.55 (10.5%) stddev-sans-first:15.72 11:17:16 INFO - PROCESS | 6501 | Values: 151.0 124.0 145.0 153.0 115.0 141.0 122.0 152.0 153.0 120.0 11:17:16 INFO - PROCESS | 6501 | 11:17:16 INFO - PROCESS | 6501 | [#2] audio-dft Cycles:10 Average:202.00 Median:200.00 stddev:11.35 (5.7%) stddev-sans-first:11.32 11:17:16 INFO - PROCESS | 6501 | Values: 191.0 197.0 203.0 233.0 200.0 199.0 200.0 199.0 201.0 197.0 11:17:16 INFO - PROCESS | 6501 | 11:17:16 INFO - PROCESS | 6501 | [#3] audio-fft Cycles:10 Average:75.20 Median:59.50 stddev:25.96 (43.6%) stddev-sans-first:27.41 11:17:16 INFO - PROCESS | 6501 | Values: 68.0 81.0 68.0 115.0 59.0 57.0 58.0 60.0 129.0 57.0 11:17:16 INFO - PROCESS | 6501 | 11:17:16 INFO - PROCESS | 6501 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:80.00 stddev:21.21 (26.5%) stddev-sans-first:22.36 11:17:16 INFO - PROCESS | 6501 | Values: 88.0 81.0 129.0 79.0 81.0 86.0 122.0 79.0 78.0 124.0 11:17:16 INFO - PROCESS | 6501 | 11:17:16 INFO - PROCESS | 6501 | [#5] imaging-gaussian-blur Cycles:10 Average:103.10 Median:88.50 stddev:19.92 (22.5%) stddev-sans-first:20.72 11:17:16 INFO - PROCESS | 6501 | Values: 92.0 129.0 89.0 88.0 135.0 130.0 91.0 87.0 89.0 101.0 11:17:16 INFO - PROCESS | 6501 | 11:17:16 INFO - PROCESS | 6501 | [#6] imaging-darkroom Cycles:10 Average:107.50 Median:122.50 stddev:18.42 (15.0%) stddev-sans-first:19.21 11:17:16 INFO - PROCESS | 6501 | Values: 98.0 103.0 102.0 104.0 130.0 151.0 95.0 96.0 94.0 102.0 11:17:16 INFO - PROCESS | 6501 | 11:17:16 INFO - PROCESS | 6501 | [#7] imaging-desaturate Cycles:10 Average:108.90 Median:91.00 stddev:25.45 (28.0%) stddev-sans-first:26.16 11:17:16 INFO - PROCESS | 6501 | Values: 91.0 122.0 148.0 153.0 92.0 91.0 92.0 91.0 122.0 87.0 11:17:16 INFO - PROCESS | 6501 | 11:17:16 INFO - PROCESS | 6501 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:59.00 stddev:2.07 (3.5%) stddev-sans-first:1.36 11:17:16 INFO - PROCESS | 6501 | Values: 54.0 61.0 58.0 59.0 60.0 58.0 59.0 59.0 61.0 57.0 11:17:16 INFO - PROCESS | 6501 | 11:17:16 INFO - PROCESS | 6501 | [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:3.06 (4.4%) stddev-sans-first:2.65 11:17:16 INFO - PROCESS | 6501 | Values: 64.0 68.0 69.0 69.0 71.0 74.0 73.0 67.0 66.0 69.0 11:17:16 INFO - PROCESS | 6501 | 11:17:16 INFO - PROCESS | 6501 | [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.00 stddev:1.20 (1.4%) stddev-sans-first:1.20 11:17:16 INFO - PROCESS | 6501 | Values: 84.0 81.0 82.0 83.0 84.0 82.0 82.0 83.0 83.0 85.0 11:17:16 INFO - PROCESS | 6501 | 11:17:16 INFO - PROCESS | 6501 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:132.50 stddev:7.90 (6.0%) stddev-sans-first:8.28 11:17:16 INFO - PROCESS | 6501 | Values: 133.0 128.0 122.0 140.0 138.0 132.0 135.0 116.0 120.0 130.0 11:17:16 INFO - PROCESS | 6501 | 11:17:16 INFO - PROCESS | 6501 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.20 Median:136.50 stddev:2.35 (1.7%) stddev-sans-first:2.40 11:17:16 INFO - PROCESS | 6501 | Values: 137.0 134.0 137.0 130.0 137.0 136.0 138.0 134.0 134.0 135.0 11:17:16 INFO - PROCESS | 6501 | 11:17:16 INFO - PROCESS | 6501 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:67.00 stddev:1.58 (2.4%) stddev-sans-first:1.39 11:17:16 INFO - PROCESS | 6501 | Values: 64.0 68.0 67.0 66.0 68.0 65.0 65.0 67.0 66.0 69.0 11:17:16 INFO - PROCESS | 6501 | -------- Summary: end -------- 11:17:16 INFO - PROCESS | 6501 | 11:17:16 INFO - TEST-INFO | 6501: exit 0 11:17:17 INFO - TEST-OK | kraken | took 57450ms 11:17:17 INFO - SUITE-END | took 1166s 11:17:17 INFO - Completed test suite (00:19:27) 11:17:17 INFO - javascript benchmark 11:17:17 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3613.385724426849, 3616.927661446771, 3638.6543278388576, 3639.4358874374466, 3671.853125874965, 5075.705695047763, 5465.152901300305, 5805.912911306334, 5817.73820178092, 5817.825465236045, 5755.0504166812425, 5787.536997040237, 5834.5040671542865, 5834.766609335621, 5852.912206316898, 5213.973930130344, 5264.631475796696, 5301.41684414716, 5302.840914772543, 5308.70802105884, 4358.673099517533, 4674.158651442739, 5034.144195486776, 5187.844364669066, 5286.841394758163, 3977.6618987385964, 4280.400743895857, 5264.394594621629, 5267.736613169345, 5336.653117547347, 5296.205569164617, 5301.973490132544, 5329.014132385521, 5343.599230057761, 5346.572274218053, 4984.601231901439, 5051.444341122474, 5285.550728188108, 5291.497307755757, 5309.256704061435, 4058.594140585947, 5524.502794748451, 5737.483626473596, 5789.218455508537, 5822.417758224186, 6215.689215539205, 6227.906581401283, 6235.314115447297, 6239.65681887496, 6241.0, 6229.221347331583, 6247.187865577492, 6251.249850018027, 6270.247570291549, 6272.1219029335925, 5739.426057394269, 5901.0, 5942.286925568917, 5953.791617293374, 6026.969865150646, 6248.909059172649, 6290.21372328459, 6324.494040476751, 6328.462080723098, 6339.904901426482, 6224.221972253468, 6265.8746825063245, 6266.060090986389, 6271.184745983084, 6277.7175027123885, 6118.131909153847, 6211.627302361782, 6240.93904036315, 6285.968570157212, 6289.528285378615, 6200.81397558074, 6217.875642487125, 6234.719437625227, 6237.656928868865, 6239.0, 6143.170671959318, 6176.197094377702, 6215.098810672427, 6244.75020999164, 6253.6560489173535, 4361.193179261847, 4643.86068417948, 4907.3620429343955, 4919.016196760591, 4986.326845875833, 4490.371348011281, 4503.392042074278, 4526.072155208174, 4537.863864084083, 4548.113117942035, 5841.328247251536, 5946.67293298864, 5962.135490353961, 5978.103284507271, 6036.094585812163, 6198.876022479525, 6256.593321434092, 6261.342559031327, 6263.552877457057, 6264.310925798159, 5981.162637230791, 5995.760169593167, 6012.098185272244, 6023.969880150571, 6053.152558641794, 4217.936730949038, 5344.9732751336, 5417.5395091416885, 5455.945440545624, 5466.726663666801, 6256.374362563707, 6338.492920566344, 6383.042543618494, 6407.359264073649, 6431.099646049651, 6229.0, 6279.183706118358, 6279.591826531261, 6296.275928268308, 6301.495880329471, 5222.582193424441, 5480.6437581557075, 6298.968505157628, 6378.936210637834, 6412.967935160481, 6161.661108639068, 6223.906641400292, 6228.252609686685, 6230.657313847601, 6235.501159907287, 5504.4770746778995, 6076.72654730547, 6232.875342493216, 6238.532110091852, 6249.875002500015, 6058.666773327509, 6144.924638188209, 6181.406957570089, 6184.690765461619, 6256.155419018374, 5353.955978584138, 6055.939440605537, 6132.693365331805, 6149.72326245329, 6165.753369865155, 5911.467967882912, 6000.51995840323, 6034.879302414015, 6040.0, 6043.667598282137, 4885.4870238624435, 6083.117947897442, 6168.629882207082, 6188.783392581238, 6233.96883015582, 6011.918119031486, 6060.636361818305, 6091.543134265036, 6106.236720409949, 6118.785842495491], "unit": "score", "name": "dojo.html", "value": 5695.497556884522}, {"lowerIsBetter": false, "replicates": [500.0524007006725, 520.3937412913958, 521.6504941689069, 616.002417224675, 665.5973136252567, 38674.22651546971, 40188.39717404237, 40205.0, 40292.59707402929, 40319.798401008025, 41370.0, 41837.16325673485, 41841.790791046005, 41989.160216795644, 41998.0, 9511.6195352186, 9652.613895444174, 9683.467409292487, 9695.0, 9725.854112188288, 8000.9199908000755, 9191.264698824078, 9507.524623768819, 9798.608055677765, 9832.508374581279, 9664.855027174597, 9748.073932976391, 9751.609935602568, 9804.509774511282, 9838.754031149243, 9703.514824258795, 9735.221182305399, 9850.0, 9853.605855765762, 9863.0, 9731.12419882214, 9871.753206169831, 9877.209823214125, 9904.90095099047, 9928.106470417697, 40048.79975600103, 40518.79740601307, 40919.795401022806, 40959.7952010241, 40987.0, 3176.9205769855707, 3312.668733126692, 3339.7662163648556, 3357.3621012007884, 3754.624537546251, 24322.0, 29784.255393615116, 30347.241318966982, 30460.390792184255, 30720.078397648107, 2738.424930764522, 2753.9586906196423, 2769.5430254008065, 2802.579613058037, 2957.142428695676, 462898.0, 466322.0, 471036.99999999657, 472194.0, 472931.0, 47747.761261194166, 48582.27126593104, 75935.24064759392, 76147.23852761512, 76229.0, 47268.5273147271, 47541.76229118832, 47557.0, 47612.28581571279, 47787.28319075217, 17459.0, 17643.55891102733, 17821.7326740099, 17826.46520604384, 17829.643407131785, 13775.448982040807, 13944.302784860716, 14093.224872632103, 14268.357923893449, 14360.066595671247, 15348.693026139637, 15530.456434024754, 15723.371065157495, 15842.920785396, 15934.9203253983, 6596.307387724316, 6659.134312539436, 6684.2981486944145, 6721.092652491851, 6722.865542689216, 955.7371722776293, 1041.286718597763, 1044.8589440425596, 1076.6608518316705, 1181.5230961298378, 30604.84697576498, 30640.0, 31205.063848084596, 31304.21739456486, 32728.0, 1025.9989530622897, 1027.9331843430152, 1098.9450527473593, 1107.7205827269518, 1125.3754166437707, 13229.536966206137, 16942.576435588962, 16966.660666786596, 17073.0, 17116.229769660396, 434934.0, 518452.0, 521109.0, 523320.0, 532877.0, 50331.0, 60881.69559152176, 61366.69316653388, 61887.69056154691, 62078.0, 1404.6067101211677, 1550.1861522700447, 1573.0, 1574.5119013105973, 1687.864970802333, 30560.84719576388, 32658.51012234866, 32722.50916236306, 32746.50880236846, 33252.33495330031, 55739.0, 55861.72069139628, 56124.0, 56438.71780641235, 56439.43560564506, 478379.0, 478936.0, 479331.0, 481401.0, 484674.0, 33162.83418582891, 33717.157071073416, 34148.487772683926, 35003.124921877155, 35390.11524711903, 46105.847353816425, 46717.065658685955, 47410.81472963204, 48141.0, 48338.791530212024, 38496.2300753989, 38680.0, 38782.80608596939, 38893.0, 39194.80402597969, 37934.810325948194, 38326.04184895288, 38496.84509464721, 38671.22657546777, 38688.6131138685, 38218.42672359861, 38377.80811095927, 38967.415488767125, 39526.0, 39676.008099797735, 33637.495437567966, 34697.479537806445, 34795.65204347924, 34832.30335393328, 35012.0, 22367.731011852324, 25893.482130357665, 25995.870020649774, 26295.0, 26676.466470670865], "unit": "score", "name": "ext.html", "value": 19986.93962424557}, {"lowerIsBetter": false, "replicates": [333.00099700897294, 361.57334345472367, 374.49256257770713, 376.8002958432031, 380.4692454026633, 20370.89814550927, 20836.479088022807, 21277.255296064643, 21884.781152188472, 22028.77971220287, 21559.1376344946, 21657.0, 21860.23489177879, 22162.22432214873, 22258.220962266325, 5965.821025369235, 5984.473959140413, 6208.689565521729, 6225.782097626584, 6251.281102673182, 6031.668258245794, 6118.3269840317525, 6136.631802091866, 6141.447269745722, 6148.077788331741, 5770.682612456313, 6056.091586262074, 6064.696765161746, 6088.391160883898, 6105.786297479589, 5111.821086261982, 5970.492508136814, 6002.699865006733, 6110.114033465123, 6128.233970753656, 4490.326451032372, 5196.168613021936, 5197.116490196638, 5276.287701160332, 5331.866703332409, 25508.74491255082, 25823.48353032929, 25992.610110848353, 26129.08548200804, 26445.471090578274, 2172.283146561631, 2185.617516934546, 2252.177955046396, 2305.827062970284, 2389.80881529479, 15112.28743992594, 15467.922660386626, 15499.380024798995, 15537.922310388489, 15775.684486310325, 1784.97322540162, 1838.8712790104564, 1845.64932662795, 1859.3399343233227, 1897.5161333859915, 103820.0, 105440.47279763629, 105465.47267263691, 108226.0, 108386.45806770994, 11200.103991680646, 11327.546898124148, 11422.086233101332, 11432.771344573062, 11551.942240288745, 13547.525836595672, 13548.661283467794, 13567.728645427036, 13862.0, 13887.513937012156, 9130.360874738704, 9159.633614655473, 9166.037566055602, 9183.678571249975, 9252.352335336596, 9480.90519094814, 9567.282453815991, 9581.041895810364, 9627.759306017406, 9668.661596844076, 4894.26586012094, 5349.518543331119, 6309.706510165405, 6368.77709280173, 6385.393387628168, 1548.2877876177085, 1726.0, 1769.78762548495, 1860.2558976409543, 1867.4677716850633, 917.5458148216676, 920.052346083535, 1006.582268358623, 1062.9149668026694, 1073.3238060022136, 21353.932303385078, 21905.890470547864, 22089.558208835733, 22208.88895555544, 22278.77721222767, 1054.0513537816028, 1060.1042119409087, 1067.4716015572342, 1089.6622047165404, 1100.312304809494, 11725.003374713246, 11840.28958262507, 12045.578404755792, 12156.331401772988, 12161.0, 585082.0745896328, 621567.0, 628433.0, 674967.0, 680060.0, 102250.0, 105673.47163264135, 105892.94107058985, 105970.0, 106522.46738766256, 1072.485207100596, 1081.8972197641212, 1087.6465148826505, 1091.7543552700579, 1094.4254266510145, 18982.525436864187, 19502.21991120396, 19543.21827126899, 19598.902005489883, 19737.605247895248, 46367.304490433344, 47133.82165445754, 48150.277745834544, 49350.50649493459, 49791.75104124456, 65945.67027164834, 69255.0, 70002.0, 70201.64899175472, 78651.60674196592, 8204.261616454547, 8295.336373090018, 8309.542975136426, 8422.578871056545, 8445.1977062179, 12966.351682415652, 13536.984726145776, 13670.453181872614, 13696.31518424055, 13975.951803614566, 11639.47622357013, 11682.649520514398, 11788.23376480526, 11866.525338986688, 11979.940100299442, 9437.0, 11732.061435085343, 11760.117991150526, 11806.631546327913, 11971.820422693841, 12058.75882482363, 12153.939230303791, 12208.694782630506, 12265.509379625071, 12268.509259629514, 8399.370047246603, 8435.620397082022, 8472.957635211784, 8483.36374771907, 8600.0, 11312.20814542974, 11856.525738970344, 11889.940550297193, 11943.0, 11954.462049207981], "unit": "score", "name": "jquery.html", "value": 9912.804045497991}, {"lowerIsBetter": false, "replicates": [1555.3078879898446, 1663.0437498438394, 1986.3345779163978, 2071.8135367816903, 2108.683697445382, 8286.75139745807, 8895.0, 8905.154010369013, 9095.590698418562, 9106.225970792482, 7318.780436586898, 8819.0, 8825.029246782864, 8856.645734170625, 9006.639734410615, 2546.9235922922344, 2562.06484633109, 2577.6262441945905, 2589.1455819579587, 2591.883365248568, 2530.4180038591135, 2573.98327660574, 2576.7423257674177, 2577.2525967469505, 2580.87095645217, 2525.368657835541, 2541.466292078666, 2555.718870924197, 2591.857447840368, 2607.1266125847865, 2563.4488584954233, 2573.137998770405, 2589.313831834556, 2591.740825917412, 2598.8310759800743, 2169.990954206286, 2538.7588179122954, 2550.961735573968, 2574.382148284417, 2574.4336246025846, 7606.771796846048, 9042.86435703465, 9078.182963533247, 9108.22580080694, 9140.497272650002, 4505.414296141514, 5609.102543593006, 5610.831675049755, 5708.943845388616, 5763.991301522216, 3125.7186853183093, 3641.217138315275, 3731.6268373162466, 3733.3653278942375, 3810.961890381116, 1067.4716015572264, 1098.3794156301744, 1098.8296813993843, 1100.873399559053, 1100.9229353945227, 11969.94015029928, 12284.201526900812, 12347.567835125728, 12381.814272785916, 12462.252264864137, 4599.839005634787, 4779.928301075487, 5023.422306434733, 5109.20807274873, 5156.458571849977, 10427.165826733843, 10484.737881553023, 10486.842697359545, 10512.737181570368, 10520.684379468628, 5537.1140617501815, 5579.191017302468, 5595.832125036255, 5648.435156484401, 5715.971420142872, 4683.601893838993, 5014.5737612303365, 5051.318072060299, 5130.538251557377, 5167.509086636764, 4009.298372784751, 4072.4095006223934, 4082.408050832613, 4097.057676734308, 4121.010957370209, 1370.5751217122724, 1373.2447154065223, 1377.7106807570322, 1380.4892189889806, 1381.550995926328, 1206.776746301937, 1395.1629022586367, 1437.2454461407845, 1439.5393474088191, 1458.6936743283818, 7613.6573854176695, 8302.252797248277, 8390.160983901562, 8431.241188293083, 8457.069722330538, 506.17493485618206, 530.8699368654704, 537.0655060195232, 540.00638824563, 541.8672425255837, 4918.606511479073, 5220.634555581149, 6214.25428948529, 6237.220347456568, 6329.145565348711, 10375.481225938824, 10671.733206669895, 10989.670309890716, 10998.230123891251, 11114.110871130451, 10576.841347379795, 10605.151587872951, 10650.041496265374, 10873.0, 10899.509522071367, 8480.406371554056, 8587.355948303903, 8676.826463470821, 8678.17557332065, 8681.869771953427, 7811.96094019549, 7915.366770658448, 8067.556284404414, 8077.192280771876, 8178.1821817817745, 9667.758306042124, 9667.951660241935, 9868.555914983699, 9904.356216845881, 9989.60041598328, 9761.658341957997, 10099.04059114383, 10142.797144057226, 10246.077852993267, 10254.128399085863, 6758.290379510081, 6973.65131743421, 7555.206703296075, 7647.388208943383, 7754.185810490043, 8015.719449819461, 8099.0, 8135.186481351818, 8163.102058773411, 8166.305864001389, 7336.266373362621, 7388.187299397169, 7494.850102998019, 7566.583837888969, 7622.5426474411715, 7297.525660832029, 7323.340899319087, 7397.445191610543, 7397.926020739939, 7457.701691932262, 7807.219278072147, 7810.765677029698, 7849.058113026474, 7854.60726963661, 7874.37005039584, 6479.611223326616, 6536.0522724205675, 6586.901196481961, 6786.117804685359, 7084.114485689289, 7210.603416812126, 7246.456515761233, 7250.238724933806, 7310.853782924205, 7344.081989751281], "unit": "score", "name": "mootools.html", "value": 4952.220111121886}, {"lowerIsBetter": false, "replicates": [341.5883859948762, 341.94699821527655, 345.1216653616547, 346.44395744829535, 350.9368313703534, 6910.4126149277245, 6992.265812089728, 6992.650367481619, 6995.720171193153, 7018.964905175473, 6864.053169427574, 6954.0959675242275, 6957.165140183185, 6979.441644668427, 7001.439884809216, 4845.854624361257, 4940.308356830046, 5077.64456488046, 5095.082885080684, 5113.667611605252, 5100.974495127519, 5183.844484665466, 5188.16989281715, 5213.635045546814, 5255.816046438356, 5064.290999260106, 5067.923981140286, 5086.720230387327, 5087.745612719368, 5088.1095808233595, 4103.8974025649295, 5068.771905264272, 5079.949200507985, 5082.08522465956, 5103.668261562986, 4337.240982828024, 4341.110072435144, 4362.105768317519, 4362.825486980517, 4371.584699453547, 5833.095870140135, 6336.398042185985, 6483.7730679425995, 6741.561798483083, 6791.626460544668, 5948.375420580864, 5997.640141591519, 6014.6391216527145, 6015.0676645120075, 6016.037434010537, 7521.135069466972, 7525.962370188169, 7532.510386824839, 7545.849083018309, 7560.092788865316, 4091.734037287567, 4677.321788340706, 4808.0383923215495, 4820.493848145929, 4835.202191638376, 7135.89296160558, 7842.7647170584405, 7900.446968712193, 7942.841143177162, 7946.443748937577, 4025.7584544926813, 4722.8429034885985, 4829.613630909519, 4832.0, 4841.95158048415, 4941.234108713155, 4963.60291176705, 4984.925226121611, 4995.100881841231, 5004.873903371785, 4884.291777692215, 5102.566281866083, 5932.970335148383, 5945.286565612154, 5963.373845746221, 6362.313986793503, 7477.962610186914, 7489.737859174903, 7493.962530187314, 7507.436942229355, 1677.2536221381613, 1705.4457301376854, 1735.5314065202324, 1736.426979096895, 1740.7562941188244, 1073.5705717712822, 1088.298047759191, 1097.5116073347283, 1099.8735145458215, 1102.7463683352873, 5972.610955617701, 7095.184053833772, 7110.217876033736, 7220.819479512949, 7246.311600397954, 6930.93069069313, 7235.312645298688, 7741.0, 7777.72777952769, 7821.178776228414, 7177.959195916563, 7204.747833825791, 7214.49498535108, 7217.855642887218, 7223.855522889513, 4013.3779264214095, 4111.177764447122, 4139.730917490354, 4145.191687620885, 4148.522919864255, 8177.223163799429, 8182.549959752271, 8191.976002999625, 8195.139510351328, 8205.466644668197, 6534.157641425995, 8011.078725946474, 8035.67857285702, 8057.758267251992, 8099.271065604124, 8123.593820308961, 8150.551719655476, 8150.877736833952, 8161.183881611792, 8182.304504117216, 7530.9246907532415, 7770.961145194238, 7843.647035883513, 7872.645730942236, 7893.210678932061, 7600.1639819618695, 7615.504992175491, 7666.731664391943, 7673.232676732282, 7684.193159718373, 8123.065847427385, 8140.308073813792, 8176.305014073632, 8180.427370084037, 8188.959055204924, 4901.58336541398, 4933.383327084114, 4942.75286235694, 4949.232868905326, 4951.935333903228, 7137.678804453708, 7744.9157118002395, 7767.262110099531, 7792.2986931176465, 7817.413693973089, 6286.52851036165, 7524.473286869867, 7546.66040028189, 7583.658735356812, 7606.163322034682, 5721.313442386941, 6852.588844669336, 7447.5531468112085, 7521.586312752851, 7605.125410577633, 7147.677679629285, 7386.298301661333, 7414.0, 7420.295071968154, 7438.070241219848, 6107.9083813741945, 7525.6989720410575, 7527.924720752722, 7568.583727894798, 7616.162222155448, 7388.556686598821, 7403.888941665987, 7407.925920740724, 7408.555486670817, 7411.814704632212], "unit": "score", "name": "prototype.html", "value": 5416.526126344223}, {"lowerIsBetter": false, "replicates": [693.6162356099582, 770.2913319745833, 786.3473317146766, 787.354369417078, 795.7374066558036, 15078.547643570682, 15157.545273641794, 15184.848151518481, 15455.845441545582, 15463.381464741426, 14206.431742730305, 14229.71540569188, 14235.572932812007, 14279.857201427983, 14560.92719536401, 796.0606484348466, 948.1656142594508, 961.3366776923936, 984.5864736810521, 990.1385794358918, 951.8905325887542, 969.7333233360812, 975.2636759246759, 984.271638987148, 987.6197663899414, 993.2401712689798, 1026.14829691356, 1031.4997226345217, 1034.4879284754056, 1045.7856139491423, 1015.2132097624363, 1024.5082360466943, 1035.8860525342207, 1035.9792804143913, 1036.3885307668436, 733.4865594084109, 733.7395224695263, 741.6328917185973, 747.8093086262968, 760.8592410404093, 14371.928140359336, 14395.568132955923, 14642.487512936996, 14704.0, 14836.109833409922, 10619.0, 13062.934685326607, 13078.215307081606, 13237.271950042743, 13242.602721918262, 9128.680496182667, 9199.70974443592, 9303.883533975966, 9483.383580067273, 10302.33034852732, 3766.6251818086475, 4091.3862920561855, 4153.982274342806, 4167.604077612622, 4261.595148460891, 80282.59858700728, 80477.19522804755, 82455.3508929824, 86757.56621216853, 87468.56265718631, 8871.778205544913, 9496.857547136799, 9642.807143857084, 9653.22774178064, 9847.359921605215, 21927.67108493374, 22028.11887524481, 22048.88975555112, 22073.668894966588, 22111.889440552695, 7699.26856948589, 7818.569978651229, 7828.686852525835, 7830.765077047698, 7935.08746494149, 3953.644172024474, 4077.9805048737817, 4132.855350062733, 4141.7100802943505, 4157.189348077096, 3527.5766907971206, 3547.379208638478, 3559.839807208682, 3597.010822023912, 3630.3465376232, 688.5971706551724, 690.5787469643514, 691.5885048396296, 692.5879101934341, 693.3932808792307, 542.4548328929401, 585.7815743254022, 597.745957967862, 610.786224821309, 622.8100429368995, 8384.455010424303, 8452.915470845213, 8551.401401901932, 8592.140785921358, 8660.26387757035, 582.8484594005589, 605.2918085839578, 614.1862032806549, 615.5229696984873, 635.478907296022, 3329.883454079096, 3608.6030536640947, 3963.801809909493, 3987.381955796798, 4039.8284497495983, 91146.0, 92650.0, 94016.0, 94016.0, 94979.52510237542, 81407.0, 81930.0, 82405.17594823975, 83579.5821020891, 83852.0, 51956.74021629868, 69218.65390673115, 71989.56020879449, 72255.0, 72940.27059729441, 7765.53406795594, 7929.246721561442, 8025.638846252049, 8201.95899020501, 8262.297704695167, 41917.79041104897, 51251.0, 51657.74171129271, 51901.82087105868, 52591.73704131455, 66252.668736656, 70867.29132708607, 71934.64032679803, 72526.63736681282, 73486.63256683682, 11231.38227397501, 11394.48724807369, 11424.543018279175, 11585.82621260665, 11623.76752464963, 10343.689689309333, 12111.091668125102, 12324.876751232372, 12349.444275007467, 12513.124081314221, 11591.884081159418, 11644.941775291069, 11875.584354547549, 11978.401079946143, 12057.939710301393, 11546.307221566733, 11578.94210528942, 11614.187006909435, 11676.357800320724, 11757.76484470323, 11094.167937404889, 11521.790212027952, 11578.189526733047, 11673.0, 12153.574624888086, 10029.949850250701, 10073.496325183858, 10193.082622564005, 10370.222233332379, 10384.792304154025, 9812.116909478182, 9861.950690246504, 9893.554790034323, 9929.3545919515, 10074.597016119566], "unit": "score", "name": "yui.html", "value": 7107.166348781925}], "name": "dromaeo_css", "value": 7740.832127935895}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 112.0, 115.0, 117.0, 115.0, 130.0, 119.0, 161.0, 170.0, 115.0], "unit": "score", "name": "ai-astar", "value": 126.9}, {"lowerIsBetter": true, "replicates": [151.0, 124.0, 145.0, 153.0, 115.0, 141.0, 122.0, 152.0, 153.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 137.6}, {"lowerIsBetter": true, "replicates": [191.0, 197.0, 203.0, 233.0, 200.0, 199.0, 200.0, 199.0, 201.0, 197.0], "unit": "score", "name": "audio-dft", "value": 202.0}, {"lowerIsBetter": true, "replicates": [68.0, 81.0, 68.0, 115.0, 59.0, 57.0, 58.0, 60.0, 129.0, 57.0], "unit": "score", "name": "audio-fft", "value": 75.2}, {"lowerIsBetter": true, "replicates": [88.0, 81.0, 129.0, 79.0, 81.0, 86.0, 122.0, 79.0, 78.0, 124.0], "unit": "score", "name": "audio-oscillator", "value": 94.7}, {"lowerIsBetter": true, "replicates": [92.0, 129.0, 89.0, 88.0, 135.0, 130.0, 91.0, 87.0, 89.0, 101.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 103.1}, {"lowerIsBetter": true, "replicates": [98.0, 103.0, 102.0, 104.0, 130.0, 151.0, 95.0, 96.0, 94.0, 102.0], "unit": "score", "name": "imaging-darkroom", "value": 107.5}, {"lowerIsBetter": true, "replicates": [91.0, 122.0, 148.0, 153.0, 92.0, 91.0, 92.0, 91.0, 122.0, 87.0], "unit": "score", "name": "imaging-desaturate", "value": 108.9}, {"lowerIsBetter": true, "replicates": [54.0, 61.0, 58.0, 59.0, 60.0, 58.0, 59.0, 59.0, 61.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [64.0, 68.0, 69.0, 69.0, 71.0, 74.0, 73.0, 67.0, 66.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [84.0, 81.0, 82.0, 83.0, 84.0, 82.0, 82.0, 83.0, 83.0, 85.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [133.0, 128.0, 122.0, 140.0, 138.0, 132.0, 135.0, 116.0, 120.0, 130.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 129.4}, {"lowerIsBetter": true, "replicates": [137.0, 134.0, 137.0, 130.0, 137.0, 136.0, 138.0, 134.0, 134.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.2}, {"lowerIsBetter": true, "replicates": [64.0, 68.0, 67.0, 66.0, 68.0, 65.0, 65.0, 67.0, 66.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.5}], "name": "kraken", "value": 1497.5000000000002}]} 11:17:17 INFO - Return code: 0 11:17:17 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:17:17 ERROR - # TBPL SUCCESS # 11:17:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 11:17:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 11:17:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 11:17:17 INFO - 2016-05-17 11:17:17.588 screenresolution[6506:120069] starting screenresolution argv=screenresolution get 11:17:17 INFO - 2016-05-17 11:17:17.590 screenresolution[6506:120069] Display 0: 1600x1200x32@60 11:17:17 INFO - 2016-05-17 11:17:17.596 screenresolution[6507:120072] starting screenresolution argv=screenresolution list 11:17:17 INFO - Available Modes on Display 0 11:17:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 11:17:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 11:17:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 11:17:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 11:17:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 11:17:17 INFO - Intel Iris: 11:17:17 INFO - Chipset Model: Intel Iris 11:17:17 INFO - Type: GPU 11:17:17 INFO - Bus: Built-In 11:17:17 INFO - VRAM (Dynamic, Max): 1536 MB 11:17:17 INFO - Vendor: Intel (0x8086) 11:17:17 INFO - Device ID: 0x0a2e 11:17:17 INFO - Revision ID: 0x0009 11:17:17 INFO - Displays: 11:17:17 INFO - Display: 11:17:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 11:17:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 11:17:17 INFO - Display Serial Number: 1600x1200 60 11:17:17 INFO - Main Display: Yes 11:17:17 INFO - Mirror: Off 11:17:17 INFO - Online: Yes 11:17:17 INFO - Rotation: Supported 11:17:17 INFO - Return code: 0 11:17:17 INFO - Running post-action listener: _resource_record_post_action 11:17:17 INFO - Running post-run listener: _resource_record_post_run 11:17:18 INFO - Total resource usage - Wall time: 1191s; CPU: 54.0%; Read bytes: 184832; Write bytes: 511200256; Read time: 3; Write time: 1816 11:17:18 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 198334976; Write bytes: 199022592; Read time: 18026; Write time: 469 11:17:18 INFO - run-tests - Wall time: 1169s; CPU: 54.0%; Read bytes: 184320; Write bytes: 301384704; Read time: 3; Write time: 1312 11:17:18 INFO - Running post-run listener: _upload_blobber_files 11:17:18 INFO - Blob upload gear active. 11:17:18 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 11:17:18 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 11:17:18 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'] 11:17:18 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 11:17:19 INFO - (blobuploader) - INFO - Open directory for files ... 11:17:19 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 11:17:19 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:19 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:20 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 11:17:20 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:20 INFO - (blobuploader) - INFO - Done attempting. 11:17:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 11:17:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 11:17:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 11:17:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 11:17:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 11:17:21 INFO - (blobuploader) - INFO - Done attempting. 11:17:21 INFO - (blobuploader) - INFO - Iteration through files over. 11:17:21 INFO - Return code: 0 11:17:21 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 11:17:21 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 11:17:21 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a5634bd59e9835ea253de4ba7e694a2c6140c9a4036ee4dae2e9da8a66b1d99d23479f0d0c4723e6806e3cc5e4594a582ffd712db59301d0540ad57c8b71c0e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/876584d284df3b6c8d91eeaf0aaaca438334652b8d30b7fbccecf098b08a3a46ccf3b8510890ad6b7bea085c63c872bc41d756e4536ba2e0f63d7d9b75cbbb57"} 11:17:21 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 11:17:21 INFO - Writing to file /builds/slave/test/properties/blobber_files 11:17:21 INFO - Contents: 11:17:21 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a5634bd59e9835ea253de4ba7e694a2c6140c9a4036ee4dae2e9da8a66b1d99d23479f0d0c4723e6806e3cc5e4594a582ffd712db59301d0540ad57c8b71c0e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/876584d284df3b6c8d91eeaf0aaaca438334652b8d30b7fbccecf098b08a3a46ccf3b8510890ad6b7bea085c63c872bc41d756e4536ba2e0f63d7d9b75cbbb57"} 11:17:21 INFO - Running post-run listener: copy_logs_to_upload_dir 11:17:21 INFO - Copying logs to upload dir... 11:17:21 INFO - mkdir: /builds/slave/test/build/upload/logs 11:17:21 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1294.036499 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 34 secs) (at 2016-05-17 11:17:21.585661) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 11:17:21.588704) ========= 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.MNBDWm8e7d/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.86Jz5UaVOc/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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/a5634bd59e9835ea253de4ba7e694a2c6140c9a4036ee4dae2e9da8a66b1d99d23479f0d0c4723e6806e3cc5e4594a582ffd712db59301d0540ad57c8b71c0e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/876584d284df3b6c8d91eeaf0aaaca438334652b8d30b7fbccecf098b08a3a46ccf3b8510890ad6b7bea085c63c872bc41d756e4536ba2e0f63d7d9b75cbbb57"} build_url:https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011233 build_url: 'https://queue.taskcluster.net/v1/task/cbYWg_4sSn2jGzgi763Mbg/artifacts/public/build/firefox-47.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/a5634bd59e9835ea253de4ba7e694a2c6140c9a4036ee4dae2e9da8a66b1d99d23479f0d0c4723e6806e3cc5e4594a582ffd712db59301d0540ad57c8b71c0e0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/876584d284df3b6c8d91eeaf0aaaca438334652b8d30b7fbccecf098b08a3a46ccf3b8510890ad6b7bea085c63c872bc41d756e4536ba2e0f63d7d9b75cbbb57"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-05-17 11:17:21.619777) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:17:21.620079) ========= 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.MNBDWm8e7d/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.86Jz5UaVOc/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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.005486 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-05-17 11:17:21.668036) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 11:17:21.671367) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-05-17 11:17:21.671701) ========= ========= Total master_lag: 0.25 =========