builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0063 starttime: 1461329322.3 results: success (0) buildid: 20160419230832 builduid: 1ab072c2db0d4b259b7f46e10e93ac05 revision: d42b25947fc26a0f9eab98d631465b72769553bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:42.296905) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:42.297692) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:42.298023) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:42.318808) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:42.319522) ========= 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.LDv0UAdT18/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.9miB4wlnMv/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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-04-22 05:48:42-- 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% 173M=0s 2016-04-22 05:48:42 (173 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090177 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:42.432787) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:42.433557) ========= 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.LDv0UAdT18/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.9miB4wlnMv/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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.027332 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:42.485080) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:42.485480) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d42b25947fc26a0f9eab98d631465b72769553bd --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d42b25947fc26a0f9eab98d631465b72769553bd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LDv0UAdT18/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.9miB4wlnMv/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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-04-22 05:48:42,562 truncating revision to first 12 chars 2016-04-22 05:48:42,562 Setting DEBUG logging. 2016-04-22 05:48:42,562 attempt 1/10 2016-04-22 05:48:42,562 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d42b25947fc2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-22 05:48:43,142 unpacking tar archive at: fx-team-d42b25947fc2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.847848 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:43.351591) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:43.352042) ========= script_repo_revision: d42b25947fc26a0f9eab98d631465b72769553bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:43.352497) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:43.352830) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-22 05:48:43.367709) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-22 05:48:43.368084) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.LDv0UAdT18/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.9miB4wlnMv/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 05:48:43 INFO - MultiFileLogger online at 20160422 05:48:43 in /builds/slave/test 05:48:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 05:48:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:48:43 INFO - {'append_to_log': False, 05:48:43 INFO - 'base_work_dir': '/builds/slave/test', 05:48:43 INFO - 'blob_upload_branch': 'Fx-Team', 05:48:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:48:43 INFO - 'branch': 'Fx-Team', 05:48:43 INFO - 'buildbot_json_path': 'buildprops.json', 05:48:43 INFO - 'config_files': ('talos/mac_config.py',), 05:48:43 INFO - 'default_actions': ('clobber', 05:48:43 INFO - 'read-buildbot-config', 05:48:43 INFO - 'download-and-extract', 05:48:43 INFO - 'populate-webroot', 05:48:43 INFO - 'create-virtualenv', 05:48:43 INFO - 'install', 05:48:43 INFO - 'run-tests'), 05:48:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:48:43 INFO - 'download_minidump_stackwalk': True, 05:48:43 INFO - 'download_symbols': 'ondemand', 05:48:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:48:43 INFO - 'tooltool.py': '/tools/tooltool.py', 05:48:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:48:43 INFO - '/tools/misc-python/virtualenv.py')}, 05:48:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:48:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:48:43 INFO - 'installer_path': 'installer.exe', 05:48:43 INFO - 'log_level': 'info', 05:48:43 INFO - 'log_name': 'talos', 05:48:43 INFO - 'log_to_console': True, 05:48:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:48:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:48:43 INFO - 'opt_config_files': (), 05:48:43 INFO - 'pip_index': False, 05:48:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:48:43 INFO - 'cmd': ('bash', 05:48:43 INFO - '-c', 05:48:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:48:43 INFO - 'enabled': True, 05:48:43 INFO - 'halt_on_failure': False, 05:48:43 INFO - 'name': 'check_screen_resolution'},), 05:48:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:48:43 INFO - 'cmd': ('bash', 05:48:43 INFO - '-c', 05:48:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:48:43 INFO - 'enabled': True, 05:48:43 INFO - 'halt_on_failure': False, 05:48:43 INFO - 'name': 'check_screen_resolution'},), 05:48:43 INFO - 'run_cmd_checks_enabled': True, 05:48:43 INFO - 'sps_profile': False, 05:48:43 INFO - 'sps_profile_interval': 0, 05:48:43 INFO - 'suite': 'dromaeojs-e10s', 05:48:43 INFO - 'system_bits': '32', 05:48:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:48:43 INFO - 'title': 't-yosemite-r7-0063', 05:48:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:48:43 INFO - 'use_talos_json': True, 05:48:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:48:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:48:43 INFO - 'work_dir': 'build'} 05:48:43 INFO - ##### 05:48:43 INFO - ##### Running clobber step. 05:48:43 INFO - ##### 05:48:43 INFO - Running pre-action listener: _resource_record_pre_action 05:48:43 INFO - Running main action method: clobber 05:48:43 INFO - rmtree: /builds/slave/test/build 05:48:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:48:45 INFO - Running post-action listener: _resource_record_post_action 05:48:45 INFO - ##### 05:48:45 INFO - ##### Running read-buildbot-config step. 05:48:45 INFO - ##### 05:48:45 INFO - Running pre-action listener: _resource_record_pre_action 05:48:45 INFO - Running main action method: read_buildbot_config 05:48:45 INFO - Using buildbot properties: 05:48:45 INFO - { 05:48:45 INFO - "project": "", 05:48:45 INFO - "product": "firefox", 05:48:45 INFO - "script_repo_revision": "production", 05:48:45 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 05:48:45 INFO - "repository": "", 05:48:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 05:48:45 INFO - "buildid": "20160419230832", 05:48:45 INFO - "pgo_build": "False", 05:48:45 INFO - "basedir": "/builds/slave/test", 05:48:45 INFO - "buildnumber": 623, 05:48:45 INFO - "slavename": "t-yosemite-r7-0063", 05:48:45 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:48:45 INFO - "platform": "yosemite_r7", 05:48:45 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 05:48:45 INFO - "branch": "fx-team", 05:48:45 INFO - "repo_path": "integration/fx-team", 05:48:45 INFO - "revision": "d42b25947fc26a0f9eab98d631465b72769553bd", 05:48:45 INFO - "stage_platform": "macosx64", 05:48:45 INFO - "builduid": "1ab072c2db0d4b259b7f46e10e93ac05", 05:48:45 INFO - "slavebuilddir": "test" 05:48:45 INFO - } 05:48:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:48:45 INFO - Running post-action listener: _resource_record_post_action 05:48:45 INFO - ##### 05:48:45 INFO - ##### Running download-and-extract step. 05:48:45 INFO - ##### 05:48:45 INFO - Running pre-action listener: _resource_record_pre_action 05:48:45 INFO - Running main action method: download_and_extract 05:48:45 INFO - mkdir: /builds/slave/test/build/tests 05:48:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:48:45 INFO - https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:48:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:48:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:48:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:48:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:48:47 INFO - Downloaded 1199 bytes. 05:48:47 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:48:47 INFO - Using the following test package requirements: 05:48:47 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:48:47 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:48:47 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:48:47 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:48:47 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:48:47 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:48:47 INFO - u'jsshell-mac.zip'], 05:48:47 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:48:47 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:48:47 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:48:47 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:48:47 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:48:47 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:48:47 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:48:47 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:48:47 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:48:47 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:48:47 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:48:47 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:48: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')]} 05:48:47 INFO - https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:48:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:48:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:48:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:48:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:48:48 INFO - Downloaded 18095480 bytes. 05:48:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:48:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:48:51 INFO - Return code: 0 05:48:51 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:48:51 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')]} 05:48:51 INFO - https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:48:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:48:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:48:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:48:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:48:52 INFO - Downloaded 18095480 bytes. 05:48:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:48:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:48:56 INFO - Return code: 0 05:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:48:56 INFO - https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:48:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:48:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:48:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:48:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:48:57 INFO - Downloaded 10845952 bytes. 05:48:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:48:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:48:57 INFO - Return code: 0 05:48:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:48:57 INFO - https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:48:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:48:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:48:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:48:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:49:01 INFO - Downloaded 110044454 bytes. 05:49:01 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:49:01 INFO - mkdir: /builds/slave/test/properties 05:49:01 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:49:01 INFO - Writing to file /builds/slave/test/properties/build_url 05:49:01 INFO - Contents: 05:49:01 INFO - build_url:https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:49:02 INFO - Running post-action listener: _resource_record_post_action 05:49:02 INFO - Running post-action listener: set_extra_try_arguments 05:49:02 INFO - ##### 05:49:02 INFO - ##### Running populate-webroot step. 05:49:02 INFO - ##### 05:49:02 INFO - Running pre-action listener: _resource_record_pre_action 05:49:02 INFO - Running main action method: populate_webroot 05:49:02 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:49:02 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:49:02 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:49:02 INFO - '--tppagecycles', 05:49:02 INFO - '7'], 05:49:02 INFO - 'tests': ['tsvgm']}}, 05:49:02 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:49:02 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:49:02 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:49:02 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:49:02 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:49:02 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:49:02 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:02 INFO - 'talos_options': ['--disable-e10s'], 05:49:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:02 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:02 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:49:02 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:02 INFO - 'talos_options': ['--disable-e10s'], 05:49:02 INFO - 'tests': ['damp', 'tps']}, 05:49:02 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:02 INFO - 'tests': ['damp', 'tps']}, 05:49:02 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:49:02 INFO - 'tests': ['dromaeo_dom']}, 05:49:02 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:49:02 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:49:02 INFO - 'tests': ['a11yr', 05:49:02 INFO - 'ts_paint', 05:49:02 INFO - 'tpaint', 05:49:02 INFO - 'sessionrestore', 05:49:02 INFO - 'sessionrestore_no_auto_restore', 05:49:02 INFO - 'tabpaint']}, 05:49:02 INFO - 'other-e10s': {'tests': ['a11yr', 05:49:02 INFO - 'ts_paint', 05:49:02 INFO - 'tpaint', 05:49:02 INFO - 'sessionrestore', 05:49:02 INFO - 'sessionrestore_no_auto_restore', 05:49:02 INFO - 'tabpaint']}, 05:49:02 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:49:02 INFO - 'ts_paint', 05:49:02 INFO - 'tpaint', 05:49:02 INFO - 'sessionrestore', 05:49:02 INFO - 'sessionrestore_no_auto_restore', 05:49:02 INFO - 'tabpaint']}, 05:49:02 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:49:02 INFO - 'ts_paint', 05:49:02 INFO - 'tpaint', 05:49:02 INFO - 'sessionrestore', 05:49:02 INFO - 'sessionrestore_no_auto_restore', 05:49:02 INFO - 'tabpaint']}, 05:49:02 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:49:02 INFO - 'tests': ['a11yr', 05:49:02 INFO - 'ts_paint', 05:49:02 INFO - 'tpaint', 05:49:02 INFO - 'sessionrestore', 05:49:02 INFO - 'sessionrestore_no_auto_restore', 05:49:02 INFO - 'tabpaint']}, 05:49:02 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:49:02 INFO - 'tests': ['a11yr', 05:49:02 INFO - 'ts_paint', 05:49:02 INFO - 'tpaint', 05:49:02 INFO - 'sessionrestore', 05:49:02 INFO - 'sessionrestore_no_auto_restore', 05:49:02 INFO - 'tabpaint']}, 05:49:02 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:49:02 INFO - 'tests': ['tsvgx', 05:49:02 INFO - 'tsvgr_opacity', 05:49:02 INFO - 'tart', 05:49:02 INFO - 'tscrollx', 05:49:02 INFO - 'cart']}, 05:49:02 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:49:02 INFO - 'tsvgr_opacity', 05:49:02 INFO - 'tart', 05:49:02 INFO - 'tscrollx', 05:49:02 INFO - 'cart']}, 05:49:02 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:02 INFO - 'talos_options': ['--disable-e10s'], 05:49:02 INFO - 'tests': ['tp5o']}, 05:49:02 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:02 INFO - 'tests': ['tp5o']}, 05:49:02 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:02 INFO - 'talos_options': ['--disable-e10s', 05:49:02 INFO - '--xperf_path', 05:49:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:02 INFO - 'tests': ['tp5n']}, 05:49:02 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:49:02 INFO - 'talos_options': ['--xperf_path', 05:49:02 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:49:02 INFO - 'tests': ['tp5n']}}, 05:49:02 INFO - 'talos.zip': {'path': '', 05:49:02 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:49:02 INFO - Running post-action listener: _resource_record_post_action 05:49:02 INFO - ##### 05:49:02 INFO - ##### Running create-virtualenv step. 05:49:02 INFO - ##### 05:49:02 INFO - Running pre-action listener: _resource_record_pre_action 05:49:02 INFO - Running main action method: create_virtualenv 05:49:02 INFO - Creating virtualenv /builds/slave/test/build/venv 05:49:02 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 05:49:02 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:49:02 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:49:02 INFO - Using real prefix '/tools/python27' 05:49:02 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:49:03 INFO - Installing distribute.............................................................................................................................................................................................done. 05:49:05 INFO - Installing pip.................done. 05:49:06 INFO - Return code: 0 05:49:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:06 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 0x1063a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063b4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f3db53b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106243e00>, '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 0x1060acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10623eb20>, '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.LDv0UAdT18/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.9miB4wlnMv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 05:49:06 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 05:49:06 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 05:49:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDv0UAdT18/Render', 05:49:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:49:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:49:06 INFO - 'HOME': '/Users/cltbld', 05:49:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:49:06 INFO - 'LOGNAME': 'cltbld', 05:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:06 INFO - 'MOZ_NO_REMOTE': '1', 05:49:06 INFO - 'NO_EM_RESTART': '1', 05:49:06 INFO - 'PAGER': '/bin/cat', 05:49:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:06 INFO - 'PWD': '/builds/slave/test', 05:49:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:49:06 INFO - 'SHELL': '/bin/bash', 05:49:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9miB4wlnMv/Listeners', 05:49:06 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 05:49:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:49:06 INFO - 'USER': 'cltbld', 05:49:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:49:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:06 INFO - 'XPC_FLAGS': '0x0', 05:49:06 INFO - 'XPC_SERVICE_NAME': '0', 05:49:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:06 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 05:49:06 INFO - Cleaning up... 05:49:06 INFO - Return code: 0 05:49:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:06 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 0x1063a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063b4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f3db53b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106243e00>, '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 0x1060acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10623eb20>, '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.LDv0UAdT18/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.9miB4wlnMv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 05:49:06 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 05:49:06 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 05:49:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDv0UAdT18/Render', 05:49:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:49:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:49:06 INFO - 'HOME': '/Users/cltbld', 05:49:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:49:06 INFO - 'LOGNAME': 'cltbld', 05:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:06 INFO - 'MOZ_NO_REMOTE': '1', 05:49:06 INFO - 'NO_EM_RESTART': '1', 05:49:06 INFO - 'PAGER': '/bin/cat', 05:49:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:06 INFO - 'PWD': '/builds/slave/test', 05:49:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:49:06 INFO - 'SHELL': '/bin/bash', 05:49:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9miB4wlnMv/Listeners', 05:49:06 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 05:49:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:49:06 INFO - 'USER': 'cltbld', 05:49:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:49:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:06 INFO - 'XPC_FLAGS': '0x0', 05:49:06 INFO - 'XPC_SERVICE_NAME': '0', 05:49:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:06 INFO - Downloading/unpacking psutil>=0.7.1 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:49:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:09 INFO - Installing collected packages: psutil 05:49:09 INFO - Running setup.py install for psutil 05:49:09 INFO - building 'psutil._psutil_osx' extension 05:49:09 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 05:49:10 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 05:49:10 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 05:49:10 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 05:49:10 INFO - building 'psutil._psutil_posix' extension 05:49:10 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 05:49:10 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:49:10 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:49:10 INFO - ^ 05:49:10 INFO - 1 warning generated. 05:49:10 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 05:49:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:49:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:49:10 INFO - Successfully installed psutil 05:49:10 INFO - Cleaning up... 05:49:10 INFO - Return code: 0 05:49:10 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 05:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:10 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 0x1063a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063b4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f3db53b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106243e00>, '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 0x1060acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10623eb20>, '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.LDv0UAdT18/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.9miB4wlnMv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 05:49:10 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 05:49:10 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 05:49:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDv0UAdT18/Render', 05:49:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:49:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:49:10 INFO - 'HOME': '/Users/cltbld', 05:49:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:49:10 INFO - 'LOGNAME': 'cltbld', 05:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:10 INFO - 'MOZ_NO_REMOTE': '1', 05:49:10 INFO - 'NO_EM_RESTART': '1', 05:49:10 INFO - 'PAGER': '/bin/cat', 05:49:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:10 INFO - 'PWD': '/builds/slave/test', 05:49:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:49:10 INFO - 'SHELL': '/bin/bash', 05:49:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9miB4wlnMv/Listeners', 05:49:10 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 05:49:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:49:10 INFO - 'USER': 'cltbld', 05:49:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:49:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:10 INFO - 'XPC_FLAGS': '0x0', 05:49:10 INFO - 'XPC_SERVICE_NAME': '0', 05:49:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:10 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:49:10 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 05:49:10 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 05:49:10 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 05:49:10 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 05:49:10 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 05:49:10 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 05:49:13 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:49:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:49:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:49:13 INFO - Installing collected packages: mozsystemmonitor 05:49:13 INFO - Running setup.py install for mozsystemmonitor 05:49:13 INFO - Successfully installed mozsystemmonitor 05:49:13 INFO - Cleaning up... 05:49:13 INFO - Return code: 0 05:49:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:49:13 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')]} 05:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:13 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')]} 05:49:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:13 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 0x1063a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063b4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f3db53b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106243e00>, '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 0x1060acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10623eb20>, '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.LDv0UAdT18/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.9miB4wlnMv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 05:49:13 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 05:49:13 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 05:49:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDv0UAdT18/Render', 05:49:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:49:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:49:13 INFO - 'HOME': '/Users/cltbld', 05:49:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:49:13 INFO - 'LOGNAME': 'cltbld', 05:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:13 INFO - 'MOZ_NO_REMOTE': '1', 05:49:13 INFO - 'NO_EM_RESTART': '1', 05:49:13 INFO - 'PAGER': '/bin/cat', 05:49:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:49:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:13 INFO - 'PWD': '/builds/slave/test', 05:49:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:49:13 INFO - 'SHELL': '/bin/bash', 05:49:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9miB4wlnMv/Listeners', 05:49:13 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 05:49:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:49:13 INFO - 'USER': 'cltbld', 05:49:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:49:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:13 INFO - 'XPC_FLAGS': '0x0', 05:49:13 INFO - 'XPC_SERVICE_NAME': '0', 05:49:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:49:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:13 INFO - Downloading/unpacking blobuploader==1.2.4 05:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:16 INFO - Downloading blobuploader-1.2.4.tar.gz 05:49:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:49:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:49:16 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 05:49:16 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 05:49:16 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 05:49:16 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 05:49:16 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 05:49:16 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 05:49:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:49:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:17 INFO - Downloading docopt-0.6.1.tar.gz 05:49:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:49:17 INFO - Installing collected packages: blobuploader, requests, docopt 05:49:17 INFO - Running setup.py install for blobuploader 05:49:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:49:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:49:17 INFO - Running setup.py install for requests 05:49:18 INFO - Running setup.py install for docopt 05:49:18 INFO - Successfully installed blobuploader requests docopt 05:49:18 INFO - Cleaning up... 05:49:18 INFO - Return code: 0 05:49:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49: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')]} 05:49:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49: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')]} 05:49:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:18 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 0x1063a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063b4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f3db53b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106243e00>, '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 0x1060acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10623eb20>, '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.LDv0UAdT18/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.9miB4wlnMv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 05:49:18 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 05:49:18 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 05:49:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDv0UAdT18/Render', 05:49:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:49:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:49:18 INFO - 'HOME': '/Users/cltbld', 05:49:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:49:18 INFO - 'LOGNAME': 'cltbld', 05:49:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:18 INFO - 'MOZ_NO_REMOTE': '1', 05:49:18 INFO - 'NO_EM_RESTART': '1', 05:49:18 INFO - 'PAGER': '/bin/cat', 05:49:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:49:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:18 INFO - 'PWD': '/builds/slave/test', 05:49:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:49:18 INFO - 'SHELL': '/bin/bash', 05:49:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9miB4wlnMv/Listeners', 05:49:18 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 05:49:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:49:18 INFO - 'USER': 'cltbld', 05:49:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:49:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:49:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:18 INFO - 'XPC_FLAGS': '0x0', 05:49:18 INFO - 'XPC_SERVICE_NAME': '0', 05:49:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:49:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:18 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-8H3aHH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:18 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-WJFPuN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:18 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-9qixgX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:19 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-58_VQ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:19 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-yAYkdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:19 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-v6t9IG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:49:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:49:19 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-4VktCJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:49:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:49:19 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-WvBXeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:49:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:49:19 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-3CGakE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:49:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:49:19 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-d0izUL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:49:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:49:19 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-1PSQfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:49:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:49:19 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-KzWx6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:49:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:49:19 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-9TQfQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:49:20 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-Kx5jZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:20 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-uR7B4r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:49:20 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-saUaw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:49:20 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-s0OzLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:49:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:49:20 INFO - Running setup.py install for manifestparser 05:49:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:49:20 INFO - Running setup.py install for mozcrash 05:49:20 INFO - Running setup.py install for mozdebug 05:49:20 INFO - Running setup.py install for mozdevice 05:49:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:49:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:49:21 INFO - Running setup.py install for mozfile 05:49:21 INFO - Running setup.py install for mozhttpd 05:49:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:49:21 INFO - Running setup.py install for mozinfo 05:49:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:49:21 INFO - Running setup.py install for mozInstall 05:49:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:49:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:49:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:49:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:49:21 INFO - Running setup.py install for mozleak 05:49:21 INFO - Running setup.py install for mozlog 05:49:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:49:21 INFO - Running setup.py install for moznetwork 05:49:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:49:22 INFO - Running setup.py install for mozprocess 05:49:22 INFO - Running setup.py install for mozprofile 05:49:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:49:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:49:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:49:22 INFO - Running setup.py install for mozrunner 05:49:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:49:22 INFO - Running setup.py install for mozscreenshot 05:49:22 INFO - Running setup.py install for moztest 05:49:22 INFO - Running setup.py install for mozversion 05:49:22 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:49:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:49:23 INFO - Cleaning up... 05:49:23 INFO - Return code: 0 05:49:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:23 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')]} 05:49:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:23 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')]} 05:49:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:23 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 0x1063a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063b4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f3db53b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106243e00>, '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 0x1060acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10623eb20>, '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.LDv0UAdT18/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.9miB4wlnMv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 05:49:23 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 05:49:23 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 05:49:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDv0UAdT18/Render', 05:49:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:49:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:49:23 INFO - 'HOME': '/Users/cltbld', 05:49:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:49:23 INFO - 'LOGNAME': 'cltbld', 05:49:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:23 INFO - 'MOZ_NO_REMOTE': '1', 05:49:23 INFO - 'NO_EM_RESTART': '1', 05:49:23 INFO - 'PAGER': '/bin/cat', 05:49:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:49:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:23 INFO - 'PWD': '/builds/slave/test', 05:49:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:49:23 INFO - 'SHELL': '/bin/bash', 05:49:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9miB4wlnMv/Listeners', 05:49:23 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 05:49:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:49:23 INFO - 'USER': 'cltbld', 05:49:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:49:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:49:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:23 INFO - 'XPC_FLAGS': '0x0', 05:49:23 INFO - 'XPC_SERVICE_NAME': '0', 05:49:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:49:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:49:23 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-fcez7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:49:23 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)) 05:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:49:23 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-HtYJo7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:49:23 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)) 05:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:49:23 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-QrBvOx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:49:23 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)) 05:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:49:23 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-5sNMcQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:49:23 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)) 05:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:49:23 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-3UObVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:49:23 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)) 05:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:49:23 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-iUXHwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:49:23 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)) 05:49:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:49:23 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-XFIjKg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:49:24 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)) 05:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:49:24 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-XxbBVz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:49:24 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)) 05:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:49:24 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-jaNraI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:49:24 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)) 05:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:49:24 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-ftooTr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:49:24 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)) 05:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:49:24 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-WcvVLh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:49:24 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)) 05:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:49:24 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-x4jhXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:49:24 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)) 05:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:49:24 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-9RDHSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:49:24 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)) 05:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:49:24 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-9cptS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:49:24 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)) 05:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:24 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-dYOkv3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:49:24 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)) 05:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:49:24 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-mVbXzP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:49:24 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)) 05:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:49:24 INFO - Running setup.py (path:/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/pip-2h8JvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:49:25 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)) 05:49:25 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)) 05:49:25 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)) 05:49:25 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)) 05:49:25 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)) 05:49:25 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)) 05:49:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49: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 05:49:27 INFO - Downloading blessings-1.6.tar.gz 05:49:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:49:27 INFO - Installing collected packages: blessings 05:49:27 INFO - Running setup.py install for blessings 05:49:27 INFO - Successfully installed blessings 05:49:27 INFO - Cleaning up... 05:49:27 INFO - Return code: 0 05:49:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:49:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:49:28 INFO - Reading from file tmpfile_stdout 05:49:28 INFO - Current package versions: 05:49:28 INFO - blessings == 1.6 05:49:28 INFO - blobuploader == 1.2.4 05:49:28 INFO - docopt == 0.6.1 05:49:28 INFO - manifestparser == 1.1 05:49:28 INFO - mozInstall == 1.12 05:49:28 INFO - mozcrash == 0.17 05:49:28 INFO - mozdebug == 0.1 05:49:28 INFO - mozdevice == 0.48 05:49:28 INFO - mozfile == 1.2 05:49:28 INFO - mozhttpd == 0.7 05:49:28 INFO - mozinfo == 0.9 05:49:28 INFO - mozleak == 0.1 05:49:28 INFO - mozlog == 3.1 05:49:28 INFO - moznetwork == 0.27 05:49:28 INFO - mozprocess == 0.22 05:49:28 INFO - mozprofile == 0.28 05:49:28 INFO - mozrunner == 6.11 05:49:28 INFO - mozscreenshot == 0.1 05:49:28 INFO - mozsystemmonitor == 0.0 05:49:28 INFO - moztest == 0.7 05:49:28 INFO - mozversion == 1.4 05:49:28 INFO - psutil == 3.1.1 05:49:28 INFO - requests == 1.2.3 05:49:28 INFO - wsgiref == 0.1.2 05:49:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:49:28 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')]} 05:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:28 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')]} 05:49:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:28 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 0x1063a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063b4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f3db53b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106243e00>, '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 0x1060acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10623eb20>, '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.LDv0UAdT18/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.9miB4wlnMv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 05:49:28 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 05:49:28 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 05:49:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDv0UAdT18/Render', 05:49:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:49:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:49:28 INFO - 'HOME': '/Users/cltbld', 05:49:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:49:28 INFO - 'LOGNAME': 'cltbld', 05:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:28 INFO - 'MOZ_NO_REMOTE': '1', 05:49:28 INFO - 'NO_EM_RESTART': '1', 05:49:28 INFO - 'PAGER': '/bin/cat', 05:49:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:28 INFO - 'PWD': '/builds/slave/test', 05:49:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:49:28 INFO - 'SHELL': '/bin/bash', 05:49:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9miB4wlnMv/Listeners', 05:49:28 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 05:49:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:49:28 INFO - 'USER': 'cltbld', 05:49:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:49:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:28 INFO - 'XPC_FLAGS': '0x0', 05:49:28 INFO - 'XPC_SERVICE_NAME': '0', 05:49:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:49:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:28 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)) 05:49:28 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)) 05:49:28 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)) 05:49:28 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)) 05:49:28 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)) 05:49:28 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)) 05:49:28 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)) 05:49:28 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)) 05:49:28 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)) 05:49:28 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)) 05:49:28 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)) 05:49:28 INFO - Cleaning up... 05:49:28 INFO - Return code: 0 05:49:28 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:49:28 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')]} 05:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:28 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')]} 05:49:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:28 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 0x1063a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063b4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f3db53b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106243e00>, '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 0x1060acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10623eb20>, '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.LDv0UAdT18/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.9miB4wlnMv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 05:49:28 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 05:49:28 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 05:49:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDv0UAdT18/Render', 05:49:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:49:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:49:28 INFO - 'HOME': '/Users/cltbld', 05:49:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:49:28 INFO - 'LOGNAME': 'cltbld', 05:49:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:28 INFO - 'MOZ_NO_REMOTE': '1', 05:49:28 INFO - 'NO_EM_RESTART': '1', 05:49:28 INFO - 'PAGER': '/bin/cat', 05:49:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:49:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:28 INFO - 'PWD': '/builds/slave/test', 05:49:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:49:28 INFO - 'SHELL': '/bin/bash', 05:49:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9miB4wlnMv/Listeners', 05:49:28 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 05:49:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:49:28 INFO - 'USER': 'cltbld', 05:49:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:49:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:49:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:28 INFO - 'XPC_FLAGS': '0x0', 05:49:28 INFO - 'XPC_SERVICE_NAME': '0', 05:49:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:49:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:28 INFO - Downloading/unpacking jsonschema 05:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:49:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:49:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:49:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:49:31 INFO - Downloading/unpacking functools32 (from jsonschema) 05:49:31 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 05:49:31 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 05:49:31 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 05:49:31 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 05:49:31 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 05:49:31 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 05:49:31 INFO - Downloading functools32-3.2.3-2.tar.gz 05:49:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:49:31 INFO - warning: no files found matching '*.txt' 05:49:31 INFO - no previously-included directories found matching 'build' 05:49:31 INFO - no previously-included directories found matching 'dist' 05:49:31 INFO - no previously-included directories found matching '.git*' 05:49:31 INFO - Installing collected packages: jsonschema, functools32 05:49:31 INFO - Running setup.py install for functools32 05:49:31 INFO - warning: no files found matching '*.txt' 05:49:31 INFO - no previously-included directories found matching 'build' 05:49:31 INFO - no previously-included directories found matching 'dist' 05:49:31 INFO - no previously-included directories found matching '.git*' 05:49:31 INFO - Successfully installed jsonschema functools32 05:49:31 INFO - Cleaning up... 05:49:32 INFO - Return code: 0 05:49:32 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:49:32 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')]} 05:49:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:49:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:32 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')]} 05:49:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:49:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:49:32 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 0x1063a4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1063b4420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe3f3db53b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106243e00>, '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 0x1060acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10623eb20>, '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.LDv0UAdT18/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.9miB4wlnMv/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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 05:49:32 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 05:49:32 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 05:49:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDv0UAdT18/Render', 05:49:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:49:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:49:32 INFO - 'HOME': '/Users/cltbld', 05:49:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:49:32 INFO - 'LOGNAME': 'cltbld', 05:49:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:49:32 INFO - 'MOZ_NO_REMOTE': '1', 05:49:32 INFO - 'NO_EM_RESTART': '1', 05:49:32 INFO - 'PAGER': '/bin/cat', 05:49:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:49:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:49:32 INFO - 'PWD': '/builds/slave/test', 05:49:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:49:32 INFO - 'SHELL': '/bin/bash', 05:49:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9miB4wlnMv/Listeners', 05:49:32 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 05:49:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:49:32 INFO - 'USER': 'cltbld', 05:49:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:49:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:49:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:49:32 INFO - 'XPC_FLAGS': '0x0', 05:49:32 INFO - 'XPC_SERVICE_NAME': '0', 05:49:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:49:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:49:32 INFO - Downloading/unpacking flake8 05:49:32 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 05:49:32 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 05:49:32 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 05:49:32 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 05:49:32 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 05:49:32 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 05:49:34 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:49:34 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:49:34 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 05:49:34 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 05:49:34 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 05:49:34 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 05:49:34 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 05:49:34 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 05:49:35 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:49:35 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:49:35 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 05:49:35 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 05:49:35 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 05:49:35 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 05:49:35 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 05:49:35 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 05:49:35 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:49:35 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 05:49:35 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 05:49:35 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 05:49:35 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 05:49:35 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 05:49:35 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 05:49:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:49:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:49:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:49:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:49:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:49:35 INFO - no previously-included directories found matching 'docs/_build' 05:49:35 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:49:36 INFO - Running setup.py install for pep8 05:49:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:49:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:49:36 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:49:36 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:49:36 INFO - no previously-included directories found matching 'docs/_build' 05:49:36 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:49:36 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:49:36 INFO - Cleaning up... 05:49:36 INFO - Return code: 0 05:49:36 INFO - Running post-action listener: _resource_record_post_action 05:49:36 INFO - Running post-action listener: _start_resource_monitoring 05:49:36 INFO - Starting resource monitoring. 05:49:36 INFO - ##### 05:49:36 INFO - ##### Running install step. 05:49:36 INFO - ##### 05:49:36 INFO - Running pre-action listener: _resource_record_pre_action 05:49:36 INFO - Running main action method: install 05:49:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:49:36 INFO - Reading from file tmpfile_stdout 05:49:36 INFO - Detecting whether we're running mozinstall >=1.0... 05:49:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:49:36 INFO - Reading from file tmpfile_stdout 05:49:36 INFO - Output received: 05:49:36 INFO - Usage: mozinstall [options] installer 05:49:36 INFO - Options: 05:49:36 INFO - -h, --help show this help message and exit 05:49:36 INFO - -d DEST, --destination=DEST 05:49:36 INFO - Directory to install application into. [default: 05:49:36 INFO - "/builds/slave/test"] 05:49:36 INFO - --app=APP Application being installed. [default: firefox] 05:49:36 INFO - mkdir: /builds/slave/test/build/application 05:49:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:50:09 INFO - Reading from file tmpfile_stdout 05:50:09 INFO - Output received: 05:50:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:50:09 INFO - Running post-action listener: _resource_record_post_action 05:50:09 INFO - ##### 05:50:09 INFO - ##### Running run-tests step. 05:50:09 INFO - ##### 05:50:09 INFO - Running pre-action listener: _resource_record_pre_action 05:50:09 INFO - Running main action method: run_tests 05:50:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:50:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:50:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:50:09 INFO - 2016-04-22 05:50:09.743 screenresolution[1666:7581] starting screenresolution argv=screenresolution get 05:50:09 INFO - 2016-04-22 05:50:09.745 screenresolution[1666:7581] Display 0: 1600x1200x32@60 05:50:09 INFO - 2016-04-22 05:50:09.751 screenresolution[1667:7583] starting screenresolution argv=screenresolution list 05:50:09 INFO - Available Modes on Display 0 05:50:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:50:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:50:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:50:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:50:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:50:09 INFO - Intel Iris: 05:50:09 INFO - Chipset Model: Intel Iris 05:50:09 INFO - Type: GPU 05:50:09 INFO - Bus: Built-In 05:50:09 INFO - VRAM (Dynamic, Max): 1536 MB 05:50:09 INFO - Vendor: Intel (0x8086) 05:50:09 INFO - Device ID: 0x0a2e 05:50:09 INFO - Revision ID: 0x0009 05:50:09 INFO - Displays: 05:50:09 INFO - Display: 05:50:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:50:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:50:09 INFO - Display Serial Number: 1600x1200 60 05:50:09 INFO - Main Display: Yes 05:50:09 INFO - Mirror: Off 05:50:09 INFO - Online: Yes 05:50:09 INFO - Rotation: Supported 05:50:09 INFO - Return code: 0 05:50:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:50:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:50:09 INFO - Python 2.7.3 05:50:09 INFO - Return code: 0 05:50:09 INFO - grabbing minidump binary from tooltool 05:50:09 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')]} 05:50:09 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 0x106243e00>, '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 0x1060acdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10623eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:50:09 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 05:50:09 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 05:50:10 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:50:10 INFO - Return code: 0 05:50:10 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:50:10 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:50:10 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:50:10 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:50:10 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:50:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:50:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:50:11 INFO - Return code: 0 05:50:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0063', '--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 05:50:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0063 --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 05:50:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.LDv0UAdT18/Render', 05:50:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:50:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:50:11 INFO - 'HOME': '/Users/cltbld', 05:50:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:50:11 INFO - 'LOGNAME': 'cltbld', 05:50:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:50:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:50:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:50:11 INFO - 'MOZ_NO_REMOTE': '1', 05:50:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:50:11 INFO - 'NO_EM_RESTART': '1', 05:50:11 INFO - 'PAGER': '/bin/cat', 05:50:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:50:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:50:11 INFO - 'PWD': '/builds/slave/test', 05:50:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:50:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:50:11 INFO - 'SHELL': '/bin/bash', 05:50:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9miB4wlnMv/Listeners', 05:50:11 INFO - 'TMPDIR': '/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/', 05:50:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:50:11 INFO - 'USER': 'cltbld', 05:50:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:50:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:50:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:50:11 INFO - 'XPC_FLAGS': '0x0', 05:50:11 INFO - 'XPC_SERVICE_NAME': '0', 05:50:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:50:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0063', '--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 05:50:11 INFO - mozversion application_buildid: 20160419230832 05:50:11 INFO - mozversion application_changeset: d42b25947fc26a0f9eab98d631465b72769553bd 05:50:11 INFO - mozversion application_display_name: Nightly 05:50:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:50:11 INFO - mozversion application_name: Firefox 05:50:11 INFO - mozversion application_remotingname: firefox 05:50:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 05:50:11 INFO - mozversion application_vendor: Mozilla 05:50:11 INFO - mozversion application_version: 48.0a1 05:50:11 INFO - mozversion platform_buildid: 20160419230832 05:50:11 INFO - mozversion platform_changeset: d42b25947fc26a0f9eab98d631465b72769553bd 05:50:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 05:50:11 INFO - mozversion platform_version: 48.0a1 05:50:11 INFO - using testdate: 1461329411 05:50:11 INFO - actual date: 1461329411 05:50:11 INFO - starting webserver on 'localhost:49278' 05:50:11 INFO - SUITE-START | Running 2 tests 05:50:11 INFO - TEST-START | dromaeo_css 05:50:11 INFO - operating with platform_type : mac_ 05:50:11 INFO - Initialising browser for dromaeo_css test... 05:50:11 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpxEmzeZ/profile http://localhost:49278/getInfo.html) 05:50:14 INFO - PROCESS | 1685 | __metrics Screen width/height:1600/1200 05:50:14 INFO - PROCESS | 1685 | colorDepth:24 05:50:14 INFO - PROCESS | 1685 | Browser inner width/height: 1024/689 05:50:14 INFO - PROCESS | 1685 | __metrics 05:50:14 ERROR - PROCESS | 1685 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 05:50:14 INFO - TEST-INFO | 1685: exit 0 05:50:14 INFO - Browser initialized. 05:50:14 INFO - Running cycle 1/1 for dromaeo_css test... 05:50:14 INFO - TEST-INFO | started process 1688 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpxEmzeZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:50:26 INFO - PROCESS | 1688 | RSS: Main: 247672832 05:50:26 INFO - PROCESS | 1688 | 05:51:16 INFO - PROCESS | 1688 | 1461329476643 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] 05:53:28 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49278/tests/dromaeo/cssquery-ext.html) 05:53:29 INFO - PROCESS | 1688 | RSS: Main: 259510272 05:53:29 INFO - PROCESS | 1688 | 05:56:31 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-ext.html (next: http://localhost:49278/tests/dromaeo/cssquery-jquery.html) 05:56:32 INFO - PROCESS | 1688 | RSS: Main: 271863808 05:56:32 INFO - PROCESS | 1688 | 05:59:33 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49278/tests/dromaeo/cssquery-mootools.html) 05:59:34 INFO - PROCESS | 1688 | RSS: Main: 273424384 05:59:34 INFO - PROCESS | 1688 | 06:02:36 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49278/tests/dromaeo/cssquery-prototype.html) 06:02:36 INFO - PROCESS | 1688 | RSS: Main: 275251200 06:02:36 INFO - PROCESS | 1688 | 06:05:39 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49278/tests/dromaeo/cssquery-yui.html) 06:05:40 INFO - PROCESS | 1688 | RSS: Main: 278069248 06:05:40 INFO - PROCESS | 1688 | 06:08:42 INFO - PROCESS | 1688 | Cycle 1(1): loaded http://localhost:49278/tests/dromaeo/cssquery-yui.html (next: http://localhost:49278/tests/dromaeo/cssquery-dojo.html) 06:08:43 INFO - PROCESS | 1688 | RSS: Main: 279171072 06:08:43 INFO - PROCESS | 1688 | 06:08:43 INFO - PROCESS | 1688 | __start_tp_report 06:08:43 INFO - PROCESS | 1688 | _x_x_mozilla_page_load 06:08:43 INFO - PROCESS | 1688 | _x_x_mozilla_page_load_details 06:08:43 INFO - PROCESS | 1688 | |i|pagename|runs| 06:08:43 INFO - PROCESS | 1688 | |0;dojo.html;3477.095955051687;3517.6130625631176;3519.8064106474144;3525.78845269284;3568.446890731936;5649.689267090308;5656.095024796034;5703.429657034295;5704.971475142618;5708.257926469559;5659.896320217559;5734.225879506265;5816.302043754745;5844.766209351621;5965.4929331006915;4591.357209990604;5113.951639913808;5172.04317201318;5210.452902445246;5224.320838291036;384.50273580689327;5212.087884620195;5258.13240815265;5269.920951185716;5301.284326615896;4360.781960901958;5174.249733788598;5176.7411629418375;5197.350331208599;5267.26258323835;5184.611154163453;5264.736763161826;5271.868203294948;5285.86785330366;5291.259223708684;5190.844274671766;5214.608904332153;5217.608679349026;5243.711595862226;5317.2821669074565;5675.9432405675825;5756.424357564252;5778.59549831512;5793.7392817323325;5819.7672093116225;6154.169187159721;6176.567640265183;6211.627302361872;6244.937550624481;6268.937310626881;6234.719437625317;6245.531585131133;6266.091416744546;6292.741451709677;6299.527535434815;6004.249468816354;6006.609570377911;6008.909866352008;6029.703613723071;6051.334353221142;6215.502759779297;6303.842403939847;6357.554971151975;6367.172267605274;6413.262474815363;5481.835544933659;5984.222051133412;6253.1245625612455;6257.749690012349;6258.405451482102;6156.753729850845;6248.156498872685;6257.311695713468;6278.4035516625845;6290.622562646256;5910.468057874812;6160.291566469913;6178.011518157074;6222.097795819581;6259.749610015549;5283.52448279649;6169.2288463942;6229.626222426669;6242.969909964805;6243.594166379171;4975;5014.07239660664;5018.774155163026;5022.196448568212;5036.370453693288;3622.623403106855;4415.51429342772;4487.551244875486;4556.977215113903;4567.018091110427;5966.671833049137;5991.430814072656;6005.759769609254;6011.9699401503585;6032.698365081728;6313.179286692701;6313.905291420632;6318.842028949313;6331.746730130835;6337.841553961096;5808.186853840466;5989.8203053908455;6055.7274922628585;6076.3316035236085;6118.265808103056;4274.636655884285;4655.37152484417;4971.806766376116;5504.834854954358;5523.585731070106;5444.265024221759;6387.393197646216;6548.8362790930605;6550.213974323112;6554.63949482783;6205.751769929152;6267.96866015667;6328.778492752732;6364.840878978062;6406.583572067801;6498.675066246574;6519.608823470607;6532.379423954717;6556.704948277244;6585.3085426029575;6085.6348619083;6167.5374346925055;6246.281677607133;6247.31279559239;6257.2804127525915;5277.920831187458;5893.292804863444;6257.342978987141;6281.780137695158;6344.524160687874;6220.502359811114;6222.719977600928;6233.348162736787;6238.594491358047;6244.188255526752;5988.011978023752;6083.543734219863;6100.389961003864;6198.411150940653;6218.19163508741;5106.974465127651;6006.459418652343;6063.605370764837;6066.363031881765;6126.908096378469;6112.205413296243;6150.938490615036;6175.6912154393;6232.470240029467;6233.781817636361;6005.669688167192;6053.909191362045;6105.574307455683;6115.936978868401;6153.261608606996 06:08:43 INFO - PROCESS | 1688 | |1;ext.html;502.6556808586119;515.3841159814021;518.2770035800056;526.3920172201107;554.082992647169;33149.66850331496;36759.63240367602;36913.26173476529;36973;36983.815080924556;38884.61115388845;39270.8036459818;39396.212075758536;39497.40753888694;39572.40641390382;9318.86021709675;9440.433573985583;9480.241580673564;9574.425534467955;9575.329726919119;9414.152726254635;9577.425354478719;9623.1820295275;9662.710118696416;9670.468124253162;9603.279754018442;9612.807743845118;9643.903560964405;9687.225021998223;9721.805563888718;9626.711198664052;9643.951780241088;9706.563204655808;9710.854337184948;9744.366616169962;9536;9541.761455963657;9542.188913942324;9632.27757918159;9677.225821934227;37955.240895181945;37972.81013594914;38206.23587528234;38307.80846095779;38432.423513647314;2805.186495916202;3002.4445477586496;3005.068428787083;3191.4255434021866;3442.6729460701445;22213.44466388337;24939.376515587075;26808.92764289426;27110.915563377443;27503;1922.903854807254;2567.82025258232;2608.232700928942;2642.2733748219202;2649.231722800386;373204;373791;375292;376858;377789;34071;34172.97481075572;34399.79600713963;34408.827955860565;34425.65574344224;67057.32942670608;67351;68600.6569967157;69182;69203.65398172977;16476.6704665906;16671.41650042267;16922.83077169237;16937;17009.574760631083;12836.486540538273;12841.202231687572;12896.419661115273;12938.094333396572;12972.481100756053;19073.232310632487;19140.234390624497;19383.612327753366;19515.90242048809;19560.315388961604;8069.878951815727;8134.471259368122;8142.226488483585;8200.876986845202;8303.252707256375;1000.7190795781412;1012.281280290987;1031.9277650564538;1109.5755773634635;1119.4775105856029;27800.860995694893;29591.556126658117;29673.554896676567;30118.247043824078;30300.69699303023;1064.6433444795925;1076.3488089705772;1092.0499165725869;1106.6097229983197;1122.3669560789033;14485.058471199338;14694;14748.487225739338;14773.40906363755;14855.405783768529;619639;619670;628275;631168;632267;55915;56621;57304.713476433186;57330.71334643383;58316.54208644818;1431.77807439847;1448.5075074474519;1474.6165996840898;1478.3125846481437;1485.0792508644709;27907.860460697568;28120.43759124847;28702.85648571744;28794.568081478377;28813.71186288194;47841;49196;49206;49798.50201498083;49864.75338116576;562638;572850;576927;577380;579520;26290.4741905157;26699.466010680066;26849.597256041565;27138.864305679133;27140.864295678395;44231.33652995272;45534.772326138154;46041.848953776425;46247.306290404995;46507.30239046484;37780.62219377771;37878;37936.051598710255;38614.80692596519;38850.2229955405;36407.54942482881;37409.06477338088;37625.62374376331;37789.43315850209;38461.80769096137;36732.632673672924;37141.44287835739;37181.62818371782;37592.24815503729;38419.42370864384;31999.36017275369;33158;33284.83503077381;33705;33753.83123084369;24573.50852982966;24954.62568061517;24981.625275620518;25147.87426062858;25205.369865753502 06:08:43 INFO - PROCESS | 1688 | |2;jquery.html;376.6817039601536;389.9025243689078;394.3434182086825;397.681854516387;400.6634427081251;18526.258949642015;19714.60570788587;20355.49111272219;20810.375688729342;20861.687074693873;11561.132915031385;11938.82091768622;12153.696157596065;12228.327441990687;12250.816237756419;5166.50171450279;5308.840734777944;5333.653312534692;5350.197470379435;5351.411344752074;3122.7970181938217;5414.620976531644;5747.994101032324;5756.539476841864;5769.249997500319;5679.460451257145;5741.626794258381;5741.655500669973;5772.134179873032;5791.797287094932;6276.811695649138;6304.905426418607;6307.243130824308;6316.715747791361;6326.620402775825;5244.688827793052;5370.087085195526;5609.382967873531;5673.971630141823;5688.516476099537;12423.75152496945;13233.470661173542;13285.933570332087;13316.600501984956;13409.66475838102;2071.440711008019;2086.113401804227;2123.6177488052144;2131.28601918356;2474.134053081425;9687.564059617334;9804;9958.90041099587;12831.422585983653;14657.56027319182;1451.9419223231057;1696.9066701331421;1760.3222759237658;1795.9281628734834;1813.1931290575699;117415;122822;123680.1447978281;124445;125366.3731681345;11406.885931140583;11609.593664221711;11746.471408786454;11783.351915644722;11807.232529885701;14739;15041.247937603077;15075;15102.622434439227;15141.242937853063;7403.111626604842;8530.763039359259;8647.092055334226;8802.03177650458;8860.778480537909;7114.004039434483;8451.788705282417;8622.956885215659;8639.95680021596;8809.559522023874;3560.9821950890077;3843.615638436134;4096.528899176573;4531.728096314232;4628.514006029386;1449.5504495504495;1646.8929519581188;1958.177565422526;1987.602479504105;1993.4019794061724;926.346925417579;971.4171497101682;982;999.9250056245811;1051.2759075116815;19471.513212169524;20019;20031.699524507145;20251.797482025286;20343.898280508503;957.2342126298932;959.7504648791364;967.5148646827228;998.960041598328;1045.3466583385384;10772.24594278393;10941.463122366258;10976.640022395224;10993.955574220436;11030.944845275882;567307;569030;574185;574963;584142;127602;129137;130248;131672;133260;1023.5496381592225;1035.6530562261726;1039.2465462539599;1039.60495011895;1049.968500944973;18139.45581632553;18348.81651183471;18500.629987400447;18585;18708.532286692942;50844.23733643924;50879.74560127176;51336.229956551426;51503.484965149866;52469.7376513115;57912.4208757907;74424;74911.25088749261;75571.24428755642;75905;6395.776147834989;6562.442192413699;6667.399934005963;7706.614669266626;7982.201779821971;8380.958095209486;10984.890151098387;11159.665210043711;11776.352300623548;11976.46105925218;9893.752656183653;10023.398596084258;10255.538500767334;10273.486325683836;10305.587776488857;4963.726995015309;6773.424258938046;9838.557264923238;9986.850197246902;10268.486575671335;7838.490498117604;9816.65641702537;10032.949835250776;10098.495075246356;10511.474426278503;6268.561200716089;6473;7676.424268179797;7892.894994700861;7918.643661035382;7811.7265895695655;8330;10126.746831329276;10264.332818366782;10609.681709548726 06:08:43 INFO - PROCESS | 1688 | |3;mootools.html;1598.0970751525388;1652.6281586643006;1915.7222202780597;1982.6728589782686;1985.9007049647514;6365.108884756138;6992.195897471793;8517.403781735282;8842.823143537125;8848.911510884882;7210.531315464491;8563.700270490534;8592.785180370494;8757.255633271163;8771.649134034631;2423.503181847726;2447.9388015299583;2451.2278632230878;2458.791002764758;2466.8766561671932;2392.8599667905382;2428.2108314797674;2430.6111022236446;2432.5134973005383;2441.084593277521;2017.788132246115;2414.4808866093786;2435.9512809743796;2459.225344016638;2480.193936970483;2419.758024197584;2423.5395274897714;2424.260600516842;2441.511697660475;2448.7428819973825;2398.8200884933526;2417.830751847371;2421.673074134987;2445.09531473356;2448.081969261527;8664.220220180214;8756.518391488466;8804.735857924272;8841.734747957571;8847.867281990775;5276.894462110775;5356.571474282087;5405.783768649249;5468.9726551367385;5475.534579560742;3584.8028358440274;3619.565652121736;3628.8004159771203;3634.5638523377365;3666.0020288942324;891.38494438837;1026.2662196529443;1050.2438244463974;1066.4294602387686;1078.8705355357408;11460.656180314603;11579.957803797615;11584.420778961103;11589.188756787029;11594.536218551248;4634.513376095529;4637.884052898705;4890.315355850184;4898.093852637274;4949.406071271471;9972.60109595608;9975.25185611082;9980.451075190935;9987.051230133126;10046.497675116216;5281.498257665516;5330.546903513167;5373.301470808769;5379.973100134474;5413.052715774724;4459.531749166355;4768.880777980578;4908.631852611068;4914.8034078637165;4916.016796640686;3731.2910546995986;4075.694322925792;4084.999175202035;4231.87304380869;4234.174336004511;1346.4748747988292;1359.2456186816412;1362.346073884541;1369.500132451668;1370.9451621935011;827.9379046571531;899.105390136805;911.0343036381457;913.3241401362943;915.8259930613162;4915.852524424273;5895.823125306248;5903.26209223847;6024.4879185268865;6098.298695649968;421.3784667615243;433.1596702397339;435.4730775761364;439.95820397062226;445.2541992163114;3709.5919448860604;3835.520559930009;3976.721629485908;4156.204605470079;4218.7679677618025;10491.632792852213;10666.306690065276;10819.78360432787;10841.67474975752;10961.451927403758;10624.150067994542;10629.202809789142;10727.249092563601;10802.189835762349;10808.351498910091;8215.753527394068;8260.256576908107;8281.710140144945;8298.585070746438;8345.374096942754;5800.622959507618;5922.407759224043;6013.488853447506;6160.876782464236;6189.35011823752;9378.718638440858;10030.899691002996;10116.443595602312;10121.898781012096;10157.746056348651;10014.449205293779;10019.499025048573;10026.997300269915;10073.848892266475;10090.2432317575;6802.115724955724;6826.692798823966;7100.751473698602;7437.702491900263;7481.850362992601;7686.500377475446;7704.768856934301;7758.534487930742;7776.377889768918;7777.533347999138;5907.645541267538;6813.659317034228;6894.448444124559;7050.294970502909;7058.752943646948;6808.183018037867;6808.82977925536;6855.828604284933;6941.47938904574;6976.5465244758925;6427;6435.356464353527;6446.677666116581;6514.804555863332;6527.902081468686;4672.9299060514795;4698.483166851575;4733.1716949533;4761.381020467317;4876.317315575893;4725.480197178239;4791.305260737243;4793.065352256276;4826.517348265286;4905.48492408292 06:08:43 INFO - PROCESS | 1688 | |4;prototype.html;319.1033196717225;320.43603258265455;324.8116092666254;329.5386458957459;329.99340013199753;6212.937870621293;6294.874102517947;6362;6367.490600751946;6377.617342959414;4848.406102735037;6229.314775374705;6261.217347831521;6278.152449419327;6296.212973378328;4009.739366941154;4436.268015777393;4523.909521809562;4618.584327410533;4651.953480465186;4403.700908232079;4568.5203053679215;4645.746812795791;4665.043666048452;4676.883077923045;4147.066909945253;4262.23117406276;4587;4608.677392582521;4621.8151273949;3979.2240513099955;4154.605312495308;4214.199302132585;4473.642108631302;4640.535946405366;3573.857045718168;3916.962005068659;3957.8522228553684;4005.559388467266;4018.618231268025;6014.699265036731;6022.795440911836;6048.485878700316;6073.848153796146;6100.908486372708;5266.236395722637;5454.154606036071;5465.72671366434;5511.173324001392;5548.056830338812;6608.801735947929;6612.834679133012;6632.93367066328;6636.900446493258;6658.334166583351;3739.8504059837574;3839.6928245740273;4021.477207962975;4046.2312160689376;4485.551444855521;6414.717056588701;6960.547564408348;7029.297070292981;7030.718771249144;7070.257622949619;4044.4135600338373;4073.6537394321813;4358.912821743547;4562.270036794097;4629.490756016836;4184.790760461965;4359.258925982591;4699.436067671902;4706.552877476634;4740.952590474051;4831.806727730922;5332.306800116037;5489.4236105209175;5495.697736624444;5502.936398850431;6087.847803804941;6731.495137864582;6744.62904540255;6750.76372326976;6781.355771201728;1186.9228500147462;1369.452219112363;1413.7064585903784;1609.1551935234095;1628.6172749403881;787.9763607091681;930.8643454984907;1045.7856139491387;1082.0207712020633;1083.2613655083635;5066.417362003343;5545.807651354978;6092.847678807977;6203.503719702413;6293.244810622755;5421.945780542144;5506.284183056177;6518.641474718936;6841.655548726495;6844.760433384808;5197.7401129943355;5318.936212757464;5611.354694210137;6010.729517171738;6352.110704501373;3204.967950320467;3476.42638964568;3600.3159399714496;3667.9816600916824;3673.669369756735;6064.454199122012;6116.969415152896;6755.986602009738;7270.9820625112525;7292.635368231568;6428.453581445536;7073.575585464786;7097.751578694721;7164.498485106097;7172.892406613905;6721.630310332978;6890.655467226618;7236.276372362721;7256.963715181496;7295.9056141579185;6594.307597702172;6946.6179360135675;6981.406580440516;7026.824329391806;7039.612821294878;5804.374775062989;6798.600699650175;6836.213835408992;6870.690818913061;6904.3095690430555;7155.749548765768;7243.167035790952;7247.637618119178;7261.3101755333155;7279.235680253497;4305.277888844487;4424.977875110604;4442.8667139985855;4453.465584129925;4461.687681862239;5758.942410575841;6084.239470066242;6901.965490172517;6913.792586222421;6974.721011159497;6097.939020609737;6676.566023208476;6744.898826517508;6753.594784312957;6761.290064543152;5433.864153396196;6664.135181317568;6699.832504187434;6709.865802684017;6735.4611631070375;5710.029295019774;6204.72078756448;6303.149074874833;6547.803565893031;6554.180727409074;5470.288862447856;5810;6219.605451901141;6661.900071499028;6663.233728121328;6290.276618188784;6522.6412547308455;6530.510211734234;6536.803895883131;6569.671516424255 06:08:43 INFO - PROCESS | 1688 | |5;yui.html;631.3087169549342;654.3619970528732;663.8805015097282;674.4840197249104;719.151401346411;12262.264264144158;14837.035592686469;14941.701165976701;15174;15176.924115379436;13766.174029558233;13795.862041379583;13833.239171845544;13868.16790992541;15394.999325043864;813.4549851599413;862.8360611483829;917.0645941140033;921.1249313152498;922.3543519536317;711.6015031582331;907.2605826251616;907.8138981508807;932.5383934952174;938.6714649872558;961.2022021721954;986.3637953519975;987.0474991633073;987.328616540752;987.3680844259679;951.46242373059;971.6016433262364;978.5938835383307;981.1807141037278;982.7150126463317;693.6185098196022;697.7453229571221;718.7161071376829;721.7473884140561;723.5586292361655;15260.084394936339;15395.307211175525;15442.45951391707;15502.22488875563;15530.922345388313;12408.379581020912;12596.118271720983;12596.937015314956;12620.81068783969;12807.039472039634;10155.238357123171;10156.94921525395;10159.647316385575;10182.28723989321;10526;2896.9130926072253;3364.66353364664;3465.7054150396993;3515.0685068456623;3561.165999510254;84231.15768842294;84494.15505844925;86401.56799215963;86652.56673716591;87066;9396.483193424427;9437.528123593793;9499.667511637059;9547.188488978376;9653;21354.252601158885;21415.822129783013;21747.891260543594;21772.56454870894;21781.891090544763;7258.455615828729;7409.481336306515;7421.480496365202;7433.10802703679;7541.886871696929;3922.725409221327;4040.8585699500377;4106.199291138199;4113.239050775616;4124.566920473367;3520.471929210639;3609.4044482660593;3610.097475631092;3624.927501450009;3637.1452708613456;540.7188262103684;617.8949578571563;669.9564528305644;682.2495255219219;687.6939761806049;537.5028099008401;562.4572287742349;590.6544671367299;597.7429705226707;608.5679167790829;7879.369650427952;7915.248051435105;8026.398020148512;8085.636146373427;8089.514629122272;567.3163837575711;568.4457653787607;572.378968818828;580.3673995345094;585.3385674188225;3818.236352729465;3863.16941857502;3879.631435013669;3907.8046097695;3949.782761948063;93458;93535.53232233795;95718.04281957091;95794;95941.5202923981;65088;87532.6870096949;88883.55558222297;89196.5540172295;89387;77491;77623;77977;78301;79209;6293.685315734287;7501.437392195498;7535.13345965221;7607.771766846782;7732.265434783912;29129.271768205963;32803.835980819946;41202;41519;41652;52592.737036314575;59912.70043649754;61747.382526174166;61942.0708689379;62461;8330.875036874573;8534.31725461974;8812.603432845666;10788.730281743019;11042.447877606248;11863.58477453285;11997.820032699341;12095.75808483843;12122.757544848877;12372.443240054039;10560.996705312982;10767.426189822494;11583.536658533565;11602.76794464123;11818.881811182122;11187.32876027441;11391.772164556829;11441;11463.541458341906;12381;11447.828282575601;11619.01238394746;11642.301461912313;11882.346470944181;11909.464074116513;8717.433366831136;9206.026159688321;9527.618895244113;9538.189253913217;9839.262055345735;9387.202087822612;9483.715488535356;9584.137427631547;10135.45072396058;10320.896791031993 06:08:43 INFO - PROCESS | 1688 | __end_tp_report 06:08:43 INFO - PROCESS | 1688 | __start_cc_report 06:08:43 INFO - PROCESS | 1688 | _x_x_mozilla_cycle_collect,394 06:08:43 INFO - PROCESS | 1688 | __end_cc_report 06:08:43 INFO - PROCESS | 1688 | __startTimestamp1461330523038__endTimestamp 06:08:43 INFO - PROCESS | 1688 | 06:08:43 INFO - PROCESS | 1688 | ------- Summary: start ------- 06:08:43 INFO - PROCESS | 1688 | Number of tests: 6 06:08:43 INFO - PROCESS | 1688 | 06:08:43 INFO - PROCESS | 1688 | [#0] dojo.html Cycles:165 Average:5741.69 Median:6051.33 stddev:800.27 (13.2%) stddev-sans-first:782.75 06:08:43 INFO - PROCESS | 1688 | Values: 3477.1 3517.6 3519.8 3525.8 3568.4 5649.7 5656.1 5703.4 5705.0 5708.3 5659.9 5734.2 5816.3 5844.8 5965.5 4591.4 5114.0 5172.0 5210.5 5224.3 384.5 5212.1 5258.1 5269.9 5301.3 4360.8 5174.2 5176.7 5197.4 5267.3 5184.6 5264.7 5271.9 5285.9 5291.3 5190.8 5214.6 5217.6 5243.7 5317.3 5675.9 5756.4 5778.6 5793.7 5819.8 6154.2 6176.6 6211.6 6244.9 6268.9 6234.7 6245.5 6266.1 6292.7 6299.5 6004.2 6006.6 6008.9 6029.7 6051.3 6215.5 6303.8 6357.6 6367.2 6413.3 5481.8 5984.2 6253.1 6257.7 6258.4 6156.8 6248.2 6257.3 6278.4 6290.6 5910.5 6160.3 6178.0 6222.1 6259.7 5283.5 6169.2 6229.6 6243.0 6243.6 4975.0 5014.1 5018.8 5022.2 5036.4 3622.6 4415.5 4487.6 4557.0 4567.0 5966.7 5991.4 6005.8 6012.0 6032.7 6313.2 6313.9 6318.8 6331.7 6337.8 5808.2 5989.8 6055.7 6076.3 6118.3 4274.6 4655.4 4971.8 5504.8 5523.6 5444.3 6387.4 6548.8 6550.2 6554.6 6205.8 6268.0 6328.8 6364.8 6406.6 6498.7 6519.6 6532.4 6556.7 6585.3 6085.6 6167.5 6246.3 6247.3 6257.3 5277.9 5893.3 6257.3 6281.8 6344.5 6220.5 6222.7 6233.3 6238.6 6244.2 5988.0 6083.5 6100.4 6198.4 6218.2 5107.0 6006.5 6063.6 6066.4 6126.9 6112.2 6150.9 6175.7 6232.5 6233.8 6005.7 6053.9 6105.6 6115.9 6153.3 06:08:43 INFO - PROCESS | 1688 | 06:08:43 INFO - PROCESS | 1688 | [#1] ext.html Cycles:180 Average:65419.64 Median:205600.03 stddev:143474.00 (69.8%) stddev-sans-first:143793.69 06:08:43 INFO - PROCESS | 1688 | Values: 502.7 515.4 518.3 526.4 554.1 33149.7 36759.6 36913.3 36973.0 36983.8 38884.6 39270.8 39396.2 39497.4 39572.4 9318.9 9440.4 9480.2 9574.4 9575.3 9414.2 9577.4 9623.2 9662.7 9670.5 9603.3 9612.8 9643.9 9687.2 9721.8 9626.7 9644.0 9706.6 9710.9 9744.4 9536.0 9541.8 9542.2 9632.3 9677.2 37955.2 37972.8 38206.2 38307.8 38432.4 2805.2 3002.4 3005.1 3191.4 3442.7 22213.4 24939.4 26808.9 27110.9 27503.0 1922.9 2567.8 2608.2 2642.3 2649.2 373204.0 373791.0 375292.0 376858.0 377789.0 34071.0 34173.0 34399.8 34408.8 34425.7 67057.3 67351.0 68600.7 69182.0 69203.7 16476.7 16671.4 16922.8 16937.0 17009.6 12836.5 12841.2 12896.4 12938.1 12972.5 19073.2 19140.2 19383.6 19515.9 19560.3 8069.9 8134.5 8142.2 8200.9 8303.3 1000.7 1012.3 1031.9 1109.6 1119.5 27800.9 29591.6 29673.6 30118.2 30300.7 1064.6 1076.3 1092.0 1106.6 1122.4 14485.1 14694.0 14748.5 14773.4 14855.4 619639.0 619670.0 628275.0 631168.0 632267.0 55915.0 56621.0 57304.7 57330.7 58316.5 1431.8 1448.5 1474.6 1478.3 1485.1 27907.9 28120.4 28702.9 28794.6 28813.7 47841.0 49196.0 49206.0 49798.5 49864.8 562638.0 572850.0 576927.0 577380.0 579520.0 26290.5 26699.5 26849.6 27138.9 27140.9 44231.3 45534.8 46041.8 46247.3 46507.3 37780.6 37878.0 37936.1 38614.8 38850.2 36407.5 37409.1 37625.6 37789.4 38461.8 36732.6 37141.4 37181.6 37592.2 38419.4 31999.4 33158.0 33284.8 33705.0 33753.8 24573.5 24954.6 24981.6 25147.9 25205.4 06:08:43 INFO - PROCESS | 1688 | 06:08:43 INFO - PROCESS | 1688 | [#2] jquery.html Cycles:180 Average:33436.75 Median:1968.83 stddev:96312.88 (4891.9%) stddev-sans-first:96551.07 06:08:43 INFO - PROCESS | 1688 | Values: 376.7 389.9 394.3 397.7 400.7 18526.3 19714.6 20355.5 20810.4 20861.7 11561.1 11938.8 12153.7 12228.3 12250.8 5166.5 5308.8 5333.7 5350.2 5351.4 3122.8 5414.6 5748.0 5756.5 5769.2 5679.5 5741.6 5741.7 5772.1 5791.8 6276.8 6304.9 6307.2 6316.7 6326.6 5244.7 5370.1 5609.4 5674.0 5688.5 12423.8 13233.5 13285.9 13316.6 13409.7 2071.4 2086.1 2123.6 2131.3 2474.1 9687.6 9804.0 9958.9 12831.4 14657.6 1451.9 1696.9 1760.3 1795.9 1813.2 117415.0 122822.0 123680.1 124445.0 125366.4 11406.9 11609.6 11746.5 11783.4 11807.2 14739.0 15041.2 15075.0 15102.6 15141.2 7403.1 8530.8 8647.1 8802.0 8860.8 7114.0 8451.8 8623.0 8640.0 8809.6 3561.0 3843.6 4096.5 4531.7 4628.5 1449.6 1646.9 1958.2 1987.6 1993.4 926.3 971.4 982.0 999.9 1051.3 19471.5 20019.0 20031.7 20251.8 20343.9 957.2 959.8 967.5 999.0 1045.3 10772.2 10941.5 10976.6 10994.0 11030.9 567307.0 569030.0 574185.0 574963.0 584142.0 127602.0 129137.0 130248.0 131672.0 133260.0 1023.5 1035.7 1039.2 1039.6 1050.0 18139.5 18348.8 18500.6 18585.0 18708.5 50844.2 50879.7 51336.2 51503.5 52469.7 57912.4 74424.0 74911.3 75571.2 75905.0 6395.8 6562.4 6667.4 7706.6 7982.2 8381.0 10984.9 11159.7 11776.4 11976.5 9893.8 10023.4 10255.5 10273.5 10305.6 4963.7 6773.4 9838.6 9986.9 10268.5 7838.5 9816.7 10032.9 10098.5 10511.5 6268.6 6473.0 7676.4 7892.9 7918.6 7811.7 8330.0 10126.7 10264.3 10609.7 06:08:43 INFO - PROCESS | 1688 | 06:08:43 INFO - PROCESS | 1688 | [#3] mootools.html Cycles:180 Average:5621.00 Median:4747.28 stddev:3144.61 (66.2%) stddev-sans-first:3138.90 06:08:43 INFO - PROCESS | 1688 | Values: 1598.1 1652.6 1915.7 1982.7 1985.9 6365.1 6992.2 8517.4 8842.8 8848.9 7210.5 8563.7 8592.8 8757.3 8771.6 2423.5 2447.9 2451.2 2458.8 2466.9 2392.9 2428.2 2430.6 2432.5 2441.1 2017.8 2414.5 2436.0 2459.2 2480.2 2419.8 2423.5 2424.3 2441.5 2448.7 2398.8 2417.8 2421.7 2445.1 2448.1 8664.2 8756.5 8804.7 8841.7 8847.9 5276.9 5356.6 5405.8 5469.0 5475.5 3584.8 3619.6 3628.8 3634.6 3666.0 891.4 1026.3 1050.2 1066.4 1078.9 11460.7 11580.0 11584.4 11589.2 11594.5 4634.5 4637.9 4890.3 4898.1 4949.4 9972.6 9975.3 9980.5 9987.1 10046.5 5281.5 5330.5 5373.3 5380.0 5413.1 4459.5 4768.9 4908.6 4914.8 4916.0 3731.3 4075.7 4085.0 4231.9 4234.2 1346.5 1359.2 1362.3 1369.5 1370.9 827.9 899.1 911.0 913.3 915.8 4915.9 5895.8 5903.3 6024.5 6098.3 421.4 433.2 435.5 440.0 445.3 3709.6 3835.5 3976.7 4156.2 4218.8 10491.6 10666.3 10819.8 10841.7 10961.5 10624.2 10629.2 10727.2 10802.2 10808.4 8215.8 8260.3 8281.7 8298.6 8345.4 5800.6 5922.4 6013.5 6160.9 6189.4 9378.7 10030.9 10116.4 10121.9 10157.7 10014.4 10019.5 10027.0 10073.8 10090.2 6802.1 6826.7 7100.8 7437.7 7481.9 7686.5 7704.8 7758.5 7776.4 7777.5 5907.6 6813.7 6894.4 7050.3 7058.8 6808.2 6808.8 6855.8 6941.5 6976.5 6427.0 6435.4 6446.7 6514.8 6527.9 4672.9 4698.5 4733.2 4761.4 4876.3 4725.5 4791.3 4793.1 4826.5 4905.5 06:08:43 INFO - PROCESS | 1688 | 06:08:43 INFO - PROCESS | 1688 | [#4] prototype.html Cycles:180 Average:5344.04 Median:6056.47 stddev:1726.87 (28.5%) stddev-sans-first:1690.03 06:08:43 INFO - PROCESS | 1688 | Values: 319.1 320.4 324.8 329.5 330.0 6212.9 6294.9 6362.0 6367.5 6377.6 4848.4 6229.3 6261.2 6278.2 6296.2 4009.7 4436.3 4523.9 4618.6 4652.0 4403.7 4568.5 4645.7 4665.0 4676.9 4147.1 4262.2 4587.0 4608.7 4621.8 3979.2 4154.6 4214.2 4473.6 4640.5 3573.9 3917.0 3957.9 4005.6 4018.6 6014.7 6022.8 6048.5 6073.8 6100.9 5266.2 5454.2 5465.7 5511.2 5548.1 6608.8 6612.8 6632.9 6636.9 6658.3 3739.9 3839.7 4021.5 4046.2 4485.6 6414.7 6960.5 7029.3 7030.7 7070.3 4044.4 4073.7 4358.9 4562.3 4629.5 4184.8 4359.3 4699.4 4706.6 4741.0 4831.8 5332.3 5489.4 5495.7 5502.9 6087.8 6731.5 6744.6 6750.8 6781.4 1186.9 1369.5 1413.7 1609.2 1628.6 788.0 930.9 1045.8 1082.0 1083.3 5066.4 5545.8 6092.8 6203.5 6293.2 5421.9 5506.3 6518.6 6841.7 6844.8 5197.7 5318.9 5611.4 6010.7 6352.1 3205.0 3476.4 3600.3 3668.0 3673.7 6064.5 6117.0 6756.0 7271.0 7292.6 6428.5 7073.6 7097.8 7164.5 7172.9 6721.6 6890.7 7236.3 7257.0 7295.9 6594.3 6946.6 6981.4 7026.8 7039.6 5804.4 6798.6 6836.2 6870.7 6904.3 7155.7 7243.2 7247.6 7261.3 7279.2 4305.3 4425.0 4442.9 4453.5 4461.7 5758.9 6084.2 6902.0 6913.8 6974.7 6097.9 6676.6 6744.9 6753.6 6761.3 5433.9 6664.1 6699.8 6709.9 6735.5 5710.0 6204.7 6303.1 6547.8 6554.2 5470.3 5810.0 6219.6 6661.9 6663.2 6290.3 6522.6 6530.5 6536.8 6569.7 06:08:43 INFO - PROCESS | 1688 | 06:08:43 INFO - PROCESS | 1688 | [#5] yui.html Cycles:180 Average:18267.12 Median:30260.63 stddev:26491.44 (87.5%) stddev-sans-first:26532.66 06:08:43 INFO - PROCESS | 1688 | Values: 631.3 654.4 663.9 674.5 719.2 12262.3 14837.0 14941.7 15174.0 15176.9 13766.2 13795.9 13833.2 13868.2 15395.0 813.5 862.8 917.1 921.1 922.4 711.6 907.3 907.8 932.5 938.7 961.2 986.4 987.0 987.3 987.4 951.5 971.6 978.6 981.2 982.7 693.6 697.7 718.7 721.7 723.6 15260.1 15395.3 15442.5 15502.2 15530.9 12408.4 12596.1 12596.9 12620.8 12807.0 10155.2 10156.9 10159.6 10182.3 10526.0 2896.9 3364.7 3465.7 3515.1 3561.2 84231.2 84494.2 86401.6 86652.6 87066.0 9396.5 9437.5 9499.7 9547.2 9653.0 21354.3 21415.8 21747.9 21772.6 21781.9 7258.5 7409.5 7421.5 7433.1 7541.9 3922.7 4040.9 4106.2 4113.2 4124.6 3520.5 3609.4 3610.1 3624.9 3637.1 540.7 617.9 670.0 682.2 687.7 537.5 562.5 590.7 597.7 608.6 7879.4 7915.2 8026.4 8085.6 8089.5 567.3 568.4 572.4 580.4 585.3 3818.2 3863.2 3879.6 3907.8 3949.8 93458.0 93535.5 95718.0 95794.0 95941.5 65088.0 87532.7 88883.6 89196.6 89387.0 77491.0 77623.0 77977.0 78301.0 79209.0 6293.7 7501.4 7535.1 7607.8 7732.3 29129.3 32803.8 41202.0 41519.0 41652.0 52592.7 59912.7 61747.4 61942.1 62461.0 8330.9 8534.3 8812.6 10788.7 11042.4 11863.6 11997.8 12095.8 12122.8 12372.4 10561.0 10767.4 11583.5 11602.8 11818.9 11187.3 11391.8 11441.0 11463.5 12381.0 11447.8 11619.0 11642.3 11882.3 11909.5 8717.4 9206.0 9527.6 9538.2 9839.3 9387.2 9483.7 9584.1 10135.5 10320.9 06:08:43 INFO - PROCESS | 1688 | -------- Summary: end -------- 06:08:43 INFO - PROCESS | 1688 | 06:08:43 INFO - TEST-INFO | 1688: exit 0 06:08:43 INFO - TEST-OK | dromaeo_css | took 1112106ms 06:08:43 INFO - TEST-START | kraken 06:08:43 INFO - operating with platform_type : mac_ 06:08:43 INFO - Initialising browser for kraken test... 06:08:43 INFO - TEST-INFO | started process 1810 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpHSjLqR/profile http://localhost:49278/getInfo.html) 06:08:46 INFO - PROCESS | 1810 | __metrics Screen width/height:1600/1200 06:08:46 INFO - PROCESS | 1810 | colorDepth:24 06:08:46 INFO - PROCESS | 1810 | Browser inner width/height: 1024/689 06:08:46 INFO - PROCESS | 1810 | __metrics 06:08:46 ERROR - PROCESS | 1810 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 06:08:47 INFO - TEST-INFO | 1810: exit 0 06:08:47 INFO - Browser initialized. 06:08:47 INFO - Running cycle 1/1 for kraken test... 06:08:47 INFO - TEST-INFO | started process 1813 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/T/tmpHSjLqR/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 06:08:59 INFO - PROCESS | 1813 | RSS: Main: 247857152 06:08:59 INFO - PROCESS | 1813 | 06:09:01 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection) 06:09:02 INFO - PROCESS | 1813 | RSS: Main: 259981312 06:09:02 INFO - PROCESS | 1813 | 06:09:05 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-dft) 06:09:05 INFO - PROCESS | 1813 | RSS: Main: 268816384 06:09:05 INFO - PROCESS | 1813 | 06:09:08 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-fft) 06:09:09 INFO - PROCESS | 1813 | RSS: Main: 272023552 06:09:09 INFO - PROCESS | 1813 | 06:09:11 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator) 06:09:12 INFO - PROCESS | 1813 | RSS: Main: 274026496 06:09:12 INFO - PROCESS | 1813 | 06:09:14 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:09:14 INFO - PROCESS | 1813 | RSS: Main: 274468864 06:09:14 INFO - PROCESS | 1813 | 06:09:17 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom) 06:09:18 INFO - PROCESS | 1813 | RSS: Main: 274911232 06:09:18 INFO - PROCESS | 1813 | 06:09:20 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate) 06:09:21 INFO - PROCESS | 1813 | RSS: Main: 274812928 06:09:21 INFO - PROCESS | 1813 | 06:09:24 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial) 06:09:24 INFO - PROCESS | 1813 | RSS: Main: 274911232 06:09:24 INFO - PROCESS | 1813 | 06:09:26 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:09:27 INFO - PROCESS | 1813 | RSS: Main: 274911232 06:09:27 INFO - PROCESS | 1813 | 06:09:29 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:09:29 INFO - PROCESS | 1813 | RSS: Main: 275062784 06:09:29 INFO - PROCESS | 1813 | 06:09:31 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:09:32 INFO - PROCESS | 1813 | RSS: Main: 275300352 06:09:32 INFO - PROCESS | 1813 | 06:09:35 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:09:36 INFO - PROCESS | 1813 | RSS: Main: 275898368 06:09:36 INFO - PROCESS | 1813 | 06:09:38 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:09:39 INFO - PROCESS | 1813 | RSS: Main: 275464192 06:09:39 INFO - PROCESS | 1813 | 06:09:41 INFO - PROCESS | 1813 | Cycle 1(1): loaded http://localhost:49278/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49278/tests/kraken/driver.html?testName=ai-astar) 06:09:41 INFO - PROCESS | 1813 | RSS: Main: 277188608 06:09:41 INFO - PROCESS | 1813 | 06:09:41 INFO - PROCESS | 1813 | __start_tp_report 06:09:41 INFO - PROCESS | 1813 | _x_x_mozilla_page_load 06:09:41 INFO - PROCESS | 1813 | _x_x_mozilla_page_load_details 06:09:41 INFO - PROCESS | 1813 | |i|pagename|runs| 06:09:41 INFO - PROCESS | 1813 | |0;ai-astar;119;106;114;113;116;126;115;114;124;134 06:09:41 INFO - PROCESS | 1813 | |1;audio-beat-detection;151;125;143;164;125;142;141;123;166;119 06:09:41 INFO - PROCESS | 1813 | |2;audio-dft;195;197;194;205;215;200;198;194;204;199 06:09:41 INFO - PROCESS | 1813 | |3;audio-fft;70;75;81;109;56;56;56;59;146;48 06:09:41 INFO - PROCESS | 1813 | |4;audio-oscillator;78;79;126;79;82;91;163;87;83;123 06:09:41 INFO - PROCESS | 1813 | |5;imaging-gaussian-blur;88;86;88;84;89;84;88;86;88;84 06:09:41 INFO - PROCESS | 1813 | |6;imaging-darkroom;94;94;94;94;94;93;93;96;93;93 06:09:41 INFO - PROCESS | 1813 | |7;imaging-desaturate;91;91;91;89;92;89;105;93;91;92 06:09:41 INFO - PROCESS | 1813 | |8;json-parse-financial;60;62;62;62;60;62;62;81;64;61 06:09:41 INFO - PROCESS | 1813 | |9;json-stringify-tinderbox;62;65;66;66;72;72;68;82;97;99 06:09:41 INFO - PROCESS | 1813 | |10;stanford-crypto-aes;87;104;110;111;85;85;86;84;84;83 06:09:41 INFO - PROCESS | 1813 | |11;stanford-crypto-ccm;140;138;136;163;156;139;137;138;172;145 06:09:41 INFO - PROCESS | 1813 | |12;stanford-crypto-pbkdf2;171;170;170;169;173;175;168;173;170;175 06:09:41 INFO - PROCESS | 1813 | |13;stanford-crypto-sha256-iterative;70;66;71;67;71;70;91;101;103;104 06:09:41 INFO - PROCESS | 1813 | __end_tp_report 06:09:41 INFO - PROCESS | 1813 | __start_cc_report 06:09:41 INFO - PROCESS | 1813 | _x_x_mozilla_cycle_collect,1014 06:09:41 INFO - PROCESS | 1813 | __end_cc_report 06:09:41 INFO - PROCESS | 1813 | __startTimestamp1461330581608__endTimestamp 06:09:41 INFO - PROCESS | 1813 | 06:09:41 INFO - PROCESS | 1813 | ------- Summary: start ------- 06:09:41 INFO - PROCESS | 1813 | Number of tests: 14 06:09:41 INFO - PROCESS | 1813 | 06:09:41 INFO - PROCESS | 1813 | [#0] ai-astar Cycles:10 Average:118.10 Median:117.50 stddev:7.96 (6.8%) stddev-sans-first:8.44 06:09:41 INFO - PROCESS | 1813 | Values: 119.0 106.0 114.0 113.0 116.0 126.0 115.0 114.0 124.0 134.0 06:09:41 INFO - PROCESS | 1813 | 06:09:41 INFO - PROCESS | 1813 | [#1] audio-beat-detection Cycles:10 Average:139.90 Median:142.50 stddev:16.89 (11.9%) stddev-sans-first:17.43 06:09:41 INFO - PROCESS | 1813 | Values: 151.0 125.0 143.0 164.0 125.0 142.0 141.0 123.0 166.0 119.0 06:09:41 INFO - PROCESS | 1813 | 06:09:41 INFO - PROCESS | 1813 | [#2] audio-dft Cycles:10 Average:200.10 Median:199.50 stddev:6.47 (3.2%) stddev-sans-first:6.60 06:09:41 INFO - PROCESS | 1813 | Values: 195.0 197.0 194.0 205.0 215.0 200.0 198.0 194.0 204.0 199.0 06:09:41 INFO - PROCESS | 1813 | 06:09:41 INFO - PROCESS | 1813 | [#3] audio-fft Cycles:10 Average:75.60 Median:57.50 stddev:30.41 (52.9%) stddev-sans-first:32.19 06:09:41 INFO - PROCESS | 1813 | Values: 70.0 75.0 81.0 109.0 56.0 56.0 56.0 59.0 146.0 48.0 06:09:41 INFO - PROCESS | 1813 | 06:09:41 INFO - PROCESS | 1813 | [#4] audio-oscillator Cycles:10 Average:99.10 Median:80.50 stddev:28.66 (35.6%) stddev-sans-first:29.37 06:09:41 INFO - PROCESS | 1813 | Values: 78.0 79.0 126.0 79.0 82.0 91.0 163.0 87.0 83.0 123.0 06:09:41 INFO - PROCESS | 1813 | 06:09:41 INFO - PROCESS | 1813 | [#5] imaging-gaussian-blur Cycles:10 Average:86.50 Median:88.00 stddev:1.96 (2.2%) stddev-sans-first:2.00 06:09:41 INFO - PROCESS | 1813 | Values: 88.0 86.0 88.0 84.0 89.0 84.0 88.0 86.0 88.0 84.0 06:09:41 INFO - PROCESS | 1813 | 06:09:41 INFO - PROCESS | 1813 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.92 (1.0%) stddev-sans-first:0.97 06:09:41 INFO - PROCESS | 1813 | Values: 94.0 94.0 94.0 94.0 94.0 93.0 93.0 96.0 93.0 93.0 06:09:41 INFO - PROCESS | 1813 | 06:09:41 INFO - PROCESS | 1813 | [#7] imaging-desaturate Cycles:10 Average:92.40 Median:91.00 stddev:4.60 (5.1%) stddev-sans-first:4.85 06:09:41 INFO - PROCESS | 1813 | Values: 91.0 91.0 91.0 89.0 92.0 89.0 105.0 93.0 91.0 92.0 06:09:41 INFO - PROCESS | 1813 | 06:09:41 INFO - PROCESS | 1813 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:62.00 stddev:6.22 (10.0%) stddev-sans-first:6.46 06:09:41 INFO - PROCESS | 1813 | Values: 60.0 62.0 62.0 62.0 60.0 62.0 62.0 81.0 64.0 61.0 06:09:41 INFO - PROCESS | 1813 | 06:09:41 INFO - PROCESS | 1813 | [#9] json-stringify-tinderbox Cycles:10 Average:74.90 Median:72.00 stddev:13.36 (18.6%) stddev-sans-first:13.33 06:09:41 INFO - PROCESS | 1813 | Values: 62.0 65.0 66.0 66.0 72.0 72.0 68.0 82.0 97.0 99.0 06:09:41 INFO - PROCESS | 1813 | 06:09:41 INFO - PROCESS | 1813 | [#10] stanford-crypto-aes Cycles:10 Average:91.90 Median:84.50 stddev:11.53 (13.6%) stddev-sans-first:12.09 06:09:41 INFO - PROCESS | 1813 | Values: 87.0 104.0 110.0 111.0 85.0 85.0 86.0 84.0 84.0 83.0 06:09:41 INFO - PROCESS | 1813 | 06:09:41 INFO - PROCESS | 1813 | [#11] stanford-crypto-ccm Cycles:10 Average:146.40 Median:142.50 stddev:12.73 (8.9%) stddev-sans-first:13.29 06:09:41 INFO - PROCESS | 1813 | Values: 140.0 138.0 136.0 163.0 156.0 139.0 137.0 138.0 172.0 145.0 06:09:41 INFO - PROCESS | 1813 | 06:09:41 INFO - PROCESS | 1813 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.40 Median:172.00 stddev:2.46 (1.4%) stddev-sans-first:2.60 06:09:41 INFO - PROCESS | 1813 | Values: 171.0 170.0 170.0 169.0 173.0 175.0 168.0 173.0 170.0 175.0 06:09:41 INFO - PROCESS | 1813 | 06:09:41 INFO - PROCESS | 1813 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:81.40 Median:70.00 stddev:16.24 (23.2%) stddev-sans-first:16.70 06:09:41 INFO - PROCESS | 1813 | Values: 70.0 66.0 71.0 67.0 71.0 70.0 91.0 101.0 103.0 104.0 06:09:41 INFO - PROCESS | 1813 | -------- Summary: end -------- 06:09:41 INFO - PROCESS | 1813 | 06:09:42 INFO - TEST-INFO | 1813: exit 0 06:09:42 INFO - TEST-OK | kraken | took 58769ms 06:09:42 INFO - SUITE-END | took 1170s 06:09:42 INFO - Completed test suite (00:19:31) 06:09:42 INFO - javascript benchmark 06:09:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3477.095955051687, 3517.6130625631176, 3519.8064106474144, 3525.78845269284, 3568.446890731936, 5649.689267090308, 5656.095024796034, 5703.429657034295, 5704.971475142618, 5708.257926469559, 5659.896320217559, 5734.225879506265, 5816.302043754745, 5844.766209351621, 5965.4929331006915, 4591.357209990604, 5113.951639913808, 5172.04317201318, 5210.452902445246, 5224.320838291036, 384.50273580689327, 5212.087884620195, 5258.13240815265, 5269.920951185716, 5301.284326615896, 4360.781960901958, 5174.249733788598, 5176.7411629418375, 5197.350331208599, 5267.26258323835, 5184.611154163453, 5264.736763161826, 5271.868203294948, 5285.86785330366, 5291.259223708684, 5190.844274671766, 5214.608904332153, 5217.608679349026, 5243.711595862226, 5317.2821669074565, 5675.9432405675825, 5756.424357564252, 5778.59549831512, 5793.7392817323325, 5819.7672093116225, 6154.169187159721, 6176.567640265183, 6211.627302361872, 6244.937550624481, 6268.937310626881, 6234.719437625317, 6245.531585131133, 6266.091416744546, 6292.741451709677, 6299.527535434815, 6004.249468816354, 6006.609570377911, 6008.909866352008, 6029.703613723071, 6051.334353221142, 6215.502759779297, 6303.842403939847, 6357.554971151975, 6367.172267605274, 6413.262474815363, 5481.835544933659, 5984.222051133412, 6253.1245625612455, 6257.749690012349, 6258.405451482102, 6156.753729850845, 6248.156498872685, 6257.311695713468, 6278.4035516625845, 6290.622562646256, 5910.468057874812, 6160.291566469913, 6178.011518157074, 6222.097795819581, 6259.749610015549, 5283.52448279649, 6169.2288463942, 6229.626222426669, 6242.969909964805, 6243.594166379171, 4975.0, 5014.07239660664, 5018.774155163026, 5022.196448568212, 5036.370453693288, 3622.623403106855, 4415.51429342772, 4487.551244875486, 4556.977215113903, 4567.018091110427, 5966.671833049137, 5991.430814072656, 6005.759769609254, 6011.9699401503585, 6032.698365081728, 6313.179286692701, 6313.905291420632, 6318.842028949313, 6331.746730130835, 6337.841553961096, 5808.186853840466, 5989.8203053908455, 6055.7274922628585, 6076.3316035236085, 6118.265808103056, 4274.636655884285, 4655.37152484417, 4971.806766376116, 5504.834854954358, 5523.585731070106, 5444.265024221759, 6387.393197646216, 6548.8362790930605, 6550.213974323112, 6554.63949482783, 6205.751769929152, 6267.96866015667, 6328.778492752732, 6364.840878978062, 6406.583572067801, 6498.675066246574, 6519.608823470607, 6532.379423954717, 6556.704948277244, 6585.3085426029575, 6085.6348619083, 6167.5374346925055, 6246.281677607133, 6247.31279559239, 6257.2804127525915, 5277.920831187458, 5893.292804863444, 6257.342978987141, 6281.780137695158, 6344.524160687874, 6220.502359811114, 6222.719977600928, 6233.348162736787, 6238.594491358047, 6244.188255526752, 5988.011978023752, 6083.543734219863, 6100.389961003864, 6198.411150940653, 6218.19163508741, 5106.974465127651, 6006.459418652343, 6063.605370764837, 6066.363031881765, 6126.908096378469, 6112.205413296243, 6150.938490615036, 6175.6912154393, 6232.470240029467, 6233.781817636361, 6005.669688167192, 6053.909191362045, 6105.574307455683, 6115.936978868401, 6153.261608606996], "value": 5693.105133332945, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.6556808586119, 515.3841159814021, 518.2770035800056, 526.3920172201107, 554.082992647169, 33149.66850331496, 36759.63240367602, 36913.26173476529, 36973.0, 36983.815080924556, 38884.61115388845, 39270.8036459818, 39396.212075758536, 39497.40753888694, 39572.40641390382, 9318.86021709675, 9440.433573985583, 9480.241580673564, 9574.425534467955, 9575.329726919119, 9414.152726254635, 9577.425354478719, 9623.1820295275, 9662.710118696416, 9670.468124253162, 9603.279754018442, 9612.807743845118, 9643.903560964405, 9687.225021998223, 9721.805563888718, 9626.711198664052, 9643.951780241088, 9706.563204655808, 9710.854337184948, 9744.366616169962, 9536.0, 9541.761455963657, 9542.188913942324, 9632.27757918159, 9677.225821934227, 37955.240895181945, 37972.81013594914, 38206.23587528234, 38307.80846095779, 38432.423513647314, 2805.186495916202, 3002.4445477586496, 3005.068428787083, 3191.4255434021866, 3442.6729460701445, 22213.44466388337, 24939.376515587075, 26808.92764289426, 27110.915563377443, 27503.0, 1922.903854807254, 2567.82025258232, 2608.232700928942, 2642.2733748219202, 2649.231722800386, 373204.0, 373791.0, 375292.0, 376858.0, 377789.0, 34071.0, 34172.97481075572, 34399.79600713963, 34408.827955860565, 34425.65574344224, 67057.32942670608, 67351.0, 68600.6569967157, 69182.0, 69203.65398172977, 16476.6704665906, 16671.41650042267, 16922.83077169237, 16937.0, 17009.574760631083, 12836.486540538273, 12841.202231687572, 12896.419661115273, 12938.094333396572, 12972.481100756053, 19073.232310632487, 19140.234390624497, 19383.612327753366, 19515.90242048809, 19560.315388961604, 8069.878951815727, 8134.471259368122, 8142.226488483585, 8200.876986845202, 8303.252707256375, 1000.7190795781412, 1012.281280290987, 1031.9277650564538, 1109.5755773634635, 1119.4775105856029, 27800.860995694893, 29591.556126658117, 29673.554896676567, 30118.247043824078, 30300.69699303023, 1064.6433444795925, 1076.3488089705772, 1092.0499165725869, 1106.6097229983197, 1122.3669560789033, 14485.058471199338, 14694.0, 14748.487225739338, 14773.40906363755, 14855.405783768529, 619639.0, 619670.0, 628275.0, 631168.0, 632267.0, 55915.0, 56621.0, 57304.713476433186, 57330.71334643383, 58316.54208644818, 1431.77807439847, 1448.5075074474519, 1474.6165996840898, 1478.3125846481437, 1485.0792508644709, 27907.860460697568, 28120.43759124847, 28702.85648571744, 28794.568081478377, 28813.71186288194, 47841.0, 49196.0, 49206.0, 49798.50201498083, 49864.75338116576, 562638.0, 572850.0, 576927.0, 577380.0, 579520.0, 26290.4741905157, 26699.466010680066, 26849.597256041565, 27138.864305679133, 27140.864295678395, 44231.33652995272, 45534.772326138154, 46041.848953776425, 46247.306290404995, 46507.30239046484, 37780.62219377771, 37878.0, 37936.051598710255, 38614.80692596519, 38850.2229955405, 36407.54942482881, 37409.06477338088, 37625.62374376331, 37789.43315850209, 38461.80769096137, 36732.632673672924, 37141.44287835739, 37181.62818371782, 37592.24815503729, 38419.42370864384, 31999.36017275369, 33158.0, 33284.83503077381, 33705.0, 33753.83123084369, 24573.50852982966, 24954.62568061517, 24981.625275620518, 25147.87426062858, 25205.369865753502], "value": 19199.472414998832, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.6817039601536, 389.9025243689078, 394.3434182086825, 397.681854516387, 400.6634427081251, 18526.258949642015, 19714.60570788587, 20355.49111272219, 20810.375688729342, 20861.687074693873, 11561.132915031385, 11938.82091768622, 12153.696157596065, 12228.327441990687, 12250.816237756419, 5166.50171450279, 5308.840734777944, 5333.653312534692, 5350.197470379435, 5351.411344752074, 3122.7970181938217, 5414.620976531644, 5747.994101032324, 5756.539476841864, 5769.249997500319, 5679.460451257145, 5741.626794258381, 5741.655500669973, 5772.134179873032, 5791.797287094932, 6276.811695649138, 6304.905426418607, 6307.243130824308, 6316.715747791361, 6326.620402775825, 5244.688827793052, 5370.087085195526, 5609.382967873531, 5673.971630141823, 5688.516476099537, 12423.75152496945, 13233.470661173542, 13285.933570332087, 13316.600501984956, 13409.66475838102, 2071.440711008019, 2086.113401804227, 2123.6177488052144, 2131.28601918356, 2474.134053081425, 9687.564059617334, 9804.0, 9958.90041099587, 12831.422585983653, 14657.56027319182, 1451.9419223231057, 1696.9066701331421, 1760.3222759237658, 1795.9281628734834, 1813.1931290575699, 117415.0, 122822.0, 123680.1447978281, 124445.0, 125366.3731681345, 11406.885931140583, 11609.593664221711, 11746.471408786454, 11783.351915644722, 11807.232529885701, 14739.0, 15041.247937603077, 15075.0, 15102.622434439227, 15141.242937853063, 7403.111626604842, 8530.763039359259, 8647.092055334226, 8802.03177650458, 8860.778480537909, 7114.004039434483, 8451.788705282417, 8622.956885215659, 8639.95680021596, 8809.559522023874, 3560.9821950890077, 3843.615638436134, 4096.528899176573, 4531.728096314232, 4628.514006029386, 1449.5504495504495, 1646.8929519581188, 1958.177565422526, 1987.602479504105, 1993.4019794061724, 926.346925417579, 971.4171497101682, 982.0, 999.9250056245811, 1051.2759075116815, 19471.513212169524, 20019.0, 20031.699524507145, 20251.797482025286, 20343.898280508503, 957.2342126298932, 959.7504648791364, 967.5148646827228, 998.960041598328, 1045.3466583385384, 10772.24594278393, 10941.463122366258, 10976.640022395224, 10993.955574220436, 11030.944845275882, 567307.0, 569030.0, 574185.0, 574963.0, 584142.0, 127602.0, 129137.0, 130248.0, 131672.0, 133260.0, 1023.5496381592225, 1035.6530562261726, 1039.2465462539599, 1039.60495011895, 1049.968500944973, 18139.45581632553, 18348.81651183471, 18500.629987400447, 18585.0, 18708.532286692942, 50844.23733643924, 50879.74560127176, 51336.229956551426, 51503.484965149866, 52469.7376513115, 57912.4208757907, 74424.0, 74911.25088749261, 75571.24428755642, 75905.0, 6395.776147834989, 6562.442192413699, 6667.399934005963, 7706.614669266626, 7982.201779821971, 8380.958095209486, 10984.890151098387, 11159.665210043711, 11776.352300623548, 11976.46105925218, 9893.752656183653, 10023.398596084258, 10255.538500767334, 10273.486325683836, 10305.587776488857, 4963.726995015309, 6773.424258938046, 9838.557264923238, 9986.850197246902, 10268.486575671335, 7838.490498117604, 9816.65641702537, 10032.949835250776, 10098.495075246356, 10511.474426278503, 6268.561200716089, 6473.0, 7676.424268179797, 7892.894994700861, 7918.643661035382, 7811.7265895695655, 8330.0, 10126.746831329276, 10264.332818366782, 10609.681709548726], "value": 8911.483423826287, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1598.0970751525388, 1652.6281586643006, 1915.7222202780597, 1982.6728589782686, 1985.9007049647514, 6365.108884756138, 6992.195897471793, 8517.403781735282, 8842.823143537125, 8848.911510884882, 7210.531315464491, 8563.700270490534, 8592.785180370494, 8757.255633271163, 8771.649134034631, 2423.503181847726, 2447.9388015299583, 2451.2278632230878, 2458.791002764758, 2466.8766561671932, 2392.8599667905382, 2428.2108314797674, 2430.6111022236446, 2432.5134973005383, 2441.084593277521, 2017.788132246115, 2414.4808866093786, 2435.9512809743796, 2459.225344016638, 2480.193936970483, 2419.758024197584, 2423.5395274897714, 2424.260600516842, 2441.511697660475, 2448.7428819973825, 2398.8200884933526, 2417.830751847371, 2421.673074134987, 2445.09531473356, 2448.081969261527, 8664.220220180214, 8756.518391488466, 8804.735857924272, 8841.734747957571, 8847.867281990775, 5276.894462110775, 5356.571474282087, 5405.783768649249, 5468.9726551367385, 5475.534579560742, 3584.8028358440274, 3619.565652121736, 3628.8004159771203, 3634.5638523377365, 3666.0020288942324, 891.38494438837, 1026.2662196529443, 1050.2438244463974, 1066.4294602387686, 1078.8705355357408, 11460.656180314603, 11579.957803797615, 11584.420778961103, 11589.188756787029, 11594.536218551248, 4634.513376095529, 4637.884052898705, 4890.315355850184, 4898.093852637274, 4949.406071271471, 9972.60109595608, 9975.25185611082, 9980.451075190935, 9987.051230133126, 10046.497675116216, 5281.498257665516, 5330.546903513167, 5373.301470808769, 5379.973100134474, 5413.052715774724, 4459.531749166355, 4768.880777980578, 4908.631852611068, 4914.8034078637165, 4916.016796640686, 3731.2910546995986, 4075.694322925792, 4084.999175202035, 4231.87304380869, 4234.174336004511, 1346.4748747988292, 1359.2456186816412, 1362.346073884541, 1369.500132451668, 1370.9451621935011, 827.9379046571531, 899.105390136805, 911.0343036381457, 913.3241401362943, 915.8259930613162, 4915.852524424273, 5895.823125306248, 5903.26209223847, 6024.4879185268865, 6098.298695649968, 421.3784667615243, 433.1596702397339, 435.4730775761364, 439.95820397062226, 445.2541992163114, 3709.5919448860604, 3835.520559930009, 3976.721629485908, 4156.204605470079, 4218.7679677618025, 10491.632792852213, 10666.306690065276, 10819.78360432787, 10841.67474975752, 10961.451927403758, 10624.150067994542, 10629.202809789142, 10727.249092563601, 10802.189835762349, 10808.351498910091, 8215.753527394068, 8260.256576908107, 8281.710140144945, 8298.585070746438, 8345.374096942754, 5800.622959507618, 5922.407759224043, 6013.488853447506, 6160.876782464236, 6189.35011823752, 9378.718638440858, 10030.899691002996, 10116.443595602312, 10121.898781012096, 10157.746056348651, 10014.449205293779, 10019.499025048573, 10026.997300269915, 10073.848892266475, 10090.2432317575, 6802.115724955724, 6826.692798823966, 7100.751473698602, 7437.702491900263, 7481.850362992601, 7686.500377475446, 7704.768856934301, 7758.534487930742, 7776.377889768918, 7777.533347999138, 5907.645541267538, 6813.659317034228, 6894.448444124559, 7050.294970502909, 7058.752943646948, 6808.183018037867, 6808.82977925536, 6855.828604284933, 6941.47938904574, 6976.5465244758925, 6427.0, 6435.356464353527, 6446.677666116581, 6514.804555863332, 6527.902081468686, 4672.9299060514795, 4698.483166851575, 4733.1716949533, 4761.381020467317, 4876.317315575893, 4725.480197178239, 4791.305260737243, 4793.065352256276, 4826.517348265286, 4905.48492408292], "value": 4476.257606247827, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [319.1033196717225, 320.43603258265455, 324.8116092666254, 329.5386458957459, 329.99340013199753, 6212.937870621293, 6294.874102517947, 6362.0, 6367.490600751946, 6377.617342959414, 4848.406102735037, 6229.314775374705, 6261.217347831521, 6278.152449419327, 6296.212973378328, 4009.739366941154, 4436.268015777393, 4523.909521809562, 4618.584327410533, 4651.953480465186, 4403.700908232079, 4568.5203053679215, 4645.746812795791, 4665.043666048452, 4676.883077923045, 4147.066909945253, 4262.23117406276, 4587.0, 4608.677392582521, 4621.8151273949, 3979.2240513099955, 4154.605312495308, 4214.199302132585, 4473.642108631302, 4640.535946405366, 3573.857045718168, 3916.962005068659, 3957.8522228553684, 4005.559388467266, 4018.618231268025, 6014.699265036731, 6022.795440911836, 6048.485878700316, 6073.848153796146, 6100.908486372708, 5266.236395722637, 5454.154606036071, 5465.72671366434, 5511.173324001392, 5548.056830338812, 6608.801735947929, 6612.834679133012, 6632.93367066328, 6636.900446493258, 6658.334166583351, 3739.8504059837574, 3839.6928245740273, 4021.477207962975, 4046.2312160689376, 4485.551444855521, 6414.717056588701, 6960.547564408348, 7029.297070292981, 7030.718771249144, 7070.257622949619, 4044.4135600338373, 4073.6537394321813, 4358.912821743547, 4562.270036794097, 4629.490756016836, 4184.790760461965, 4359.258925982591, 4699.436067671902, 4706.552877476634, 4740.952590474051, 4831.806727730922, 5332.306800116037, 5489.4236105209175, 5495.697736624444, 5502.936398850431, 6087.847803804941, 6731.495137864582, 6744.62904540255, 6750.76372326976, 6781.355771201728, 1186.9228500147462, 1369.452219112363, 1413.7064585903784, 1609.1551935234095, 1628.6172749403881, 787.9763607091681, 930.8643454984907, 1045.7856139491387, 1082.0207712020633, 1083.2613655083635, 5066.417362003343, 5545.807651354978, 6092.847678807977, 6203.503719702413, 6293.244810622755, 5421.945780542144, 5506.284183056177, 6518.641474718936, 6841.655548726495, 6844.760433384808, 5197.7401129943355, 5318.936212757464, 5611.354694210137, 6010.729517171738, 6352.110704501373, 3204.967950320467, 3476.42638964568, 3600.3159399714496, 3667.9816600916824, 3673.669369756735, 6064.454199122012, 6116.969415152896, 6755.986602009738, 7270.9820625112525, 7292.635368231568, 6428.453581445536, 7073.575585464786, 7097.751578694721, 7164.498485106097, 7172.892406613905, 6721.630310332978, 6890.655467226618, 7236.276372362721, 7256.963715181496, 7295.9056141579185, 6594.307597702172, 6946.6179360135675, 6981.406580440516, 7026.824329391806, 7039.612821294878, 5804.374775062989, 6798.600699650175, 6836.213835408992, 6870.690818913061, 6904.3095690430555, 7155.749548765768, 7243.167035790952, 7247.637618119178, 7261.3101755333155, 7279.235680253497, 4305.277888844487, 4424.977875110604, 4442.8667139985855, 4453.465584129925, 4461.687681862239, 5758.942410575841, 6084.239470066242, 6901.965490172517, 6913.792586222421, 6974.721011159497, 6097.939020609737, 6676.566023208476, 6744.898826517508, 6753.594784312957, 6761.290064543152, 5433.864153396196, 6664.135181317568, 6699.832504187434, 6709.865802684017, 6735.4611631070375, 5710.029295019774, 6204.72078756448, 6303.149074874833, 6547.803565893031, 6554.180727409074, 5470.288862447856, 5810.0, 6219.605451901141, 6661.900071499028, 6663.233728121328, 6290.276618188784, 6522.6412547308455, 6530.510211734234, 6536.803895883131, 6569.671516424255], "value": 4775.277487663704, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [631.3087169549342, 654.3619970528732, 663.8805015097282, 674.4840197249104, 719.151401346411, 12262.264264144158, 14837.035592686469, 14941.701165976701, 15174.0, 15176.924115379436, 13766.174029558233, 13795.862041379583, 13833.239171845544, 13868.16790992541, 15394.999325043864, 813.4549851599413, 862.8360611483829, 917.0645941140033, 921.1249313152498, 922.3543519536317, 711.6015031582331, 907.2605826251616, 907.8138981508807, 932.5383934952174, 938.6714649872558, 961.2022021721954, 986.3637953519975, 987.0474991633073, 987.328616540752, 987.3680844259679, 951.46242373059, 971.6016433262364, 978.5938835383307, 981.1807141037278, 982.7150126463317, 693.6185098196022, 697.7453229571221, 718.7161071376829, 721.7473884140561, 723.5586292361655, 15260.084394936339, 15395.307211175525, 15442.45951391707, 15502.22488875563, 15530.922345388313, 12408.379581020912, 12596.118271720983, 12596.937015314956, 12620.81068783969, 12807.039472039634, 10155.238357123171, 10156.94921525395, 10159.647316385575, 10182.28723989321, 10526.0, 2896.9130926072253, 3364.66353364664, 3465.7054150396993, 3515.0685068456623, 3561.165999510254, 84231.15768842294, 84494.15505844925, 86401.56799215963, 86652.56673716591, 87066.0, 9396.483193424427, 9437.528123593793, 9499.667511637059, 9547.188488978376, 9653.0, 21354.252601158885, 21415.822129783013, 21747.891260543594, 21772.56454870894, 21781.891090544763, 7258.455615828729, 7409.481336306515, 7421.480496365202, 7433.10802703679, 7541.886871696929, 3922.725409221327, 4040.8585699500377, 4106.199291138199, 4113.239050775616, 4124.566920473367, 3520.471929210639, 3609.4044482660593, 3610.097475631092, 3624.927501450009, 3637.1452708613456, 540.7188262103684, 617.8949578571563, 669.9564528305644, 682.2495255219219, 687.6939761806049, 537.5028099008401, 562.4572287742349, 590.6544671367299, 597.7429705226707, 608.5679167790829, 7879.369650427952, 7915.248051435105, 8026.398020148512, 8085.636146373427, 8089.514629122272, 567.3163837575711, 568.4457653787607, 572.378968818828, 580.3673995345094, 585.3385674188225, 3818.236352729465, 3863.16941857502, 3879.631435013669, 3907.8046097695, 3949.782761948063, 93458.0, 93535.53232233795, 95718.04281957091, 95794.0, 95941.5202923981, 65088.0, 87532.6870096949, 88883.55558222297, 89196.5540172295, 89387.0, 77491.0, 77623.0, 77977.0, 78301.0, 79209.0, 6293.685315734287, 7501.437392195498, 7535.13345965221, 7607.771766846782, 7732.265434783912, 29129.271768205963, 32803.835980819946, 41202.0, 41519.0, 41652.0, 52592.737036314575, 59912.70043649754, 61747.382526174166, 61942.0708689379, 62461.0, 8330.875036874573, 8534.31725461974, 8812.603432845666, 10788.730281743019, 11042.447877606248, 11863.58477453285, 11997.820032699341, 12095.75808483843, 12122.757544848877, 12372.443240054039, 10560.996705312982, 10767.426189822494, 11583.536658533565, 11602.76794464123, 11818.881811182122, 11187.32876027441, 11391.772164556829, 11441.0, 11463.541458341906, 12381.0, 11447.828282575601, 11619.01238394746, 11642.301461912313, 11882.346470944181, 11909.464074116513, 8717.433366831136, 9206.026159688321, 9527.618895244113, 9538.189253913217, 9839.262055345735, 9387.202087822612, 9483.715488535356, 9584.137427631547, 10135.45072396058, 10320.896791031993], "value": 6815.060171043361, "unit": "score"}], "name": "dromaeo_css", "value": 7222.1815372839, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 106.0, 114.0, 113.0, 116.0, 126.0, 115.0, 114.0, 124.0, 134.0], "value": 118.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 143.0, 164.0, 125.0, 142.0, 141.0, 123.0, 166.0, 119.0], "value": 139.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [195.0, 197.0, 194.0, 205.0, 215.0, 200.0, 198.0, 194.0, 204.0, 199.0], "value": 200.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 75.0, 81.0, 109.0, 56.0, 56.0, 56.0, 59.0, 146.0, 48.0], "value": 75.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 126.0, 79.0, 82.0, 91.0, 163.0, 87.0, 83.0, 123.0], "value": 99.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 86.0, 88.0, 84.0, 89.0, 84.0, 88.0, 86.0, 88.0, 84.0], "value": 86.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 94.0, 93.0, 93.0, 96.0, 93.0, 93.0], "value": 93.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 91.0, 91.0, 89.0, 92.0, 89.0, 105.0, 93.0, 91.0, 92.0], "value": 92.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 62.0, 62.0, 62.0, 60.0, 62.0, 62.0, 81.0, 64.0, 61.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 66.0, 66.0, 72.0, 72.0, 68.0, 82.0, 97.0, 99.0], "value": 74.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 104.0, 110.0, 111.0, 85.0, 85.0, 86.0, 84.0, 84.0, 83.0], "value": 91.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 138.0, 136.0, 163.0, 156.0, 139.0, 137.0, 138.0, 172.0, 145.0], "value": 146.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 170.0, 170.0, 169.0, 173.0, 175.0, 168.0, 173.0, 170.0, 175.0], "value": 171.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 66.0, 71.0, 67.0, 71.0, 70.0, 91.0, 101.0, 103.0, 104.0], "value": 81.4, "unit": "score"}], "name": "kraken", "value": 1535.1000000000004, "alertThreshold": 2.0}]} 06:09:42 INFO - Return code: 0 06:09:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:09:42 ERROR - # TBPL SUCCESS # 06:09:42 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 06:09:42 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 06:09:42 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 06:09:42 INFO - 2016-04-22 06:09:42.878 screenresolution[1824:10627] starting screenresolution argv=screenresolution get 06:09:42 INFO - 2016-04-22 06:09:42.881 screenresolution[1824:10627] Display 0: 1600x1200x32@60 06:09:42 INFO - 2016-04-22 06:09:42.886 screenresolution[1825:10630] starting screenresolution argv=screenresolution list 06:09:42 INFO - Available Modes on Display 0 06:09:42 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 06:09:42 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 06:09:42 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 06:09:42 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 06:09:43 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 06:09:43 INFO - Intel Iris: 06:09:43 INFO - Chipset Model: Intel Iris 06:09:43 INFO - Type: GPU 06:09:43 INFO - Bus: Built-In 06:09:43 INFO - VRAM (Dynamic, Max): 1536 MB 06:09:43 INFO - Vendor: Intel (0x8086) 06:09:43 INFO - Device ID: 0x0a2e 06:09:43 INFO - Revision ID: 0x0009 06:09:43 INFO - Displays: 06:09:43 INFO - Display: 06:09:43 INFO - Resolution: 1600 x 1200 @ 60 Hz 06:09:43 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 06:09:43 INFO - Display Serial Number: 1600x1200 60 06:09:43 INFO - Main Display: Yes 06:09:43 INFO - Mirror: Off 06:09:43 INFO - Online: Yes 06:09:43 INFO - Rotation: Supported 06:09:43 INFO - Return code: 0 06:09:43 INFO - Running post-action listener: _resource_record_post_action 06:09:43 INFO - Running post-run listener: _resource_record_post_run 06:09:44 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 38012416; Write bytes: 699372032; Read time: 399; Write time: 2378 06:09:44 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 388254208; Write bytes: 382150144; Read time: 28470; Write time: 673 06:09:44 INFO - run-tests - Wall time: 1173s; CPU: 54.0%; Read bytes: 36181504; Write bytes: 301677568; Read time: 373; Write time: 1667 06:09:44 INFO - Running post-run listener: _upload_blobber_files 06:09:44 INFO - Blob upload gear active. 06:09:44 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 06:09:44 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 06:09:44 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 06:09:44 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 06:09:44 INFO - (blobuploader) - INFO - Open directory for files ... 06:09:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 06:09:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 06:09:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:45 INFO - (blobuploader) - INFO - Done attempting. 06:09:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 06:09:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 06:09:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 06:09:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 06:09:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 06:09:46 INFO - (blobuploader) - INFO - Done attempting. 06:09:46 INFO - (blobuploader) - INFO - Iteration through files over. 06:09:46 INFO - Return code: 0 06:09:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 06:09:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 06:09:46 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d77e173fa1e4ac4058d5ebee33bfc2a652f7475f5a91a40564b581fb8abea823922f71a3080a32ea4d095de16e6ef576fb29f4d9e57c56a52149f0b03e07b66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9daef5f5e347a209e3fd58474fc829d37d6deadb1c5470036a215ab790dbd4ed6ac36b6c877cfd7dd4cf355b62f6669a42c1bd245d3165c3b115498e3ae5770d"} 06:09:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 06:09:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 06:09:46 INFO - Contents: 06:09:46 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d77e173fa1e4ac4058d5ebee33bfc2a652f7475f5a91a40564b581fb8abea823922f71a3080a32ea4d095de16e6ef576fb29f4d9e57c56a52149f0b03e07b66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9daef5f5e347a209e3fd58474fc829d37d6deadb1c5470036a215ab790dbd4ed6ac36b6c877cfd7dd4cf355b62f6669a42c1bd245d3165c3b115498e3ae5770d"} 06:09:46 INFO - Running post-run listener: copy_logs_to_upload_dir 06:09:46 INFO - Copying logs to upload dir... 06:09:46 INFO - mkdir: /builds/slave/test/build/upload/logs 06:09:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.513925 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-22 06:09:46.924793) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:09:46.933200) ========= 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.LDv0UAdT18/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.9miB4wlnMv/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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/Fx-Team/sha512/6d77e173fa1e4ac4058d5ebee33bfc2a652f7475f5a91a40564b581fb8abea823922f71a3080a32ea4d095de16e6ef576fb29f4d9e57c56a52149f0b03e07b66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9daef5f5e347a209e3fd58474fc829d37d6deadb1c5470036a215ab790dbd4ed6ac36b6c877cfd7dd4cf355b62f6669a42c1bd245d3165c3b115498e3ae5770d"} build_url:https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011058 build_url: 'https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6d77e173fa1e4ac4058d5ebee33bfc2a652f7475f5a91a40564b581fb8abea823922f71a3080a32ea4d095de16e6ef576fb29f4d9e57c56a52149f0b03e07b66", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9daef5f5e347a209e3fd58474fc829d37d6deadb1c5470036a215ab790dbd4ed6ac36b6c877cfd7dd4cf355b62f6669a42c1bd245d3165c3b115498e3ae5770d"}' ========= master_lag: 0.09 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-22 06:09:47.031648) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:09:47.032044) ========= 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.LDv0UAdT18/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.9miB4wlnMv/Listeners TMPDIR=/var/folders/6q/y_pvszzd4sd4pdvxdygmrt4r00000w/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.004996 ========= master_lag: 0.03 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-22 06:09:47.063104) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:09:47.063419) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-22 06:09:47.063860) ========= ========= Total master_lag: 0.22 =========