builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0121 starttime: 1461146121.58 results: success (0) buildid: 20160420005033 builduid: 0561e628aab0406a8b2e605d200e020c revision: f71acdbd0d45ebdd0c69621dbf0f2f6ac74f9f43 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 02:55:21.577191) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 02:55:21.577689) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 02:55:21.577987) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 02:55:21.598229) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 02:55:21.598655) ========= 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.KYMLEyU1vO/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.SDGVlyaCw3/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 02:55:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 11.6M=0.001s 2016-04-20 02:55:21 (11.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.070615 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 02:55:21.687169) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 02:55:21.687512) ========= 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.KYMLEyU1vO/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.SDGVlyaCw3/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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.020556 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 02:55:21.736840) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 02:55:21.737216) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev f71acdbd0d45ebdd0c69621dbf0f2f6ac74f9f43 --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 f71acdbd0d45ebdd0c69621dbf0f2f6ac74f9f43 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KYMLEyU1vO/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.SDGVlyaCw3/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 02:55:21,812 truncating revision to first 12 chars 2016-04-20 02:55:21,812 Setting DEBUG logging. 2016-04-20 02:55:21,812 attempt 1/10 2016-04-20 02:55:21,812 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/f71acdbd0d45?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-20 02:55:23,433 unpacking tar archive at: fx-team-f71acdbd0d45/testing/mozharness/ program finished with exit code 0 elapsedTime=1.867823 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-20 02:55:23.624662) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 02:55:23.625227) ========= script_repo_revision: f71acdbd0d45ebdd0c69621dbf0f2f6ac74f9f43 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 02:55:23.625900) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 02:55:23.626385) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 02:55:23.642704) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-20 02:55:23.643333) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.KYMLEyU1vO/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.SDGVlyaCw3/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 02:55:23 INFO - MultiFileLogger online at 20160420 02:55:23 in /builds/slave/test 02:55:23 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 02:55:23 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 02:55:23 INFO - {'append_to_log': False, 02:55:23 INFO - 'base_work_dir': '/builds/slave/test', 02:55:23 INFO - 'blob_upload_branch': 'Fx-Team', 02:55:23 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 02:55:23 INFO - 'branch': 'Fx-Team', 02:55:23 INFO - 'buildbot_json_path': 'buildprops.json', 02:55:23 INFO - 'config_files': ('talos/mac_config.py',), 02:55:23 INFO - 'default_actions': ('clobber', 02:55:23 INFO - 'read-buildbot-config', 02:55:23 INFO - 'download-and-extract', 02:55:23 INFO - 'populate-webroot', 02:55:23 INFO - 'create-virtualenv', 02:55:23 INFO - 'install', 02:55:23 INFO - 'run-tests'), 02:55:23 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 02:55:23 INFO - 'download_minidump_stackwalk': True, 02:55:23 INFO - 'download_symbols': 'ondemand', 02:55:23 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 02:55:23 INFO - 'tooltool.py': '/tools/tooltool.py', 02:55:23 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 02:55:23 INFO - '/tools/misc-python/virtualenv.py')}, 02:55:23 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 02:55:23 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 02:55:23 INFO - 'installer_path': 'installer.exe', 02:55:23 INFO - 'log_level': 'info', 02:55:23 INFO - 'log_name': 'talos', 02:55:23 INFO - 'log_to_console': True, 02:55:23 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 02:55:23 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 02:55:23 INFO - 'opt_config_files': (), 02:55:23 INFO - 'pip_index': False, 02:55:23 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:55:23 INFO - 'cmd': ('bash', 02:55:23 INFO - '-c', 02:55:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:55:23 INFO - 'enabled': True, 02:55:23 INFO - 'halt_on_failure': False, 02:55:23 INFO - 'name': 'check_screen_resolution'},), 02:55:23 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 02:55:23 INFO - 'cmd': ('bash', 02:55:23 INFO - '-c', 02:55:23 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 02:55:23 INFO - 'enabled': True, 02:55:23 INFO - 'halt_on_failure': False, 02:55:23 INFO - 'name': 'check_screen_resolution'},), 02:55:23 INFO - 'run_cmd_checks_enabled': True, 02:55:23 INFO - 'sps_profile': False, 02:55:23 INFO - 'sps_profile_interval': 0, 02:55:23 INFO - 'suite': 'dromaeojs-e10s', 02:55:23 INFO - 'system_bits': '32', 02:55:23 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 02:55:23 INFO - 'title': 't-yosemite-r7-0121', 02:55:23 INFO - 'tooltool_cache': '/builds/tooltool_cache', 02:55:23 INFO - 'use_talos_json': True, 02:55:23 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 02:55:23 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 02:55:23 INFO - 'work_dir': 'build'} 02:55:23 INFO - ##### 02:55:23 INFO - ##### Running clobber step. 02:55:23 INFO - ##### 02:55:23 INFO - Running pre-action listener: _resource_record_pre_action 02:55:23 INFO - Running main action method: clobber 02:55:23 INFO - rmtree: /builds/slave/test/build 02:55:23 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 02:55:24 INFO - Running post-action listener: _resource_record_post_action 02:55:24 INFO - ##### 02:55:24 INFO - ##### Running read-buildbot-config step. 02:55:24 INFO - ##### 02:55:24 INFO - Running pre-action listener: _resource_record_pre_action 02:55:24 INFO - Running main action method: read_buildbot_config 02:55:24 INFO - Using buildbot properties: 02:55:24 INFO - { 02:55:24 INFO - "project": "", 02:55:24 INFO - "product": "firefox", 02:55:24 INFO - "script_repo_revision": "production", 02:55:24 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 02:55:24 INFO - "repository": "", 02:55:24 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 02:55:24 INFO - "buildid": "20160420005033", 02:55:24 INFO - "pgo_build": "False", 02:55:24 INFO - "basedir": "/builds/slave/test", 02:55:24 INFO - "buildnumber": 608, 02:55:24 INFO - "slavename": "t-yosemite-r7-0121", 02:55:24 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 02:55:24 INFO - "platform": "yosemite_r7", 02:55:24 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 02:55:24 INFO - "branch": "fx-team", 02:55:24 INFO - "repo_path": "integration/fx-team", 02:55:24 INFO - "revision": "f71acdbd0d45ebdd0c69621dbf0f2f6ac74f9f43", 02:55:24 INFO - "stage_platform": "macosx64", 02:55:24 INFO - "builduid": "0561e628aab0406a8b2e605d200e020c", 02:55:24 INFO - "slavebuilddir": "test" 02:55:24 INFO - } 02:55:24 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 02:55:24 INFO - Running post-action listener: _resource_record_post_action 02:55:24 INFO - ##### 02:55:24 INFO - ##### Running download-and-extract step. 02:55:24 INFO - ##### 02:55:24 INFO - Running pre-action listener: _resource_record_pre_action 02:55:24 INFO - Running main action method: download_and_extract 02:55:24 INFO - mkdir: /builds/slave/test/build/tests 02:55:24 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')]} 02:55:24 INFO - https://queue.taskcluster.net/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 02:55:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 02:55:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 02:55:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xa2a2XdPQS-UNfnskrv5fw/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 02:55:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xa2a2XdPQS-UNfnskrv5fw/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 02:55:26 INFO - Downloaded 1199 bytes. 02:55:26 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 02:55:26 INFO - Using the following test package requirements: 02:55:26 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 02:55:26 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:55:26 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 02:55:26 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:55:26 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 02:55:26 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:55:26 INFO - u'jsshell-mac.zip'], 02:55:26 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:55:26 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 02:55:26 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 02:55:26 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:55:26 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 02:55:26 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:55:26 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 02:55:26 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:55:26 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 02:55:26 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 02:55:26 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 02:55:26 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 02:55:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:26 INFO - https://queue.taskcluster.net/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:55:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:55:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:55:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xa2a2XdPQS-UNfnskrv5fw/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 02:55:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xa2a2XdPQS-UNfnskrv5fw/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 02:55:27 INFO - Downloaded 18095510 bytes. 02:55:27 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'] 02:55:27 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 02:55:30 INFO - Return code: 0 02:55:30 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 02:55:30 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')]} 02:55:30 INFO - https://queue.taskcluster.net/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 02:55:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:55:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 02:55:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xa2a2XdPQS-UNfnskrv5fw/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 02:55:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xa2a2XdPQS-UNfnskrv5fw/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 02:55:31 INFO - Downloaded 18095510 bytes. 02:55:31 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'] 02:55:31 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 02:55:35 INFO - Return code: 0 02:55:35 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')]} 02:55:35 INFO - https://queue.taskcluster.net/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 02:55:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 02:55:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 02:55:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xa2a2XdPQS-UNfnskrv5fw/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 02:55:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xa2a2XdPQS-UNfnskrv5fw/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 02:55:36 INFO - Downloaded 10845952 bytes. 02:55:36 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'] 02:55:36 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 02:55:36 INFO - Return code: 0 02:55:36 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')]} 02:55:36 INFO - https://queue.taskcluster.net/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 02:55:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 02:55:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 02:55:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 02:55:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Xa2a2XdPQS-UNfnskrv5fw/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 02:55:41 INFO - Downloaded 110058536 bytes. 02:55:41 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 02:55:41 INFO - mkdir: /builds/slave/test/properties 02:55:41 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 02:55:41 INFO - Writing to file /builds/slave/test/properties/build_url 02:55:41 INFO - Contents: 02:55:41 INFO - build_url:https://queue.taskcluster.net/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 02:55:42 INFO - Running post-action listener: _resource_record_post_action 02:55:42 INFO - Running post-action listener: set_extra_try_arguments 02:55:42 INFO - ##### 02:55:42 INFO - ##### Running populate-webroot step. 02:55:42 INFO - ##### 02:55:42 INFO - Running pre-action listener: _resource_record_pre_action 02:55:42 INFO - Running main action method: populate_webroot 02:55:42 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 02:55:42 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 02:55:42 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 02:55:42 INFO - '--tppagecycles', 02:55:42 INFO - '7'], 02:55:42 INFO - 'tests': ['tsvgm']}}, 02:55:42 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 02:55:42 INFO - 'tests': ['tresize', 'tcanvasmark']}, 02:55:42 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 02:55:42 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 02:55:42 INFO - 'tests': ['dromaeo_css', 'kraken']}, 02:55:42 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 02:55:42 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:42 INFO - 'talos_options': ['--disable-e10s'], 02:55:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:55:42 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:42 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 02:55:42 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:42 INFO - 'talos_options': ['--disable-e10s'], 02:55:42 INFO - 'tests': ['damp', 'tps']}, 02:55:42 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:42 INFO - 'tests': ['damp', 'tps']}, 02:55:42 INFO - 'g3': {'talos_options': ['--disable-e10s'], 02:55:42 INFO - 'tests': ['dromaeo_dom']}, 02:55:42 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 02:55:42 INFO - 'other': {'talos_options': ['--disable-e10s'], 02:55:42 INFO - 'tests': ['a11yr', 02:55:42 INFO - 'ts_paint', 02:55:42 INFO - 'tpaint', 02:55:42 INFO - 'sessionrestore', 02:55:42 INFO - 'sessionrestore_no_auto_restore', 02:55:42 INFO - 'tabpaint']}, 02:55:42 INFO - 'other-e10s': {'tests': ['a11yr', 02:55:42 INFO - 'ts_paint', 02:55:42 INFO - 'tpaint', 02:55:42 INFO - 'sessionrestore', 02:55:42 INFO - 'sessionrestore_no_auto_restore', 02:55:42 INFO - 'tabpaint']}, 02:55:42 INFO - 'other-e10s_l64': {'tests': ['a11yr', 02:55:42 INFO - 'ts_paint', 02:55:42 INFO - 'tpaint', 02:55:42 INFO - 'sessionrestore', 02:55:42 INFO - 'sessionrestore_no_auto_restore', 02:55:42 INFO - 'tabpaint']}, 02:55:42 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 02:55:42 INFO - 'ts_paint', 02:55:42 INFO - 'tpaint', 02:55:42 INFO - 'sessionrestore', 02:55:42 INFO - 'sessionrestore_no_auto_restore', 02:55:42 INFO - 'tabpaint']}, 02:55:42 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 02:55:42 INFO - 'tests': ['a11yr', 02:55:42 INFO - 'ts_paint', 02:55:42 INFO - 'tpaint', 02:55:42 INFO - 'sessionrestore', 02:55:42 INFO - 'sessionrestore_no_auto_restore', 02:55:42 INFO - 'tabpaint']}, 02:55:42 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 02:55:42 INFO - 'tests': ['a11yr', 02:55:42 INFO - 'ts_paint', 02:55:42 INFO - 'tpaint', 02:55:42 INFO - 'sessionrestore', 02:55:42 INFO - 'sessionrestore_no_auto_restore', 02:55:42 INFO - 'tabpaint']}, 02:55:42 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 02:55:42 INFO - 'tests': ['tsvgx', 02:55:42 INFO - 'tsvgr_opacity', 02:55:42 INFO - 'tart', 02:55:42 INFO - 'tscrollx', 02:55:42 INFO - 'cart']}, 02:55:42 INFO - 'svgr-e10s': {'tests': ['tsvgx', 02:55:42 INFO - 'tsvgr_opacity', 02:55:42 INFO - 'tart', 02:55:42 INFO - 'tscrollx', 02:55:42 INFO - 'cart']}, 02:55:42 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:42 INFO - 'talos_options': ['--disable-e10s'], 02:55:42 INFO - 'tests': ['tp5o']}, 02:55:42 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:42 INFO - 'tests': ['tp5o']}, 02:55:42 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:42 INFO - 'talos_options': ['--disable-e10s', 02:55:42 INFO - '--xperf_path', 02:55:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:55:42 INFO - 'tests': ['tp5n']}, 02:55:42 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 02:55:42 INFO - 'talos_options': ['--xperf_path', 02:55:42 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 02:55:42 INFO - 'tests': ['tp5n']}}, 02:55:42 INFO - 'talos.zip': {'path': '', 02:55:42 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 02:55:42 INFO - Running post-action listener: _resource_record_post_action 02:55:42 INFO - ##### 02:55:42 INFO - ##### Running create-virtualenv step. 02:55:42 INFO - ##### 02:55:42 INFO - Running pre-action listener: _resource_record_pre_action 02:55:42 INFO - Running main action method: create_virtualenv 02:55:42 INFO - Creating virtualenv /builds/slave/test/build/venv 02:55:42 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 02:55:42 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 02:55:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 02:55:42 INFO - Using real prefix '/tools/python27' 02:55:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 02:55:42 INFO - Installing distribute.............................................................................................................................................................................................done. 02:55:45 INFO - Installing pip.................done. 02:55:45 INFO - Return code: 0 02:55:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 02:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:45 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 0x101278a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101288420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92d3d76e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101117e00>, '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 0x100f80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101112b20>, '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.KYMLEyU1vO/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.SDGVlyaCw3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 02:55:45 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 02:55:45 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 02:55:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KYMLEyU1vO/Render', 02:55:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:45 INFO - 'HOME': '/Users/cltbld', 02:55:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:45 INFO - 'LOGNAME': 'cltbld', 02:55:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:45 INFO - 'MOZ_NO_REMOTE': '1', 02:55:45 INFO - 'NO_EM_RESTART': '1', 02:55:45 INFO - 'PAGER': '/bin/cat', 02:55:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:45 INFO - 'PWD': '/builds/slave/test', 02:55:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:45 INFO - 'SHELL': '/bin/bash', 02:55:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SDGVlyaCw3/Listeners', 02:55:45 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 02:55:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:45 INFO - 'USER': 'cltbld', 02:55:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:45 INFO - 'XPC_FLAGS': '0x0', 02:55:45 INFO - 'XPC_SERVICE_NAME': '0', 02:55:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:46 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 02:55:46 INFO - Cleaning up... 02:55:46 INFO - Return code: 0 02:55:46 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 02:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:46 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 0x101278a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101288420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92d3d76e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101117e00>, '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 0x100f80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101112b20>, '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.KYMLEyU1vO/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.SDGVlyaCw3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 02:55:46 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 02:55:46 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 02:55:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KYMLEyU1vO/Render', 02:55:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:46 INFO - 'HOME': '/Users/cltbld', 02:55:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:46 INFO - 'LOGNAME': 'cltbld', 02:55:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:46 INFO - 'MOZ_NO_REMOTE': '1', 02:55:46 INFO - 'NO_EM_RESTART': '1', 02:55:46 INFO - 'PAGER': '/bin/cat', 02:55:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:46 INFO - 'PWD': '/builds/slave/test', 02:55:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:46 INFO - 'SHELL': '/bin/bash', 02:55:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SDGVlyaCw3/Listeners', 02:55:46 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 02:55:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:46 INFO - 'USER': 'cltbld', 02:55:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:46 INFO - 'XPC_FLAGS': '0x0', 02:55:46 INFO - 'XPC_SERVICE_NAME': '0', 02:55:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:46 INFO - Downloading/unpacking psutil>=0.7.1 02:55:46 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 02:55:46 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 02:55:46 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 02:55:46 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 02:55:46 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 02:55:46 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 02:55:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 02:55:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:55:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:55:49 INFO - Installing collected packages: psutil 02:55:49 INFO - Running setup.py install for psutil 02:55:49 INFO - building 'psutil._psutil_osx' extension 02:55:49 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 02:55:49 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 02:55:49 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 02:55:49 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 02:55:49 INFO - building 'psutil._psutil_posix' extension 02:55:49 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 02:55:49 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 02:55:49 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 02:55:49 INFO - ^ 02:55:49 INFO - 1 warning generated. 02:55:49 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 02:55:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 02:55:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 02:55:50 INFO - Successfully installed psutil 02:55:50 INFO - Cleaning up... 02:55:50 INFO - Return code: 0 02:55:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 02:55:50 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')]} 02:55:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:50 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')]} 02:55:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:50 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 0x101278a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101288420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92d3d76e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101117e00>, '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 0x100f80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101112b20>, '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.KYMLEyU1vO/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.SDGVlyaCw3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 02:55:50 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 02:55:50 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 02:55:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KYMLEyU1vO/Render', 02:55:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:50 INFO - 'HOME': '/Users/cltbld', 02:55:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:50 INFO - 'LOGNAME': 'cltbld', 02:55:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:50 INFO - 'MOZ_NO_REMOTE': '1', 02:55:50 INFO - 'NO_EM_RESTART': '1', 02:55:50 INFO - 'PAGER': '/bin/cat', 02:55:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:50 INFO - 'PWD': '/builds/slave/test', 02:55:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:50 INFO - 'SHELL': '/bin/bash', 02:55:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SDGVlyaCw3/Listeners', 02:55:50 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 02:55:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:50 INFO - 'USER': 'cltbld', 02:55:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:50 INFO - 'XPC_FLAGS': '0x0', 02:55:50 INFO - 'XPC_SERVICE_NAME': '0', 02:55:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 02:55:50 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 02:55:50 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 02:55:50 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 02:55:50 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 02:55:50 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 02:55:50 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 02:55:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 02:55:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 02:55:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 02:55:52 INFO - Installing collected packages: mozsystemmonitor 02:55:52 INFO - Running setup.py install for mozsystemmonitor 02:55:53 INFO - Successfully installed mozsystemmonitor 02:55:53 INFO - Cleaning up... 02:55:53 INFO - Return code: 0 02:55:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 02:55: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')]} 02:55:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55: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')]} 02:55:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x101278a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101288420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92d3d76e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101117e00>, '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 0x100f80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101112b20>, '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.KYMLEyU1vO/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.SDGVlyaCw3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 02:55:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 02:55:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 02:55:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KYMLEyU1vO/Render', 02:55:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:53 INFO - 'HOME': '/Users/cltbld', 02:55:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:53 INFO - 'LOGNAME': 'cltbld', 02:55:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:53 INFO - 'MOZ_NO_REMOTE': '1', 02:55:53 INFO - 'NO_EM_RESTART': '1', 02:55:53 INFO - 'PAGER': '/bin/cat', 02:55:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:53 INFO - 'PWD': '/builds/slave/test', 02:55:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:53 INFO - 'SHELL': '/bin/bash', 02:55:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SDGVlyaCw3/Listeners', 02:55:53 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 02:55:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:53 INFO - 'USER': 'cltbld', 02:55:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:53 INFO - 'XPC_FLAGS': '0x0', 02:55:53 INFO - 'XPC_SERVICE_NAME': '0', 02:55:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:53 INFO - Downloading/unpacking blobuploader==1.2.4 02:55:53 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 02:55:53 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 02:55:53 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 02:55:53 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 02:55:53 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 02:55:53 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 02:55:55 INFO - Downloading blobuploader-1.2.4.tar.gz 02:55:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 02:55:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 02:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 02:55:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 02:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:55:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:55:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:55:56 INFO - Downloading docopt-0.6.1.tar.gz 02:55:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 02:55:57 INFO - Installing collected packages: blobuploader, requests, docopt 02:55:57 INFO - Running setup.py install for blobuploader 02:55:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 02:55:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 02:55:57 INFO - Running setup.py install for requests 02:55:57 INFO - Running setup.py install for docopt 02:55:57 INFO - Successfully installed blobuploader requests docopt 02:55:57 INFO - Cleaning up... 02:55:57 INFO - Return code: 0 02:55:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:55:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:55:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:55:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:55:57 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 0x101278a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101288420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92d3d76e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101117e00>, '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 0x100f80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101112b20>, '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.KYMLEyU1vO/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.SDGVlyaCw3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 02:55:57 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 02:55:57 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 02:55:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KYMLEyU1vO/Render', 02:55:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:55:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:55:57 INFO - 'HOME': '/Users/cltbld', 02:55:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:55:57 INFO - 'LOGNAME': 'cltbld', 02:55:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:55:57 INFO - 'MOZ_NO_REMOTE': '1', 02:55:57 INFO - 'NO_EM_RESTART': '1', 02:55:57 INFO - 'PAGER': '/bin/cat', 02:55:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:55:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:55:57 INFO - 'PWD': '/builds/slave/test', 02:55:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:55:57 INFO - 'SHELL': '/bin/bash', 02:55:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SDGVlyaCw3/Listeners', 02:55:57 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 02:55:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:55:57 INFO - 'USER': 'cltbld', 02:55:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:55:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:55:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:55:57 INFO - 'XPC_FLAGS': '0x0', 02:55:57 INFO - 'XPC_SERVICE_NAME': '0', 02:55:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:55:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:55:58 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-zHY16Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:55:58 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-kKxmIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:55:58 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-CvcEGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:55:58 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-sEulOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:55:58 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-z2OggB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:55:58 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-nGhAr7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:55:58 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-zFMhZ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:55:58 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-FQJHDC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:55:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:55:58 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-3yBM7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:55:59 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-ukOGMN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:55:59 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-BixDFw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:55:59 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-cCPEQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:55:59 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-jVvTvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:55:59 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-W0xAA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:55:59 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-4i7VWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:55:59 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-fPmvcR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:55:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:55:59 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-Stb8Gk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:55:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 02:55:59 INFO - Running setup.py install for manifestparser 02:56:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 02:56:00 INFO - Running setup.py install for mozcrash 02:56:00 INFO - Running setup.py install for mozdebug 02:56:00 INFO - Running setup.py install for mozdevice 02:56:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 02:56:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 02:56:00 INFO - Running setup.py install for mozfile 02:56:00 INFO - Running setup.py install for mozhttpd 02:56:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 02:56:00 INFO - Running setup.py install for mozinfo 02:56:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 02:56:00 INFO - Running setup.py install for mozInstall 02:56:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 02:56:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 02:56:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 02:56:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 02:56:01 INFO - Running setup.py install for mozleak 02:56:01 INFO - Running setup.py install for mozlog 02:56:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 02:56:01 INFO - Running setup.py install for moznetwork 02:56:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 02:56:01 INFO - Running setup.py install for mozprocess 02:56:01 INFO - Running setup.py install for mozprofile 02:56:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 02:56:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 02:56:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 02:56:01 INFO - Running setup.py install for mozrunner 02:56:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 02:56:02 INFO - Running setup.py install for mozscreenshot 02:56:02 INFO - Running setup.py install for moztest 02:56:02 INFO - Running setup.py install for mozversion 02:56:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 02:56:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 02:56:02 INFO - Cleaning up... 02:56:02 INFO - Return code: 0 02:56:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:02 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 0x101278a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101288420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92d3d76e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101117e00>, '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 0x100f80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101112b20>, '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.KYMLEyU1vO/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.SDGVlyaCw3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 02:56:02 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 02:56:02 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 02:56:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KYMLEyU1vO/Render', 02:56:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:02 INFO - 'HOME': '/Users/cltbld', 02:56:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:02 INFO - 'LOGNAME': 'cltbld', 02:56:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:02 INFO - 'MOZ_NO_REMOTE': '1', 02:56:02 INFO - 'NO_EM_RESTART': '1', 02:56:02 INFO - 'PAGER': '/bin/cat', 02:56:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:02 INFO - 'PWD': '/builds/slave/test', 02:56:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:02 INFO - 'SHELL': '/bin/bash', 02:56:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SDGVlyaCw3/Listeners', 02:56:02 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 02:56:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:02 INFO - 'USER': 'cltbld', 02:56:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:02 INFO - 'XPC_FLAGS': '0x0', 02:56:02 INFO - 'XPC_SERVICE_NAME': '0', 02:56:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 02:56:02 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-qfGfT5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 02:56:02 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)) 02:56:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 02:56:02 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-es4rlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 02:56:03 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)) 02:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 02:56:03 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-M5hCxF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 02:56:03 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)) 02:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 02:56:03 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-f3jsTB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 02:56:03 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)) 02:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 02:56:03 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-gYGtwJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 02:56:03 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)) 02:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 02:56:03 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-5LMuh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 02:56:03 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)) 02:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 02:56:03 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-hNUdRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 02:56:03 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)) 02:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 02:56:03 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-K0dc2Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 02:56:03 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)) 02:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 02:56:03 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-fMTb1w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 02:56:03 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)) 02:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 02:56:03 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-Ou2_2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 02:56:03 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)) 02:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 02:56:03 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-Tzg6gp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 02:56:03 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)) 02:56:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 02:56:03 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-RkIqDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 02:56:04 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)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 02:56:04 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-Gf0Xru-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 02:56:04 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)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 02:56:04 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-TWNNhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 02:56:04 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)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:04 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-ya_884-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 02:56:04 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)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 02:56:04 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-V8g5s3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 02:56:04 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)) 02:56:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 02:56:04 INFO - Running setup.py (path:/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/pip-mm0xHc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 02:56:04 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)) 02:56:04 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)) 02:56:04 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)) 02:56:04 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)) 02:56:04 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)) 02:56:04 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)) 02:56:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 02:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:06 INFO - Downloading blessings-1.6.tar.gz 02:56:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 02:56:07 INFO - Installing collected packages: blessings 02:56:07 INFO - Running setup.py install for blessings 02:56:07 INFO - Successfully installed blessings 02:56:07 INFO - Cleaning up... 02:56:07 INFO - Return code: 0 02:56:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 02:56:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:56:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:56:07 INFO - Reading from file tmpfile_stdout 02:56:07 INFO - Current package versions: 02:56:07 INFO - blessings == 1.6 02:56:07 INFO - blobuploader == 1.2.4 02:56:07 INFO - docopt == 0.6.1 02:56:07 INFO - manifestparser == 1.1 02:56:07 INFO - mozInstall == 1.12 02:56:07 INFO - mozcrash == 0.17 02:56:07 INFO - mozdebug == 0.1 02:56:07 INFO - mozdevice == 0.48 02:56:07 INFO - mozfile == 1.2 02:56:07 INFO - mozhttpd == 0.7 02:56:07 INFO - mozinfo == 0.9 02:56:07 INFO - mozleak == 0.1 02:56:07 INFO - mozlog == 3.1 02:56:07 INFO - moznetwork == 0.27 02:56:07 INFO - mozprocess == 0.22 02:56:07 INFO - mozprofile == 0.28 02:56:07 INFO - mozrunner == 6.11 02:56:07 INFO - mozscreenshot == 0.1 02:56:07 INFO - mozsystemmonitor == 0.0 02:56:07 INFO - moztest == 0.7 02:56:07 INFO - mozversion == 1.4 02:56:07 INFO - psutil == 3.1.1 02:56:07 INFO - requests == 1.2.3 02:56:07 INFO - wsgiref == 0.1.2 02:56:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 02:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:07 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 0x101278a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101288420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92d3d76e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101117e00>, '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 0x100f80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101112b20>, '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.KYMLEyU1vO/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.SDGVlyaCw3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 02:56:07 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 02:56:07 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 02:56:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KYMLEyU1vO/Render', 02:56:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:07 INFO - 'HOME': '/Users/cltbld', 02:56:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:07 INFO - 'LOGNAME': 'cltbld', 02:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:07 INFO - 'MOZ_NO_REMOTE': '1', 02:56:07 INFO - 'NO_EM_RESTART': '1', 02:56:07 INFO - 'PAGER': '/bin/cat', 02:56:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:07 INFO - 'PWD': '/builds/slave/test', 02:56:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:07 INFO - 'SHELL': '/bin/bash', 02:56:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SDGVlyaCw3/Listeners', 02:56:07 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 02:56:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:07 INFO - 'USER': 'cltbld', 02:56:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:07 INFO - 'XPC_FLAGS': '0x0', 02:56:07 INFO - 'XPC_SERVICE_NAME': '0', 02:56:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:07 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)) 02:56:07 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)) 02:56:07 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)) 02:56:07 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)) 02:56:07 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)) 02:56:07 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)) 02:56:07 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)) 02:56:07 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)) 02:56:07 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)) 02:56:07 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)) 02:56:07 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)) 02:56:07 INFO - Cleaning up... 02:56:07 INFO - Return code: 0 02:56:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 02:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:07 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 0x101278a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101288420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92d3d76e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101117e00>, '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 0x100f80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101112b20>, '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.KYMLEyU1vO/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.SDGVlyaCw3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 02:56:07 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 02:56:07 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 02:56:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KYMLEyU1vO/Render', 02:56:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:07 INFO - 'HOME': '/Users/cltbld', 02:56:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:07 INFO - 'LOGNAME': 'cltbld', 02:56:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:07 INFO - 'MOZ_NO_REMOTE': '1', 02:56:07 INFO - 'NO_EM_RESTART': '1', 02:56:07 INFO - 'PAGER': '/bin/cat', 02:56:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:07 INFO - 'PWD': '/builds/slave/test', 02:56:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:07 INFO - 'SHELL': '/bin/bash', 02:56:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SDGVlyaCw3/Listeners', 02:56:07 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 02:56:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:07 INFO - 'USER': 'cltbld', 02:56:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:07 INFO - 'XPC_FLAGS': '0x0', 02:56:07 INFO - 'XPC_SERVICE_NAME': '0', 02:56:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:08 INFO - Downloading/unpacking jsonschema 02:56:08 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 02:56:08 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 02:56:08 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 02:56:08 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 02:56:08 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 02:56:08 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 02:56:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 02:56:10 INFO - Downloading/unpacking functools32 (from jsonschema) 02:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:10 INFO - Downloading functools32-3.2.3-2.tar.gz 02:56:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 02:56:10 INFO - warning: no files found matching '*.txt' 02:56:10 INFO - no previously-included directories found matching 'build' 02:56:10 INFO - no previously-included directories found matching 'dist' 02:56:10 INFO - no previously-included directories found matching '.git*' 02:56:10 INFO - Installing collected packages: jsonschema, functools32 02:56:11 INFO - Running setup.py install for functools32 02:56:11 INFO - warning: no files found matching '*.txt' 02:56:11 INFO - no previously-included directories found matching 'build' 02:56:11 INFO - no previously-included directories found matching 'dist' 02:56:11 INFO - no previously-included directories found matching '.git*' 02:56:11 INFO - Successfully installed jsonschema functools32 02:56:11 INFO - Cleaning up... 02:56:11 INFO - Return code: 0 02:56:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 02:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 02:56:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 02:56:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 02:56:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 02:56:11 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 0x101278a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101288420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f92d3d76e50>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x101117e00>, '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 0x100f80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101112b20>, '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.KYMLEyU1vO/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.SDGVlyaCw3/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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 02:56:11 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 02:56:11 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 02:56:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KYMLEyU1vO/Render', 02:56:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:11 INFO - 'HOME': '/Users/cltbld', 02:56:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:11 INFO - 'LOGNAME': 'cltbld', 02:56:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:11 INFO - 'MOZ_NO_REMOTE': '1', 02:56:11 INFO - 'NO_EM_RESTART': '1', 02:56:11 INFO - 'PAGER': '/bin/cat', 02:56:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:11 INFO - 'PWD': '/builds/slave/test', 02:56:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:11 INFO - 'SHELL': '/bin/bash', 02:56:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SDGVlyaCw3/Listeners', 02:56:11 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 02:56:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:11 INFO - 'USER': 'cltbld', 02:56:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:11 INFO - 'XPC_FLAGS': '0x0', 02:56:11 INFO - 'XPC_SERVICE_NAME': '0', 02:56:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 02:56:11 INFO - Downloading/unpacking flake8 02:56: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 02:56: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 02:56: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 02:56: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 02:56: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 02:56: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 02:56:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 02:56:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 02:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 02:56:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 02:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 02:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 02:56:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 02:56:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 02:56:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 02:56:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:56:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:56:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:56:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:56:15 INFO - no previously-included directories found matching 'docs/_build' 02:56:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 02:56:15 INFO - Running setup.py install for pep8 02:56:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 02:56:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 02:56:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 02:56:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 02:56:15 INFO - no previously-included directories found matching 'docs/_build' 02:56:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 02:56:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 02:56:15 INFO - Cleaning up... 02:56:15 INFO - Return code: 0 02:56:15 INFO - Running post-action listener: _resource_record_post_action 02:56:15 INFO - Running post-action listener: _start_resource_monitoring 02:56:15 INFO - Starting resource monitoring. 02:56:15 INFO - ##### 02:56:15 INFO - ##### Running install step. 02:56:15 INFO - ##### 02:56:15 INFO - Running pre-action listener: _resource_record_pre_action 02:56:15 INFO - Running main action method: install 02:56:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 02:56:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 02:56:16 INFO - Reading from file tmpfile_stdout 02:56:16 INFO - Detecting whether we're running mozinstall >=1.0... 02:56:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 02:56:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 02:56:16 INFO - Reading from file tmpfile_stdout 02:56:16 INFO - Output received: 02:56:16 INFO - Usage: mozinstall [options] installer 02:56:16 INFO - Options: 02:56:16 INFO - -h, --help show this help message and exit 02:56:16 INFO - -d DEST, --destination=DEST 02:56:16 INFO - Directory to install application into. [default: 02:56:16 INFO - "/builds/slave/test"] 02:56:16 INFO - --app=APP Application being installed. [default: firefox] 02:56:16 INFO - mkdir: /builds/slave/test/build/application 02:56:16 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'] 02:56:16 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 02:56:49 INFO - Reading from file tmpfile_stdout 02:56:49 INFO - Output received: 02:56:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 02:56:49 INFO - Running post-action listener: _resource_record_post_action 02:56:49 INFO - ##### 02:56:49 INFO - ##### Running run-tests step. 02:56:49 INFO - ##### 02:56:49 INFO - Running pre-action listener: _resource_record_pre_action 02:56:49 INFO - Running main action method: run_tests 02:56:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:56:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:56:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:56:49 INFO - 2016-04-20 02:56:49.443 screenresolution[2057:12141] starting screenresolution argv=screenresolution get 02:56:49 INFO - 2016-04-20 02:56:49.445 screenresolution[2057:12141] Display 0: 1600x1200x32@60 02:56:49 INFO - 2016-04-20 02:56:49.452 screenresolution[2058:12144] starting screenresolution argv=screenresolution list 02:56:49 INFO - Available Modes on Display 0 02:56:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:56:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:56:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:56:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:56:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:56:49 INFO - Intel Iris: 02:56:49 INFO - Chipset Model: Intel Iris 02:56:49 INFO - Type: GPU 02:56:49 INFO - Bus: Built-In 02:56:49 INFO - VRAM (Dynamic, Max): 1536 MB 02:56:49 INFO - Vendor: Intel (0x8086) 02:56:49 INFO - Device ID: 0x0a2e 02:56:49 INFO - Revision ID: 0x0009 02:56:49 INFO - Displays: 02:56:49 INFO - Display: 02:56:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:56:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:56:49 INFO - Display Serial Number: 1600x1200 60 02:56:49 INFO - Main Display: Yes 02:56:49 INFO - Mirror: Off 02:56:49 INFO - Online: Yes 02:56:49 INFO - Rotation: Supported 02:56:49 INFO - Return code: 0 02:56:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 02:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 02:56:49 INFO - Python 2.7.3 02:56:49 INFO - Return code: 0 02:56:49 INFO - grabbing minidump binary from tooltool 02:56:49 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')]} 02:56:49 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 0x101117e00>, '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 0x100f80db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x101112b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 02:56:49 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 02:56:49 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 02:56:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 02:56:49 INFO - Return code: 0 02:56:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 02:56:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 02:56:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 02:56:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 02:56:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 02:56:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 02:56:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 02:56:50 INFO - Return code: 0 02:56:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0121', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 02:56:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0121 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 02:56:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.KYMLEyU1vO/Render', 02:56:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 02:56:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 02:56:50 INFO - 'HOME': '/Users/cltbld', 02:56:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 02:56:50 INFO - 'LOGNAME': 'cltbld', 02:56:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 02:56:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 02:56:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 02:56:50 INFO - 'MOZ_NO_REMOTE': '1', 02:56:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 02:56:50 INFO - 'NO_EM_RESTART': '1', 02:56:50 INFO - 'PAGER': '/bin/cat', 02:56:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 02:56:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 02:56:50 INFO - 'PWD': '/builds/slave/test', 02:56:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 02:56:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 02:56:50 INFO - 'SHELL': '/bin/bash', 02:56:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.SDGVlyaCw3/Listeners', 02:56:50 INFO - 'TMPDIR': '/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/', 02:56:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 02:56:50 INFO - 'USER': 'cltbld', 02:56:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 02:56:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 02:56:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 02:56:50 INFO - 'XPC_FLAGS': '0x0', 02:56:50 INFO - 'XPC_SERVICE_NAME': '0', 02:56:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 02:56:50 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0121', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 02:56:51 INFO - mozversion application_buildid: 20160420005033 02:56:51 INFO - mozversion application_changeset: f71acdbd0d45ebdd0c69621dbf0f2f6ac74f9f43 02:56:51 INFO - mozversion application_display_name: Nightly 02:56:51 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 02:56:51 INFO - mozversion application_name: Firefox 02:56:51 INFO - mozversion application_remotingname: firefox 02:56:51 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 02:56:51 INFO - mozversion application_vendor: Mozilla 02:56:51 INFO - mozversion application_version: 48.0a1 02:56:51 INFO - mozversion platform_buildid: 20160420005033 02:56:51 INFO - mozversion platform_changeset: f71acdbd0d45ebdd0c69621dbf0f2f6ac74f9f43 02:56:51 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 02:56:51 INFO - mozversion platform_version: 48.0a1 02:56:51 INFO - using testdate: 1461146211 02:56:51 INFO - actual date: 1461146211 02:56:51 INFO - starting webserver on 'localhost:49357' 02:56:51 INFO - SUITE-START | Running 2 tests 02:56:51 INFO - TEST-START | dromaeo_css 02:56:51 INFO - operating with platform_type : mac_ 02:56:51 INFO - Initialising browser for dromaeo_css test... 02:56:51 INFO - TEST-INFO | started process 2076 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/tmpSQGDeA/profile http://localhost:49357/getInfo.html) 02:56:54 INFO - PROCESS | 2076 | __metrics Screen width/height:1600/1200 02:56:54 INFO - PROCESS | 2076 | colorDepth:24 02:56:54 INFO - PROCESS | 2076 | Browser inner width/height: 1024/689 02:56:54 INFO - PROCESS | 2076 | __metrics 02:56:54 ERROR - PROCESS | 2076 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 02:56:54 INFO - TEST-INFO | 2076: exit 0 02:56:54 INFO - Browser initialized. 02:56:54 INFO - Running cycle 1/1 for dromaeo_css test... 02:56:54 INFO - TEST-INFO | started process 2080 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/tmpSQGDeA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:57:06 INFO - PROCESS | 2080 | RSS: Main: 247513088 02:57:06 INFO - PROCESS | 2080 | 02:57:56 INFO - PROCESS | 2080 | 1461146276532 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] 03:00:07 INFO - PROCESS | 2080 | Cycle 1(1): loaded http://localhost:49357/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49357/tests/dromaeo/cssquery-ext.html) 03:00:08 INFO - PROCESS | 2080 | RSS: Main: 259760128 03:00:08 INFO - PROCESS | 2080 | 03:03:11 INFO - PROCESS | 2080 | Cycle 1(1): loaded http://localhost:49357/tests/dromaeo/cssquery-ext.html (next: http://localhost:49357/tests/dromaeo/cssquery-jquery.html) 03:03:11 INFO - PROCESS | 2080 | RSS: Main: 271626240 03:03:11 INFO - PROCESS | 2080 | 03:06:13 INFO - PROCESS | 2080 | Cycle 1(1): loaded http://localhost:49357/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49357/tests/dromaeo/cssquery-mootools.html) 03:06:14 INFO - PROCESS | 2080 | RSS: Main: 273788928 03:06:14 INFO - PROCESS | 2080 | 03:09:15 INFO - PROCESS | 2080 | Cycle 1(1): loaded http://localhost:49357/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49357/tests/dromaeo/cssquery-prototype.html) 03:09:16 INFO - PROCESS | 2080 | RSS: Main: 275345408 03:09:16 INFO - PROCESS | 2080 | 03:12:19 INFO - PROCESS | 2080 | Cycle 1(1): loaded http://localhost:49357/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49357/tests/dromaeo/cssquery-yui.html) 03:12:19 INFO - PROCESS | 2080 | RSS: Main: 278208512 03:12:19 INFO - PROCESS | 2080 | 03:15:22 INFO - PROCESS | 2080 | Cycle 1(1): loaded http://localhost:49357/tests/dromaeo/cssquery-yui.html (next: http://localhost:49357/tests/dromaeo/cssquery-dojo.html) 03:15:22 INFO - PROCESS | 2080 | RSS: Main: 279392256 03:15:22 INFO - PROCESS | 2080 | 03:15:22 INFO - PROCESS | 2080 | __start_tp_report 03:15:22 INFO - PROCESS | 2080 | _x_x_mozilla_page_load 03:15:22 INFO - PROCESS | 2080 | _x_x_mozilla_page_load_details 03:15:22 INFO - PROCESS | 2080 | |i|pagename|runs| 03:15:22 INFO - PROCESS | 2080 | |0;dojo.html;2918.5622156676495;3424.982875085625;3502.247016891368;3507.1232191952013;3536.787792732435;5778.62438941469;5799.304083509985;5836.44553767392;5839.620424672394;5845.0647896336595;5725.227094342263;5843.5033022193165;5845.918505076554;5917.319508256552;5964.970175149129;5198.2982297389935;5228.111221092405;5270.7628156733035;5281.102212623863;5304.9920515102;181.8442838684979;5160.638755287131;5212.192110222903;5221.2951251580935;5230.790768369261;3982.4026396040535;5204.635675502716;5227.11139106349;5242.213667949819;5262.131748261532;5270.39390470097;5278.261043453919;5279.815206467793;5290.153575427951;5308.681479111227;5109.131447653907;5145.125328694094;5148.279240906276;5181.611379146541;5222.529972302511;5573.554115670737;5712.771489140429;5739.770409183628;5766.135079738031;5827.388124246978;6141.731496609858;6231.189945307126;6248.593841400295;6258.06129080637;6277.403646653561;6194.132821405007;6252.906206406908;6280.560360774748;6286.591371560834;6308.526860485436;5932.288125424933;5950.464458198783;5970.283565972068;5987.730552125165;6034.034554471307;6181.227346581677;6271.937280627227;6317.727250111964;6340.651264180515;6373.936260637427;5673.461021202979;6186.288576813724;6268.937310626835;6292.433680968735;6330.683465826783;6151.96924015377;6187.071939209065;6276.811695649138;6288.685565721696;6295.307516173218;6173.81478555644;6228.626282423069;6266.028765541349;6272.3100458949475;6273.309935907047;6236.719347629368;6240.7503699852405;6255.343188965184;6256.468200202943;6257.590827531433;4182.1844740275355;4992.475790042066;5001.624878134155;5021.121303771898;5024.346834911511;4338.284183109815;4421.889452763707;4478.664100192498;4502.144592527409;4551.5676010778925;5905.232319798399;5921.14143449206;5954.434328738763;5979.910301345483;6018.307894592091;6234.844128896814;6239.532035097386;6263.906041409383;6285.465735412449;6286.308506064329;5818.418158184148;5904.911426328608;5945.048792193228;5989.2812862456785;5989.64062156272;5489.204065410493;5495.53287970527;5499;5502.944970550323;5513.807016754475;5106.795728170831;6254.437100660963;6456.54804163704;6471.7734879279;6490.448311893448;6172.783952561639;6232.189815323979;6249.7500099997305;6251.4061164189325;6263.279722831932;5362.115250983544;6396.328385519453;6418.967905160444;6446.709898054505;6446.903296450463;6128.28924408451;6148.754049837957;6239.1577137085915;6280.309165991646;6296.118543403835;4988.9501104988485;5224.869378265574;6186.845328866814;6249.187605611423;6264.31092579825;6197.380261973766;6215.409536094064;6228.968855155696;6241.8140553294725;6242.500599952084;6098.695065246809;6106.938930610637;6119.015143218386;6236.469900058546;6240.656763878031;4538.636909047203;6063.818085457443;6100.23747031621;6104.938950610437;6126.938730612636;5834;6211.409916057967;6211.472024877936;6231.594946328474;6250.093736408105;5947.464728174485;6024.578279520391;6106.673025714562;6109.45014948639;6129.417705317987 03:15:22 INFO - PROCESS | 2080 | |1;ext.html;505.6561538154056;536.1823219590125;537.6908277740299;540.1924123435465;579.203595056797;36943.076423089406;37613.62386376136;37677.811610941906;37691.623083769155;37742.86771396855;40000.599994000055;40527.99999999993;40590.39114413286;40781.388279175764;40796;9474.526273686306;9703.029697030312;9717.368371055894;9719.125278724914;9725.221982241439;9561.61753529858;9684.709458716214;9692.854607180898;9708.368956017872;9770.90229097707;9720.75698107546;9730.172935300508;9759;9763.023697630251;9817.116459518642;9439.575219115157;9678.161149381665;9701.563429645612;9708.514574271294;9745.658901938468;9546.093121153479;9651.083147101013;9681.564329605184;9683.322167448281;9687.934327224;37537.06157346088;37877.62122378768;37919;37955.62044379549;38011.80994095039;2482.329770961848;2823.50588646988;3147.2761264908972;3292.407366673998;3332.0670212340583;23875.88062059696;26574.335641608923;26737.331566710793;27210.1836944892;28520.0017999369;2696.3393968477653;2737.411456536854;2771.5842623606623;2880.9135725928254;2885.3507960708885;392936;393694;399111.00444497884;399562;399790.0020999782;61332.08001879975;61622;61718.76562468815;61764;61970.69014654988;65635;66568;67619;67887;67944.6602766983;16304.103274320027;16349.673006539802;16494;16521.091339976418;16542.917285413496;12598.937005315098;12686.04854635906;12692.365381730877;12701.428435720414;12740.426680799386;18843.811561884206;18972.62054758897;19025.14386852595;19399.515012124808;19411;7821.256980586835;8420.789480263042;8424.199701028516;8441.662333506714;8459.492430454193;942.137943781446;1001.929864909464;1010.075780660702;1027.275770581738;1053.146950969717;24519.877400612884;29483.557746633818;29659.258518537208;29816.10551683453;30069.797208111868;1021.7241344837001;1044;1085.4247248958065;1130.8021096308278;1161.1291531351487;11963.521459141537;15213.391464341525;15245;15607.453739119303;15745.504177103157;604634;611837;614460;616686;619806;58364.832703345695;58686.41313586895;58932.705336473045;59177.99999999914;59263;1420.6732451536204;1458.5624312706145;1464.934077966494;1472.4699108320997;1474.7935289059756;29087.272818179714;29752.851235744547;30692.145890383636;31359;31443.056708298787;46884;55689;56808.43191568197;56829;56995;540963;562005.1899740475;564867;565592;566124;40692;41798.37302440405;41856.79071604623;42162.57837421587;42417;44843.10313793771;44870.98080586316;44988.55011449844;46581;46902.53097468981;29938.70061299359;36570.63429365672;37142.44286335653;37417.06457338479;37819.432708508844;30959;36645;37025.629743702215;37415.62584374121;37768.62231377651;36658.8167059163;36746;37403;37715;38260.617393825705;31644.525332119578;32377.676223237468;32509.674903250663;32792.50811237881;32804.67195328016;22428.170533191143;24599.87700061488;25161.370965726004;25422.618660719734;25505.61741573915 03:15:22 INFO - PROCESS | 2080 | |2;jquery.html;343.63059710810876;393.390245120064;394.87166670831976;404.9514058313001;412;18779.53051173718;18954.715679264824;21177.364679059654;21436.464088397817;21490.89254553727;20277.0875310611;20997.895010524964;21196.576068478622;21247.25634602789;21377.610455320395;5254.9861461271485;5869.2369991901;6137.877242455148;6139.754409823602;6158.907616385758;4022.416749571325;6307.905381419282;6666;6679.699413526403;6686.665666716669;6338.176037115169;6575.309592492791;6615.569987950792;6657.3675500827585;6761.188657361124;6697.062411262427;6733.831654208635;6737.461003119739;6739.022841687953;6742.157230346232;5561.6663000220115;5875.529957603424;5883.205767221413;5909.8227053188475;5917.349091599921;26336.73663263362;26452.338691532674;26499.205023849314;26995.325116872038;27021.729782702118;2152.074607918594;2155.4072630026712;2163.816075633573;2279.87460689662;2561.7950563954837;14912.925435372754;15339;15339.693206135926;15366.30851611669;15558.066516008963;1638.6067343837512;1753.7635966643613;1779.946601601954;1794.9192286347145;1801.9008954507497;110387.58764138313;113487.43256283748;113559;114939;116715.249271261;11158.995690387905;11288;11850.822237666442;11928.687844337115;11935.820962685566;14568.125912445286;14622.415103395957;14661.04703194289;14665.340059697339;14685.339159737623;8437.704680336159;8696;8878.200961913459;8903.887014123235;8984.416012959136;7658.195889431641;7802.063752349641;8683.696070637498;8766.298696104297;8940.240079593177;5102.4897510248675;6922.861542769117;6997.475189360818;7035.47233957445;7045.68294426752;1680.7646929429889;1737.5144251664897;1934.3809980806288;1947.1015759634242;1963.626910886927;943.8820147481565;981.7300242433388;995.7311525887969;1020.5713600287897;1052.6684094510206;20321.288754893805;21298.680519792215;21527.67708484374;21760.782392175875;21792.346229613137;1032.550840384435;1051.3849398102195;1055.488088277185;1083.7290677330668;1090.5964793026471;10343.896561034444;11524.423778811026;11578.536858525733;11624.6512604622;11693.941530292293;482051.58974204905;606248;609061;612931;621079;78629;116738.41630791791;135614.32192838972;135765;147044;1009.3641006166068;1030.9278350515392;1057.751428414322;1058.6771034834449;1061.1828891753307;18326.725099123258;18368.448946531626;18609.53476163107;18665.720014199527;18766.967816770208;36713;48108;51097.978040439724;52032.47967520276;52083.73958130185;59158.40841591529;59485.40514594972;59823.700881495315;60235;67258.9911151343;7703.961480192787;7949.443538952449;8081.191880811872;8295.087540370434;8316.085230624505;9033;9989.401695728939;10426.843597345895;12348.876511234772;12649.241045537297;10972.451377430936;11149.554017839195;11213.71965700864;11288.034683235795;11321.773564528829;7728.033995750531;10554.313969591953;10585.682429527127;10593.629222977159;10871.075958543612;7412.444066694911;9512.524373781145;11069;11407.600733974272;11451.828222576502;8172.182781722018;8185.959070204611;8217.9141201684;8416.537090460084;8502.702405415781;8179.427440079376;10202;11082.16883733707;11344.20590558653;11373.886261137282 03:15:22 INFO - PROCESS | 2080 | |3;mootools.html;1525.6567272363716;1592.792936918201;1868.093974422405;1969.5174682202862;1971.2804826238428;7949;8507.234348908598;8588;8776.297896168315;8798.824023519534;8520.446170998881;8578.056413794478;8652.567371631409;8661.69684061058;8666.52334121623;2399.4961058177805;2417.2506522977933;2421.164698179134;2424.5150969806023;2427.66012758214;2400.423898264413;2402.2192787344184;2428.5021570577987;2440.1459489178733;2444.1934161726585;2103.5056761661;2413.6379543068592;2415.3599296186526;2417.129833260025;2437.5612389769835;2380.1312520929737;2383.07060246504;2384.391980045095;2410.409449684821;2413.9517209655796;2380.73811880693;2390.1634427950253;2398.2325655790155;2401.435662619283;2404.074431343945;8721.127887211229;8788.340874434443;8791.736247912573;8800.295976321942;8815.338849586307;5130.127878260705;5357.812476563302;5359.490848369399;5371.248025276464;5400.540954018874;3496.807675577842;3575.964240357589;3584.121890136907;3617.1680513482047;3617.385044542434;1033.912117470016;1046.7801761630067;1056.0548309263243;1068.9625863094755;1091.5579190427889;11375.317480951087;11445.370504622242;11499.59751408705;11502.424878756112;11523.308601483854;3870.3420418528353;4600.838970636079;4814.903701925942;4852.8544143675745;4886.486918873467;9906.851397229048;9926.2059035277;9931.304808663468;9986.900130998742;9999.750006249902;4699.389079419722;4868.391451068616;4917.606591472745;5387.649802762808;5405.621606487508;4369.453818272716;4753.809847606057;4876.414830220397;4920.8769780755765;5052.696838189647;3890.2608504384075;4043.1913617276664;4062.405715008706;4066.898327541835;4074.490688663917;1339.638297659646;1356.6404902700792;1357;1358.3547814787896;1360.7074478987065;895.9865602015975;901.5402144906145;910.8360495110811;919.4483310014072;942.9862897385201;5486.177073439016;5680.403557626472;5801.7099145042575;5894.2926848778425;5964.493018093423;997.7904640025675;1013.6113524471522;1040.422565476168;1047.9633212837514;1071.4267866691282;3252.837358132084;3714.4428335749853;3822.445745366962;3839.9056268963213;3845.3270677631303;8174.591270436455;10246.897531024595;10699.679009629723;10700.732481688021;10742.409167495707;10449.425281609432;10534.618494615037;10708.78582428347;10760.730981725519;10816;7450.515716478411;7858.960705196552;8173.754787356389;8247.546384948886;8300.667973281;5596.384397716167;5597.160425936142;5651.915221271766;5692.743826527733;5744.396838331915;9618.615255389986;9840.212782977202;9889.109980101824;9948.651797187063;9950.004999500281;10196.592136314464;10198.286119971532;10279.588816447258;10312.175025998053;10350.585976561155;6482.675866206765;6726.764563240263;7024.121984751906;7043.190033146049;7182.96408517954;8192.30365418946;8219.095899451175;8252.669893204446;8278.751637450887;8315.916840831514;7211.278872112956;7310.19587845326;7328.377087947584;7449.962750186214;7456.888146677913;6988.685509152202;7197.964010179916;7229.566226026455;7229.855402891808;7285.672144753605;6755.898661520179;6809.455243580601;6858.554193977376;6873.621950792754;6877.449804015567;4606.378138951199;4661.557152070548;4673.065386922561;4782.832600858953;4808.3989501312335;4792.400949881265;4809.254565542206;4810.941592849567;4838.225883858566;4875 03:15:22 INFO - PROCESS | 2080 | |4;prototype.html;314.2113295627973;324.20893021028695;331.41670659639027;331.4249776637534;333.1022893302551;5800.723840755032;5967.880642387149;6031.155638210654;6132.877342453154;6157.045657923023;5336.91994620081;5849.824505264838;6087.847803804907;6104.786332478364;6142.447179753821;4582.106489234592;4584.381108550353;4593.058423023289;4600.97699511502;4621.722696638196;3631.4189729643263;4236.9152616947795;4590.40324757781;4614.492405835355;4694.882627934295;3980.761154330735;4510.233260345749;4523.864284071483;4530.307799143704;4566.58900698937;4034.6570541504007;4569.926067374165;4573.679842411033;4573.8170473181035;4590.334401511779;3241.2383089973837;3492.406290930548;3575.4458059000635;3963.742356746802;3966.5240171179353;5850.590458667895;5861.384554621789;5863.824085277449;5873.970630146822;5876.207756634225;4837.226043833005;5273.235380869791;5276.81531146408;5292.867678308035;5308.336457942757;6325.557210995232;6508.9023664645065;6530.575512591714;6563.3764792344655;6563.868722625521;3737.588865224823;4290.785460726983;4301.41930839339;4314.180305741899;4344.522102568715;6289.528285378569;6570.408663220333;6804.183497980224;6850.629874025165;6904.930950690479;4034.293998550242;4326.935095973563;4342.782860856944;4347.174036932973;4350.630196433275;4369.4101296325225;4396.7142135761715;4407.449068866392;4419.889502762392;4421.513633500313;4148.564400737879;5193.350831146106;5228.503292187236;5244.029854476934;5269.604779641542;5802.767889284466;6195.16365290689;6212;6588.967055164693;6599.406053455212;1376.9535153283377;1516.9393224271125;1519.9088054716754;1529.4646873594374;1531.2343828085957;848.3933987199182;967.9903200968041;984.6110786239395;998.2612866478753;1012.2964539645023;5097.286379906816;5339.985402773461;6020.548458865603;6036.788712395045;6115.266168059861;5998.4601385875485;6663.600183988976;6718.596884186964;6718.832029199211;6756.729730810811;5762.538996880239;6101;6107.694615269219;6122.295935967331;6168.876622467616;2937.5153099738304;3559.430491121408;3564.928701425957;3577.964220357763;3600.9099772505897;5965.821025369246;6339.844452885949;6381.329960354189;6658.96670516654;6987.231404545598;5860.648361098262;6963.234044255128;7016.052832867497;7023.262557431498;7041;5891.970540147272;6594.736210551524;6740.797776066628;7092.6099064551945;7107.36033756954;6312;6431.517636177212;6815;6817.045613613999;6831.28271531482;6462.7091780870915;6637.1703537057865;6708.463322934251;6716.496262780409;6772.932270677427;6636.701348439428;6916.858718311422;7043.6830342633675;7048.753293634698;7078.575285482888;3709.406494960793;4311.417958575552;4371.2568863293955;4379.167958088081;4382.189294980439;5533.446655334435;6435.292117866938;6576.934230657632;6626.734930602722;6763.7632682855865;6304.211973503312;6510.251321098134;6555.4427873629365;6565.015247712881;6579.769708060195;6224.62652240867;6536.3136870627895;6555.508336874658;6560.868782624416;6561.212654481493;6282.555012347094;6342;6367.522435817425;6389;6399.072134540559;5738.680103576285;6119.317187773398;6237.1891654084675;6556.0493728410065;6600.504962127764;5473.781048758165;5703.401142879938;5847.883042339045;6194.81415557534;6461.289258181502 03:15:22 INFO - PROCESS | 2080 | |5;yui.html;616.1589430427465;662.6620423583972;662.9535932484727;723.9420846332293;736.9189389167191;14782.77825832612;14993.250337483138;15301.00543464674;15302.387904483821;15322.540323790276;12416.944559712412;13748.175109493437;13894.096883702578;14191.432342706279;14209.218492982882;714.3428046197511;913.1827014821764;924.8982611912701;947.4031360243038;952.1383148250809;875.4659657608853;907.5870478932103;920.2591913509622;934.1499235695518;938.7183844846553;936.4802534593332;944.8771659684265;946.4510583861378;948.4309414351369;949.7388218240005;931.0735817861204;939.1547607153548;941.7692665296978;942.4015749998766;944.5843828715343;682.1302838880417;692.8995295682148;710.5452510393352;710.6908494804776;711.1288671377521;12504.49982000719;14900.850991490055;15069.849301506954;15097;15130.319135638812;12727.172733772368;12767.297798621072;12777.93611031939;12799.616011519669;12938.48246070156;10001.549930253155;10222.6422075227;10262.025107614765;10316.535755891004;10484.475776211235;3411.9317613647586;3476.3047390521997;3483.4600636901323;3496.5629296337956;3529.0647978285774;58118.837623247724;85781.14218857857;86885;87565.56217218937;87812.24375512454;9553.283503737108;9617.422954622745;9628.085331893459;9777.022297770167;9843.852342214872;22358.217462389064;22445;22445.887770561043;22520.436989075406;22743.09027638909;7437.405007599379;7551.924480755232;7607.66865798483;7618.771436856903;7757.534547927143;3441.9655803442147;4043.3126368517424;4056.7971601419813;4092.815823287959;4098.036961314089;3530.1880567469625;3612.9819350903076;3639.6724294813066;3648.8175591220333;3652.2695460907926;536.888640514132;655.9704813283414;657.0472814419112;658.0852614865341;661.5600625584029;517.7023211653315;519.8674338043775;528.207688467299;581.9330776960619;599.8470390050509;7073.540219885691;7410.96294518524;7564.713998620247;7654.502457340366;7972.322352599978;514.6474664854586;555.5139253153491;561;596.6479776931632;613.9969300153471;3732.421474671376;3796.1648437344293;3836.175222327213;3838.846446142123;3863.710221733325;77478;80403;82098.94752631112;83713;83939.58030209932;67358.66320668464;67659.32340676629;68102.97845532322;68658.9701154483;69625.65187174133;62638;65639;66352.00471992925;68932.62134757377;72719;8228.50628962264;8253.463524870864;8279.875801862856;8303.95848020756;8345.54099524532;42967.14065718731;43516.78241608771;44267.11465770602;45032.549674504146;45122.323165153204;44318;57308.1403778952;60172.39827601843;60438;60972.390276096674;10673.41296228715;10863.619773307897;10918.454077296263;11103.500342484445;11256.324620522795;11822.645320640395;11905.52377904874;11998.40007999579;12024.819627705767;12054.578089766816;8471.305738852378;10807.513661885392;11392;11451.713707157387;11904.821427678418;9447.385919915183;11313.71715707114;11331.660050198507;11432.657020289405;11776.352300623548;11237.213395062266;11373.829392558953;11507.481005550544;11588;11938.52245910154;9332.626694932398;9399.295052870926;9500.762480938032;9686.418814871131;9896.851547226941;9506.667266645634;9644.180244679;9682.56428460707;9692.69732381462;9705.708828734867 03:15:22 INFO - PROCESS | 2080 | __end_tp_report 03:15:22 INFO - PROCESS | 2080 | __start_cc_report 03:15:22 INFO - PROCESS | 2080 | _x_x_mozilla_cycle_collect,397 03:15:22 INFO - PROCESS | 2080 | __end_cc_report 03:15:22 INFO - PROCESS | 2080 | __startTimestamp1461147322397__endTimestamp 03:15:22 INFO - PROCESS | 2080 | 03:15:22 INFO - PROCESS | 2080 | ------- Summary: start ------- 03:15:22 INFO - PROCESS | 2080 | Number of tests: 6 03:15:22 INFO - PROCESS | 2080 | 03:15:22 INFO - PROCESS | 2080 | [#0] dojo.html Cycles:165 Average:5735.14 Median:6024.58 stddev:805.91 (13.4%) stddev-sans-first:777.51 03:15:22 INFO - PROCESS | 2080 | Values: 2918.6 3425.0 3502.2 3507.1 3536.8 5778.6 5799.3 5836.4 5839.6 5845.1 5725.2 5843.5 5845.9 5917.3 5965.0 5198.3 5228.1 5270.8 5281.1 5305.0 181.8 5160.6 5212.2 5221.3 5230.8 3982.4 5204.6 5227.1 5242.2 5262.1 5270.4 5278.3 5279.8 5290.2 5308.7 5109.1 5145.1 5148.3 5181.6 5222.5 5573.6 5712.8 5739.8 5766.1 5827.4 6141.7 6231.2 6248.6 6258.1 6277.4 6194.1 6252.9 6280.6 6286.6 6308.5 5932.3 5950.5 5970.3 5987.7 6034.0 6181.2 6271.9 6317.7 6340.7 6373.9 5673.5 6186.3 6268.9 6292.4 6330.7 6152.0 6187.1 6276.8 6288.7 6295.3 6173.8 6228.6 6266.0 6272.3 6273.3 6236.7 6240.8 6255.3 6256.5 6257.6 4182.2 4992.5 5001.6 5021.1 5024.3 4338.3 4421.9 4478.7 4502.1 4551.6 5905.2 5921.1 5954.4 5979.9 6018.3 6234.8 6239.5 6263.9 6285.5 6286.3 5818.4 5904.9 5945.0 5989.3 5989.6 5489.2 5495.5 5499.0 5502.9 5513.8 5106.8 6254.4 6456.5 6471.8 6490.4 6172.8 6232.2 6249.8 6251.4 6263.3 5362.1 6396.3 6419.0 6446.7 6446.9 6128.3 6148.8 6239.2 6280.3 6296.1 4989.0 5224.9 6186.8 6249.2 6264.3 6197.4 6215.4 6229.0 6241.8 6242.5 6098.7 6106.9 6119.0 6236.5 6240.7 4538.6 6063.8 6100.2 6104.9 6126.9 5834.0 6211.4 6211.5 6231.6 6250.1 5947.5 6024.6 6106.7 6109.5 6129.4 03:15:22 INFO - PROCESS | 2080 | 03:15:22 INFO - PROCESS | 2080 | [#1] ext.html Cycles:180 Average:66601.58 Median:37937.31 stddev:141885.69 (374.0%) stddev-sans-first:142196.93 03:15:22 INFO - PROCESS | 2080 | Values: 505.7 536.2 537.7 540.2 579.2 36943.1 37613.6 37677.8 37691.6 37742.9 40000.6 40528.0 40590.4 40781.4 40796.0 9474.5 9703.0 9717.4 9719.1 9725.2 9561.6 9684.7 9692.9 9708.4 9770.9 9720.8 9730.2 9759.0 9763.0 9817.1 9439.6 9678.2 9701.6 9708.5 9745.7 9546.1 9651.1 9681.6 9683.3 9687.9 37537.1 37877.6 37919.0 37955.6 38011.8 2482.3 2823.5 3147.3 3292.4 3332.1 23875.9 26574.3 26737.3 27210.2 28520.0 2696.3 2737.4 2771.6 2880.9 2885.4 392936.0 393694.0 399111.0 399562.0 399790.0 61332.1 61622.0 61718.8 61764.0 61970.7 65635.0 66568.0 67619.0 67887.0 67944.7 16304.1 16349.7 16494.0 16521.1 16542.9 12598.9 12686.0 12692.4 12701.4 12740.4 18843.8 18972.6 19025.1 19399.5 19411.0 7821.3 8420.8 8424.2 8441.7 8459.5 942.1 1001.9 1010.1 1027.3 1053.1 24519.9 29483.6 29659.3 29816.1 30069.8 1021.7 1044.0 1085.4 1130.8 1161.1 11963.5 15213.4 15245.0 15607.5 15745.5 604634.0 611837.0 614460.0 616686.0 619806.0 58364.8 58686.4 58932.7 59178.0 59263.0 1420.7 1458.6 1464.9 1472.5 1474.8 29087.3 29752.9 30692.1 31359.0 31443.1 46884.0 55689.0 56808.4 56829.0 56995.0 540963.0 562005.2 564867.0 565592.0 566124.0 40692.0 41798.4 41856.8 42162.6 42417.0 44843.1 44871.0 44988.6 46581.0 46902.5 29938.7 36570.6 37142.4 37417.1 37819.4 30959.0 36645.0 37025.6 37415.6 37768.6 36658.8 36746.0 37403.0 37715.0 38260.6 31644.5 32377.7 32509.7 32792.5 32804.7 22428.2 24599.9 25161.4 25422.6 25505.6 03:15:22 INFO - PROCESS | 2080 | 03:15:22 INFO - PROCESS | 2080 | [#2] jquery.html Cycles:180 Average:34063.98 Median:11962.30 stddev:97964.05 (818.9%) stddev-sans-first:98206.14 03:15:22 INFO - PROCESS | 2080 | Values: 343.6 393.4 394.9 405.0 412.0 18779.5 18954.7 21177.4 21436.5 21490.9 20277.1 20997.9 21196.6 21247.3 21377.6 5255.0 5869.2 6137.9 6139.8 6158.9 4022.4 6307.9 6666.0 6679.7 6686.7 6338.2 6575.3 6615.6 6657.4 6761.2 6697.1 6733.8 6737.5 6739.0 6742.2 5561.7 5875.5 5883.2 5909.8 5917.3 26336.7 26452.3 26499.2 26995.3 27021.7 2152.1 2155.4 2163.8 2279.9 2561.8 14912.9 15339.0 15339.7 15366.3 15558.1 1638.6 1753.8 1779.9 1794.9 1801.9 110387.6 113487.4 113559.0 114939.0 116715.2 11159.0 11288.0 11850.8 11928.7 11935.8 14568.1 14622.4 14661.0 14665.3 14685.3 8437.7 8696.0 8878.2 8903.9 8984.4 7658.2 7802.1 8683.7 8766.3 8940.2 5102.5 6922.9 6997.5 7035.5 7045.7 1680.8 1737.5 1934.4 1947.1 1963.6 943.9 981.7 995.7 1020.6 1052.7 20321.3 21298.7 21527.7 21760.8 21792.3 1032.6 1051.4 1055.5 1083.7 1090.6 10343.9 11524.4 11578.5 11624.7 11693.9 482051.6 606248.0 609061.0 612931.0 621079.0 78629.0 116738.4 135614.3 135765.0 147044.0 1009.4 1030.9 1057.8 1058.7 1061.2 18326.7 18368.4 18609.5 18665.7 18767.0 36713.0 48108.0 51098.0 52032.5 52083.7 59158.4 59485.4 59823.7 60235.0 67259.0 7704.0 7949.4 8081.2 8295.1 8316.1 9033.0 9989.4 10426.8 12348.9 12649.2 10972.5 11149.6 11213.7 11288.0 11321.8 7728.0 10554.3 10585.7 10593.6 10871.1 7412.4 9512.5 11069.0 11407.6 11451.8 8172.2 8186.0 8217.9 8416.5 8502.7 8179.4 10202.0 11082.2 11344.2 11373.9 03:15:22 INFO - PROCESS | 2080 | 03:15:22 INFO - PROCESS | 2080 | [#3] mootools.html Cycles:180 Average:5636.61 Median:4812.92 stddev:3131.66 (65.1%) stddev-sans-first:3125.20 03:15:22 INFO - PROCESS | 2080 | Values: 1525.7 1592.8 1868.1 1969.5 1971.3 7949.0 8507.2 8588.0 8776.3 8798.8 8520.4 8578.1 8652.6 8661.7 8666.5 2399.5 2417.3 2421.2 2424.5 2427.7 2400.4 2402.2 2428.5 2440.1 2444.2 2103.5 2413.6 2415.4 2417.1 2437.6 2380.1 2383.1 2384.4 2410.4 2414.0 2380.7 2390.2 2398.2 2401.4 2404.1 8721.1 8788.3 8791.7 8800.3 8815.3 5130.1 5357.8 5359.5 5371.2 5400.5 3496.8 3576.0 3584.1 3617.2 3617.4 1033.9 1046.8 1056.1 1069.0 1091.6 11375.3 11445.4 11499.6 11502.4 11523.3 3870.3 4600.8 4814.9 4852.9 4886.5 9906.9 9926.2 9931.3 9986.9 9999.8 4699.4 4868.4 4917.6 5387.6 5405.6 4369.5 4753.8 4876.4 4920.9 5052.7 3890.3 4043.2 4062.4 4066.9 4074.5 1339.6 1356.6 1357.0 1358.4 1360.7 896.0 901.5 910.8 919.4 943.0 5486.2 5680.4 5801.7 5894.3 5964.5 997.8 1013.6 1040.4 1048.0 1071.4 3252.8 3714.4 3822.4 3839.9 3845.3 8174.6 10246.9 10699.7 10700.7 10742.4 10449.4 10534.6 10708.8 10760.7 10816.0 7450.5 7859.0 8173.8 8247.5 8300.7 5596.4 5597.2 5651.9 5692.7 5744.4 9618.6 9840.2 9889.1 9948.7 9950.0 10196.6 10198.3 10279.6 10312.2 10350.6 6482.7 6726.8 7024.1 7043.2 7183.0 8192.3 8219.1 8252.7 8278.8 8315.9 7211.3 7310.2 7328.4 7450.0 7456.9 6988.7 7198.0 7229.6 7229.9 7285.7 6755.9 6809.5 6858.6 6873.6 6877.4 4606.4 4661.6 4673.1 4782.8 4808.4 4792.4 4809.3 4810.9 4838.2 4875.0 03:15:22 INFO - PROCESS | 2080 | 03:15:22 INFO - PROCESS | 2080 | [#4] prototype.html Cycles:180 Average:5242.83 Median:5966.85 stddev:1669.07 (28.0%) stddev-sans-first:1632.25 03:15:22 INFO - PROCESS | 2080 | Values: 314.2 324.2 331.4 331.4 333.1 5800.7 5967.9 6031.2 6132.9 6157.0 5336.9 5849.8 6087.8 6104.8 6142.4 4582.1 4584.4 4593.1 4601.0 4621.7 3631.4 4236.9 4590.4 4614.5 4694.9 3980.8 4510.2 4523.9 4530.3 4566.6 4034.7 4569.9 4573.7 4573.8 4590.3 3241.2 3492.4 3575.4 3963.7 3966.5 5850.6 5861.4 5863.8 5874.0 5876.2 4837.2 5273.2 5276.8 5292.9 5308.3 6325.6 6508.9 6530.6 6563.4 6563.9 3737.6 4290.8 4301.4 4314.2 4344.5 6289.5 6570.4 6804.2 6850.6 6904.9 4034.3 4326.9 4342.8 4347.2 4350.6 4369.4 4396.7 4407.4 4419.9 4421.5 4148.6 5193.4 5228.5 5244.0 5269.6 5802.8 6195.2 6212.0 6589.0 6599.4 1377.0 1516.9 1519.9 1529.5 1531.2 848.4 968.0 984.6 998.3 1012.3 5097.3 5340.0 6020.5 6036.8 6115.3 5998.5 6663.6 6718.6 6718.8 6756.7 5762.5 6101.0 6107.7 6122.3 6168.9 2937.5 3559.4 3564.9 3578.0 3600.9 5965.8 6339.8 6381.3 6659.0 6987.2 5860.6 6963.2 7016.1 7023.3 7041.0 5892.0 6594.7 6740.8 7092.6 7107.4 6312.0 6431.5 6815.0 6817.0 6831.3 6462.7 6637.2 6708.5 6716.5 6772.9 6636.7 6916.9 7043.7 7048.8 7078.6 3709.4 4311.4 4371.3 4379.2 4382.2 5533.4 6435.3 6576.9 6626.7 6763.8 6304.2 6510.3 6555.4 6565.0 6579.8 6224.6 6536.3 6555.5 6560.9 6561.2 6282.6 6342.0 6367.5 6389.0 6399.1 5738.7 6119.3 6237.2 6556.0 6600.5 5473.8 5703.4 5847.9 6194.8 6461.3 03:15:22 INFO - PROCESS | 2080 | 03:15:22 INFO - PROCESS | 2080 | [#5] yui.html Cycles:180 Average:17176.66 Median:30386.12 stddev:23474.16 (77.3%) stddev-sans-first:23507.07 03:15:22 INFO - PROCESS | 2080 | Values: 616.2 662.7 663.0 723.9 736.9 14782.8 14993.3 15301.0 15302.4 15322.5 12416.9 13748.2 13894.1 14191.4 14209.2 714.3 913.2 924.9 947.4 952.1 875.5 907.6 920.3 934.1 938.7 936.5 944.9 946.5 948.4 949.7 931.1 939.2 941.8 942.4 944.6 682.1 692.9 710.5 710.7 711.1 12504.5 14900.9 15069.8 15097.0 15130.3 12727.2 12767.3 12777.9 12799.6 12938.5 10001.5 10222.6 10262.0 10316.5 10484.5 3411.9 3476.3 3483.5 3496.6 3529.1 58118.8 85781.1 86885.0 87565.6 87812.2 9553.3 9617.4 9628.1 9777.0 9843.9 22358.2 22445.0 22445.9 22520.4 22743.1 7437.4 7551.9 7607.7 7618.8 7757.5 3442.0 4043.3 4056.8 4092.8 4098.0 3530.2 3613.0 3639.7 3648.8 3652.3 536.9 656.0 657.0 658.1 661.6 517.7 519.9 528.2 581.9 599.8 7073.5 7411.0 7564.7 7654.5 7972.3 514.6 555.5 561.0 596.6 614.0 3732.4 3796.2 3836.2 3838.8 3863.7 77478.0 80403.0 82098.9 83713.0 83939.6 67358.7 67659.3 68103.0 68659.0 69625.7 62638.0 65639.0 66352.0 68932.6 72719.0 8228.5 8253.5 8279.9 8304.0 8345.5 42967.1 43516.8 44267.1 45032.5 45122.3 44318.0 57308.1 60172.4 60438.0 60972.4 10673.4 10863.6 10918.5 11103.5 11256.3 11822.6 11905.5 11998.4 12024.8 12054.6 8471.3 10807.5 11392.0 11451.7 11904.8 9447.4 11313.7 11331.7 11432.7 11776.4 11237.2 11373.8 11507.5 11588.0 11938.5 9332.6 9399.3 9500.8 9686.4 9896.9 9506.7 9644.2 9682.6 9692.7 9705.7 03:15:22 INFO - PROCESS | 2080 | -------- Summary: end -------- 03:15:22 INFO - PROCESS | 2080 | 03:15:22 INFO - TEST-INFO | 2080: exit 0 03:15:22 INFO - TEST-OK | dromaeo_css | took 1111734ms 03:15:22 INFO - TEST-START | kraken 03:15:22 INFO - operating with platform_type : mac_ 03:15:22 INFO - Initialising browser for kraken test... 03:15:22 INFO - TEST-INFO | started process 2086 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/tmp_VavgP/profile http://localhost:49357/getInfo.html) 03:15:25 INFO - PROCESS | 2086 | __metrics Screen width/height:1600/1200 03:15:25 INFO - PROCESS | 2086 | colorDepth:24 03:15:25 INFO - PROCESS | 2086 | Browser inner width/height: 1024/689 03:15:25 INFO - PROCESS | 2086 | __metrics 03:15:25 ERROR - PROCESS | 2086 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 03:15:26 INFO - TEST-INFO | 2086: exit 0 03:15:26 INFO - Browser initialized. 03:15:26 INFO - Running cycle 1/1 for kraken test... 03:15:26 INFO - TEST-INFO | started process 2089 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/tmp_VavgP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:15:38 INFO - PROCESS | 2089 | RSS: Main: 247738368 03:15:38 INFO - PROCESS | 2089 | 03:15:41 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49357/tests/kraken/driver.html?testName=audio-beat-detection) 03:15:42 INFO - PROCESS | 2089 | RSS: Main: 259923968 03:15:42 INFO - PROCESS | 2089 | 03:15:44 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49357/tests/kraken/driver.html?testName=audio-dft) 03:15:45 INFO - PROCESS | 2089 | RSS: Main: 268746752 03:15:45 INFO - PROCESS | 2089 | 03:15:48 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49357/tests/kraken/driver.html?testName=audio-fft) 03:15:49 INFO - PROCESS | 2089 | RSS: Main: 271937536 03:15:49 INFO - PROCESS | 2089 | 03:15:51 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49357/tests/kraken/driver.html?testName=audio-oscillator) 03:15:51 INFO - PROCESS | 2089 | RSS: Main: 273948672 03:15:51 INFO - PROCESS | 2089 | 03:15:53 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49357/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:15:54 INFO - PROCESS | 2089 | RSS: Main: 274460672 03:15:54 INFO - PROCESS | 2089 | 03:15:57 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49357/tests/kraken/driver.html?testName=imaging-darkroom) 03:15:58 INFO - PROCESS | 2089 | RSS: Main: 275369984 03:15:58 INFO - PROCESS | 2089 | 03:16:01 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49357/tests/kraken/driver.html?testName=imaging-desaturate) 03:16:02 INFO - PROCESS | 2089 | RSS: Main: 275517440 03:16:02 INFO - PROCESS | 2089 | 03:16:04 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49357/tests/kraken/driver.html?testName=json-parse-financial) 03:16:05 INFO - PROCESS | 2089 | RSS: Main: 276152320 03:16:05 INFO - PROCESS | 2089 | 03:16:07 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49357/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:16:07 INFO - PROCESS | 2089 | RSS: Main: 274931712 03:16:07 INFO - PROCESS | 2089 | 03:16:09 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49357/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:16:10 INFO - PROCESS | 2089 | RSS: Main: 275050496 03:16:10 INFO - PROCESS | 2089 | 03:16:12 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49357/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:16:13 INFO - PROCESS | 2089 | RSS: Main: 275279872 03:16:13 INFO - PROCESS | 2089 | 03:16:16 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49357/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:16:16 INFO - PROCESS | 2089 | RSS: Main: 275382272 03:16:16 INFO - PROCESS | 2089 | 03:16:19 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49357/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:16:20 INFO - PROCESS | 2089 | RSS: Main: 275361792 03:16:20 INFO - PROCESS | 2089 | 03:16:22 INFO - PROCESS | 2089 | Cycle 1(1): loaded http://localhost:49357/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49357/tests/kraken/driver.html?testName=ai-astar) 03:16:22 INFO - PROCESS | 2089 | RSS: Main: 277262336 03:16:22 INFO - PROCESS | 2089 | 03:16:22 INFO - PROCESS | 2089 | __start_tp_report 03:16:22 INFO - PROCESS | 2089 | _x_x_mozilla_page_load 03:16:22 INFO - PROCESS | 2089 | _x_x_mozilla_page_load_details 03:16:22 INFO - PROCESS | 2089 | |i|pagename|runs| 03:16:22 INFO - PROCESS | 2089 | |0;ai-astar;117;111;114;114;116;128;115;115;117;131 03:16:22 INFO - PROCESS | 2089 | |1;audio-beat-detection;157;127;145;168;123;144;122;160;157;121 03:16:22 INFO - PROCESS | 2089 | |2;audio-dft;189;199;202;213;235;200;196;199;205;197 03:16:22 INFO - PROCESS | 2089 | |3;audio-fft;67;72;73;142;60;75;82;87;143;48 03:16:22 INFO - PROCESS | 2089 | |4;audio-oscillator;78;82;130;77;83;83;122;82;84;156 03:16:22 INFO - PROCESS | 2089 | |5;imaging-gaussian-blur;91;78;119;132;91;132;136;106;88;85 03:16:22 INFO - PROCESS | 2089 | |6;imaging-darkroom;146;124;141;152;95;94;100;155;93;134 03:16:22 INFO - PROCESS | 2089 | |7;imaging-desaturate;90;99;92;91;91;92;138;147;92;117 03:16:22 INFO - PROCESS | 2089 | |8;json-parse-financial;64;61;60;62;59;62;60;79;69;78 03:16:22 INFO - PROCESS | 2089 | |9;json-stringify-tinderbox;62;65;65;69;87;102;70;58;75;97 03:16:22 INFO - PROCESS | 2089 | |10;stanford-crypto-aes;81;86;87;84;84;85;84;86;85;86 03:16:22 INFO - PROCESS | 2089 | |11;stanford-crypto-ccm;148;164;157;144;145;142;142;145;176;174 03:16:22 INFO - PROCESS | 2089 | |12;stanford-crypto-pbkdf2;172;172;205;172;240;232;178;170;168;173 03:16:22 INFO - PROCESS | 2089 | |13;stanford-crypto-sha256-iterative;72;72;81;83;97;75;67;69;71;70 03:16:22 INFO - PROCESS | 2089 | __end_tp_report 03:16:22 INFO - PROCESS | 2089 | __start_cc_report 03:16:22 INFO - PROCESS | 2089 | _x_x_mozilla_cycle_collect,1017 03:16:22 INFO - PROCESS | 2089 | __end_cc_report 03:16:22 INFO - PROCESS | 2089 | __startTimestamp1461147382478__endTimestamp 03:16:22 INFO - PROCESS | 2089 | 03:16:22 INFO - PROCESS | 2089 | ------- Summary: start ------- 03:16:22 INFO - PROCESS | 2089 | Number of tests: 14 03:16:22 INFO - PROCESS | 2089 | 03:16:22 INFO - PROCESS | 2089 | [#0] ai-astar Cycles:10 Average:117.80 Median:116.50 stddev:6.44 (5.5%) stddev-sans-first:6.83 03:16:22 INFO - PROCESS | 2089 | Values: 117.0 111.0 114.0 114.0 116.0 128.0 115.0 115.0 117.0 131.0 03:16:22 INFO - PROCESS | 2089 | 03:16:22 INFO - PROCESS | 2089 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:151.00 stddev:17.91 (11.9%) stddev-sans-first:18.21 03:16:22 INFO - PROCESS | 2089 | Values: 157.0 127.0 145.0 168.0 123.0 144.0 122.0 160.0 157.0 121.0 03:16:22 INFO - PROCESS | 2089 | 03:16:22 INFO - PROCESS | 2089 | [#2] audio-dft Cycles:10 Average:203.50 Median:201.00 stddev:12.69 (6.3%) stddev-sans-first:12.32 03:16:22 INFO - PROCESS | 2089 | Values: 189.0 199.0 202.0 213.0 235.0 200.0 196.0 199.0 205.0 197.0 03:16:22 INFO - PROCESS | 2089 | 03:16:22 INFO - PROCESS | 2089 | [#3] audio-fft Cycles:10 Average:84.90 Median:72.50 stddev:32.24 (44.5%) stddev-sans-first:33.54 03:16:22 INFO - PROCESS | 2089 | Values: 67.0 72.0 73.0 142.0 60.0 75.0 82.0 87.0 143.0 48.0 03:16:22 INFO - PROCESS | 2089 | 03:16:22 INFO - PROCESS | 2089 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:82.00 stddev:27.81 (33.9%) stddev-sans-first:28.57 03:16:22 INFO - PROCESS | 2089 | Values: 78.0 82.0 130.0 77.0 83.0 83.0 122.0 82.0 84.0 156.0 03:16:22 INFO - PROCESS | 2089 | 03:16:22 INFO - PROCESS | 2089 | [#5] imaging-gaussian-blur Cycles:10 Average:105.80 Median:81.50 stddev:22.16 (27.2%) stddev-sans-first:22.85 03:16:22 INFO - PROCESS | 2089 | Values: 91.0 78.0 119.0 132.0 91.0 132.0 136.0 106.0 88.0 85.0 03:16:22 INFO - PROCESS | 2089 | 03:16:22 INFO - PROCESS | 2089 | [#6] imaging-darkroom Cycles:10 Average:123.40 Median:153.50 stddev:25.59 (16.7%) stddev-sans-first:25.80 03:16:22 INFO - PROCESS | 2089 | Values: 146.0 124.0 141.0 152.0 95.0 94.0 100.0 155.0 93.0 134.0 03:16:22 INFO - PROCESS | 2089 | 03:16:22 INFO - PROCESS | 2089 | [#7] imaging-desaturate Cycles:10 Average:104.90 Median:91.50 stddev:21.49 (23.5%) stddev-sans-first:22.11 03:16:22 INFO - PROCESS | 2089 | Values: 90.0 99.0 92.0 91.0 91.0 92.0 138.0 147.0 92.0 117.0 03:16:22 INFO - PROCESS | 2089 | 03:16:22 INFO - PROCESS | 2089 | [#8] json-parse-financial Cycles:10 Average:65.40 Median:63.00 stddev:7.46 (11.8%) stddev-sans-first:7.89 03:16:22 INFO - PROCESS | 2089 | Values: 64.0 61.0 60.0 62.0 59.0 62.0 60.0 79.0 69.0 78.0 03:16:22 INFO - PROCESS | 2089 | 03:16:22 INFO - PROCESS | 2089 | [#9] json-stringify-tinderbox Cycles:10 Average:75.00 Median:69.50 stddev:15.19 (21.9%) stddev-sans-first:15.36 03:16:22 INFO - PROCESS | 2089 | Values: 62.0 65.0 65.0 69.0 87.0 102.0 70.0 58.0 75.0 97.0 03:16:22 INFO - PROCESS | 2089 | 03:16:22 INFO - PROCESS | 2089 | [#10] stanford-crypto-aes Cycles:10 Average:84.80 Median:85.50 stddev:1.69 (2.0%) stddev-sans-first:1.09 03:16:22 INFO - PROCESS | 2089 | Values: 81.0 86.0 87.0 84.0 84.0 85.0 84.0 86.0 85.0 86.0 03:16:22 INFO - PROCESS | 2089 | 03:16:22 INFO - PROCESS | 2089 | [#11] stanford-crypto-ccm Cycles:10 Average:153.70 Median:152.50 stddev:13.24 (8.7%) stddev-sans-first:13.88 03:16:22 INFO - PROCESS | 2089 | Values: 148.0 164.0 157.0 144.0 145.0 142.0 142.0 145.0 176.0 174.0 03:16:22 INFO - PROCESS | 2089 | 03:16:22 INFO - PROCESS | 2089 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:188.20 Median:175.50 stddev:27.38 (15.6%) stddev-sans-first:28.40 03:16:22 INFO - PROCESS | 2089 | Values: 172.0 172.0 205.0 172.0 240.0 232.0 178.0 170.0 168.0 173.0 03:16:22 INFO - PROCESS | 2089 | 03:16:22 INFO - PROCESS | 2089 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.70 Median:73.50 stddev:9.06 (12.3%) stddev-sans-first:9.51 03:16:22 INFO - PROCESS | 2089 | Values: 72.0 72.0 81.0 83.0 97.0 75.0 67.0 69.0 71.0 70.0 03:16:22 INFO - PROCESS | 2089 | -------- Summary: end -------- 03:16:22 INFO - PROCESS | 2089 | 03:16:23 INFO - TEST-INFO | 2089: exit 0 03:16:23 INFO - TEST-OK | kraken | took 60281ms 03:16:23 INFO - SUITE-END | took 1172s 03:16:23 INFO - Completed test suite (00:19:32) 03:16:23 INFO - javascript benchmark 03:16:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2918.5622156676495, 3424.982875085625, 3502.247016891368, 3507.1232191952013, 3536.787792732435, 5778.62438941469, 5799.304083509985, 5836.44553767392, 5839.620424672394, 5845.0647896336595, 5725.227094342263, 5843.5033022193165, 5845.918505076554, 5917.319508256552, 5964.970175149129, 5198.2982297389935, 5228.111221092405, 5270.7628156733035, 5281.102212623863, 5304.9920515102, 181.8442838684979, 5160.638755287131, 5212.192110222903, 5221.2951251580935, 5230.790768369261, 3982.4026396040535, 5204.635675502716, 5227.11139106349, 5242.213667949819, 5262.131748261532, 5270.39390470097, 5278.261043453919, 5279.815206467793, 5290.153575427951, 5308.681479111227, 5109.131447653907, 5145.125328694094, 5148.279240906276, 5181.611379146541, 5222.529972302511, 5573.554115670737, 5712.771489140429, 5739.770409183628, 5766.135079738031, 5827.388124246978, 6141.731496609858, 6231.189945307126, 6248.593841400295, 6258.06129080637, 6277.403646653561, 6194.132821405007, 6252.906206406908, 6280.560360774748, 6286.591371560834, 6308.526860485436, 5932.288125424933, 5950.464458198783, 5970.283565972068, 5987.730552125165, 6034.034554471307, 6181.227346581677, 6271.937280627227, 6317.727250111964, 6340.651264180515, 6373.936260637427, 5673.461021202979, 6186.288576813724, 6268.937310626835, 6292.433680968735, 6330.683465826783, 6151.96924015377, 6187.071939209065, 6276.811695649138, 6288.685565721696, 6295.307516173218, 6173.81478555644, 6228.626282423069, 6266.028765541349, 6272.3100458949475, 6273.309935907047, 6236.719347629368, 6240.7503699852405, 6255.343188965184, 6256.468200202943, 6257.590827531433, 4182.1844740275355, 4992.475790042066, 5001.624878134155, 5021.121303771898, 5024.346834911511, 4338.284183109815, 4421.889452763707, 4478.664100192498, 4502.144592527409, 4551.5676010778925, 5905.232319798399, 5921.14143449206, 5954.434328738763, 5979.910301345483, 6018.307894592091, 6234.844128896814, 6239.532035097386, 6263.906041409383, 6285.465735412449, 6286.308506064329, 5818.418158184148, 5904.911426328608, 5945.048792193228, 5989.2812862456785, 5989.64062156272, 5489.204065410493, 5495.53287970527, 5499.0, 5502.944970550323, 5513.807016754475, 5106.795728170831, 6254.437100660963, 6456.54804163704, 6471.7734879279, 6490.448311893448, 6172.783952561639, 6232.189815323979, 6249.7500099997305, 6251.4061164189325, 6263.279722831932, 5362.115250983544, 6396.328385519453, 6418.967905160444, 6446.709898054505, 6446.903296450463, 6128.28924408451, 6148.754049837957, 6239.1577137085915, 6280.309165991646, 6296.118543403835, 4988.9501104988485, 5224.869378265574, 6186.845328866814, 6249.187605611423, 6264.31092579825, 6197.380261973766, 6215.409536094064, 6228.968855155696, 6241.8140553294725, 6242.500599952084, 6098.695065246809, 6106.938930610637, 6119.015143218386, 6236.469900058546, 6240.656763878031, 4538.636909047203, 6063.818085457443, 6100.23747031621, 6104.938950610437, 6126.938730612636, 5834.0, 6211.409916057967, 6211.472024877936, 6231.594946328474, 6250.093736408105, 5947.464728174485, 6024.578279520391, 6106.673025714562, 6109.45014948639, 6129.417705317987], "value": 5686.251580749039, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [505.6561538154056, 536.1823219590125, 537.6908277740299, 540.1924123435465, 579.203595056797, 36943.076423089406, 37613.62386376136, 37677.811610941906, 37691.623083769155, 37742.86771396855, 40000.599994000055, 40527.99999999993, 40590.39114413286, 40781.388279175764, 40796.0, 9474.526273686306, 9703.029697030312, 9717.368371055894, 9719.125278724914, 9725.221982241439, 9561.61753529858, 9684.709458716214, 9692.854607180898, 9708.368956017872, 9770.90229097707, 9720.75698107546, 9730.172935300508, 9759.0, 9763.023697630251, 9817.116459518642, 9439.575219115157, 9678.161149381665, 9701.563429645612, 9708.514574271294, 9745.658901938468, 9546.093121153479, 9651.083147101013, 9681.564329605184, 9683.322167448281, 9687.934327224, 37537.06157346088, 37877.62122378768, 37919.0, 37955.62044379549, 38011.80994095039, 2482.329770961848, 2823.50588646988, 3147.2761264908972, 3292.407366673998, 3332.0670212340583, 23875.88062059696, 26574.335641608923, 26737.331566710793, 27210.1836944892, 28520.0017999369, 2696.3393968477653, 2737.411456536854, 2771.5842623606623, 2880.9135725928254, 2885.3507960708885, 392936.0, 393694.0, 399111.00444497884, 399562.0, 399790.0020999782, 61332.08001879975, 61622.0, 61718.76562468815, 61764.0, 61970.69014654988, 65635.0, 66568.0, 67619.0, 67887.0, 67944.6602766983, 16304.103274320027, 16349.673006539802, 16494.0, 16521.091339976418, 16542.917285413496, 12598.937005315098, 12686.04854635906, 12692.365381730877, 12701.428435720414, 12740.426680799386, 18843.811561884206, 18972.62054758897, 19025.14386852595, 19399.515012124808, 19411.0, 7821.256980586835, 8420.789480263042, 8424.199701028516, 8441.662333506714, 8459.492430454193, 942.137943781446, 1001.929864909464, 1010.075780660702, 1027.275770581738, 1053.146950969717, 24519.877400612884, 29483.557746633818, 29659.258518537208, 29816.10551683453, 30069.797208111868, 1021.7241344837001, 1044.0, 1085.4247248958065, 1130.8021096308278, 1161.1291531351487, 11963.521459141537, 15213.391464341525, 15245.0, 15607.453739119303, 15745.504177103157, 604634.0, 611837.0, 614460.0, 616686.0, 619806.0, 58364.832703345695, 58686.41313586895, 58932.705336473045, 59177.99999999914, 59263.0, 1420.6732451536204, 1458.5624312706145, 1464.934077966494, 1472.4699108320997, 1474.7935289059756, 29087.272818179714, 29752.851235744547, 30692.145890383636, 31359.0, 31443.056708298787, 46884.0, 55689.0, 56808.43191568197, 56829.0, 56995.0, 540963.0, 562005.1899740475, 564867.0, 565592.0, 566124.0, 40692.0, 41798.37302440405, 41856.79071604623, 42162.57837421587, 42417.0, 44843.10313793771, 44870.98080586316, 44988.55011449844, 46581.0, 46902.53097468981, 29938.70061299359, 36570.63429365672, 37142.44286335653, 37417.06457338479, 37819.432708508844, 30959.0, 36645.0, 37025.629743702215, 37415.62584374121, 37768.62231377651, 36658.8167059163, 36746.0, 37403.0, 37715.0, 38260.617393825705, 31644.525332119578, 32377.676223237468, 32509.674903250663, 32792.50811237881, 32804.67195328016, 22428.170533191143, 24599.87700061488, 25161.370965726004, 25422.618660719734, 25505.61741573915], "value": 19868.52265369987, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.63059710810876, 393.390245120064, 394.87166670831976, 404.9514058313001, 412.0, 18779.53051173718, 18954.715679264824, 21177.364679059654, 21436.464088397817, 21490.89254553727, 20277.0875310611, 20997.895010524964, 21196.576068478622, 21247.25634602789, 21377.610455320395, 5254.9861461271485, 5869.2369991901, 6137.877242455148, 6139.754409823602, 6158.907616385758, 4022.416749571325, 6307.905381419282, 6666.0, 6679.699413526403, 6686.665666716669, 6338.176037115169, 6575.309592492791, 6615.569987950792, 6657.3675500827585, 6761.188657361124, 6697.062411262427, 6733.831654208635, 6737.461003119739, 6739.022841687953, 6742.157230346232, 5561.6663000220115, 5875.529957603424, 5883.205767221413, 5909.8227053188475, 5917.349091599921, 26336.73663263362, 26452.338691532674, 26499.205023849314, 26995.325116872038, 27021.729782702118, 2152.074607918594, 2155.4072630026712, 2163.816075633573, 2279.87460689662, 2561.7950563954837, 14912.925435372754, 15339.0, 15339.693206135926, 15366.30851611669, 15558.066516008963, 1638.6067343837512, 1753.7635966643613, 1779.946601601954, 1794.9192286347145, 1801.9008954507497, 110387.58764138313, 113487.43256283748, 113559.0, 114939.0, 116715.249271261, 11158.995690387905, 11288.0, 11850.822237666442, 11928.687844337115, 11935.820962685566, 14568.125912445286, 14622.415103395957, 14661.04703194289, 14665.340059697339, 14685.339159737623, 8437.704680336159, 8696.0, 8878.200961913459, 8903.887014123235, 8984.416012959136, 7658.195889431641, 7802.063752349641, 8683.696070637498, 8766.298696104297, 8940.240079593177, 5102.4897510248675, 6922.861542769117, 6997.475189360818, 7035.47233957445, 7045.68294426752, 1680.7646929429889, 1737.5144251664897, 1934.3809980806288, 1947.1015759634242, 1963.626910886927, 943.8820147481565, 981.7300242433388, 995.7311525887969, 1020.5713600287897, 1052.6684094510206, 20321.288754893805, 21298.680519792215, 21527.67708484374, 21760.782392175875, 21792.346229613137, 1032.550840384435, 1051.3849398102195, 1055.488088277185, 1083.7290677330668, 1090.5964793026471, 10343.896561034444, 11524.423778811026, 11578.536858525733, 11624.6512604622, 11693.941530292293, 482051.58974204905, 606248.0, 609061.0, 612931.0, 621079.0, 78629.0, 116738.41630791791, 135614.32192838972, 135765.0, 147044.0, 1009.3641006166068, 1030.9278350515392, 1057.751428414322, 1058.6771034834449, 1061.1828891753307, 18326.725099123258, 18368.448946531626, 18609.53476163107, 18665.720014199527, 18766.967816770208, 36713.0, 48108.0, 51097.978040439724, 52032.47967520276, 52083.73958130185, 59158.40841591529, 59485.40514594972, 59823.700881495315, 60235.0, 67258.9911151343, 7703.961480192787, 7949.443538952449, 8081.191880811872, 8295.087540370434, 8316.085230624505, 9033.0, 9989.401695728939, 10426.843597345895, 12348.876511234772, 12649.241045537297, 10972.451377430936, 11149.554017839195, 11213.71965700864, 11288.034683235795, 11321.773564528829, 7728.033995750531, 10554.313969591953, 10585.682429527127, 10593.629222977159, 10871.075958543612, 7412.444066694911, 9512.524373781145, 11069.0, 11407.600733974272, 11451.828222576502, 8172.182781722018, 8185.959070204611, 8217.9141201684, 8416.537090460084, 8502.702405415781, 8179.427440079376, 10202.0, 11082.16883733707, 11344.20590558653, 11373.886261137282], "value": 9751.64970032517, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1525.6567272363716, 1592.792936918201, 1868.093974422405, 1969.5174682202862, 1971.2804826238428, 7949.0, 8507.234348908598, 8588.0, 8776.297896168315, 8798.824023519534, 8520.446170998881, 8578.056413794478, 8652.567371631409, 8661.69684061058, 8666.52334121623, 2399.4961058177805, 2417.2506522977933, 2421.164698179134, 2424.5150969806023, 2427.66012758214, 2400.423898264413, 2402.2192787344184, 2428.5021570577987, 2440.1459489178733, 2444.1934161726585, 2103.5056761661, 2413.6379543068592, 2415.3599296186526, 2417.129833260025, 2437.5612389769835, 2380.1312520929737, 2383.07060246504, 2384.391980045095, 2410.409449684821, 2413.9517209655796, 2380.73811880693, 2390.1634427950253, 2398.2325655790155, 2401.435662619283, 2404.074431343945, 8721.127887211229, 8788.340874434443, 8791.736247912573, 8800.295976321942, 8815.338849586307, 5130.127878260705, 5357.812476563302, 5359.490848369399, 5371.248025276464, 5400.540954018874, 3496.807675577842, 3575.964240357589, 3584.121890136907, 3617.1680513482047, 3617.385044542434, 1033.912117470016, 1046.7801761630067, 1056.0548309263243, 1068.9625863094755, 1091.5579190427889, 11375.317480951087, 11445.370504622242, 11499.59751408705, 11502.424878756112, 11523.308601483854, 3870.3420418528353, 4600.838970636079, 4814.903701925942, 4852.8544143675745, 4886.486918873467, 9906.851397229048, 9926.2059035277, 9931.304808663468, 9986.900130998742, 9999.750006249902, 4699.389079419722, 4868.391451068616, 4917.606591472745, 5387.649802762808, 5405.621606487508, 4369.453818272716, 4753.809847606057, 4876.414830220397, 4920.8769780755765, 5052.696838189647, 3890.2608504384075, 4043.1913617276664, 4062.405715008706, 4066.898327541835, 4074.490688663917, 1339.638297659646, 1356.6404902700792, 1357.0, 1358.3547814787896, 1360.7074478987065, 895.9865602015975, 901.5402144906145, 910.8360495110811, 919.4483310014072, 942.9862897385201, 5486.177073439016, 5680.403557626472, 5801.7099145042575, 5894.2926848778425, 5964.493018093423, 997.7904640025675, 1013.6113524471522, 1040.422565476168, 1047.9633212837514, 1071.4267866691282, 3252.837358132084, 3714.4428335749853, 3822.445745366962, 3839.9056268963213, 3845.3270677631303, 8174.591270436455, 10246.897531024595, 10699.679009629723, 10700.732481688021, 10742.409167495707, 10449.425281609432, 10534.618494615037, 10708.78582428347, 10760.730981725519, 10816.0, 7450.515716478411, 7858.960705196552, 8173.754787356389, 8247.546384948886, 8300.667973281, 5596.384397716167, 5597.160425936142, 5651.915221271766, 5692.743826527733, 5744.396838331915, 9618.615255389986, 9840.212782977202, 9889.109980101824, 9948.651797187063, 9950.004999500281, 10196.592136314464, 10198.286119971532, 10279.588816447258, 10312.175025998053, 10350.585976561155, 6482.675866206765, 6726.764563240263, 7024.121984751906, 7043.190033146049, 7182.96408517954, 8192.30365418946, 8219.095899451175, 8252.669893204446, 8278.751637450887, 8315.916840831514, 7211.278872112956, 7310.19587845326, 7328.377087947584, 7449.962750186214, 7456.888146677913, 6988.685509152202, 7197.964010179916, 7229.566226026455, 7229.855402891808, 7285.672144753605, 6755.898661520179, 6809.455243580601, 6858.554193977376, 6873.621950792754, 6877.449804015567, 4606.378138951199, 4661.557152070548, 4673.065386922561, 4782.832600858953, 4808.3989501312335, 4792.400949881265, 4809.254565542206, 4810.941592849567, 4838.225883858566, 4875.0], "value": 4575.036592930975, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [314.2113295627973, 324.20893021028695, 331.41670659639027, 331.4249776637534, 333.1022893302551, 5800.723840755032, 5967.880642387149, 6031.155638210654, 6132.877342453154, 6157.045657923023, 5336.91994620081, 5849.824505264838, 6087.847803804907, 6104.786332478364, 6142.447179753821, 4582.106489234592, 4584.381108550353, 4593.058423023289, 4600.97699511502, 4621.722696638196, 3631.4189729643263, 4236.9152616947795, 4590.40324757781, 4614.492405835355, 4694.882627934295, 3980.761154330735, 4510.233260345749, 4523.864284071483, 4530.307799143704, 4566.58900698937, 4034.6570541504007, 4569.926067374165, 4573.679842411033, 4573.8170473181035, 4590.334401511779, 3241.2383089973837, 3492.406290930548, 3575.4458059000635, 3963.742356746802, 3966.5240171179353, 5850.590458667895, 5861.384554621789, 5863.824085277449, 5873.970630146822, 5876.207756634225, 4837.226043833005, 5273.235380869791, 5276.81531146408, 5292.867678308035, 5308.336457942757, 6325.557210995232, 6508.9023664645065, 6530.575512591714, 6563.3764792344655, 6563.868722625521, 3737.588865224823, 4290.785460726983, 4301.41930839339, 4314.180305741899, 4344.522102568715, 6289.528285378569, 6570.408663220333, 6804.183497980224, 6850.629874025165, 6904.930950690479, 4034.293998550242, 4326.935095973563, 4342.782860856944, 4347.174036932973, 4350.630196433275, 4369.4101296325225, 4396.7142135761715, 4407.449068866392, 4419.889502762392, 4421.513633500313, 4148.564400737879, 5193.350831146106, 5228.503292187236, 5244.029854476934, 5269.604779641542, 5802.767889284466, 6195.16365290689, 6212.0, 6588.967055164693, 6599.406053455212, 1376.9535153283377, 1516.9393224271125, 1519.9088054716754, 1529.4646873594374, 1531.2343828085957, 848.3933987199182, 967.9903200968041, 984.6110786239395, 998.2612866478753, 1012.2964539645023, 5097.286379906816, 5339.985402773461, 6020.548458865603, 6036.788712395045, 6115.266168059861, 5998.4601385875485, 6663.600183988976, 6718.596884186964, 6718.832029199211, 6756.729730810811, 5762.538996880239, 6101.0, 6107.694615269219, 6122.295935967331, 6168.876622467616, 2937.5153099738304, 3559.430491121408, 3564.928701425957, 3577.964220357763, 3600.9099772505897, 5965.821025369246, 6339.844452885949, 6381.329960354189, 6658.96670516654, 6987.231404545598, 5860.648361098262, 6963.234044255128, 7016.052832867497, 7023.262557431498, 7041.0, 5891.970540147272, 6594.736210551524, 6740.797776066628, 7092.6099064551945, 7107.36033756954, 6312.0, 6431.517636177212, 6815.0, 6817.045613613999, 6831.28271531482, 6462.7091780870915, 6637.1703537057865, 6708.463322934251, 6716.496262780409, 6772.932270677427, 6636.701348439428, 6916.858718311422, 7043.6830342633675, 7048.753293634698, 7078.575285482888, 3709.406494960793, 4311.417958575552, 4371.2568863293955, 4379.167958088081, 4382.189294980439, 5533.446655334435, 6435.292117866938, 6576.934230657632, 6626.734930602722, 6763.7632682855865, 6304.211973503312, 6510.251321098134, 6555.4427873629365, 6565.015247712881, 6579.769708060195, 6224.62652240867, 6536.3136870627895, 6555.508336874658, 6560.868782624416, 6561.212654481493, 6282.555012347094, 6342.0, 6367.522435817425, 6389.0, 6399.072134540559, 5738.680103576285, 6119.317187773398, 6237.1891654084675, 6556.0493728410065, 6600.504962127764, 5473.781048758165, 5703.401142879938, 5847.883042339045, 6194.81415557534, 6461.289258181502], "value": 4695.541079214224, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [616.1589430427465, 662.6620423583972, 662.9535932484727, 723.9420846332293, 736.9189389167191, 14782.77825832612, 14993.250337483138, 15301.00543464674, 15302.387904483821, 15322.540323790276, 12416.944559712412, 13748.175109493437, 13894.096883702578, 14191.432342706279, 14209.218492982882, 714.3428046197511, 913.1827014821764, 924.8982611912701, 947.4031360243038, 952.1383148250809, 875.4659657608853, 907.5870478932103, 920.2591913509622, 934.1499235695518, 938.7183844846553, 936.4802534593332, 944.8771659684265, 946.4510583861378, 948.4309414351369, 949.7388218240005, 931.0735817861204, 939.1547607153548, 941.7692665296978, 942.4015749998766, 944.5843828715343, 682.1302838880417, 692.8995295682148, 710.5452510393352, 710.6908494804776, 711.1288671377521, 12504.49982000719, 14900.850991490055, 15069.849301506954, 15097.0, 15130.319135638812, 12727.172733772368, 12767.297798621072, 12777.93611031939, 12799.616011519669, 12938.48246070156, 10001.549930253155, 10222.6422075227, 10262.025107614765, 10316.535755891004, 10484.475776211235, 3411.9317613647586, 3476.3047390521997, 3483.4600636901323, 3496.5629296337956, 3529.0647978285774, 58118.837623247724, 85781.14218857857, 86885.0, 87565.56217218937, 87812.24375512454, 9553.283503737108, 9617.422954622745, 9628.085331893459, 9777.022297770167, 9843.852342214872, 22358.217462389064, 22445.0, 22445.887770561043, 22520.436989075406, 22743.09027638909, 7437.405007599379, 7551.924480755232, 7607.66865798483, 7618.771436856903, 7757.534547927143, 3441.9655803442147, 4043.3126368517424, 4056.7971601419813, 4092.815823287959, 4098.036961314089, 3530.1880567469625, 3612.9819350903076, 3639.6724294813066, 3648.8175591220333, 3652.2695460907926, 536.888640514132, 655.9704813283414, 657.0472814419112, 658.0852614865341, 661.5600625584029, 517.7023211653315, 519.8674338043775, 528.207688467299, 581.9330776960619, 599.8470390050509, 7073.540219885691, 7410.96294518524, 7564.713998620247, 7654.502457340366, 7972.322352599978, 514.6474664854586, 555.5139253153491, 561.0, 596.6479776931632, 613.9969300153471, 3732.421474671376, 3796.1648437344293, 3836.175222327213, 3838.846446142123, 3863.710221733325, 77478.0, 80403.0, 82098.94752631112, 83713.0, 83939.58030209932, 67358.66320668464, 67659.32340676629, 68102.97845532322, 68658.9701154483, 69625.65187174133, 62638.0, 65639.0, 66352.00471992925, 68932.62134757377, 72719.0, 8228.50628962264, 8253.463524870864, 8279.875801862856, 8303.95848020756, 8345.54099524532, 42967.14065718731, 43516.78241608771, 44267.11465770602, 45032.549674504146, 45122.323165153204, 44318.0, 57308.1403778952, 60172.39827601843, 60438.0, 60972.390276096674, 10673.41296228715, 10863.619773307897, 10918.454077296263, 11103.500342484445, 11256.324620522795, 11822.645320640395, 11905.52377904874, 11998.40007999579, 12024.819627705767, 12054.578089766816, 8471.305738852378, 10807.513661885392, 11392.0, 11451.713707157387, 11904.821427678418, 9447.385919915183, 11313.71715707114, 11331.660050198507, 11432.657020289405, 11776.352300623548, 11237.213395062266, 11373.829392558953, 11507.481005550544, 11588.0, 11938.52245910154, 9332.626694932398, 9399.295052870926, 9500.762480938032, 9686.418814871131, 9896.851547226941, 9506.667266645634, 9644.180244679, 9682.56428460707, 9692.69732381462, 9705.708828734867], "value": 6739.948586682135, "unit": "score"}], "name": "dromaeo_css", "value": 7364.4653029687715, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 111.0, 114.0, 114.0, 116.0, 128.0, 115.0, 115.0, 117.0, 131.0], "value": 117.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 127.0, 145.0, 168.0, 123.0, 144.0, 122.0, 160.0, 157.0, 121.0], "value": 142.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 199.0, 202.0, 213.0, 235.0, 200.0, 196.0, 199.0, 205.0, 197.0], "value": 203.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 72.0, 73.0, 142.0, 60.0, 75.0, 82.0, 87.0, 143.0, 48.0], "value": 84.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 82.0, 130.0, 77.0, 83.0, 83.0, 122.0, 82.0, 84.0, 156.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 78.0, 119.0, 132.0, 91.0, 132.0, 136.0, 106.0, 88.0, 85.0], "value": 105.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 124.0, 141.0, 152.0, 95.0, 94.0, 100.0, 155.0, 93.0, 134.0], "value": 123.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 99.0, 92.0, 91.0, 91.0, 92.0, 138.0, 147.0, 92.0, 117.0], "value": 104.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 61.0, 60.0, 62.0, 59.0, 62.0, 60.0, 79.0, 69.0, 78.0], "value": 65.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 65.0, 69.0, 87.0, 102.0, 70.0, 58.0, 75.0, 97.0], "value": 75.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 86.0, 87.0, 84.0, 84.0, 85.0, 84.0, 86.0, 85.0, 86.0], "value": 84.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 164.0, 157.0, 144.0, 145.0, 142.0, 142.0, 145.0, 176.0, 174.0], "value": 153.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 172.0, 205.0, 172.0, 240.0, 232.0, 178.0, 170.0, 168.0, 173.0], "value": 188.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 72.0, 81.0, 83.0, 97.0, 75.0, 67.0, 69.0, 71.0, 70.0], "value": 75.7, "unit": "score"}], "name": "kraken", "value": 1623.2, "alertThreshold": 2.0}]} 03:16:23 INFO - Return code: 0 03:16:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:16:23 ERROR - # TBPL SUCCESS # 03:16:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:16:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:16:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:16:23 INFO - 2016-04-20 03:16:23.800 screenresolution[2096:14924] starting screenresolution argv=screenresolution get 03:16:23 INFO - 2016-04-20 03:16:23.803 screenresolution[2096:14924] Display 0: 1600x1200x32@60 03:16:23 INFO - 2016-04-20 03:16:23.809 screenresolution[2097:14926] starting screenresolution argv=screenresolution list 03:16:23 INFO - Available Modes on Display 0 03:16:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:16:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:16:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:16:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:16:24 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:16:24 INFO - Intel Iris: 03:16:24 INFO - Chipset Model: Intel Iris 03:16:24 INFO - Type: GPU 03:16:24 INFO - Bus: Built-In 03:16:24 INFO - VRAM (Dynamic, Max): 1536 MB 03:16:24 INFO - Vendor: Intel (0x8086) 03:16:24 INFO - Device ID: 0x0a2e 03:16:24 INFO - Revision ID: 0x0009 03:16:24 INFO - Displays: 03:16:24 INFO - Display: 03:16:24 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:16:24 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:16:24 INFO - Display Serial Number: 1600x1200 60 03:16:24 INFO - Main Display: Yes 03:16:24 INFO - Mirror: Off 03:16:24 INFO - Online: Yes 03:16:24 INFO - Rotation: Supported 03:16:24 INFO - Return code: 0 03:16:24 INFO - Running post-action listener: _resource_record_post_action 03:16:24 INFO - Running post-run listener: _resource_record_post_run 03:16:25 INFO - Total resource usage - Wall time: 1207s; CPU: 54.0%; Read bytes: 30367232; Write bytes: 697879552; Read time: 300; Write time: 1923 03:16:25 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 381624832; Write bytes: 376763392; Read time: 28198; Write time: 736 03:16:25 INFO - run-tests - Wall time: 1175s; CPU: 54.0%; Read bytes: 30367232; Write bytes: 299276288; Read time: 300; Write time: 1139 03:16:25 INFO - Running post-run listener: _upload_blobber_files 03:16:25 INFO - Blob upload gear active. 03:16:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 03:16:25 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 03:16:25 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'] 03:16:25 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 03:16:25 INFO - (blobuploader) - INFO - Open directory for files ... 03:16:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 03:16:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 03:16:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:26 INFO - (blobuploader) - INFO - Done attempting. 03:16:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 03:16:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 03:16:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 03:16:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 03:16:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 03:16:27 INFO - (blobuploader) - INFO - Done attempting. 03:16:27 INFO - (blobuploader) - INFO - Iteration through files over. 03:16:27 INFO - Return code: 0 03:16:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 03:16:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 03:16:27 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f76866737af715386cf34a1720ed362ed51ac38cc6a1d5ba246b0eb2364739dada5bbfbb469a6fecb504eb24e33030ba3529ed00b9b555bcb2483426668f92f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/70ab733b61bd07840bee704042012d13b272655fbb801c8eac43abff195ff7d80dbdf1ff57f6a374970c0ba82f9b37798fab2db28ebfbfbe1dca705e07639148"} 03:16:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 03:16:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 03:16:27 INFO - Contents: 03:16:27 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f76866737af715386cf34a1720ed362ed51ac38cc6a1d5ba246b0eb2364739dada5bbfbb469a6fecb504eb24e33030ba3529ed00b9b555bcb2483426668f92f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/70ab733b61bd07840bee704042012d13b272655fbb801c8eac43abff195ff7d80dbdf1ff57f6a374970c0ba82f9b37798fab2db28ebfbfbe1dca705e07639148"} 03:16:27 INFO - Running post-run listener: copy_logs_to_upload_dir 03:16:27 INFO - Copying logs to upload dir... 03:16:27 INFO - mkdir: /builds/slave/test/build/upload/logs 03:16:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.732853 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2016-04-20 03:16:27.415899) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 03:16:27.421287) ========= 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.KYMLEyU1vO/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.SDGVlyaCw3/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f76866737af715386cf34a1720ed362ed51ac38cc6a1d5ba246b0eb2364739dada5bbfbb469a6fecb504eb24e33030ba3529ed00b9b555bcb2483426668f92f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/70ab733b61bd07840bee704042012d13b272655fbb801c8eac43abff195ff7d80dbdf1ff57f6a374970c0ba82f9b37798fab2db28ebfbfbe1dca705e07639148"} build_url:https://queue.taskcluster.net/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011378 build_url: 'https://queue.taskcluster.net/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f76866737af715386cf34a1720ed362ed51ac38cc6a1d5ba246b0eb2364739dada5bbfbb469a6fecb504eb24e33030ba3529ed00b9b555bcb2483426668f92f6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/70ab733b61bd07840bee704042012d13b272655fbb801c8eac43abff195ff7d80dbdf1ff57f6a374970c0ba82f9b37798fab2db28ebfbfbe1dca705e07639148"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 03:16:27.451150) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 03:16:27.451618) ========= 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.KYMLEyU1vO/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.SDGVlyaCw3/Listeners TMPDIR=/var/folders/v_/vkyzkmvs35919vlc7qy0wc4h00000w/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.005221 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 03:16:27.501644) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 03:16:27.501954) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 03:16:27.502367) ========= ========= Total master_lag: 0.17 =========