builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0162 starttime: 1461135877.08 results: success (0) buildid: 20160419230832 builduid: 1ab072c2db0d4b259b7f46e10e93ac05 revision: d42b25947fc26a0f9eab98d631465b72769553bd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 00:04:37.083491) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 00:04:37.083958) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 00:04:37.084873) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 00:04:37.118243) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 00:04:37.118640) ========= 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.roIxPCGgCA/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.GCR5jqT8YK/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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-20 00:04:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2016-04-20 00:04:37 (161 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.577520 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 00:04:37.714267) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 00:04:37.714580) ========= 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.roIxPCGgCA/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.GCR5jqT8YK/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.019974 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 00:04:37.763610) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 00:04:37.764067) ========= 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.roIxPCGgCA/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.GCR5jqT8YK/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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-20 00:04:37,839 truncating revision to first 12 chars 2016-04-20 00:04:37,839 Setting DEBUG logging. 2016-04-20 00:04:37,839 attempt 1/10 2016-04-20 00:04:37,839 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-20 00:04:38,582 unpacking tar archive at: fx-team-d42b25947fc2/testing/mozharness/ program finished with exit code 0 elapsedTime=0.997342 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 00:04:38.780859) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 00:04:38.781192) ========= script_repo_revision: d42b25947fc26a0f9eab98d631465b72769553bd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 00:04:38.781600) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 00:04:38.781942) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 00:04:38.796308) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-20 00:04:38.796675) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.roIxPCGgCA/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.GCR5jqT8YK/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 00:04:38 INFO - MultiFileLogger online at 20160420 00:04:38 in /builds/slave/test 00:04:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 00:04:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:04:38 INFO - {'append_to_log': False, 00:04:38 INFO - 'base_work_dir': '/builds/slave/test', 00:04:38 INFO - 'blob_upload_branch': 'Fx-Team', 00:04:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:04:38 INFO - 'branch': 'Fx-Team', 00:04:38 INFO - 'buildbot_json_path': 'buildprops.json', 00:04:38 INFO - 'config_files': ('talos/mac_config.py',), 00:04:38 INFO - 'default_actions': ('clobber', 00:04:38 INFO - 'read-buildbot-config', 00:04:38 INFO - 'download-and-extract', 00:04:38 INFO - 'populate-webroot', 00:04:38 INFO - 'create-virtualenv', 00:04:38 INFO - 'install', 00:04:38 INFO - 'run-tests'), 00:04:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:04:38 INFO - 'download_minidump_stackwalk': True, 00:04:38 INFO - 'download_symbols': 'ondemand', 00:04:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:04:38 INFO - 'tooltool.py': '/tools/tooltool.py', 00:04:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:04:38 INFO - '/tools/misc-python/virtualenv.py')}, 00:04:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:04:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:04:38 INFO - 'installer_path': 'installer.exe', 00:04:38 INFO - 'log_level': 'info', 00:04:38 INFO - 'log_name': 'talos', 00:04:38 INFO - 'log_to_console': True, 00:04:38 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 00:04:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 00:04:38 INFO - 'opt_config_files': (), 00:04:38 INFO - 'pip_index': False, 00:04:38 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:04:38 INFO - 'cmd': ('bash', 00:04:38 INFO - '-c', 00:04:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:04:38 INFO - 'enabled': True, 00:04:38 INFO - 'halt_on_failure': False, 00:04:38 INFO - 'name': 'check_screen_resolution'},), 00:04:38 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 00:04:38 INFO - 'cmd': ('bash', 00:04:38 INFO - '-c', 00:04:38 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 00:04:38 INFO - 'enabled': True, 00:04:38 INFO - 'halt_on_failure': False, 00:04:38 INFO - 'name': 'check_screen_resolution'},), 00:04:38 INFO - 'run_cmd_checks_enabled': True, 00:04:38 INFO - 'sps_profile': False, 00:04:38 INFO - 'sps_profile_interval': 0, 00:04:38 INFO - 'suite': 'dromaeojs', 00:04:38 INFO - 'system_bits': '32', 00:04:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:04:38 INFO - 'title': 't-yosemite-r7-0162', 00:04:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:04:38 INFO - 'use_talos_json': True, 00:04:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:04:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:04:38 INFO - 'work_dir': 'build'} 00:04:38 INFO - ##### 00:04:38 INFO - ##### Running clobber step. 00:04:38 INFO - ##### 00:04:38 INFO - Running pre-action listener: _resource_record_pre_action 00:04:38 INFO - Running main action method: clobber 00:04:38 INFO - rmtree: /builds/slave/test/build 00:04:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:04:41 INFO - Running post-action listener: _resource_record_post_action 00:04:41 INFO - ##### 00:04:41 INFO - ##### Running read-buildbot-config step. 00:04:41 INFO - ##### 00:04:41 INFO - Running pre-action listener: _resource_record_pre_action 00:04:41 INFO - Running main action method: read_buildbot_config 00:04:41 INFO - Using buildbot properties: 00:04:41 INFO - { 00:04:41 INFO - "project": "", 00:04:41 INFO - "product": "firefox", 00:04:41 INFO - "script_repo_revision": "production", 00:04:41 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 00:04:41 INFO - "repository": "", 00:04:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 00:04:41 INFO - "buildid": "20160419230832", 00:04:41 INFO - "pgo_build": "False", 00:04:41 INFO - "basedir": "/builds/slave/test", 00:04:41 INFO - "buildnumber": 648, 00:04:41 INFO - "slavename": "t-yosemite-r7-0162", 00:04:41 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 00:04:41 INFO - "platform": "yosemite_r7", 00:04:41 INFO - "scheduler": "tests-fx-team-macosx64-talos", 00:04:41 INFO - "branch": "fx-team", 00:04:41 INFO - "repo_path": "integration/fx-team", 00:04:41 INFO - "revision": "d42b25947fc26a0f9eab98d631465b72769553bd", 00:04:41 INFO - "stage_platform": "macosx64", 00:04:41 INFO - "builduid": "1ab072c2db0d4b259b7f46e10e93ac05", 00:04:41 INFO - "slavebuilddir": "test" 00:04:41 INFO - } 00:04:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 00:04:41 INFO - Running post-action listener: _resource_record_post_action 00:04:41 INFO - ##### 00:04:41 INFO - ##### Running download-and-extract step. 00:04:41 INFO - ##### 00:04:41 INFO - Running pre-action listener: _resource_record_pre_action 00:04:41 INFO - Running main action method: download_and_extract 00:04:41 INFO - mkdir: /builds/slave/test/build/tests 00:04:41 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')]} 00:04:41 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 00:04:41 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 00:04:41 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 00:04:41 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 00:04:41 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 00:04:42 INFO - Downloaded 1199 bytes. 00:04:42 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 00:04:42 INFO - Using the following test package requirements: 00:04:42 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 00:04:42 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 00:04:42 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 00:04:42 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 00:04:42 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 00:04:42 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 00:04:42 INFO - u'jsshell-mac.zip'], 00:04:42 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 00:04:42 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 00:04:42 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 00:04:42 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 00:04:42 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 00:04:42 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 00:04:42 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 00:04:42 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 00:04:42 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 00:04:42 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 00:04:42 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 00:04:42 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 00:04:42 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')]} 00:04:42 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 00:04:42 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 00:04:42 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 00:04:42 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 00:04:42 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 00:04:43 INFO - Downloaded 18095480 bytes. 00:04:43 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'] 00:04:43 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 00:04:46 INFO - Return code: 0 00:04:46 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 00:04:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:04:46 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 00:04:46 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 00:04:46 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 00:04:46 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 00:04:46 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 00:04:48 INFO - Downloaded 18095480 bytes. 00:04: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'] 00:04: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 00:04:51 INFO - Return code: 0 00:04: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')]} 00:04:51 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 00:04: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.talos.tests.zip 00:04: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.talos.tests.zip 00:04: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.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 00:04: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.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 00:04:53 INFO - Downloaded 10845952 bytes. 00:04:53 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'] 00:04:53 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 00:04:53 INFO - Return code: 0 00:04:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:04:53 INFO - https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 00:04:53 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 00:04:53 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 00:04:53 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 00:04:53 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 00:04:56 INFO - Downloaded 110044454 bytes. 00:04:56 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 00:04:56 INFO - mkdir: /builds/slave/test/properties 00:04:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:04:56 INFO - Writing to file /builds/slave/test/properties/build_url 00:04:56 INFO - Contents: 00:04:56 INFO - build_url:https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 00:04:57 INFO - Running post-action listener: _resource_record_post_action 00:04:57 INFO - Running post-action listener: set_extra_try_arguments 00:04:57 INFO - ##### 00:04:57 INFO - ##### Running populate-webroot step. 00:04:57 INFO - ##### 00:04:57 INFO - Running pre-action listener: _resource_record_pre_action 00:04:57 INFO - Running main action method: populate_webroot 00:04:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:04:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:04:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:04:57 INFO - '--tppagecycles', 00:04:57 INFO - '7'], 00:04:57 INFO - 'tests': ['tsvgm']}}, 00:04:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 00:04:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:04:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 00:04:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 00:04:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 00:04:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 00:04:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:04:57 INFO - 'talos_options': ['--disable-e10s'], 00:04:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:04:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:04:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:04:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:04:57 INFO - 'talos_options': ['--disable-e10s'], 00:04:57 INFO - 'tests': ['damp', 'tps']}, 00:04:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:04:57 INFO - 'tests': ['damp', 'tps']}, 00:04:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 00:04:57 INFO - 'tests': ['dromaeo_dom']}, 00:04:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:04:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 00:04:57 INFO - 'tests': ['a11yr', 00:04:57 INFO - 'ts_paint', 00:04:57 INFO - 'tpaint', 00:04:57 INFO - 'sessionrestore', 00:04:57 INFO - 'sessionrestore_no_auto_restore', 00:04:57 INFO - 'tabpaint']}, 00:04:57 INFO - 'other-e10s': {'tests': ['a11yr', 00:04:57 INFO - 'ts_paint', 00:04:57 INFO - 'tpaint', 00:04:57 INFO - 'sessionrestore', 00:04:57 INFO - 'sessionrestore_no_auto_restore', 00:04:57 INFO - 'tabpaint']}, 00:04:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 00:04:57 INFO - 'ts_paint', 00:04:57 INFO - 'tpaint', 00:04:57 INFO - 'sessionrestore', 00:04:57 INFO - 'sessionrestore_no_auto_restore', 00:04:57 INFO - 'tabpaint']}, 00:04:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 00:04:57 INFO - 'ts_paint', 00:04:57 INFO - 'tpaint', 00:04:57 INFO - 'sessionrestore', 00:04:57 INFO - 'sessionrestore_no_auto_restore', 00:04:57 INFO - 'tabpaint']}, 00:04:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 00:04:57 INFO - 'tests': ['a11yr', 00:04:57 INFO - 'ts_paint', 00:04:57 INFO - 'tpaint', 00:04:57 INFO - 'sessionrestore', 00:04:57 INFO - 'sessionrestore_no_auto_restore', 00:04:57 INFO - 'tabpaint']}, 00:04:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 00:04:57 INFO - 'tests': ['a11yr', 00:04:57 INFO - 'ts_paint', 00:04:57 INFO - 'tpaint', 00:04:57 INFO - 'sessionrestore', 00:04:57 INFO - 'sessionrestore_no_auto_restore', 00:04:57 INFO - 'tabpaint']}, 00:04:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 00:04:57 INFO - 'tests': ['tsvgx', 00:04:57 INFO - 'tsvgr_opacity', 00:04:57 INFO - 'tart', 00:04:57 INFO - 'tscrollx', 00:04:57 INFO - 'cart']}, 00:04:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 00:04:57 INFO - 'tsvgr_opacity', 00:04:57 INFO - 'tart', 00:04:57 INFO - 'tscrollx', 00:04:57 INFO - 'cart']}, 00:04:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:04:57 INFO - 'talos_options': ['--disable-e10s'], 00:04:57 INFO - 'tests': ['tp5o']}, 00:04:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:04:57 INFO - 'tests': ['tp5o']}, 00:04:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:04:57 INFO - 'talos_options': ['--disable-e10s', 00:04:57 INFO - '--xperf_path', 00:04:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:04:57 INFO - 'tests': ['tp5n']}, 00:04:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:04:57 INFO - 'talos_options': ['--xperf_path', 00:04:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:04:57 INFO - 'tests': ['tp5n']}}, 00:04:57 INFO - 'talos.zip': {'path': '', 00:04:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:04:57 INFO - Running post-action listener: _resource_record_post_action 00:04:57 INFO - ##### 00:04:57 INFO - ##### Running create-virtualenv step. 00:04:57 INFO - ##### 00:04:57 INFO - Running pre-action listener: _resource_record_pre_action 00:04:57 INFO - Running main action method: create_virtualenv 00:04:57 INFO - Creating virtualenv /builds/slave/test/build/venv 00:04:57 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 00:04:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:04:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:04:57 INFO - Using real prefix '/tools/python27' 00:04:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:04:58 INFO - Installing distribute.............................................................................................................................................................................................done. 00:05:01 INFO - Installing pip.................done. 00:05:01 INFO - Return code: 0 00:05:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:01 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 0x1102cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102de420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6e35da830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11016de00>, '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 0x10ff96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110168b20>, '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.roIxPCGgCA/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.GCR5jqT8YK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 00:05:01 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 00:05:01 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 00:05:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.roIxPCGgCA/Render', 00:05:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:01 INFO - 'HOME': '/Users/cltbld', 00:05:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:01 INFO - 'LOGNAME': 'cltbld', 00:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:01 INFO - 'MOZ_NO_REMOTE': '1', 00:05:01 INFO - 'NO_EM_RESTART': '1', 00:05:01 INFO - 'PAGER': '/bin/cat', 00:05:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:01 INFO - 'PWD': '/builds/slave/test', 00:05:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:01 INFO - 'SHELL': '/bin/bash', 00:05:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCR5jqT8YK/Listeners', 00:05:01 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 00:05:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:01 INFO - 'USER': 'cltbld', 00:05:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:01 INFO - 'XPC_FLAGS': '0x0', 00:05:01 INFO - 'XPC_SERVICE_NAME': '0', 00:05:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:05:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:01 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 00:05:01 INFO - Cleaning up... 00:05:01 INFO - Return code: 0 00:05:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 00:05:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:01 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 0x1102cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102de420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6e35da830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11016de00>, '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 0x10ff96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110168b20>, '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.roIxPCGgCA/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.GCR5jqT8YK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 00:05:01 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 00:05:01 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 00:05:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.roIxPCGgCA/Render', 00:05:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:01 INFO - 'HOME': '/Users/cltbld', 00:05:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:01 INFO - 'LOGNAME': 'cltbld', 00:05:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:01 INFO - 'MOZ_NO_REMOTE': '1', 00:05:01 INFO - 'NO_EM_RESTART': '1', 00:05:01 INFO - 'PAGER': '/bin/cat', 00:05:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:01 INFO - 'PWD': '/builds/slave/test', 00:05:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:01 INFO - 'SHELL': '/bin/bash', 00:05:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCR5jqT8YK/Listeners', 00:05:01 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 00:05:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:01 INFO - 'USER': 'cltbld', 00:05:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:01 INFO - 'XPC_FLAGS': '0x0', 00:05:01 INFO - 'XPC_SERVICE_NAME': '0', 00:05:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:05:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:01 INFO - Downloading/unpacking psutil>=0.7.1 00:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:05:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:05:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:05:05 INFO - Installing collected packages: psutil 00:05:05 INFO - Running setup.py install for psutil 00:05:05 INFO - building 'psutil._psutil_osx' extension 00:05:05 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 00:05:05 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 00:05:05 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 00:05:05 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 00:05:05 INFO - building 'psutil._psutil_posix' extension 00:05:05 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 00:05:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 00:05:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 00:05:05 INFO - ^ 00:05:05 INFO - 1 warning generated. 00:05:05 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 00:05:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:05:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:05:05 INFO - Successfully installed psutil 00:05:05 INFO - Cleaning up... 00:05:05 INFO - Return code: 0 00:05:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:05:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:05 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 0x1102cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102de420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6e35da830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11016de00>, '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 0x10ff96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110168b20>, '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.roIxPCGgCA/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.GCR5jqT8YK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 00:05:05 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 00:05:05 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 00:05:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.roIxPCGgCA/Render', 00:05:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:05 INFO - 'HOME': '/Users/cltbld', 00:05:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:05 INFO - 'LOGNAME': 'cltbld', 00:05:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:05 INFO - 'MOZ_NO_REMOTE': '1', 00:05:05 INFO - 'NO_EM_RESTART': '1', 00:05:05 INFO - 'PAGER': '/bin/cat', 00:05:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:05 INFO - 'PWD': '/builds/slave/test', 00:05:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:05 INFO - 'SHELL': '/bin/bash', 00:05:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCR5jqT8YK/Listeners', 00:05:05 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 00:05:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:05 INFO - 'USER': 'cltbld', 00:05:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:05 INFO - 'XPC_FLAGS': '0x0', 00:05:05 INFO - 'XPC_SERVICE_NAME': '0', 00:05:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:05:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:05: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 00:05: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 00:05: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 00:05: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 00:05: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 00:05: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 00:05:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:05:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:05:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:05:08 INFO - Installing collected packages: mozsystemmonitor 00:05:08 INFO - Running setup.py install for mozsystemmonitor 00:05:08 INFO - Successfully installed mozsystemmonitor 00:05:08 INFO - Cleaning up... 00:05:09 INFO - Return code: 0 00:05:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:05: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')]} 00:05:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05: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')]} 00:05:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:09 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 0x1102cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102de420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6e35da830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11016de00>, '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 0x10ff96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110168b20>, '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.roIxPCGgCA/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.GCR5jqT8YK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 00:05:09 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 00:05:09 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 00:05:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.roIxPCGgCA/Render', 00:05:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:09 INFO - 'HOME': '/Users/cltbld', 00:05:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:09 INFO - 'LOGNAME': 'cltbld', 00:05:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:09 INFO - 'MOZ_NO_REMOTE': '1', 00:05:09 INFO - 'NO_EM_RESTART': '1', 00:05:09 INFO - 'PAGER': '/bin/cat', 00:05:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:09 INFO - 'PWD': '/builds/slave/test', 00:05:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:09 INFO - 'SHELL': '/bin/bash', 00:05:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCR5jqT8YK/Listeners', 00:05:09 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 00:05:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:09 INFO - 'USER': 'cltbld', 00:05:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:09 INFO - 'XPC_FLAGS': '0x0', 00:05:09 INFO - 'XPC_SERVICE_NAME': '0', 00:05:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:05:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:09 INFO - Downloading/unpacking blobuploader==1.2.4 00:05:09 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 00:05:09 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 00:05:09 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 00:05:09 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 00:05:09 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 00:05:09 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 00:05:11 INFO - Downloading blobuploader-1.2.4.tar.gz 00:05:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:05:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:05:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:12 INFO - Downloading docopt-0.6.1.tar.gz 00:05:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:05:12 INFO - Installing collected packages: blobuploader, requests, docopt 00:05:12 INFO - Running setup.py install for blobuploader 00:05:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:05:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:05:13 INFO - Running setup.py install for requests 00:05:13 INFO - Running setup.py install for docopt 00:05:13 INFO - Successfully installed blobuploader requests docopt 00:05:13 INFO - Cleaning up... 00:05:13 INFO - Return code: 0 00:05:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:05: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')]} 00:05:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05: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')]} 00:05:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:13 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 0x1102cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102de420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6e35da830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11016de00>, '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 0x10ff96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110168b20>, '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.roIxPCGgCA/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.GCR5jqT8YK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 00:05:13 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 00:05:13 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 00:05:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.roIxPCGgCA/Render', 00:05:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:13 INFO - 'HOME': '/Users/cltbld', 00:05:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:13 INFO - 'LOGNAME': 'cltbld', 00:05:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:13 INFO - 'MOZ_NO_REMOTE': '1', 00:05:13 INFO - 'NO_EM_RESTART': '1', 00:05:13 INFO - 'PAGER': '/bin/cat', 00:05:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:13 INFO - 'PWD': '/builds/slave/test', 00:05:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:13 INFO - 'SHELL': '/bin/bash', 00:05:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCR5jqT8YK/Listeners', 00:05:13 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 00:05:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:13 INFO - 'USER': 'cltbld', 00:05:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:13 INFO - 'XPC_FLAGS': '0x0', 00:05:13 INFO - 'XPC_SERVICE_NAME': '0', 00:05:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:05:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:05:14 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-zuHFGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:05:14 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-0nZlVp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:05:14 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-KCwLy_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:05:14 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-i6YqOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:05:14 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-3qTf5c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:05:14 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-4E_XJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:05:14 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-0o8u0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:05:14 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Mt4h7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:05:14 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-e8x0xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:05:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:05:14 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-SICo1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:05:15 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-YTY19Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:05:15 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Rv9lN9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:05:15 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-YCrd3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:05:15 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-7dPfUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:05:15 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-w4maec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:05:15 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-9WRU52-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:05:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:05:15 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-kMK1Zu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:05:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:05:15 INFO - Running setup.py install for manifestparser 00:05:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:05:15 INFO - Running setup.py install for mozcrash 00:05:16 INFO - Running setup.py install for mozdebug 00:05:16 INFO - Running setup.py install for mozdevice 00:05:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:05:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:05:16 INFO - Running setup.py install for mozfile 00:05:16 INFO - Running setup.py install for mozhttpd 00:05:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:05:16 INFO - Running setup.py install for mozinfo 00:05:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:05:16 INFO - Running setup.py install for mozInstall 00:05:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:05:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:05:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:05:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:05:16 INFO - Running setup.py install for mozleak 00:05:17 INFO - Running setup.py install for mozlog 00:05:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:05:17 INFO - Running setup.py install for moznetwork 00:05:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:05:17 INFO - Running setup.py install for mozprocess 00:05:17 INFO - Running setup.py install for mozprofile 00:05:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:05:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:05:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:05:17 INFO - Running setup.py install for mozrunner 00:05:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:05:17 INFO - Running setup.py install for mozscreenshot 00:05:18 INFO - Running setup.py install for moztest 00:05:18 INFO - Running setup.py install for mozversion 00:05:18 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:05:18 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:05:18 INFO - Cleaning up... 00:05:18 INFO - Return code: 0 00:05:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:05: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')]} 00:05:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05: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')]} 00:05:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:18 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 0x1102cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102de420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6e35da830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11016de00>, '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 0x10ff96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110168b20>, '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.roIxPCGgCA/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.GCR5jqT8YK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 00:05:18 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 00:05:18 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 00:05:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.roIxPCGgCA/Render', 00:05:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:18 INFO - 'HOME': '/Users/cltbld', 00:05:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:18 INFO - 'LOGNAME': 'cltbld', 00:05:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:18 INFO - 'MOZ_NO_REMOTE': '1', 00:05:18 INFO - 'NO_EM_RESTART': '1', 00:05:18 INFO - 'PAGER': '/bin/cat', 00:05:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:18 INFO - 'PWD': '/builds/slave/test', 00:05:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:18 INFO - 'SHELL': '/bin/bash', 00:05:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCR5jqT8YK/Listeners', 00:05:18 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 00:05:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:18 INFO - 'USER': 'cltbld', 00:05:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:18 INFO - 'XPC_FLAGS': '0x0', 00:05:18 INFO - 'XPC_SERVICE_NAME': '0', 00:05:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:05:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:05:18 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-suv786-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:05:18 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)) 00:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:05:18 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Zmz3dl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:05:18 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)) 00:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:05:18 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-n2DEgc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:05:18 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)) 00:05:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:05:19 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-C6Kaa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:05:19 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)) 00:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:05:19 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-NkQs9e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:05:19 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)) 00:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:05:19 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-6OhsyG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:05:19 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)) 00:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:05:19 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-GXZgvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:05:19 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)) 00:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:05:19 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-T4rvSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:05:19 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)) 00:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:05:19 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-oj5mID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:05:19 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)) 00:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:05:19 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Ueiey_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:05:19 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)) 00:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:05:19 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-ZjMUxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:05:19 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)) 00:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:05:19 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-hfM1_M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:05:19 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)) 00:05:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:05:19 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-MQP4nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:05:20 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)) 00:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:05:20 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-REn4q8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:05:20 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)) 00:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:05:20 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-SIB3DT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:05:20 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)) 00:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:05:20 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-_rpPqO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:05:20 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)) 00:05:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:05:20 INFO - Running setup.py (path:/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/pip-Wl92_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:05:20 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)) 00:05:20 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)) 00:05:20 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)) 00:05:20 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)) 00:05:20 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)) 00:05:20 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)) 00:05:20 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:22 INFO - Downloading blessings-1.6.tar.gz 00:05:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:05:23 INFO - Installing collected packages: blessings 00:05:23 INFO - Running setup.py install for blessings 00:05:23 INFO - Successfully installed blessings 00:05:23 INFO - Cleaning up... 00:05:23 INFO - Return code: 0 00:05:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:05:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:05:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:05:23 INFO - Reading from file tmpfile_stdout 00:05:23 INFO - Current package versions: 00:05:23 INFO - blessings == 1.6 00:05:23 INFO - blobuploader == 1.2.4 00:05:23 INFO - docopt == 0.6.1 00:05:23 INFO - manifestparser == 1.1 00:05:23 INFO - mozInstall == 1.12 00:05:23 INFO - mozcrash == 0.17 00:05:23 INFO - mozdebug == 0.1 00:05:23 INFO - mozdevice == 0.48 00:05:23 INFO - mozfile == 1.2 00:05:23 INFO - mozhttpd == 0.7 00:05:23 INFO - mozinfo == 0.9 00:05:23 INFO - mozleak == 0.1 00:05:23 INFO - mozlog == 3.1 00:05:23 INFO - moznetwork == 0.27 00:05:23 INFO - mozprocess == 0.22 00:05:23 INFO - mozprofile == 0.28 00:05:23 INFO - mozrunner == 6.11 00:05:23 INFO - mozscreenshot == 0.1 00:05:23 INFO - mozsystemmonitor == 0.0 00:05:23 INFO - moztest == 0.7 00:05:23 INFO - mozversion == 1.4 00:05:23 INFO - psutil == 3.1.1 00:05:23 INFO - requests == 1.2.3 00:05:23 INFO - wsgiref == 0.1.2 00:05:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:05: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')]} 00:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05: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')]} 00:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:23 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 0x1102cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102de420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6e35da830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11016de00>, '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 0x10ff96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110168b20>, '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.roIxPCGgCA/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.GCR5jqT8YK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 00:05:23 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 00:05:23 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 00:05:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.roIxPCGgCA/Render', 00:05:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:23 INFO - 'HOME': '/Users/cltbld', 00:05:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:23 INFO - 'LOGNAME': 'cltbld', 00:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:23 INFO - 'MOZ_NO_REMOTE': '1', 00:05:23 INFO - 'NO_EM_RESTART': '1', 00:05:23 INFO - 'PAGER': '/bin/cat', 00:05:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:23 INFO - 'PWD': '/builds/slave/test', 00:05:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:23 INFO - 'SHELL': '/bin/bash', 00:05:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCR5jqT8YK/Listeners', 00:05:23 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 00:05:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:23 INFO - 'USER': 'cltbld', 00:05:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:23 INFO - 'XPC_FLAGS': '0x0', 00:05:23 INFO - 'XPC_SERVICE_NAME': '0', 00:05:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:05:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:23 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)) 00:05:23 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)) 00:05:23 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)) 00:05:23 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)) 00:05:23 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)) 00:05:23 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)) 00:05:23 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)) 00:05:23 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)) 00:05:23 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)) 00:05:23 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)) 00:05:23 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)) 00:05:23 INFO - Cleaning up... 00:05:23 INFO - Return code: 0 00:05:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:05: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')]} 00:05:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05: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')]} 00:05:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:23 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 0x1102cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102de420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6e35da830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11016de00>, '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 0x10ff96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110168b20>, '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.roIxPCGgCA/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.GCR5jqT8YK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 00:05:23 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 00:05:23 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 00:05:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.roIxPCGgCA/Render', 00:05:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:23 INFO - 'HOME': '/Users/cltbld', 00:05:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:23 INFO - 'LOGNAME': 'cltbld', 00:05:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:23 INFO - 'MOZ_NO_REMOTE': '1', 00:05:23 INFO - 'NO_EM_RESTART': '1', 00:05:23 INFO - 'PAGER': '/bin/cat', 00:05:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:23 INFO - 'PWD': '/builds/slave/test', 00:05:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:23 INFO - 'SHELL': '/bin/bash', 00:05:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCR5jqT8YK/Listeners', 00:05:23 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 00:05:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:23 INFO - 'USER': 'cltbld', 00:05:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:23 INFO - 'XPC_FLAGS': '0x0', 00:05:23 INFO - 'XPC_SERVICE_NAME': '0', 00:05:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:05:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:24 INFO - Downloading/unpacking jsonschema 00:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:26 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:05:26 INFO - Downloading/unpacking functools32 (from jsonschema) 00:05:26 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 00:05:26 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 00:05:26 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 00:05:26 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 00:05:26 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 00:05:26 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 00:05:26 INFO - Downloading functools32-3.2.3-2.tar.gz 00:05:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:05:27 INFO - warning: no files found matching '*.txt' 00:05:27 INFO - no previously-included directories found matching 'build' 00:05:27 INFO - no previously-included directories found matching 'dist' 00:05:27 INFO - no previously-included directories found matching '.git*' 00:05:27 INFO - Installing collected packages: jsonschema, functools32 00:05:27 INFO - Running setup.py install for functools32 00:05:27 INFO - warning: no files found matching '*.txt' 00:05:27 INFO - no previously-included directories found matching 'build' 00:05:27 INFO - no previously-included directories found matching 'dist' 00:05:27 INFO - no previously-included directories found matching '.git*' 00:05:27 INFO - Successfully installed jsonschema functools32 00:05:27 INFO - Cleaning up... 00:05:27 INFO - Return code: 0 00:05:27 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 00:05:27 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')]} 00:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:05:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:27 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')]} 00:05:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:05:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:05:27 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 0x1102cea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1102de420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd6e35da830>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11016de00>, '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 0x10ff96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110168b20>, '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.roIxPCGgCA/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.GCR5jqT8YK/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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 00:05:27 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 00:05:27 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 00:05:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.roIxPCGgCA/Render', 00:05:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:05:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:05:27 INFO - 'HOME': '/Users/cltbld', 00:05:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:05:27 INFO - 'LOGNAME': 'cltbld', 00:05:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:05:27 INFO - 'MOZ_NO_REMOTE': '1', 00:05:27 INFO - 'NO_EM_RESTART': '1', 00:05:27 INFO - 'PAGER': '/bin/cat', 00:05:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:05:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:05:27 INFO - 'PWD': '/builds/slave/test', 00:05:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:05:27 INFO - 'SHELL': '/bin/bash', 00:05:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCR5jqT8YK/Listeners', 00:05:27 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 00:05:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:05:27 INFO - 'USER': 'cltbld', 00:05:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:05:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:05:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:05:27 INFO - 'XPC_FLAGS': '0x0', 00:05:27 INFO - 'XPC_SERVICE_NAME': '0', 00:05:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:05:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:05:27 INFO - Downloading/unpacking flake8 00:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:05:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:05:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:05:29 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 00:05:29 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 00:05:29 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 00:05:29 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 00:05:29 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 00:05:29 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 00:05:29 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 00:05:29 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 00:05:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 00:05:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 00:05:30 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 00:05:30 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 00:05:30 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 00:05:30 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 00:05:30 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 00:05:30 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 00:05:30 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 00:05:30 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 00:05:30 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 00:05:30 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 00:05:30 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 00:05:30 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 00:05:30 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 00:05:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 00:05:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:05:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:05:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:05:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:05:31 INFO - no previously-included directories found matching 'docs/_build' 00:05:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 00:05:31 INFO - Running setup.py install for pep8 00:05:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 00:05:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 00:05:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 00:05:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 00:05:31 INFO - no previously-included directories found matching 'docs/_build' 00:05:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 00:05:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 00:05:31 INFO - Cleaning up... 00:05:31 INFO - Return code: 0 00:05:31 INFO - Running post-action listener: _resource_record_post_action 00:05:31 INFO - Running post-action listener: _start_resource_monitoring 00:05:31 INFO - Starting resource monitoring. 00:05:31 INFO - ##### 00:05:31 INFO - ##### Running install step. 00:05:31 INFO - ##### 00:05:31 INFO - Running pre-action listener: _resource_record_pre_action 00:05:31 INFO - Running main action method: install 00:05:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:05:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:05:31 INFO - Reading from file tmpfile_stdout 00:05:31 INFO - Detecting whether we're running mozinstall >=1.0... 00:05:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:05:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:05:31 INFO - Reading from file tmpfile_stdout 00:05:31 INFO - Output received: 00:05:31 INFO - Usage: mozinstall [options] installer 00:05:31 INFO - Options: 00:05:31 INFO - -h, --help show this help message and exit 00:05:31 INFO - -d DEST, --destination=DEST 00:05:31 INFO - Directory to install application into. [default: 00:05:31 INFO - "/builds/slave/test"] 00:05:31 INFO - --app=APP Application being installed. [default: firefox] 00:05:31 INFO - mkdir: /builds/slave/test/build/application 00:05:31 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'] 00:05:31 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 00:06:05 INFO - Reading from file tmpfile_stdout 00:06:05 INFO - Output received: 00:06:05 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 00:06:05 INFO - Running post-action listener: _resource_record_post_action 00:06:05 INFO - ##### 00:06:05 INFO - ##### Running run-tests step. 00:06:05 INFO - ##### 00:06:05 INFO - Running pre-action listener: _resource_record_pre_action 00:06:05 INFO - Running main action method: run_tests 00:06:05 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:06:05 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:06:05 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:06:05 INFO - 2016-04-20 00:06:05.395 screenresolution[1943:18254] starting screenresolution argv=screenresolution get 00:06:05 INFO - 2016-04-20 00:06:05.398 screenresolution[1943:18254] Display 0: 1600x1200x32@60 00:06:05 INFO - 2016-04-20 00:06:05.404 screenresolution[1944:18256] starting screenresolution argv=screenresolution list 00:06:05 INFO - Available Modes on Display 0 00:06:05 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:06:05 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:06:05 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:06:05 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:06:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:06:05 INFO - Intel Iris: 00:06:05 INFO - Chipset Model: Intel Iris 00:06:05 INFO - Type: GPU 00:06:05 INFO - Bus: Built-In 00:06:05 INFO - VRAM (Dynamic, Max): 1536 MB 00:06:05 INFO - Vendor: Intel (0x8086) 00:06:05 INFO - Device ID: 0x0a2e 00:06:05 INFO - Revision ID: 0x0009 00:06:05 INFO - Displays: 00:06:05 INFO - Display: 00:06:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:06:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:06:05 INFO - Display Serial Number: 1600x1200 60 00:06:05 INFO - Main Display: Yes 00:06:05 INFO - Mirror: Off 00:06:05 INFO - Online: Yes 00:06:05 INFO - Rotation: Supported 00:06:05 INFO - Return code: 0 00:06:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:06:05 INFO - Python 2.7.3 00:06:05 INFO - Return code: 0 00:06:05 INFO - grabbing minidump binary from tooltool 00:06:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:06:05 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 0x11016de00>, '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 0x10ff96db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x110168b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:06:05 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 00:06:05 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 00:06:05 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:06:05 INFO - Return code: 0 00:06:05 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 00:06:05 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:06:05 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:06:05 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 00:06:05 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:06:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 00:06:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 00:06:06 INFO - Return code: 0 00:06:06 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', '--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-0162', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 00:06:06 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 --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-0162 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 00:06:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.roIxPCGgCA/Render', 00:06:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 00:06:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 00:06:06 INFO - 'HOME': '/Users/cltbld', 00:06:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 00:06:06 INFO - 'LOGNAME': 'cltbld', 00:06:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:06:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 00:06:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:06:06 INFO - 'MOZ_NO_REMOTE': '1', 00:06:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:06:06 INFO - 'NO_EM_RESTART': '1', 00:06:06 INFO - 'PAGER': '/bin/cat', 00:06:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 00:06:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:06:06 INFO - 'PWD': '/builds/slave/test', 00:06:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:06:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 00:06:06 INFO - 'SHELL': '/bin/bash', 00:06:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.GCR5jqT8YK/Listeners', 00:06:06 INFO - 'TMPDIR': '/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/', 00:06:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 00:06:06 INFO - 'USER': 'cltbld', 00:06:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 00:06:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 00:06:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:06:06 INFO - 'XPC_FLAGS': '0x0', 00:06:06 INFO - 'XPC_SERVICE_NAME': '0', 00:06:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 00:06:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--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-0162', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 00:06:07 INFO - mozversion application_buildid: 20160419230832 00:06:07 INFO - mozversion application_changeset: d42b25947fc26a0f9eab98d631465b72769553bd 00:06:07 INFO - mozversion application_display_name: Nightly 00:06:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:06:07 INFO - mozversion application_name: Firefox 00:06:07 INFO - mozversion application_remotingname: firefox 00:06:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 00:06:07 INFO - mozversion application_vendor: Mozilla 00:06:07 INFO - mozversion application_version: 48.0a1 00:06:07 INFO - mozversion platform_buildid: 20160419230832 00:06:07 INFO - mozversion platform_changeset: d42b25947fc26a0f9eab98d631465b72769553bd 00:06:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 00:06:07 INFO - mozversion platform_version: 48.0a1 00:06:07 INFO - using testdate: 1461135967 00:06:07 INFO - actual date: 1461135967 00:06:07 INFO - starting webserver on 'localhost:56057' 00:06:07 INFO - SUITE-START | Running 2 tests 00:06:07 INFO - TEST-START | dromaeo_css 00:06:07 INFO - operating with platform_type : mac_ 00:06:07 INFO - Initialising browser for dromaeo_css test... 00:06:07 INFO - TEST-INFO | started process 1962 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpz5haCS/profile http://localhost:56057/getInfo.html) 00:06:09 INFO - PROCESS | 1962 | __metrics Screen width/height:1600/1200 00:06:09 INFO - PROCESS | 1962 | colorDepth:24 00:06:09 INFO - PROCESS | 1962 | Browser inner width/height: 1024/689 00:06:09 INFO - PROCESS | 1962 | __metrics 00:06:09 INFO - PROCESS | 1962 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:06:09 ERROR - PROCESS | 1962 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:06:10 INFO - TEST-INFO | 1962: exit 0 00:06:10 INFO - Browser initialized. 00:06:10 INFO - Running cycle 1/1 for dromaeo_css test... 00:06:10 INFO - TEST-INFO | started process 1964 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpz5haCS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:06:22 INFO - PROCESS | 1964 | RSS: Main: 237596672 00:06:22 INFO - PROCESS | 1964 | 00:07:13 INFO - PROCESS | 1964 | 1461136033760 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] 00:09:24 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56057/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56057/tests/dromaeo/cssquery-ext.html) 00:09:25 INFO - PROCESS | 1964 | RSS: Main: 341438464 00:09:25 INFO - PROCESS | 1964 | 00:12:28 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56057/tests/dromaeo/cssquery-ext.html (next: http://localhost:56057/tests/dromaeo/cssquery-jquery.html) 00:12:28 INFO - PROCESS | 1964 | RSS: Main: 372420608 00:12:28 INFO - PROCESS | 1964 | 00:15:30 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56057/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56057/tests/dromaeo/cssquery-mootools.html) 00:15:31 INFO - PROCESS | 1964 | RSS: Main: 375955456 00:15:31 INFO - PROCESS | 1964 | 00:18:33 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56057/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56057/tests/dromaeo/cssquery-prototype.html) 00:18:34 INFO - PROCESS | 1964 | RSS: Main: 368390144 00:18:34 INFO - PROCESS | 1964 | 00:21:37 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56057/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56057/tests/dromaeo/cssquery-yui.html) 00:21:37 INFO - PROCESS | 1964 | RSS: Main: 339349504 00:21:37 INFO - PROCESS | 1964 | 00:24:41 INFO - PROCESS | 1964 | Cycle 1(1): loaded http://localhost:56057/tests/dromaeo/cssquery-yui.html (next: http://localhost:56057/tests/dromaeo/cssquery-dojo.html) 00:24:41 INFO - PROCESS | 1964 | RSS: Main: 383639552 00:24:41 INFO - PROCESS | 1964 | 00:24:41 INFO - PROCESS | 1964 | __start_tp_report 00:24:41 INFO - PROCESS | 1964 | _x_x_mozilla_page_load 00:24:41 INFO - PROCESS | 1964 | _x_x_mozilla_page_load_details 00:24:41 INFO - PROCESS | 1964 | |i|pagename|runs| 00:24:41 INFO - PROCESS | 1964 | |0;dojo.html;3327.9667203327963;3360.4623260278345;3386.55974723286;3401.6088149862744;3425.7430692698053;5419.647722898009;5515.613907026504;5522.806701765429;5536.640118392307;5548.972255138724;4140.834366625331;5518.365387980383;5578.525825304844;5623.437656234374;5679.261695979527;4975.353204083464;4977.452480227181;5025.221090730943;5039.269305950635;5210.452902445246;5111.872203194913;5120.871978200537;5145.588352931756;5161;5202.713850738208;4992.251162325644;5001;5052.469490703496;5071.771770270309;5115.309433226504;4206.936895946563;5045.142325804622;5085.110105731482;5087.440381558025;5089.491050894918;5033.119204139261;5040.395152581677;5050;5057.393112826484;5061.114304996611;5316.6544174628525;5362.115250983583;5440.129579267338;5480.890382192374;5500.724963751796;6075.908861367083;6112.388761123896;6134.478569321613;6146.877062458726;6155.353687862755;5094.388673359221;6183.907241391383;6222.906656400158;6233.750649974041;6233.937660623381;5032.723200223986;5595.328560572757;5608.887822243573;5715.771369145187;5738.196652468658;6300.527460440485;6320.178376810985;6320.873582528324;6332.366763323631;6349.174607301022;5959.046552551571;5964.343922168558;5973.671448070398;5979.850503737442;5994.580379373402;5992.34084250732;6110.388961103943;6129;6166.907496387557;6184;6001.399860013964;6087.6956152192215;6095.329513753483;6097.085437184458;6102;6033.7586496540525;6131.110988906584;6139.754409823557;6155.938440615537;6193.566450348522;4748.976255118771;4814.855554333376;4820.108279968217;4824.179889418807;4830.565249127595;4294.7852607369505;4400.647948164139;4415.381846541487;4418.116376724668;4432.534583868712;4670.486246512881;5555.916661250085;5624.465675760796;5655.830325090254;5675.404082571353;6096;6170.413810687977;6174.9073763893575;6181.536384771161;6182.505399568024;5479.6164268500825;5554.583406244547;5581.6930068846605;5592.7762889483965;5598.972005139948;5245.659032162897;5274.314339135888;5289.2859463972645;5325.334333208349;5340;6267.059941008885;6306.747730090837;6315.96842015787;6318.873622527523;6353;5954.672493012926;6030;6055.455009049207;6137.938620613915;6139.662318572343;6213.689315534296;6326.810195694136;6338.556301058881;6339.049142628643;6341.936580634135;5977.163197152315;5984.162217289496;5987.401259873977;5990.324699886552;5993.160957465871;5922.911156332744;5950.791722289872;6123.2652081750475;6132.110769108063;6146.631202127886;5864.618799778001;5888.087346461305;5898.026825573732;5902.350741418355;5914.34942156371;5824.184614154106;5870.970645146747;5886.175935368966;5897.64614123154;5921.526277897672;5639.041362968387;5677.176809362537;5724.4561766632105;5799;5805.709714514342;5892.204552385373;5908.143319218603;5911.083782013795;5921.970390148022;5934.169216309807;5290.947090529199;5523.922835047128;5763.510101641407;5817.680027598522;5824.650520968756 00:24:41 INFO - PROCESS | 1964 | |1;ext.html;497.94771548987376;498.1730327656089;529.9072662284101;578.8581797459623;594.0821430889275;26328.605070923928;30724.07827765168;38249.426258606145;39192;39400;43682.563174368246;44447;44455.888602784864;44549.55450445494;44644;8557.914420855774;9684.661036863728;9928.45393503357;9936.503174841266;9937.652182173626;11499.425028748528;11848.466818993165;11857;11861.347625880573;11877.524899004073;9640.71077867665;11426.657200284004;11579.421028948518;11681.883181168207;11691;11533.365664888428;11586.652400427958;11633.941830290794;11638.301701897914;11644.59243926467;11438.885611143865;11579.594714184963;11581.07351411885;11763.764724705457;11769.293842369485;40441;40792.18415631671;40908.1818363634;40925;40991.59008409937;3276.967230327714;3339.2987472630775;3396.3886500429912;3400.540926974876;3601.891943241707;21793.782062179333;29266;29445.852770736223;29488.8525557373;29639.55540666892;2728.4952283827356;2730.9180724578296;2751.5322395192866;2759.4756996170663;2851.800373973823;466093;467981;471235;472486.6375668134;472519;52902;63451;63831;63922.32932048091;64122.679386602766;68705.65647171732;68922.65538672275;69199.96200057003;69221.30778692149;69268;16326.75509867353;17001.829981700273;17026.020446421826;17031.574210644834;17087.401940932257;11797.17419780607;12851.48594056246;13052.34738263083;13144.539941102015;13186.472541098441;18015.18931648079;18051.097445127954;18074.638507230044;18082.909585451987;18102.5474363142;6642.468602511787;6685.6322902240845;6688.4649228061635;6708.765193218214;6717.261101278856;984.4437892590663;994.3039872089566;1062.2776511971779;1074.4788777442934;1093.7593729379682;29508.409831803245;29848.40303193924;29892;30324.84837575798;30910.690893091232;1103.7957977774138;1124.2692250037378;1162.633770362333;1219.9878001219874;1252.8997680185564;15106.471273505374;15264.923675381775;15499.380024799108;15550.611234718996;15779;598014;598670.1263379971;603826;604080;608387;61667.69166154141;62112.68943655253;62162;62282;62491.37508624946;1394.219237227156;1473.9852601474063;1477.6822983058694;1488.2038109611306;1534.1638806850294;28623.713762862106;28794.424111517234;28977;29428.411431770815;29647.88450771756;48853.755731221114;49222.75388623034;49329.50670493393;49391.25913111378;49543.75228123836;396153;409754;410653;410872;411139;26487;26882.32794180161;27550.5867411993;27587;27698.86150569234;42799.3580096305;43080.784596078076;43155.78422107869;43198.568014320714;43502.34746478868;37007.26387409956;37291.81354093212;37462;37919.241615168095;38179.61820381872;37195.6280437203;37449;38153.618463816114;38859.417108742826;39228.80385598168;35203;35814.64185358113;35995.82002089973;36678.8166059168;36790.26419471649;30815.383692326475;31459.75538614118;31690.683093168773;32219.194520137185;32536.34927301488;20812.68780968317;24294.14970476025;24342.026318947752;24663.63004554969;25677.61483577785 00:24:41 INFO - PROCESS | 1964 | |2;jquery.html;379.8138911933153;389.1749491078912;391.1180288449546;398.26958731030663;399.7841165770484;14838.480653177141;16464.423745168922;19379.12793924273;20001.499962500944;20010.59978800425;19409.93245371504;19828.70256946147;20662.380128596127;20686.68969965452;20728.792712072875;5382.865428364283;5937.584369094165;5950.196723442323;5952.672603006833;5956.940430595703;4098.549159592442;4190.266703326905;5829.067349224125;5946.167536544887;5950.494207992326;6435.581687190341;6500.057491663706;6504.317046710098;6506.219253689564;6526.902096468557;6241.28225254097;6465.773697920574;6564.901526477107;6574.14536110305;6575.112359831457;5379.623426360156;5678.545716342683;5686.232358631614;5686.516646085088;5702.885942281173;21597.46006349838;24783;25147.62278565823;25524.744752552422;25556.572125648032;2236.7539570647214;2246.9101235950543;2258.288639078701;2301.4476525633895;2823.39297051135;14253.572392828231;14634.268286585628;14779.33492992807;15043.699126017527;15050.774238386433;1582.319602570894;1652.9504114876572;1727.369510128794;1828.3783513605438;1859.7675290588677;103628.96371036344;113731.43134284441;118739;122386;122958.15562766566;11457.942710286396;11509.769804604028;11555.2489088209;11660.591879284184;11727.944484996391;13246.470141194437;13836.169829810244;13852.861471385359;14904.18027008525;14989.70020599582;7167.319104685047;7576.772696819105;8389.790255243546;8487.618057187441;8521.744347669579;7223.386012189023;7685.00094987648;8156.184381561915;8173;8448.32413406926;4405.757683327448;4480;4497.460304763449;4553.157665831832;4560.901985086897;1644.4984279794778;1889.3576184097474;1954.4234450837037;1967.4884530022298;1980.3464856597288;891.3092353426147;972.7422233108232;977.2572844637984;1001.4992503748126;1082.6481393547128;16522.917385412995;18875;19755.901220493804;19782.70325945112;19867.205311787366;957.9377340472986;967.144077491411;976.9658061967797;983.9704808855746;992.1814503035025;8209.917900820916;10427.843582346271;10440.791184176274;10451.634192803216;10463.05832475081;505698;512325;513335;585914;589900;82964.3407131854;131099;142767.28616356853;144063;144377.27811361087;976.3360914578013;982.3172894838161;1027.6814187601867;1030.701096681954;1050.0444595418285;16716.916415417843;17512.299508020045;17622.942623442636;17917.73123403124;17983.550411239823;35169.29661406706;40884;48645.756771215914;49123.52629421123;49277.76805579889;69802.65098674475;72275;72408.27591724016;73211.26788732044;74512.88230676652;6861.451083913175;7791.805204869924;7887;7983.321417679563;8041.155678653891;10757.677269681923;12125.878741212475;12370.13409061357;12510.249385036926;12568.811467828173;10234.33476824004;10620.52207650673;10847.945760271148;11038.779224415628;11074.39090850011;10415.791684166123;10688.572457101629;10689.358638481715;10864.728381790519;10924.399158046384;10702.197335199735;10861.34831910088;11012.889871101186;11100.500477478372;11101.945315195366;7893.644785984759;7893.684252629831;8013.799655008672;8036.557989310644;8320.04319503265;8248.876266856121;10178.898211017795;10774.73063173427;10887.346759194474;11029.283096599016 00:24:41 INFO - PROCESS | 1964 | |3;mootools.html;1427.393357822925;1609.6539244062526;1614.7012802631511;1880.5204672808431;2001.8398528117752;7857.3321267692245;8536.871946920794;8811.162939520735;8814.25078868296;8814.735557933273;8436.198561136682;8669.306455483562;8670.696525621604;8680.782980425476;8688.782780430492;2140.871547707143;2238.8432809703327;2242.6299660555987;2408.722996855362;2453.1046168148587;2237.686723858661;2388.0805889732405;2485.2420011896365;2489.676342075528;2489.850608963459;2043.5912817436497;2409.0484258717797;2429.356220601542;2430.307362401716;2449.1795248591743;2110.9683354749536;2416.395901024744;2423.503181847717;2424.830261881669;2433.2700189943034;2354.1525050981804;2444.1567659157563;2447.963280550793;2449.595816690244;2452.766987136219;8336.999560052773;8538.359623028298;8611.95694021526;8613.440126391764;8621.741347759515;4569.977150114261;5239.5546378557865;5239.921401178985;5244.79020839166;5281.9207711884355;2945.440366330412;3362.5628668272966;3432.7768695034742;3531.4526248431534;3533.4169861972746;1028.444639894456;1043.3791893823163;1044.5769463367349;1052.6736711619421;1056.118141351972;11556.284273195792;11594.188406811527;11596.420178991017;11596.536138554533;11651.126165537535;4550.908981820345;4575.565321294472;4777.757782976451;4788.569028787426;4835.782389792468;9914.851277230848;9933.453660048623;9951.25365597583;9951.751206219902;9959.601615935426;5361.195820626937;5365.7585408656705;5376.704281264568;5406.297181366397;5410.215518749838;4769.475357710649;4814.422269327703;4885.462599114095;4906.484819094015;4947.752612369439;3303.884364047247;3929.980350098231;4004.2391945530258;4054.1486287879284;4055.2295063938345;1137.556353022322;1325.6619562011817;1339.4776037345443;1352.5671785028696;1354.2348573056192;692.56022425759;841.1252297610539;887.8236336853695;889.7241855024963;936.8594710793299;5021.5229553192385;5512.5589952803675;5659.207710920475;5823.283190328038;5877.206577112121;926.5221970956449;947.9810403792023;963.2967933408651;967.949774494667;977.3988996766938;3804.0299723570865;3853.5761066282685;3906.824192911326;3965.4448377227213;3970.1265721541213;10251.948740256401;10653.9467302663;10740.946295268473;10757;10799.514021868878;9310.767230819283;10416.270861039655;10544.420056896945;10577.153827693766;10600.681979540626;7891.802704932308;8111.269985701315;8124.918750812534;8192;8198.59007049657;5694.487496125369;5789.305283366023;5832.708364581669;6018.3680713524445;6038.607490513103;9160.816783664422;9816.312858099864;9909.355891867006;9979.700608981742;10023.949880250551;9083.409578377385;9480.620775169193;9749.463779492196;9857.162141218078;9880.752981175241;7196.424286056998;7519.360854327443;7519.774406767806;7525.736599219001;7529.284717951786;7986.161453047346;8324.375671824517;8383.371247156365;8383.706570270011;8394.160583941557;7348.70605175787;7349.412047036118;7354.043974283309;7463.328300452985;7508.624568771649;7183.892241616484;7189.137303523611;7259.165196002316;7296.015037970018;7336.559806411632;6639.767608133692;6650.933490665225;6704.66476676174;6787.490938179755;6806.353396427331;4791;4806.255030470283;4826.927596085991;4901.362822833009;4999.9750051240135;4789.99410123864;4814.422269327703;4851.58761505276;4864.756762161948;4923.950760492349 00:24:41 INFO - PROCESS | 1964 | |4;prototype.html;309.46771552928953;316.637450119613;325.0686782368515;327.33387556322856;329.9836503569008;5409.5401890839275;5883.382244864287;5958.43394877487;5968.850778730534;5974.8805023899495;5528.530074943635;5624.915626265599;5775.422457754223;5862.794802181925;5882.382349853257;3639.399499082648;4346.500152482457;4392.3631073494325;4425.092855964527;4453.176162409948;4396.824127034931;4413.161499315136;4414.7351158930405;4436.29019356903;4440.755758433284;4282.099526373835;4359.585839345257;4383.978080109611;4392.97803510982;4400.273954797454;4362.411074504965;4382.2331092059085;4387.3857659927635;4387.714798538117;4409.096135292273;3831.0039389758863;3831.4061320495366;3836.693064554829;3838.9826695925603;3844.8462061517507;4369.847055353048;5419.376771671269;5611.494965453088;5637.830865074055;5654.151877218409;3996.360582306817;5044.899102017939;5122.231665250205;5142.640015198937;5147.562457191143;5161.81933632321;5419.783208671648;6169.043798211284;6169.198004259418;6204.348543402968;3572.8570857165682;3584.7849129052343;4098.7950602470055;4100.384942258655;4269.4449721536;6497.732942076297;6578.8026359208825;6596.373344532261;6600.4389626881775;6672.466202703772;4140.958590414118;4348.239058164809;4350.2387082260475;4355.128974205171;4355.1725172217175;3747.15688969985;4264.272969447379;4392.5518468002465;4409.368533642509;4427.46870375557;4076.7961601919787;4722.150012997693;4827.61379089672;5123.846284611468;5124.564412024945;6204.5967012144065;6217.409346112112;6248.375162483715;6259.530535209878;6305.527085468608;1452.4988878836996;1454.8036015138032;1483.8219413670429;1520.2702702702766;1536.8002159719165;999.4153420249236;1021.5760459409411;1032.6575451912483;1034;1037.7716902281486;5164.624272834538;5773.769049237983;5837.073765657323;5838.970805145947;5874.206982057368;4841.661083724176;5779.826605201851;6416.615003099829;6436.935630643728;6454.935450645527;5053.620978426559;5294.735263236823;5366.524205843424;5711.485966262973;5758.337791154071;3361.428557145291;3364.62989071202;3365.798052116832;3394.6435624259593;3405.897823065312;5560.694161821058;6421.325760795049;6708.731650733916;6711.932880671131;6746.628935408501;6193.628382297076;6558.672066396661;6573.57271777333;6586.637734924625;6618.4705223582;5574.804881829116;5943.346231914573;6269.686515674198;6641.1366522352755;6723.596584204964;5670.914936275876;5887.911681324698;6367.649779262185;6413.8717225656155;6436.613803171825;5243.134882744457;5526.530244929226;6205.782797602063;6353.951597986281;6360.586561873463;6388.968055159695;6394.488440924808;6612.966935165294;6691.46468282546;6708.6981085850275;4329.134173165443;4354.172707185625;4363.956360436482;4371.650267978618;4375.693701440869;5543.972280138735;6372.139761132188;6389.393007664265;6407.8465876142745;6434.581752186093;5292.338457692788;5695.316562012585;5841.620294680833;6103.023516237381;6276.027215781562;6280.340564240689;6281.246250449793;6283.748650053946;6301.6534090625455;6321;5132.230165475059;5956.463918247378;6163.568550201443;6190.235782801879;6190.473809726043;5948;6297.622142671455;6310.2743184534365;6330;6341.365863413622;4718.952810471851;6052.759184367283;6074.271087469532;6164.044573091178;6202.4417802398 00:24:41 INFO - PROCESS | 1964 | |5;yui.html;659.9076129341892;673.0846049372852;718.238667012966;742.7771668499449;758.3380006641654;14496.927515362422;14916.477923272687;14925.776113358308;14959.626009349744;14968.251587420613;13374.398152083155;13708.588742337746;13724.794128088086;13792.586222413343;13958.441662333495;722.8482018776064;906.2795077913075;924.7641851327936;933.0156684697641;934.9298802589833;737.4137560639305;900.4642237868458;935.979782037579;936.1761649748246;937.8265020971108;973.1144658360893;973.9269554783384;975.4293738163183;977.0376179463223;978.7357413498387;748.3414595156228;941.6657086734248;965.030144704571;965.8647789309467;969.2682025071097;727.8325985023421;730.696760844249;731.4075598765018;731.8316787138934;733.5488674465219;14654.706905861824;14738;14740;14749.631259218499;14764.26178691061;12410.193337433038;12468.376581170905;12687.809682854764;12790.488380464863;12825.615231543068;10033.046860548237;10109.34289271195;10229.130523905476;10468.633597824115;10754.892451075546;3481.5822101348;3522.7886326820217;3619.69232615228;3630.981845090758;3716.1824398632257;80588;80734.59632701857;81523;81786.59106704488;84732.57633711792;9484.245414598321;9642.903570964341;9685.128338449573;9744.707658770249;10069.949650251849;22156.1137554496;22193.44516387071;22195.223167189393;22244.221452249094;22259.888700556716;7535.510191837513;7678.424118191158;7692;7765.805854853674;7766.262205090507;4090.2228576570355;4189.350650649093;4210;4227.51383590891;4312.396264522969;3501.5272938153025;3597.4603809428795;3607.981960090183;3609.6931760800626;3613.801240931774;627.4008322052429;639.4085470939456;647.8801421736994;655.9963256217994;659.0871642774696;548.506344290134;583.5623282538096;586.6685322792608;603.6348009454305;627.1564745417406;7328.706851725978;7428.480006399608;7500.137484189279;7530.698772049166;7873.763787086396;535.904076164245;569.866081470854;570.7745440551042;582.469952343374;600.6876424259448;2838.3471801485775;3553.7868424325334;3570;3639.217568222845;3705.3515634763808;85797.57101214578;86734.56632716922;87822.12177878268;88373.11626883778;88606.55696721475;76096;76297.6185119082;76313.61843190748;76778.61610692022;78206.6089669548;65414;66941.66529167323;67737.66131169412;67895;68306;6224.906626400698;7073.328033836778;7082.18554866197;7132.465065120033;7237.927620723725;41701.58298416977;42105.94735131523;43170.13659726725;43313.35029974616;43322.916927075814;61363.46591335252;62333.68833155805;62757.68621157048;62804;63491;10013.148882345082;10102.494875256354;10185.592576296865;10238;10616.681499555025;10878.401687906924;10879.075278601407;10883.401412922365;11040.834387484034;11274.943625282149;10285.177185824967;10471.633492827714;10568.788624227625;10597.735056623338;10616.787664246518;9776.266779991387;10146.644867429604;10405.84391234117;10428.58285668595;10432.217583681102;10188.541515631667;10382.532786024496;10468.214883883587;10472.424016679155;10488.160947124365;8426.662933482838;8463.788405289917;8690.130986901258;8740;8781.63214374844;8814.91185088141;8815.250703690259;8961.283097352327;9010.909890901006;9057.728119180632 00:24:41 INFO - PROCESS | 1964 | __end_tp_report 00:24:41 INFO - PROCESS | 1964 | __start_cc_report 00:24:41 INFO - PROCESS | 1964 | _x_x_mozilla_cycle_collect,1078 00:24:41 INFO - PROCESS | 1964 | __end_cc_report 00:24:41 INFO - PROCESS | 1964 | __startTimestamp1461137081272__endTimestamp 00:24:41 INFO - PROCESS | 1964 | 00:24:41 INFO - PROCESS | 1964 | ------- Summary: start ------- 00:24:41 INFO - PROCESS | 1964 | Number of tests: 6 00:24:41 INFO - PROCESS | 1964 | 00:24:41 INFO - PROCESS | 1964 | [#0] dojo.html Cycles:165 Average:5591.90 Median:5799.00 stddev:651.19 (11.2%) stddev-sans-first:628.50 00:24:41 INFO - PROCESS | 1964 | Values: 3328.0 3360.5 3386.6 3401.6 3425.7 5419.6 5515.6 5522.8 5536.6 5549.0 4140.8 5518.4 5578.5 5623.4 5679.3 4975.4 4977.5 5025.2 5039.3 5210.5 5111.9 5120.9 5145.6 5161.0 5202.7 4992.3 5001.0 5052.5 5071.8 5115.3 4206.9 5045.1 5085.1 5087.4 5089.5 5033.1 5040.4 5050.0 5057.4 5061.1 5316.7 5362.1 5440.1 5480.9 5500.7 6075.9 6112.4 6134.5 6146.9 6155.4 5094.4 6183.9 6222.9 6233.8 6233.9 5032.7 5595.3 5608.9 5715.8 5738.2 6300.5 6320.2 6320.9 6332.4 6349.2 5959.0 5964.3 5973.7 5979.9 5994.6 5992.3 6110.4 6129.0 6166.9 6184.0 6001.4 6087.7 6095.3 6097.1 6102.0 6033.8 6131.1 6139.8 6155.9 6193.6 4749.0 4814.9 4820.1 4824.2 4830.6 4294.8 4400.6 4415.4 4418.1 4432.5 4670.5 5555.9 5624.5 5655.8 5675.4 6096.0 6170.4 6174.9 6181.5 6182.5 5479.6 5554.6 5581.7 5592.8 5599.0 5245.7 5274.3 5289.3 5325.3 5340.0 6267.1 6306.7 6316.0 6318.9 6353.0 5954.7 6030.0 6055.5 6137.9 6139.7 6213.7 6326.8 6338.6 6339.0 6341.9 5977.2 5984.2 5987.4 5990.3 5993.2 5922.9 5950.8 6123.3 6132.1 6146.6 5864.6 5888.1 5898.0 5902.4 5914.3 5824.2 5871.0 5886.2 5897.6 5921.5 5639.0 5677.2 5724.5 5799.0 5805.7 5892.2 5908.1 5911.1 5922.0 5934.2 5290.9 5523.9 5763.5 5817.7 5824.7 00:24:41 INFO - PROCESS | 1964 | 00:24:41 INFO - PROCESS | 1964 | [#1] ext.html Cycles:180 Average:63989.45 Median:3367.84 stddev:133215.87 (3955.5%) stddev-sans-first:133504.28 00:24:41 INFO - PROCESS | 1964 | Values: 497.9 498.2 529.9 578.9 594.1 26328.6 30724.1 38249.4 39192.0 39400.0 43682.6 44447.0 44455.9 44549.6 44644.0 8557.9 9684.7 9928.5 9936.5 9937.7 11499.4 11848.5 11857.0 11861.3 11877.5 9640.7 11426.7 11579.4 11681.9 11691.0 11533.4 11586.7 11633.9 11638.3 11644.6 11438.9 11579.6 11581.1 11763.8 11769.3 40441.0 40792.2 40908.2 40925.0 40991.6 3277.0 3339.3 3396.4 3400.5 3601.9 21793.8 29266.0 29445.9 29488.9 29639.6 2728.5 2730.9 2751.5 2759.5 2851.8 466093.0 467981.0 471235.0 472486.6 472519.0 52902.0 63451.0 63831.0 63922.3 64122.7 68705.7 68922.7 69200.0 69221.3 69268.0 16326.8 17001.8 17026.0 17031.6 17087.4 11797.2 12851.5 13052.3 13144.5 13186.5 18015.2 18051.1 18074.6 18082.9 18102.5 6642.5 6685.6 6688.5 6708.8 6717.3 984.4 994.3 1062.3 1074.5 1093.8 29508.4 29848.4 29892.0 30324.8 30910.7 1103.8 1124.3 1162.6 1220.0 1252.9 15106.5 15264.9 15499.4 15550.6 15779.0 598014.0 598670.1 603826.0 604080.0 608387.0 61667.7 62112.7 62162.0 62282.0 62491.4 1394.2 1474.0 1477.7 1488.2 1534.2 28623.7 28794.4 28977.0 29428.4 29647.9 48853.8 49222.8 49329.5 49391.3 49543.8 396153.0 409754.0 410653.0 410872.0 411139.0 26487.0 26882.3 27550.6 27587.0 27698.9 42799.4 43080.8 43155.8 43198.6 43502.3 37007.3 37291.8 37462.0 37919.2 38179.6 37195.6 37449.0 38153.6 38859.4 39228.8 35203.0 35814.6 35995.8 36678.8 36790.3 30815.4 31459.8 31690.7 32219.2 32536.3 20812.7 24294.1 24342.0 24663.6 25677.6 00:24:41 INFO - PROCESS | 1964 | 00:24:41 INFO - PROCESS | 1964 | [#2] jquery.html Cycles:180 Average:32880.85 Median:2279.87 stddev:91155.67 (3998.3%) stddev-sans-first:91378.72 00:24:41 INFO - PROCESS | 1964 | Values: 379.8 389.2 391.1 398.3 399.8 14838.5 16464.4 19379.1 20001.5 20010.6 19409.9 19828.7 20662.4 20686.7 20728.8 5382.9 5937.6 5950.2 5952.7 5956.9 4098.5 4190.3 5829.1 5946.2 5950.5 6435.6 6500.1 6504.3 6506.2 6526.9 6241.3 6465.8 6564.9 6574.1 6575.1 5379.6 5678.5 5686.2 5686.5 5702.9 21597.5 24783.0 25147.6 25524.7 25556.6 2236.8 2246.9 2258.3 2301.4 2823.4 14253.6 14634.3 14779.3 15043.7 15050.8 1582.3 1653.0 1727.4 1828.4 1859.8 103629.0 113731.4 118739.0 122386.0 122958.2 11457.9 11509.8 11555.2 11660.6 11727.9 13246.5 13836.2 13852.9 14904.2 14989.7 7167.3 7576.8 8389.8 8487.6 8521.7 7223.4 7685.0 8156.2 8173.0 8448.3 4405.8 4480.0 4497.5 4553.2 4560.9 1644.5 1889.4 1954.4 1967.5 1980.3 891.3 972.7 977.3 1001.5 1082.6 16522.9 18875.0 19755.9 19782.7 19867.2 957.9 967.1 977.0 984.0 992.2 8209.9 10427.8 10440.8 10451.6 10463.1 505698.0 512325.0 513335.0 585914.0 589900.0 82964.3 131099.0 142767.3 144063.0 144377.3 976.3 982.3 1027.7 1030.7 1050.0 16716.9 17512.3 17622.9 17917.7 17983.6 35169.3 40884.0 48645.8 49123.5 49277.8 69802.7 72275.0 72408.3 73211.3 74512.9 6861.5 7791.8 7887.0 7983.3 8041.2 10757.7 12125.9 12370.1 12510.2 12568.8 10234.3 10620.5 10847.9 11038.8 11074.4 10415.8 10688.6 10689.4 10864.7 10924.4 10702.2 10861.3 11012.9 11100.5 11101.9 7893.6 7893.7 8013.8 8036.6 8320.0 8248.9 10178.9 10774.7 10887.3 11029.3 00:24:41 INFO - PROCESS | 1964 | 00:24:41 INFO - PROCESS | 1964 | [#3] mootools.html Cycles:180 Average:5636.63 Median:5010.75 stddev:3136.09 (62.6%) stddev-sans-first:3128.93 00:24:41 INFO - PROCESS | 1964 | Values: 1427.4 1609.7 1614.7 1880.5 2001.8 7857.3 8536.9 8811.2 8814.3 8814.7 8436.2 8669.3 8670.7 8680.8 8688.8 2140.9 2238.8 2242.6 2408.7 2453.1 2237.7 2388.1 2485.2 2489.7 2489.9 2043.6 2409.0 2429.4 2430.3 2449.2 2111.0 2416.4 2423.5 2424.8 2433.3 2354.2 2444.2 2448.0 2449.6 2452.8 8337.0 8538.4 8612.0 8613.4 8621.7 4570.0 5239.6 5239.9 5244.8 5281.9 2945.4 3362.6 3432.8 3531.5 3533.4 1028.4 1043.4 1044.6 1052.7 1056.1 11556.3 11594.2 11596.4 11596.5 11651.1 4550.9 4575.6 4777.8 4788.6 4835.8 9914.9 9933.5 9951.3 9951.8 9959.6 5361.2 5365.8 5376.7 5406.3 5410.2 4769.5 4814.4 4885.5 4906.5 4947.8 3303.9 3930.0 4004.2 4054.1 4055.2 1137.6 1325.7 1339.5 1352.6 1354.2 692.6 841.1 887.8 889.7 936.9 5021.5 5512.6 5659.2 5823.3 5877.2 926.5 948.0 963.3 967.9 977.4 3804.0 3853.6 3906.8 3965.4 3970.1 10251.9 10653.9 10740.9 10757.0 10799.5 9310.8 10416.3 10544.4 10577.2 10600.7 7891.8 8111.3 8124.9 8192.0 8198.6 5694.5 5789.3 5832.7 6018.4 6038.6 9160.8 9816.3 9909.4 9979.7 10023.9 9083.4 9480.6 9749.5 9857.2 9880.8 7196.4 7519.4 7519.8 7525.7 7529.3 7986.2 8324.4 8383.4 8383.7 8394.2 7348.7 7349.4 7354.0 7463.3 7508.6 7183.9 7189.1 7259.2 7296.0 7336.6 6639.8 6650.9 6704.7 6787.5 6806.4 4791.0 4806.3 4826.9 4901.4 5000.0 4790.0 4814.4 4851.6 4864.8 4924.0 00:24:41 INFO - PROCESS | 1964 | 00:24:41 INFO - PROCESS | 1964 | [#4] prototype.html Cycles:180 Average:5024.26 Median:5552.33 stddev:1556.31 (28.0%) stddev-sans-first:1519.91 00:24:41 INFO - PROCESS | 1964 | Values: 309.5 316.6 325.1 327.3 330.0 5409.5 5883.4 5958.4 5968.9 5974.9 5528.5 5624.9 5775.4 5862.8 5882.4 3639.4 4346.5 4392.4 4425.1 4453.2 4396.8 4413.2 4414.7 4436.3 4440.8 4282.1 4359.6 4384.0 4393.0 4400.3 4362.4 4382.2 4387.4 4387.7 4409.1 3831.0 3831.4 3836.7 3839.0 3844.8 4369.8 5419.4 5611.5 5637.8 5654.2 3996.4 5044.9 5122.2 5142.6 5147.6 5161.8 5419.8 6169.0 6169.2 6204.3 3572.9 3584.8 4098.8 4100.4 4269.4 6497.7 6578.8 6596.4 6600.4 6672.5 4141.0 4348.2 4350.2 4355.1 4355.2 3747.2 4264.3 4392.6 4409.4 4427.5 4076.8 4722.2 4827.6 5123.8 5124.6 6204.6 6217.4 6248.4 6259.5 6305.5 1452.5 1454.8 1483.8 1520.3 1536.8 999.4 1021.6 1032.7 1034.0 1037.8 5164.6 5773.8 5837.1 5839.0 5874.2 4841.7 5779.8 6416.6 6436.9 6454.9 5053.6 5294.7 5366.5 5711.5 5758.3 3361.4 3364.6 3365.8 3394.6 3405.9 5560.7 6421.3 6708.7 6711.9 6746.6 6193.6 6558.7 6573.6 6586.6 6618.5 5574.8 5943.3 6269.7 6641.1 6723.6 5670.9 5887.9 6367.6 6413.9 6436.6 5243.1 5526.5 6205.8 6354.0 6360.6 6389.0 6394.5 6613.0 6691.5 6708.7 4329.1 4354.2 4364.0 4371.7 4375.7 5544.0 6372.1 6389.4 6407.8 6434.6 5292.3 5695.3 5841.6 6103.0 6276.0 6280.3 6281.2 6283.7 6301.7 6321.0 5132.2 5956.5 6163.6 6190.2 6190.5 5948.0 6297.6 6310.3 6330.0 6341.4 4719.0 6052.8 6074.3 6164.0 6202.4 00:24:41 INFO - PROCESS | 1964 | 00:24:41 INFO - PROCESS | 1964 | [#5] yui.html Cycles:180 Average:17518.07 Median:34279.30 stddev:24716.53 (72.1%) stddev-sans-first:24753.45 00:24:41 INFO - PROCESS | 1964 | Values: 659.9 673.1 718.2 742.8 758.3 14496.9 14916.5 14925.8 14959.6 14968.3 13374.4 13708.6 13724.8 13792.6 13958.4 722.8 906.3 924.8 933.0 934.9 737.4 900.5 936.0 936.2 937.8 973.1 973.9 975.4 977.0 978.7 748.3 941.7 965.0 965.9 969.3 727.8 730.7 731.4 731.8 733.5 14654.7 14738.0 14740.0 14749.6 14764.3 12410.2 12468.4 12687.8 12790.5 12825.6 10033.0 10109.3 10229.1 10468.6 10754.9 3481.6 3522.8 3619.7 3631.0 3716.2 80588.0 80734.6 81523.0 81786.6 84732.6 9484.2 9642.9 9685.1 9744.7 10069.9 22156.1 22193.4 22195.2 22244.2 22259.9 7535.5 7678.4 7692.0 7765.8 7766.3 4090.2 4189.4 4210.0 4227.5 4312.4 3501.5 3597.5 3608.0 3609.7 3613.8 627.4 639.4 647.9 656.0 659.1 548.5 583.6 586.7 603.6 627.2 7328.7 7428.5 7500.1 7530.7 7873.8 535.9 569.9 570.8 582.5 600.7 2838.3 3553.8 3570.0 3639.2 3705.4 85797.6 86734.6 87822.1 88373.1 88606.6 76096.0 76297.6 76313.6 76778.6 78206.6 65414.0 66941.7 67737.7 67895.0 68306.0 6224.9 7073.3 7082.2 7132.5 7237.9 41701.6 42105.9 43170.1 43313.4 43322.9 61363.5 62333.7 62757.7 62804.0 63491.0 10013.1 10102.5 10185.6 10238.0 10616.7 10878.4 10879.1 10883.4 11040.8 11274.9 10285.2 10471.6 10568.8 10597.7 10616.8 9776.3 10146.6 10405.8 10428.6 10432.2 10188.5 10382.5 10468.2 10472.4 10488.2 8426.7 8463.8 8690.1 8740.0 8781.6 8814.9 8815.3 8961.3 9010.9 9057.7 00:24:41 INFO - PROCESS | 1964 | -------- Summary: end -------- 00:24:41 INFO - PROCESS | 1964 | 00:24:41 INFO - TEST-INFO | 1964: exit 0 00:24:41 INFO - TEST-OK | dromaeo_css | took 1114685ms 00:24:41 INFO - TEST-START | kraken 00:24:41 INFO - operating with platform_type : mac_ 00:24:41 INFO - Initialising browser for kraken test... 00:24:41 INFO - TEST-INFO | started process 1966 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpTj7PgJ/profile http://localhost:56057/getInfo.html) 00:24:43 INFO - PROCESS | 1966 | __metrics Screen width/height:1600/1200 00:24:43 INFO - PROCESS | 1966 | colorDepth:24 00:24:43 INFO - PROCESS | 1966 | Browser inner width/height: 1024/689 00:24:43 INFO - PROCESS | 1966 | __metrics 00:24:44 INFO - PROCESS | 1966 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 00:24:44 ERROR - PROCESS | 1966 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 00:24:44 INFO - TEST-INFO | 1966: exit 0 00:24:44 INFO - Browser initialized. 00:24:44 INFO - Running cycle 1/1 for kraken test... 00:24:44 INFO - TEST-INFO | started process 1968 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/tmpTj7PgJ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:24:56 INFO - PROCESS | 1968 | RSS: Main: 237776896 00:24:56 INFO - PROCESS | 1968 | 00:24:59 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:56057/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56057/tests/kraken/driver.html?testName=audio-beat-detection) 00:25:00 INFO - PROCESS | 1968 | RSS: Main: 285691904 00:25:00 INFO - PROCESS | 1968 | 00:25:02 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:56057/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56057/tests/kraken/driver.html?testName=audio-dft) 00:25:03 INFO - PROCESS | 1968 | RSS: Main: 299257856 00:25:03 INFO - PROCESS | 1968 | 00:25:06 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:56057/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56057/tests/kraken/driver.html?testName=audio-fft) 00:25:07 INFO - PROCESS | 1968 | RSS: Main: 385417216 00:25:07 INFO - PROCESS | 1968 | 00:25:09 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:56057/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56057/tests/kraken/driver.html?testName=audio-oscillator) 00:25:10 INFO - PROCESS | 1968 | RSS: Main: 286408704 00:25:10 INFO - PROCESS | 1968 | 00:25:12 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:56057/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56057/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:25:12 INFO - PROCESS | 1968 | RSS: Main: 290533376 00:25:12 INFO - PROCESS | 1968 | 00:25:15 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:56057/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56057/tests/kraken/driver.html?testName=imaging-darkroom) 00:25:16 INFO - PROCESS | 1968 | RSS: Main: 328527872 00:25:16 INFO - PROCESS | 1968 | 00:25:18 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:56057/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56057/tests/kraken/driver.html?testName=imaging-desaturate) 00:25:19 INFO - PROCESS | 1968 | RSS: Main: 329330688 00:25:19 INFO - PROCESS | 1968 | 00:25:22 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:56057/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56057/tests/kraken/driver.html?testName=json-parse-financial) 00:25:22 INFO - PROCESS | 1968 | RSS: Main: 327839744 00:25:22 INFO - PROCESS | 1968 | 00:25:24 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:56057/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56057/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:25:25 INFO - PROCESS | 1968 | RSS: Main: 319807488 00:25:25 INFO - PROCESS | 1968 | 00:25:26 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:56057/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56057/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:25:27 INFO - PROCESS | 1968 | RSS: Main: 326725632 00:25:27 INFO - PROCESS | 1968 | 00:25:29 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:56057/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56057/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:25:30 INFO - PROCESS | 1968 | RSS: Main: 329687040 00:25:30 INFO - PROCESS | 1968 | 00:25:33 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:56057/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56057/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:25:33 INFO - PROCESS | 1968 | RSS: Main: 334135296 00:25:33 INFO - PROCESS | 1968 | 00:25:36 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:56057/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56057/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:25:37 INFO - PROCESS | 1968 | RSS: Main: 331845632 00:25:37 INFO - PROCESS | 1968 | 00:25:39 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:56057/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56057/tests/kraken/driver.html?testName=ai-astar) 00:25:39 INFO - PROCESS | 1968 | RSS: Main: 395980800 00:25:39 INFO - PROCESS | 1968 | 00:25:39 INFO - PROCESS | 1968 | __start_tp_report 00:25:39 INFO - PROCESS | 1968 | _x_x_mozilla_page_load 00:25:39 INFO - PROCESS | 1968 | _x_x_mozilla_page_load_details 00:25:39 INFO - PROCESS | 1968 | |i|pagename|runs| 00:25:39 INFO - PROCESS | 1968 | |0;ai-astar;113;111;113;112;112;114;120;113;111;113 00:25:39 INFO - PROCESS | 1968 | |1;audio-beat-detection;166;154;177;170;118;143;139;120;167;119 00:25:39 INFO - PROCESS | 1968 | |2;audio-dft;187;186;187;185;186;181;182;184;183;188 00:25:39 INFO - PROCESS | 1968 | |3;audio-fft;76;73;87;95;56;58;61;79;84;53 00:25:39 INFO - PROCESS | 1968 | |4;audio-oscillator;89;96;134;77;79;81;121;79;76;121 00:25:39 INFO - PROCESS | 1968 | |5;imaging-gaussian-blur;89;86;89;87;90;85;90;87;89;84 00:25:39 INFO - PROCESS | 1968 | |6;imaging-darkroom;93;93;94;94;93;93;91;94;93;96 00:25:39 INFO - PROCESS | 1968 | |7;imaging-desaturate;87;88;85;84;85;86;86;83;87;87 00:25:39 INFO - PROCESS | 1968 | |8;json-parse-financial;58;61;59;59;59;59;59;79;60;58 00:25:39 INFO - PROCESS | 1968 | |9;json-stringify-tinderbox;63;63;78;77;70;70;67;68;68;67 00:25:39 INFO - PROCESS | 1968 | |10;stanford-crypto-aes;82;83;83;82;81;82;83;79;82;83 00:25:39 INFO - PROCESS | 1968 | |11;stanford-crypto-ccm;140;140;137;135;136;139;143;152;195;149 00:25:39 INFO - PROCESS | 1968 | |12;stanford-crypto-pbkdf2;172;169;170;175;171;174;170;173;171;160 00:25:39 INFO - PROCESS | 1968 | |13;stanford-crypto-sha256-iterative;68;68;68;68;68;69;68;71;71;90 00:25:39 INFO - PROCESS | 1968 | __end_tp_report 00:25:39 INFO - PROCESS | 1968 | __start_cc_report 00:25:39 INFO - PROCESS | 1968 | _x_x_mozilla_cycle_collect,1923 00:25:39 INFO - PROCESS | 1968 | __end_cc_report 00:25:39 INFO - PROCESS | 1968 | __startTimestamp1461137139315__endTimestamp 00:25:39 INFO - PROCESS | 1968 | 00:25:39 INFO - PROCESS | 1968 | ------- Summary: start ------- 00:25:39 INFO - PROCESS | 1968 | Number of tests: 14 00:25:39 INFO - PROCESS | 1968 | 00:25:39 INFO - PROCESS | 1968 | [#0] ai-astar Cycles:10 Average:113.20 Median:113.00 stddev:2.57 (2.3%) stddev-sans-first:2.73 00:25:39 INFO - PROCESS | 1968 | Values: 113.0 111.0 113.0 112.0 112.0 114.0 120.0 113.0 111.0 113.0 00:25:39 INFO - PROCESS | 1968 | 00:25:39 INFO - PROCESS | 1968 | [#1] audio-beat-detection Cycles:10 Average:147.30 Median:160.00 stddev:22.78 (14.2%) stddev-sans-first:23.14 00:25:39 INFO - PROCESS | 1968 | Values: 166.0 154.0 177.0 170.0 118.0 143.0 139.0 120.0 167.0 119.0 00:25:39 INFO - PROCESS | 1968 | 00:25:39 INFO - PROCESS | 1968 | [#2] audio-dft Cycles:10 Average:184.90 Median:186.00 stddev:2.33 (1.3%) stddev-sans-first:2.35 00:25:39 INFO - PROCESS | 1968 | Values: 187.0 186.0 187.0 185.0 186.0 181.0 182.0 184.0 183.0 188.0 00:25:39 INFO - PROCESS | 1968 | 00:25:39 INFO - PROCESS | 1968 | [#3] audio-fft Cycles:10 Average:72.20 Median:77.50 stddev:14.52 (18.7%) stddev-sans-first:15.34 00:25:39 INFO - PROCESS | 1968 | Values: 76.0 73.0 87.0 95.0 56.0 58.0 61.0 79.0 84.0 53.0 00:25:39 INFO - PROCESS | 1968 | 00:25:39 INFO - PROCESS | 1968 | [#4] audio-oscillator Cycles:10 Average:95.30 Median:79.00 stddev:21.86 (27.7%) stddev-sans-first:23.07 00:25:39 INFO - PROCESS | 1968 | Values: 89.0 96.0 134.0 77.0 79.0 81.0 121.0 79.0 76.0 121.0 00:25:39 INFO - PROCESS | 1968 | 00:25:39 INFO - PROCESS | 1968 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:89.00 stddev:2.12 (2.4%) stddev-sans-first:2.19 00:25:39 INFO - PROCESS | 1968 | Values: 89.0 86.0 89.0 87.0 90.0 85.0 90.0 87.0 89.0 84.0 00:25:39 INFO - PROCESS | 1968 | 00:25:39 INFO - PROCESS | 1968 | [#6] imaging-darkroom Cycles:10 Average:93.40 Median:93.50 stddev:1.26 (1.4%) stddev-sans-first:1.33 00:25:39 INFO - PROCESS | 1968 | Values: 93.0 93.0 94.0 94.0 93.0 93.0 91.0 94.0 93.0 96.0 00:25:39 INFO - PROCESS | 1968 | 00:25:39 INFO - PROCESS | 1968 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.50 stddev:1.55 (1.8%) stddev-sans-first:1.58 00:25:39 INFO - PROCESS | 1968 | Values: 87.0 88.0 85.0 84.0 85.0 86.0 86.0 83.0 87.0 87.0 00:25:39 INFO - PROCESS | 1968 | 00:25:39 INFO - PROCESS | 1968 | [#8] json-parse-financial Cycles:10 Average:61.10 Median:59.00 stddev:6.35 (10.8%) stddev-sans-first:6.64 00:25:39 INFO - PROCESS | 1968 | Values: 58.0 61.0 59.0 59.0 59.0 59.0 59.0 79.0 60.0 58.0 00:25:39 INFO - PROCESS | 1968 | 00:25:39 INFO - PROCESS | 1968 | [#9] json-stringify-tinderbox Cycles:10 Average:69.10 Median:69.00 stddev:5.04 (7.3%) stddev-sans-first:4.84 00:25:39 INFO - PROCESS | 1968 | Values: 63.0 63.0 78.0 77.0 70.0 70.0 67.0 68.0 68.0 67.0 00:25:39 INFO - PROCESS | 1968 | 00:25:39 INFO - PROCESS | 1968 | [#10] stanford-crypto-aes Cycles:10 Average:82.00 Median:82.50 stddev:1.25 (1.5%) stddev-sans-first:1.32 00:25:39 INFO - PROCESS | 1968 | Values: 82.0 83.0 83.0 82.0 81.0 82.0 83.0 79.0 82.0 83.0 00:25:39 INFO - PROCESS | 1968 | 00:25:39 INFO - PROCESS | 1968 | [#11] stanford-crypto-ccm Cycles:10 Average:146.60 Median:141.50 stddev:17.87 (12.6%) stddev-sans-first:18.79 00:25:39 INFO - PROCESS | 1968 | Values: 140.0 140.0 137.0 135.0 136.0 139.0 143.0 152.0 195.0 149.0 00:25:39 INFO - PROCESS | 1968 | 00:25:39 INFO - PROCESS | 1968 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.50 Median:171.50 stddev:4.14 (2.4%) stddev-sans-first:4.36 00:25:39 INFO - PROCESS | 1968 | Values: 172.0 169.0 170.0 175.0 171.0 174.0 170.0 173.0 171.0 160.0 00:25:39 INFO - PROCESS | 1968 | 00:25:39 INFO - PROCESS | 1968 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:68.50 stddev:6.82 (10.0%) stddev-sans-first:7.16 00:25:39 INFO - PROCESS | 1968 | Values: 68.0 68.0 68.0 68.0 68.0 69.0 68.0 71.0 71.0 90.0 00:25:39 INFO - PROCESS | 1968 | -------- Summary: end -------- 00:25:39 INFO - PROCESS | 1968 | 00:25:40 INFO - TEST-INFO | 1968: exit 0 00:25:40 INFO - TEST-OK | kraken | took 58329ms 00:25:40 INFO - SUITE-END | took 1173s 00:25:40 INFO - Completed test suite (00:19:33) 00:25:40 INFO - javascript benchmark 00:25:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3327.9667203327963, 3360.4623260278345, 3386.55974723286, 3401.6088149862744, 3425.7430692698053, 5419.647722898009, 5515.613907026504, 5522.806701765429, 5536.640118392307, 5548.972255138724, 4140.834366625331, 5518.365387980383, 5578.525825304844, 5623.437656234374, 5679.261695979527, 4975.353204083464, 4977.452480227181, 5025.221090730943, 5039.269305950635, 5210.452902445246, 5111.872203194913, 5120.871978200537, 5145.588352931756, 5161.0, 5202.713850738208, 4992.251162325644, 5001.0, 5052.469490703496, 5071.771770270309, 5115.309433226504, 4206.936895946563, 5045.142325804622, 5085.110105731482, 5087.440381558025, 5089.491050894918, 5033.119204139261, 5040.395152581677, 5050.0, 5057.393112826484, 5061.114304996611, 5316.6544174628525, 5362.115250983583, 5440.129579267338, 5480.890382192374, 5500.724963751796, 6075.908861367083, 6112.388761123896, 6134.478569321613, 6146.877062458726, 6155.353687862755, 5094.388673359221, 6183.907241391383, 6222.906656400158, 6233.750649974041, 6233.937660623381, 5032.723200223986, 5595.328560572757, 5608.887822243573, 5715.771369145187, 5738.196652468658, 6300.527460440485, 6320.178376810985, 6320.873582528324, 6332.366763323631, 6349.174607301022, 5959.046552551571, 5964.343922168558, 5973.671448070398, 5979.850503737442, 5994.580379373402, 5992.34084250732, 6110.388961103943, 6129.0, 6166.907496387557, 6184.0, 6001.399860013964, 6087.6956152192215, 6095.329513753483, 6097.085437184458, 6102.0, 6033.7586496540525, 6131.110988906584, 6139.754409823557, 6155.938440615537, 6193.566450348522, 4748.976255118771, 4814.855554333376, 4820.108279968217, 4824.179889418807, 4830.565249127595, 4294.7852607369505, 4400.647948164139, 4415.381846541487, 4418.116376724668, 4432.534583868712, 4670.486246512881, 5555.916661250085, 5624.465675760796, 5655.830325090254, 5675.404082571353, 6096.0, 6170.413810687977, 6174.9073763893575, 6181.536384771161, 6182.505399568024, 5479.6164268500825, 5554.583406244547, 5581.6930068846605, 5592.7762889483965, 5598.972005139948, 5245.659032162897, 5274.314339135888, 5289.2859463972645, 5325.334333208349, 5340.0, 6267.059941008885, 6306.747730090837, 6315.96842015787, 6318.873622527523, 6353.0, 5954.672493012926, 6030.0, 6055.455009049207, 6137.938620613915, 6139.662318572343, 6213.689315534296, 6326.810195694136, 6338.556301058881, 6339.049142628643, 6341.936580634135, 5977.163197152315, 5984.162217289496, 5987.401259873977, 5990.324699886552, 5993.160957465871, 5922.911156332744, 5950.791722289872, 6123.2652081750475, 6132.110769108063, 6146.631202127886, 5864.618799778001, 5888.087346461305, 5898.026825573732, 5902.350741418355, 5914.34942156371, 5824.184614154106, 5870.970645146747, 5886.175935368966, 5897.64614123154, 5921.526277897672, 5639.041362968387, 5677.176809362537, 5724.4561766632105, 5799.0, 5805.709714514342, 5892.204552385373, 5908.143319218603, 5911.083782013795, 5921.970390148022, 5934.169216309807, 5290.947090529199, 5523.922835047128, 5763.510101641407, 5817.680027598522, 5824.650520968756], "value": 5551.553163045687, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [497.94771548987376, 498.1730327656089, 529.9072662284101, 578.8581797459623, 594.0821430889275, 26328.605070923928, 30724.07827765168, 38249.426258606145, 39192.0, 39400.0, 43682.563174368246, 44447.0, 44455.888602784864, 44549.55450445494, 44644.0, 8557.914420855774, 9684.661036863728, 9928.45393503357, 9936.503174841266, 9937.652182173626, 11499.425028748528, 11848.466818993165, 11857.0, 11861.347625880573, 11877.524899004073, 9640.71077867665, 11426.657200284004, 11579.421028948518, 11681.883181168207, 11691.0, 11533.365664888428, 11586.652400427958, 11633.941830290794, 11638.301701897914, 11644.59243926467, 11438.885611143865, 11579.594714184963, 11581.07351411885, 11763.764724705457, 11769.293842369485, 40441.0, 40792.18415631671, 40908.1818363634, 40925.0, 40991.59008409937, 3276.967230327714, 3339.2987472630775, 3396.3886500429912, 3400.540926974876, 3601.891943241707, 21793.782062179333, 29266.0, 29445.852770736223, 29488.8525557373, 29639.55540666892, 2728.4952283827356, 2730.9180724578296, 2751.5322395192866, 2759.4756996170663, 2851.800373973823, 466093.0, 467981.0, 471235.0, 472486.6375668134, 472519.0, 52902.0, 63451.0, 63831.0, 63922.32932048091, 64122.679386602766, 68705.65647171732, 68922.65538672275, 69199.96200057003, 69221.30778692149, 69268.0, 16326.75509867353, 17001.829981700273, 17026.020446421826, 17031.574210644834, 17087.401940932257, 11797.17419780607, 12851.48594056246, 13052.34738263083, 13144.539941102015, 13186.472541098441, 18015.18931648079, 18051.097445127954, 18074.638507230044, 18082.909585451987, 18102.5474363142, 6642.468602511787, 6685.6322902240845, 6688.4649228061635, 6708.765193218214, 6717.261101278856, 984.4437892590663, 994.3039872089566, 1062.2776511971779, 1074.4788777442934, 1093.7593729379682, 29508.409831803245, 29848.40303193924, 29892.0, 30324.84837575798, 30910.690893091232, 1103.7957977774138, 1124.2692250037378, 1162.633770362333, 1219.9878001219874, 1252.8997680185564, 15106.471273505374, 15264.923675381775, 15499.380024799108, 15550.611234718996, 15779.0, 598014.0, 598670.1263379971, 603826.0, 604080.0, 608387.0, 61667.69166154141, 62112.68943655253, 62162.0, 62282.0, 62491.37508624946, 1394.219237227156, 1473.9852601474063, 1477.6822983058694, 1488.2038109611306, 1534.1638806850294, 28623.713762862106, 28794.424111517234, 28977.0, 29428.411431770815, 29647.88450771756, 48853.755731221114, 49222.75388623034, 49329.50670493393, 49391.25913111378, 49543.75228123836, 396153.0, 409754.0, 410653.0, 410872.0, 411139.0, 26487.0, 26882.32794180161, 27550.5867411993, 27587.0, 27698.86150569234, 42799.3580096305, 43080.784596078076, 43155.78422107869, 43198.568014320714, 43502.34746478868, 37007.26387409956, 37291.81354093212, 37462.0, 37919.241615168095, 38179.61820381872, 37195.6280437203, 37449.0, 38153.618463816114, 38859.417108742826, 39228.80385598168, 35203.0, 35814.64185358113, 35995.82002089973, 36678.8166059168, 36790.26419471649, 30815.383692326475, 31459.75538614118, 31690.683093168773, 32219.194520137185, 32536.34927301488, 20812.68780968317, 24294.14970476025, 24342.026318947752, 24663.63004554969, 25677.61483577785], "value": 19995.08945687869, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.8138911933153, 389.1749491078912, 391.1180288449546, 398.26958731030663, 399.7841165770484, 14838.480653177141, 16464.423745168922, 19379.12793924273, 20001.499962500944, 20010.59978800425, 19409.93245371504, 19828.70256946147, 20662.380128596127, 20686.68969965452, 20728.792712072875, 5382.865428364283, 5937.584369094165, 5950.196723442323, 5952.672603006833, 5956.940430595703, 4098.549159592442, 4190.266703326905, 5829.067349224125, 5946.167536544887, 5950.494207992326, 6435.581687190341, 6500.057491663706, 6504.317046710098, 6506.219253689564, 6526.902096468557, 6241.28225254097, 6465.773697920574, 6564.901526477107, 6574.14536110305, 6575.112359831457, 5379.623426360156, 5678.545716342683, 5686.232358631614, 5686.516646085088, 5702.885942281173, 21597.46006349838, 24783.0, 25147.62278565823, 25524.744752552422, 25556.572125648032, 2236.7539570647214, 2246.9101235950543, 2258.288639078701, 2301.4476525633895, 2823.39297051135, 14253.572392828231, 14634.268286585628, 14779.33492992807, 15043.699126017527, 15050.774238386433, 1582.319602570894, 1652.9504114876572, 1727.369510128794, 1828.3783513605438, 1859.7675290588677, 103628.96371036344, 113731.43134284441, 118739.0, 122386.0, 122958.15562766566, 11457.942710286396, 11509.769804604028, 11555.2489088209, 11660.591879284184, 11727.944484996391, 13246.470141194437, 13836.169829810244, 13852.861471385359, 14904.18027008525, 14989.70020599582, 7167.319104685047, 7576.772696819105, 8389.790255243546, 8487.618057187441, 8521.744347669579, 7223.386012189023, 7685.00094987648, 8156.184381561915, 8173.0, 8448.32413406926, 4405.757683327448, 4480.0, 4497.460304763449, 4553.157665831832, 4560.901985086897, 1644.4984279794778, 1889.3576184097474, 1954.4234450837037, 1967.4884530022298, 1980.3464856597288, 891.3092353426147, 972.7422233108232, 977.2572844637984, 1001.4992503748126, 1082.6481393547128, 16522.917385412995, 18875.0, 19755.901220493804, 19782.70325945112, 19867.205311787366, 957.9377340472986, 967.144077491411, 976.9658061967797, 983.9704808855746, 992.1814503035025, 8209.917900820916, 10427.843582346271, 10440.791184176274, 10451.634192803216, 10463.05832475081, 505698.0, 512325.0, 513335.0, 585914.0, 589900.0, 82964.3407131854, 131099.0, 142767.28616356853, 144063.0, 144377.27811361087, 976.3360914578013, 982.3172894838161, 1027.6814187601867, 1030.701096681954, 1050.0444595418285, 16716.916415417843, 17512.299508020045, 17622.942623442636, 17917.73123403124, 17983.550411239823, 35169.29661406706, 40884.0, 48645.756771215914, 49123.52629421123, 49277.76805579889, 69802.65098674475, 72275.0, 72408.27591724016, 73211.26788732044, 74512.88230676652, 6861.451083913175, 7791.805204869924, 7887.0, 7983.321417679563, 8041.155678653891, 10757.677269681923, 12125.878741212475, 12370.13409061357, 12510.249385036926, 12568.811467828173, 10234.33476824004, 10620.52207650673, 10847.945760271148, 11038.779224415628, 11074.39090850011, 10415.791684166123, 10688.572457101629, 10689.358638481715, 10864.728381790519, 10924.399158046384, 10702.197335199735, 10861.34831910088, 11012.889871101186, 11100.500477478372, 11101.945315195366, 7893.644785984759, 7893.684252629831, 8013.799655008672, 8036.557989310644, 8320.04319503265, 8248.876266856121, 10178.898211017795, 10774.73063173427, 10887.346759194474, 11029.283096599016], "value": 9412.204033529897, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1427.393357822925, 1609.6539244062526, 1614.7012802631511, 1880.5204672808431, 2001.8398528117752, 7857.3321267692245, 8536.871946920794, 8811.162939520735, 8814.25078868296, 8814.735557933273, 8436.198561136682, 8669.306455483562, 8670.696525621604, 8680.782980425476, 8688.782780430492, 2140.871547707143, 2238.8432809703327, 2242.6299660555987, 2408.722996855362, 2453.1046168148587, 2237.686723858661, 2388.0805889732405, 2485.2420011896365, 2489.676342075528, 2489.850608963459, 2043.5912817436497, 2409.0484258717797, 2429.356220601542, 2430.307362401716, 2449.1795248591743, 2110.9683354749536, 2416.395901024744, 2423.503181847717, 2424.830261881669, 2433.2700189943034, 2354.1525050981804, 2444.1567659157563, 2447.963280550793, 2449.595816690244, 2452.766987136219, 8336.999560052773, 8538.359623028298, 8611.95694021526, 8613.440126391764, 8621.741347759515, 4569.977150114261, 5239.5546378557865, 5239.921401178985, 5244.79020839166, 5281.9207711884355, 2945.440366330412, 3362.5628668272966, 3432.7768695034742, 3531.4526248431534, 3533.4169861972746, 1028.444639894456, 1043.3791893823163, 1044.5769463367349, 1052.6736711619421, 1056.118141351972, 11556.284273195792, 11594.188406811527, 11596.420178991017, 11596.536138554533, 11651.126165537535, 4550.908981820345, 4575.565321294472, 4777.757782976451, 4788.569028787426, 4835.782389792468, 9914.851277230848, 9933.453660048623, 9951.25365597583, 9951.751206219902, 9959.601615935426, 5361.195820626937, 5365.7585408656705, 5376.704281264568, 5406.297181366397, 5410.215518749838, 4769.475357710649, 4814.422269327703, 4885.462599114095, 4906.484819094015, 4947.752612369439, 3303.884364047247, 3929.980350098231, 4004.2391945530258, 4054.1486287879284, 4055.2295063938345, 1137.556353022322, 1325.6619562011817, 1339.4776037345443, 1352.5671785028696, 1354.2348573056192, 692.56022425759, 841.1252297610539, 887.8236336853695, 889.7241855024963, 936.8594710793299, 5021.5229553192385, 5512.5589952803675, 5659.207710920475, 5823.283190328038, 5877.206577112121, 926.5221970956449, 947.9810403792023, 963.2967933408651, 967.949774494667, 977.3988996766938, 3804.0299723570865, 3853.5761066282685, 3906.824192911326, 3965.4448377227213, 3970.1265721541213, 10251.948740256401, 10653.9467302663, 10740.946295268473, 10757.0, 10799.514021868878, 9310.767230819283, 10416.270861039655, 10544.420056896945, 10577.153827693766, 10600.681979540626, 7891.802704932308, 8111.269985701315, 8124.918750812534, 8192.0, 8198.59007049657, 5694.487496125369, 5789.305283366023, 5832.708364581669, 6018.3680713524445, 6038.607490513103, 9160.816783664422, 9816.312858099864, 9909.355891867006, 9979.700608981742, 10023.949880250551, 9083.409578377385, 9480.620775169193, 9749.463779492196, 9857.162141218078, 9880.752981175241, 7196.424286056998, 7519.360854327443, 7519.774406767806, 7525.736599219001, 7529.284717951786, 7986.161453047346, 8324.375671824517, 8383.371247156365, 8383.706570270011, 8394.160583941557, 7348.70605175787, 7349.412047036118, 7354.043974283309, 7463.328300452985, 7508.624568771649, 7183.892241616484, 7189.137303523611, 7259.165196002316, 7296.015037970018, 7336.559806411632, 6639.767608133692, 6650.933490665225, 6704.66476676174, 6787.490938179755, 6806.353396427331, 4791.0, 4806.255030470283, 4826.927596085991, 4901.362822833009, 4999.9750051240135, 4789.99410123864, 4814.422269327703, 4851.58761505276, 4864.756762161948, 4923.950760492349], "value": 4546.742070021532, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [309.46771552928953, 316.637450119613, 325.0686782368515, 327.33387556322856, 329.9836503569008, 5409.5401890839275, 5883.382244864287, 5958.43394877487, 5968.850778730534, 5974.8805023899495, 5528.530074943635, 5624.915626265599, 5775.422457754223, 5862.794802181925, 5882.382349853257, 3639.399499082648, 4346.500152482457, 4392.3631073494325, 4425.092855964527, 4453.176162409948, 4396.824127034931, 4413.161499315136, 4414.7351158930405, 4436.29019356903, 4440.755758433284, 4282.099526373835, 4359.585839345257, 4383.978080109611, 4392.97803510982, 4400.273954797454, 4362.411074504965, 4382.2331092059085, 4387.3857659927635, 4387.714798538117, 4409.096135292273, 3831.0039389758863, 3831.4061320495366, 3836.693064554829, 3838.9826695925603, 3844.8462061517507, 4369.847055353048, 5419.376771671269, 5611.494965453088, 5637.830865074055, 5654.151877218409, 3996.360582306817, 5044.899102017939, 5122.231665250205, 5142.640015198937, 5147.562457191143, 5161.81933632321, 5419.783208671648, 6169.043798211284, 6169.198004259418, 6204.348543402968, 3572.8570857165682, 3584.7849129052343, 4098.7950602470055, 4100.384942258655, 4269.4449721536, 6497.732942076297, 6578.8026359208825, 6596.373344532261, 6600.4389626881775, 6672.466202703772, 4140.958590414118, 4348.239058164809, 4350.2387082260475, 4355.128974205171, 4355.1725172217175, 3747.15688969985, 4264.272969447379, 4392.5518468002465, 4409.368533642509, 4427.46870375557, 4076.7961601919787, 4722.150012997693, 4827.61379089672, 5123.846284611468, 5124.564412024945, 6204.5967012144065, 6217.409346112112, 6248.375162483715, 6259.530535209878, 6305.527085468608, 1452.4988878836996, 1454.8036015138032, 1483.8219413670429, 1520.2702702702766, 1536.8002159719165, 999.4153420249236, 1021.5760459409411, 1032.6575451912483, 1034.0, 1037.7716902281486, 5164.624272834538, 5773.769049237983, 5837.073765657323, 5838.970805145947, 5874.206982057368, 4841.661083724176, 5779.826605201851, 6416.615003099829, 6436.935630643728, 6454.935450645527, 5053.620978426559, 5294.735263236823, 5366.524205843424, 5711.485966262973, 5758.337791154071, 3361.428557145291, 3364.62989071202, 3365.798052116832, 3394.6435624259593, 3405.897823065312, 5560.694161821058, 6421.325760795049, 6708.731650733916, 6711.932880671131, 6746.628935408501, 6193.628382297076, 6558.672066396661, 6573.57271777333, 6586.637734924625, 6618.4705223582, 5574.804881829116, 5943.346231914573, 6269.686515674198, 6641.1366522352755, 6723.596584204964, 5670.914936275876, 5887.911681324698, 6367.649779262185, 6413.8717225656155, 6436.613803171825, 5243.134882744457, 5526.530244929226, 6205.782797602063, 6353.951597986281, 6360.586561873463, 6388.968055159695, 6394.488440924808, 6612.966935165294, 6691.46468282546, 6708.6981085850275, 4329.134173165443, 4354.172707185625, 4363.956360436482, 4371.650267978618, 4375.693701440869, 5543.972280138735, 6372.139761132188, 6389.393007664265, 6407.8465876142745, 6434.581752186093, 5292.338457692788, 5695.316562012585, 5841.620294680833, 6103.023516237381, 6276.027215781562, 6280.340564240689, 6281.246250449793, 6283.748650053946, 6301.6534090625455, 6321.0, 5132.230165475059, 5956.463918247378, 6163.568550201443, 6190.235782801879, 6190.473809726043, 5948.0, 6297.622142671455, 6310.2743184534365, 6330.0, 6341.365863413622, 4718.952810471851, 6052.759184367283, 6074.271087469532, 6164.044573091178, 6202.4417802398], "value": 4529.093116738072, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [659.9076129341892, 673.0846049372852, 718.238667012966, 742.7771668499449, 758.3380006641654, 14496.927515362422, 14916.477923272687, 14925.776113358308, 14959.626009349744, 14968.251587420613, 13374.398152083155, 13708.588742337746, 13724.794128088086, 13792.586222413343, 13958.441662333495, 722.8482018776064, 906.2795077913075, 924.7641851327936, 933.0156684697641, 934.9298802589833, 737.4137560639305, 900.4642237868458, 935.979782037579, 936.1761649748246, 937.8265020971108, 973.1144658360893, 973.9269554783384, 975.4293738163183, 977.0376179463223, 978.7357413498387, 748.3414595156228, 941.6657086734248, 965.030144704571, 965.8647789309467, 969.2682025071097, 727.8325985023421, 730.696760844249, 731.4075598765018, 731.8316787138934, 733.5488674465219, 14654.706905861824, 14738.0, 14740.0, 14749.631259218499, 14764.26178691061, 12410.193337433038, 12468.376581170905, 12687.809682854764, 12790.488380464863, 12825.615231543068, 10033.046860548237, 10109.34289271195, 10229.130523905476, 10468.633597824115, 10754.892451075546, 3481.5822101348, 3522.7886326820217, 3619.69232615228, 3630.981845090758, 3716.1824398632257, 80588.0, 80734.59632701857, 81523.0, 81786.59106704488, 84732.57633711792, 9484.245414598321, 9642.903570964341, 9685.128338449573, 9744.707658770249, 10069.949650251849, 22156.1137554496, 22193.44516387071, 22195.223167189393, 22244.221452249094, 22259.888700556716, 7535.510191837513, 7678.424118191158, 7692.0, 7765.805854853674, 7766.262205090507, 4090.2228576570355, 4189.350650649093, 4210.0, 4227.51383590891, 4312.396264522969, 3501.5272938153025, 3597.4603809428795, 3607.981960090183, 3609.6931760800626, 3613.801240931774, 627.4008322052429, 639.4085470939456, 647.8801421736994, 655.9963256217994, 659.0871642774696, 548.506344290134, 583.5623282538096, 586.6685322792608, 603.6348009454305, 627.1564745417406, 7328.706851725978, 7428.480006399608, 7500.137484189279, 7530.698772049166, 7873.763787086396, 535.904076164245, 569.866081470854, 570.7745440551042, 582.469952343374, 600.6876424259448, 2838.3471801485775, 3553.7868424325334, 3570.0, 3639.217568222845, 3705.3515634763808, 85797.57101214578, 86734.56632716922, 87822.12177878268, 88373.11626883778, 88606.55696721475, 76096.0, 76297.6185119082, 76313.61843190748, 76778.61610692022, 78206.6089669548, 65414.0, 66941.66529167323, 67737.66131169412, 67895.0, 68306.0, 6224.906626400698, 7073.328033836778, 7082.18554866197, 7132.465065120033, 7237.927620723725, 41701.58298416977, 42105.94735131523, 43170.13659726725, 43313.35029974616, 43322.916927075814, 61363.46591335252, 62333.68833155805, 62757.68621157048, 62804.0, 63491.0, 10013.148882345082, 10102.494875256354, 10185.592576296865, 10238.0, 10616.681499555025, 10878.401687906924, 10879.075278601407, 10883.401412922365, 11040.834387484034, 11274.943625282149, 10285.177185824967, 10471.633492827714, 10568.788624227625, 10597.735056623338, 10616.787664246518, 9776.266779991387, 10146.644867429604, 10405.84391234117, 10428.58285668595, 10432.217583681102, 10188.541515631667, 10382.532786024496, 10468.214883883587, 10472.424016679155, 10488.160947124365, 8426.662933482838, 8463.788405289917, 8690.130986901258, 8740.0, 8781.63214374844, 8814.91185088141, 8815.250703690259, 8961.283097352327, 9010.909890901006, 9057.728119180632], "value": 6679.880452106117, "unit": "score"}], "name": "dromaeo_css", "value": 7237.556810842833, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 113.0, 112.0, 112.0, 114.0, 120.0, 113.0, 111.0, 113.0], "value": 113.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 154.0, 177.0, 170.0, 118.0, 143.0, 139.0, 120.0, 167.0, 119.0], "value": 147.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 186.0, 187.0, 185.0, 186.0, 181.0, 182.0, 184.0, 183.0, 188.0], "value": 184.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 73.0, 87.0, 95.0, 56.0, 58.0, 61.0, 79.0, 84.0, 53.0], "value": 72.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 96.0, 134.0, 77.0, 79.0, 81.0, 121.0, 79.0, 76.0, 121.0], "value": 95.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 89.0, 87.0, 90.0, 85.0, 90.0, 87.0, 89.0, 84.0], "value": 87.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 93.0, 94.0, 94.0, 93.0, 93.0, 91.0, 94.0, 93.0, 96.0], "value": 93.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 85.0, 84.0, 85.0, 86.0, 86.0, 83.0, 87.0, 87.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 61.0, 59.0, 59.0, 59.0, 59.0, 59.0, 79.0, 60.0, 58.0], "value": 61.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 78.0, 77.0, 70.0, 70.0, 67.0, 68.0, 68.0, 67.0], "value": 69.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 83.0, 82.0, 81.0, 82.0, 83.0, 79.0, 82.0, 83.0], "value": 82.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 140.0, 137.0, 135.0, 136.0, 139.0, 143.0, 152.0, 195.0, 149.0], "value": 146.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 169.0, 170.0, 175.0, 171.0, 174.0, 170.0, 173.0, 171.0, 160.0], "value": 170.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 71.0, 71.0, 90.0], "value": 70.9, "unit": "score"}], "name": "kraken", "value": 1479.9, "alertThreshold": 2.0}]} 00:25:40 INFO - Return code: 0 00:25:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 00:25:40 ERROR - # TBPL SUCCESS # 00:25:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 00:25:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 00:25:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 00:25:40 INFO - 2016-04-20 00:25:40.587 screenresolution[1972:20081] starting screenresolution argv=screenresolution get 00:25:40 INFO - 2016-04-20 00:25:40.590 screenresolution[1972:20081] Display 0: 1600x1200x32@60 00:25:40 INFO - 2016-04-20 00:25:40.596 screenresolution[1973:20084] starting screenresolution argv=screenresolution list 00:25:40 INFO - Available Modes on Display 0 00:25:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 00:25:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 00:25:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 00:25:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 00:25:40 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 00:25:40 INFO - Intel Iris: 00:25:40 INFO - Chipset Model: Intel Iris 00:25:40 INFO - Type: GPU 00:25:40 INFO - Bus: Built-In 00:25:40 INFO - VRAM (Dynamic, Max): 1536 MB 00:25:40 INFO - Vendor: Intel (0x8086) 00:25:40 INFO - Device ID: 0x0a2e 00:25:40 INFO - Revision ID: 0x0009 00:25:40 INFO - Displays: 00:25:40 INFO - Display: 00:25:40 INFO - Resolution: 1600 x 1200 @ 60 Hz 00:25:40 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 00:25:40 INFO - Display Serial Number: 1600x1200 60 00:25:40 INFO - Main Display: Yes 00:25:40 INFO - Mirror: Off 00:25:40 INFO - Online: Yes 00:25:40 INFO - Rotation: Supported 00:25:40 INFO - Return code: 0 00:25:40 INFO - Running post-action listener: _resource_record_post_action 00:25:40 INFO - Running post-run listener: _resource_record_post_run 00:25:41 INFO - Total resource usage - Wall time: 1208s; CPU: 53.0%; Read bytes: 61440; Write bytes: 694381056; Read time: 1; Write time: 1877 00:25:41 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 379591168; Write bytes: 375134208; Read time: 28252; Write time: 754 00:25:41 INFO - run-tests - Wall time: 1175s; CPU: 53.0%; Read bytes: 61440; Write bytes: 296149504; Read time: 1; Write time: 1076 00:25:41 INFO - Running post-run listener: _upload_blobber_files 00:25:41 INFO - Blob upload gear active. 00:25:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:25:41 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 00:25:41 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'] 00:25:41 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 00:25:42 INFO - (blobuploader) - INFO - Open directory for files ... 00:25:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:25:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:25:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:25:43 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:25:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:25:43 INFO - (blobuploader) - INFO - Done attempting. 00:25:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:25:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:25:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:25:44 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:25:44 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:25:44 INFO - (blobuploader) - INFO - Done attempting. 00:25:44 INFO - (blobuploader) - INFO - Iteration through files over. 00:25:44 INFO - Return code: 0 00:25:44 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:25:44 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:25:44 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/683fba67569666b84e5a88ac61fa321e68b8b2b4bcbf43405d6a72995e290222e4ce2bf1c8cce9633fe431e7e21fd4fd7cd2ffd038bcf69fe1f5c8b5644e6e61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08ba8e199bf0dbeaa7dde1d628f18c6a80f21a6468dd8a20debf7d371a19ec0a0c81e5c1b7fd2eddd08703a3e868cd597d1e5689fca6167a1e69a744b5e1c056"} 00:25:44 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:25:44 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:25:44 INFO - Contents: 00:25:44 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/683fba67569666b84e5a88ac61fa321e68b8b2b4bcbf43405d6a72995e290222e4ce2bf1c8cce9633fe431e7e21fd4fd7cd2ffd038bcf69fe1f5c8b5644e6e61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08ba8e199bf0dbeaa7dde1d628f18c6a80f21a6468dd8a20debf7d371a19ec0a0c81e5c1b7fd2eddd08703a3e868cd597d1e5689fca6167a1e69a744b5e1c056"} 00:25:44 INFO - Running post-run listener: copy_logs_to_upload_dir 00:25:44 INFO - Copying logs to upload dir... 00:25:44 INFO - mkdir: /builds/slave/test/build/upload/logs 00:25:44 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.583673 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-04-20 00:25:44.411901) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 00:25:44.415014) ========= 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.roIxPCGgCA/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.GCR5jqT8YK/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/683fba67569666b84e5a88ac61fa321e68b8b2b4bcbf43405d6a72995e290222e4ce2bf1c8cce9633fe431e7e21fd4fd7cd2ffd038bcf69fe1f5c8b5644e6e61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08ba8e199bf0dbeaa7dde1d628f18c6a80f21a6468dd8a20debf7d371a19ec0a0c81e5c1b7fd2eddd08703a3e868cd597d1e5689fca6167a1e69a744b5e1c056"} 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.010768 build_url: 'https://queue.taskcluster.net/v1/task/I4vTWX0DROiS0WyhGRP33Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/683fba67569666b84e5a88ac61fa321e68b8b2b4bcbf43405d6a72995e290222e4ce2bf1c8cce9633fe431e7e21fd4fd7cd2ffd038bcf69fe1f5c8b5644e6e61", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/08ba8e199bf0dbeaa7dde1d628f18c6a80f21a6468dd8a20debf7d371a19ec0a0c81e5c1b7fd2eddd08703a3e868cd597d1e5689fca6167a1e69a744b5e1c056"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 00:25:44.441742) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 00:25:44.442039) ========= 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.roIxPCGgCA/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.GCR5jqT8YK/Listeners TMPDIR=/var/folders/4s/dwjnph5j5jzfjbt8cm0511q000000w/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.005114 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 00:25:44.490180) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 00:25:44.490482) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 00:25:44.490822) ========= ========= Total master_lag: 0.16 =========