builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0159 starttime: 1461142491.86 results: success (0) buildid: 20160420005033 builduid: 0561e628aab0406a8b2e605d200e020c revision: f71acdbd0d45ebdd0c69621dbf0f2f6ac74f9f43 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 01:54:51.856220) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-20 01:54:51.856868) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 01:54:51.857203) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-20 01:54:51.877460) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 01:54:51.877940) ========= 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.IB9KLhQJ47/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.8PKkOIYtLy/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 01:54:51-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 11.8M=0.001s 2016-04-20 01:54:52 (11.8 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125900 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 01:54:52.022674) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 01:54:52.023043) ========= 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.IB9KLhQJ47/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.8PKkOIYtLy/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.026030 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 01:54:52.072505) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-20 01:54:52.072973) ========= 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.IB9KLhQJ47/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.8PKkOIYtLy/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 01:54:52,145 truncating revision to first 12 chars 2016-04-20 01:54:52,146 Setting DEBUG logging. 2016-04-20 01:54:52,146 attempt 1/10 2016-04-20 01:54:52,146 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 01:54:53,925 unpacking tar archive at: fx-team-f71acdbd0d45/testing/mozharness/ program finished with exit code 0 elapsedTime=2.022721 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-04-20 01:54:54.113991) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 01:54:54.114444) ========= script_repo_revision: f71acdbd0d45ebdd0c69621dbf0f2f6ac74f9f43 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-20 01:54:54.114985) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 01:54:54.115389) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-20 01:54:54.129805) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-20 01:54:54.130238) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.IB9KLhQJ47/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.8PKkOIYtLy/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 01:54:54 INFO - MultiFileLogger online at 20160420 01:54:54 in /builds/slave/test 01:54:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 01:54:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:54:54 INFO - {'append_to_log': False, 01:54:54 INFO - 'base_work_dir': '/builds/slave/test', 01:54:54 INFO - 'blob_upload_branch': 'Fx-Team', 01:54:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:54:54 INFO - 'branch': 'Fx-Team', 01:54:54 INFO - 'buildbot_json_path': 'buildprops.json', 01:54:54 INFO - 'config_files': ('talos/mac_config.py',), 01:54:54 INFO - 'default_actions': ('clobber', 01:54:54 INFO - 'read-buildbot-config', 01:54:54 INFO - 'download-and-extract', 01:54:54 INFO - 'populate-webroot', 01:54:54 INFO - 'create-virtualenv', 01:54:54 INFO - 'install', 01:54:54 INFO - 'run-tests'), 01:54:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:54:54 INFO - 'download_minidump_stackwalk': True, 01:54:54 INFO - 'download_symbols': 'ondemand', 01:54:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:54:54 INFO - 'tooltool.py': '/tools/tooltool.py', 01:54:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:54:54 INFO - '/tools/misc-python/virtualenv.py')}, 01:54:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:54:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:54:54 INFO - 'installer_path': 'installer.exe', 01:54:54 INFO - 'log_level': 'info', 01:54:54 INFO - 'log_name': 'talos', 01:54:54 INFO - 'log_to_console': True, 01:54:54 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:54:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:54:54 INFO - 'opt_config_files': (), 01:54:54 INFO - 'pip_index': False, 01:54:54 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:54:54 INFO - 'cmd': ('bash', 01:54:54 INFO - '-c', 01:54:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:54:54 INFO - 'enabled': True, 01:54:54 INFO - 'halt_on_failure': False, 01:54:54 INFO - 'name': 'check_screen_resolution'},), 01:54:54 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:54:54 INFO - 'cmd': ('bash', 01:54:54 INFO - '-c', 01:54:54 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:54:54 INFO - 'enabled': True, 01:54:54 INFO - 'halt_on_failure': False, 01:54:54 INFO - 'name': 'check_screen_resolution'},), 01:54:54 INFO - 'run_cmd_checks_enabled': True, 01:54:54 INFO - 'sps_profile': False, 01:54:54 INFO - 'sps_profile_interval': 0, 01:54:54 INFO - 'suite': 'dromaeojs', 01:54:54 INFO - 'system_bits': '32', 01:54:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:54:54 INFO - 'title': 't-yosemite-r7-0159', 01:54:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:54:54 INFO - 'use_talos_json': True, 01:54:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:54:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:54:54 INFO - 'work_dir': 'build'} 01:54:54 INFO - ##### 01:54:54 INFO - ##### Running clobber step. 01:54:54 INFO - ##### 01:54:54 INFO - Running pre-action listener: _resource_record_pre_action 01:54:54 INFO - Running main action method: clobber 01:54:54 INFO - rmtree: /builds/slave/test/build 01:54:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:54:55 INFO - Running post-action listener: _resource_record_post_action 01:54:55 INFO - ##### 01:54:55 INFO - ##### Running read-buildbot-config step. 01:54:55 INFO - ##### 01:54:55 INFO - Running pre-action listener: _resource_record_pre_action 01:54:55 INFO - Running main action method: read_buildbot_config 01:54:55 INFO - Using buildbot properties: 01:54:55 INFO - { 01:54:55 INFO - "project": "", 01:54:55 INFO - "product": "firefox", 01:54:55 INFO - "script_repo_revision": "production", 01:54:55 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 01:54:55 INFO - "repository": "", 01:54:55 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 01:54:55 INFO - "buildid": "20160420005033", 01:54:55 INFO - "pgo_build": "False", 01:54:55 INFO - "basedir": "/builds/slave/test", 01:54:55 INFO - "buildnumber": 650, 01:54:55 INFO - "slavename": "t-yosemite-r7-0159", 01:54:55 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 01:54:55 INFO - "platform": "yosemite_r7", 01:54:55 INFO - "scheduler": "tests-fx-team-macosx64-talos", 01:54:55 INFO - "branch": "fx-team", 01:54:55 INFO - "repo_path": "integration/fx-team", 01:54:55 INFO - "revision": "f71acdbd0d45ebdd0c69621dbf0f2f6ac74f9f43", 01:54:55 INFO - "stage_platform": "macosx64", 01:54:55 INFO - "builduid": "0561e628aab0406a8b2e605d200e020c", 01:54:55 INFO - "slavebuilddir": "test" 01:54:55 INFO - } 01:54:55 INFO - Found installer url https://queue.taskcluster.net/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 01:54:55 INFO - Running post-action listener: _resource_record_post_action 01:54:55 INFO - ##### 01:54:55 INFO - ##### Running download-and-extract step. 01:54:55 INFO - ##### 01:54:55 INFO - Running pre-action listener: _resource_record_pre_action 01:54:55 INFO - Running main action method: download_and_extract 01:54:55 INFO - mkdir: /builds/slave/test/build/tests 01:54:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:55 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 01:54:55 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 01:54:55 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 01:54:55 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 01:54:55 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 01:54:57 INFO - Downloaded 1199 bytes. 01:54:57 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 01:54:57 INFO - Using the following test package requirements: 01:54:57 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 01:54:57 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:54:57 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 01:54:57 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:54:57 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 01:54:57 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:54:57 INFO - u'jsshell-mac.zip'], 01:54:57 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:54:57 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 01:54:57 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 01:54:57 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:54:57 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 01:54:57 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:54:57 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 01:54:57 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:54:57 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 01:54:57 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:54:57 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 01:54:57 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:54: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')]} 01:54:57 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 01:54:57 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 01:54:57 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 01:54:57 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 01:54:57 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 01:54:58 INFO - Downloaded 18095510 bytes. 01:54:58 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'] 01:54:58 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 01:55:01 INFO - Return code: 0 01:55:01 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 01:55:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:01 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 01:55:01 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 01:55:01 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 01:55:01 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 01:55:01 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 01:55:02 INFO - Downloaded 18095510 bytes. 01:55:02 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'] 01:55:02 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 01:55:06 INFO - Return code: 0 01:55:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:06 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 01:55:06 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 01:55:06 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 01:55:06 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 01:55:06 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 01:55:07 INFO - Downloaded 10845952 bytes. 01:55:07 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'] 01:55:07 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 01:55:07 INFO - Return code: 0 01:55: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')]} 01:55:07 INFO - https://queue.taskcluster.net/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:55:07 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 01:55:07 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 01:55:07 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 01:55:07 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 01:55:10 INFO - Downloaded 110058536 bytes. 01:55:10 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 01:55:10 INFO - mkdir: /builds/slave/test/properties 01:55:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:55:10 INFO - Writing to file /builds/slave/test/properties/build_url 01:55:10 INFO - Contents: 01:55:10 INFO - build_url:https://queue.taskcluster.net/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:55:11 INFO - Running post-action listener: _resource_record_post_action 01:55:11 INFO - Running post-action listener: set_extra_try_arguments 01:55:11 INFO - ##### 01:55:11 INFO - ##### Running populate-webroot step. 01:55:11 INFO - ##### 01:55:11 INFO - Running pre-action listener: _resource_record_pre_action 01:55:11 INFO - Running main action method: populate_webroot 01:55:11 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:55:11 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:55:11 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:55:11 INFO - '--tppagecycles', 01:55:11 INFO - '7'], 01:55:11 INFO - 'tests': ['tsvgm']}}, 01:55:11 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:55:11 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:55:11 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:55:11 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:55:11 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:55:11 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:55:11 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:11 INFO - 'talos_options': ['--disable-e10s'], 01:55:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:55:11 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:11 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:55:11 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:11 INFO - 'talos_options': ['--disable-e10s'], 01:55:11 INFO - 'tests': ['damp', 'tps']}, 01:55:11 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:11 INFO - 'tests': ['damp', 'tps']}, 01:55:11 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:55:11 INFO - 'tests': ['dromaeo_dom']}, 01:55:11 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:55:11 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:55:11 INFO - 'tests': ['a11yr', 01:55:11 INFO - 'ts_paint', 01:55:11 INFO - 'tpaint', 01:55:11 INFO - 'sessionrestore', 01:55:11 INFO - 'sessionrestore_no_auto_restore', 01:55:11 INFO - 'tabpaint']}, 01:55:11 INFO - 'other-e10s': {'tests': ['a11yr', 01:55:11 INFO - 'ts_paint', 01:55:11 INFO - 'tpaint', 01:55:11 INFO - 'sessionrestore', 01:55:11 INFO - 'sessionrestore_no_auto_restore', 01:55:11 INFO - 'tabpaint']}, 01:55:11 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:55:11 INFO - 'ts_paint', 01:55:11 INFO - 'tpaint', 01:55:11 INFO - 'sessionrestore', 01:55:11 INFO - 'sessionrestore_no_auto_restore', 01:55:11 INFO - 'tabpaint']}, 01:55:11 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:55:11 INFO - 'ts_paint', 01:55:11 INFO - 'tpaint', 01:55:11 INFO - 'sessionrestore', 01:55:11 INFO - 'sessionrestore_no_auto_restore', 01:55:11 INFO - 'tabpaint']}, 01:55:11 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:55:11 INFO - 'tests': ['a11yr', 01:55:11 INFO - 'ts_paint', 01:55:11 INFO - 'tpaint', 01:55:11 INFO - 'sessionrestore', 01:55:11 INFO - 'sessionrestore_no_auto_restore', 01:55:11 INFO - 'tabpaint']}, 01:55:11 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:55:11 INFO - 'tests': ['a11yr', 01:55:11 INFO - 'ts_paint', 01:55:11 INFO - 'tpaint', 01:55:11 INFO - 'sessionrestore', 01:55:11 INFO - 'sessionrestore_no_auto_restore', 01:55:11 INFO - 'tabpaint']}, 01:55:11 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:55:11 INFO - 'tests': ['tsvgx', 01:55:11 INFO - 'tsvgr_opacity', 01:55:11 INFO - 'tart', 01:55:11 INFO - 'tscrollx', 01:55:11 INFO - 'cart']}, 01:55:11 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:55:11 INFO - 'tsvgr_opacity', 01:55:11 INFO - 'tart', 01:55:11 INFO - 'tscrollx', 01:55:11 INFO - 'cart']}, 01:55:11 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:11 INFO - 'talos_options': ['--disable-e10s'], 01:55:11 INFO - 'tests': ['tp5o']}, 01:55:11 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:11 INFO - 'tests': ['tp5o']}, 01:55:11 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:11 INFO - 'talos_options': ['--disable-e10s', 01:55:11 INFO - '--xperf_path', 01:55:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:55:11 INFO - 'tests': ['tp5n']}, 01:55:11 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:11 INFO - 'talos_options': ['--xperf_path', 01:55:11 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:55:11 INFO - 'tests': ['tp5n']}}, 01:55:11 INFO - 'talos.zip': {'path': '', 01:55:11 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:55:11 INFO - Running post-action listener: _resource_record_post_action 01:55:11 INFO - ##### 01:55:11 INFO - ##### Running create-virtualenv step. 01:55:11 INFO - ##### 01:55:11 INFO - Running pre-action listener: _resource_record_pre_action 01:55:11 INFO - Running main action method: create_virtualenv 01:55:11 INFO - Creating virtualenv /builds/slave/test/build/venv 01:55:11 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 01:55:11 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:55:11 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:55:11 INFO - Using real prefix '/tools/python27' 01:55:11 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:55:12 INFO - Installing distribute.............................................................................................................................................................................................done. 01:55:15 INFO - Installing pip.................done. 01:55:15 INFO - Return code: 0 01:55:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:55:15 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')]} 01:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:15 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')]} 01:55:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:15 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 0x10f259a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f269420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd22a4bb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f8e00>, '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 0x10ef21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f3b20>, '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.IB9KLhQJ47/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.8PKkOIYtLy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 01:55:15 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 01:55:15 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 01:55:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IB9KLhQJ47/Render', 01:55:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:55:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:55:15 INFO - 'HOME': '/Users/cltbld', 01:55:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:55:15 INFO - 'LOGNAME': 'cltbld', 01:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:15 INFO - 'MOZ_NO_REMOTE': '1', 01:55:15 INFO - 'NO_EM_RESTART': '1', 01:55:15 INFO - 'PAGER': '/bin/cat', 01:55:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:55:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:15 INFO - 'PWD': '/builds/slave/test', 01:55:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:55:15 INFO - 'SHELL': '/bin/bash', 01:55:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8PKkOIYtLy/Listeners', 01:55:15 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 01:55:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:55:15 INFO - 'USER': 'cltbld', 01:55:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:55:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:15 INFO - 'XPC_FLAGS': '0x0', 01:55:15 INFO - 'XPC_SERVICE_NAME': '0', 01:55:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:55:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:15 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 01:55:15 INFO - Cleaning up... 01:55:15 INFO - Return code: 0 01:55:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:55:15 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')]} 01:55:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:15 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')]} 01:55:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:15 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 0x10f259a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f269420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd22a4bb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f8e00>, '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 0x10ef21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f3b20>, '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.IB9KLhQJ47/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.8PKkOIYtLy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 01:55:15 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 01:55:15 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 01:55:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IB9KLhQJ47/Render', 01:55:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:55:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:55:15 INFO - 'HOME': '/Users/cltbld', 01:55:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:55:15 INFO - 'LOGNAME': 'cltbld', 01:55:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:15 INFO - 'MOZ_NO_REMOTE': '1', 01:55:15 INFO - 'NO_EM_RESTART': '1', 01:55:15 INFO - 'PAGER': '/bin/cat', 01:55:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:55:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:15 INFO - 'PWD': '/builds/slave/test', 01:55:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:55:15 INFO - 'SHELL': '/bin/bash', 01:55:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8PKkOIYtLy/Listeners', 01:55:15 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 01:55:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:55:15 INFO - 'USER': 'cltbld', 01:55:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:55:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:55:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:15 INFO - 'XPC_FLAGS': '0x0', 01:55:15 INFO - 'XPC_SERVICE_NAME': '0', 01:55:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:55:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:15 INFO - Downloading/unpacking psutil>=0.7.1 01:55:15 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 01:55:15 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 01:55:15 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 01:55:15 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 01:55:15 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 01:55:15 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 01:55:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:55:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:55:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:55:18 INFO - Installing collected packages: psutil 01:55:18 INFO - Running setup.py install for psutil 01:55:18 INFO - building 'psutil._psutil_osx' extension 01:55:18 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 01:55:18 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 01:55:19 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 01:55:19 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 01:55:19 INFO - building 'psutil._psutil_posix' extension 01:55:19 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 01:55:19 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:55:19 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:55:19 INFO - ^ 01:55:19 INFO - 1 warning generated. 01:55:19 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 01:55:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:55:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:55:19 INFO - Successfully installed psutil 01:55:19 INFO - Cleaning up... 01:55:19 INFO - Return code: 0 01:55:19 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:55:19 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')]} 01:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:19 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')]} 01:55:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:19 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 0x10f259a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f269420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd22a4bb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f8e00>, '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 0x10ef21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f3b20>, '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.IB9KLhQJ47/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.8PKkOIYtLy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 01:55:19 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 01:55:19 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 01:55:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IB9KLhQJ47/Render', 01:55:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:55:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:55:19 INFO - 'HOME': '/Users/cltbld', 01:55:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:55:19 INFO - 'LOGNAME': 'cltbld', 01:55:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:19 INFO - 'MOZ_NO_REMOTE': '1', 01:55:19 INFO - 'NO_EM_RESTART': '1', 01:55:19 INFO - 'PAGER': '/bin/cat', 01:55:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:55:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:19 INFO - 'PWD': '/builds/slave/test', 01:55:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:55:19 INFO - 'SHELL': '/bin/bash', 01:55:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8PKkOIYtLy/Listeners', 01:55:19 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 01:55:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:55:19 INFO - 'USER': 'cltbld', 01:55:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:55:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:55:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:19 INFO - 'XPC_FLAGS': '0x0', 01:55:19 INFO - 'XPC_SERVICE_NAME': '0', 01:55:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:55:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:19 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:22 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:55:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:55:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:55:22 INFO - Installing collected packages: mozsystemmonitor 01:55:22 INFO - Running setup.py install for mozsystemmonitor 01:55:22 INFO - Successfully installed mozsystemmonitor 01:55:22 INFO - Cleaning up... 01:55:22 INFO - Return code: 0 01:55:22 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:55:22 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')]} 01:55:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:22 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')]} 01:55:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:22 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 0x10f259a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f269420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd22a4bb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f8e00>, '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 0x10ef21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f3b20>, '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.IB9KLhQJ47/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.8PKkOIYtLy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 01:55:22 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 01:55:22 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 01:55:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IB9KLhQJ47/Render', 01:55:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:55:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:55:22 INFO - 'HOME': '/Users/cltbld', 01:55:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:55:22 INFO - 'LOGNAME': 'cltbld', 01:55:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:22 INFO - 'MOZ_NO_REMOTE': '1', 01:55:22 INFO - 'NO_EM_RESTART': '1', 01:55:22 INFO - 'PAGER': '/bin/cat', 01:55:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:55:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:22 INFO - 'PWD': '/builds/slave/test', 01:55:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:55:22 INFO - 'SHELL': '/bin/bash', 01:55:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8PKkOIYtLy/Listeners', 01:55:22 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 01:55:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:55:22 INFO - 'USER': 'cltbld', 01:55:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:55:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:55:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:22 INFO - 'XPC_FLAGS': '0x0', 01:55:22 INFO - 'XPC_SERVICE_NAME': '0', 01:55:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:55:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:22 INFO - Downloading/unpacking blobuploader==1.2.4 01:55:22 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 01:55:22 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 01:55:22 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 01:55:22 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 01:55:22 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 01:55:22 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 01:55:25 INFO - Downloading blobuploader-1.2.4.tar.gz 01:55:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:55:25 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:55:26 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:26 INFO - Downloading docopt-0.6.1.tar.gz 01:55:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:55:26 INFO - Installing collected packages: blobuploader, requests, docopt 01:55:26 INFO - Running setup.py install for blobuploader 01:55:26 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:55:26 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:55:26 INFO - Running setup.py install for requests 01:55:27 INFO - Running setup.py install for docopt 01:55:27 INFO - Successfully installed blobuploader requests docopt 01:55:27 INFO - Cleaning up... 01:55:27 INFO - Return code: 0 01:55:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:27 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 0x10f259a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f269420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd22a4bb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f8e00>, '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 0x10ef21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f3b20>, '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.IB9KLhQJ47/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.8PKkOIYtLy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 01:55:27 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 01:55:27 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 01:55:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IB9KLhQJ47/Render', 01:55:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:55:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:55:27 INFO - 'HOME': '/Users/cltbld', 01:55:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:55:27 INFO - 'LOGNAME': 'cltbld', 01:55:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:27 INFO - 'MOZ_NO_REMOTE': '1', 01:55:27 INFO - 'NO_EM_RESTART': '1', 01:55:27 INFO - 'PAGER': '/bin/cat', 01:55:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:55:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:27 INFO - 'PWD': '/builds/slave/test', 01:55:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:55:27 INFO - 'SHELL': '/bin/bash', 01:55:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8PKkOIYtLy/Listeners', 01:55:27 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 01:55:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:55:27 INFO - 'USER': 'cltbld', 01:55:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:55:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:55:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:27 INFO - 'XPC_FLAGS': '0x0', 01:55:27 INFO - 'XPC_SERVICE_NAME': '0', 01:55:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:55:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:55:27 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-2FU7cp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:55:27 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-RKCeCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:55:27 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-MEh8AU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:55:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:55:27 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-BN8xwb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:55:28 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-PGyC3N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:55:28 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-HEO4op-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:55:28 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-UVz76d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:55:28 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-r68PGp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:55:28 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-P2ZZe7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:55:28 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-tLXYq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:55:28 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-dp2zJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:55:28 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-ZAeEWS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:55:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:55:28 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-mQUSJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:55:29 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-hEGs9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:29 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-2b_3UV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:55:29 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-jYM4k6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:55:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:55:29 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-DCw7JQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:55:29 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:55:29 INFO - Running setup.py install for manifestparser 01:55:29 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:55:29 INFO - Running setup.py install for mozcrash 01:55:29 INFO - Running setup.py install for mozdebug 01:55:29 INFO - Running setup.py install for mozdevice 01:55:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:55:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:55:30 INFO - Running setup.py install for mozfile 01:55:30 INFO - Running setup.py install for mozhttpd 01:55:30 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:55:30 INFO - Running setup.py install for mozinfo 01:55:30 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:55:30 INFO - Running setup.py install for mozInstall 01:55:30 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:55:30 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:55:30 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:55:30 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:55:30 INFO - Running setup.py install for mozleak 01:55:30 INFO - Running setup.py install for mozlog 01:55:30 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:55:30 INFO - Running setup.py install for moznetwork 01:55:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:55:31 INFO - Running setup.py install for mozprocess 01:55:31 INFO - Running setup.py install for mozprofile 01:55:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:55:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:55:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:55:31 INFO - Running setup.py install for mozrunner 01:55:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:55:31 INFO - Running setup.py install for mozscreenshot 01:55:31 INFO - Running setup.py install for moztest 01:55:31 INFO - Running setup.py install for mozversion 01:55:31 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:55:31 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:55:31 INFO - Cleaning up... 01:55:31 INFO - Return code: 0 01:55:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:55:31 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')]} 01:55:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:31 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')]} 01:55:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:31 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 0x10f259a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f269420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd22a4bb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f8e00>, '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 0x10ef21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f3b20>, '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.IB9KLhQJ47/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.8PKkOIYtLy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 01:55:31 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 01:55:31 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 01:55:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IB9KLhQJ47/Render', 01:55:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:55:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:55:32 INFO - 'HOME': '/Users/cltbld', 01:55:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:55:32 INFO - 'LOGNAME': 'cltbld', 01:55:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:32 INFO - 'MOZ_NO_REMOTE': '1', 01:55:32 INFO - 'NO_EM_RESTART': '1', 01:55:32 INFO - 'PAGER': '/bin/cat', 01:55:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:55:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:32 INFO - 'PWD': '/builds/slave/test', 01:55:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:55:32 INFO - 'SHELL': '/bin/bash', 01:55:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8PKkOIYtLy/Listeners', 01:55:32 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 01:55:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:55:32 INFO - 'USER': 'cltbld', 01:55:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:55:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:55:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:32 INFO - 'XPC_FLAGS': '0x0', 01:55:32 INFO - 'XPC_SERVICE_NAME': '0', 01:55:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:55:32 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-QUICHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:55:32 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)) 01:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:55:32 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-Q3KOft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:55:32 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)) 01:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:55:32 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-XR8E7u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:55:32 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)) 01:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:55:32 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-hL5BWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:55:32 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)) 01:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:55:32 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-DDBwr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:55:32 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)) 01:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:55:32 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-I563LU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:55:32 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)) 01:55:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:55:32 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-JF8gIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:55:33 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)) 01:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:55:33 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-zLEFbR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:55:33 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)) 01:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:55:33 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-ttWtfu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:55:33 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)) 01:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:55:33 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-IcJq7b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:55:33 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)) 01:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:55:33 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-3YW15f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:55:33 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)) 01:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:55:33 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-UuYgfQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:55:33 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)) 01:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:55:33 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-3MSdZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:55:33 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)) 01:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:55:33 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-qW5EyO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:55:33 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)) 01:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:33 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-6LCHDQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:33 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)) 01:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:55:33 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-wxnmkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:55:33 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)) 01:55:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:55:33 INFO - Running setup.py (path:/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/pip-pZiWYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:55:34 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)) 01:55:34 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)) 01:55:34 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)) 01:55:34 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)) 01:55:34 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)) 01:55:34 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)) 01:55:34 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:36 INFO - Downloading blessings-1.6.tar.gz 01:55:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:55:36 INFO - Installing collected packages: blessings 01:55:36 INFO - Running setup.py install for blessings 01:55:36 INFO - Successfully installed blessings 01:55:36 INFO - Cleaning up... 01:55:36 INFO - Return code: 0 01:55:36 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:55:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:55:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:55:37 INFO - Reading from file tmpfile_stdout 01:55:37 INFO - Current package versions: 01:55:37 INFO - blessings == 1.6 01:55:37 INFO - blobuploader == 1.2.4 01:55:37 INFO - docopt == 0.6.1 01:55:37 INFO - manifestparser == 1.1 01:55:37 INFO - mozInstall == 1.12 01:55:37 INFO - mozcrash == 0.17 01:55:37 INFO - mozdebug == 0.1 01:55:37 INFO - mozdevice == 0.48 01:55:37 INFO - mozfile == 1.2 01:55:37 INFO - mozhttpd == 0.7 01:55:37 INFO - mozinfo == 0.9 01:55:37 INFO - mozleak == 0.1 01:55:37 INFO - mozlog == 3.1 01:55:37 INFO - moznetwork == 0.27 01:55:37 INFO - mozprocess == 0.22 01:55:37 INFO - mozprofile == 0.28 01:55:37 INFO - mozrunner == 6.11 01:55:37 INFO - mozscreenshot == 0.1 01:55:37 INFO - mozsystemmonitor == 0.0 01:55:37 INFO - moztest == 0.7 01:55:37 INFO - mozversion == 1.4 01:55:37 INFO - psutil == 3.1.1 01:55:37 INFO - requests == 1.2.3 01:55:37 INFO - wsgiref == 0.1.2 01:55:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:55:37 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')]} 01:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:37 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')]} 01:55:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:37 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 0x10f259a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f269420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd22a4bb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f8e00>, '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 0x10ef21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f3b20>, '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.IB9KLhQJ47/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.8PKkOIYtLy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 01:55:37 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 01:55:37 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 01:55:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IB9KLhQJ47/Render', 01:55:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:55:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:55:37 INFO - 'HOME': '/Users/cltbld', 01:55:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:55:37 INFO - 'LOGNAME': 'cltbld', 01:55:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:37 INFO - 'MOZ_NO_REMOTE': '1', 01:55:37 INFO - 'NO_EM_RESTART': '1', 01:55:37 INFO - 'PAGER': '/bin/cat', 01:55:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:55:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:37 INFO - 'PWD': '/builds/slave/test', 01:55:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:55:37 INFO - 'SHELL': '/bin/bash', 01:55:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8PKkOIYtLy/Listeners', 01:55:37 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 01:55:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:55:37 INFO - 'USER': 'cltbld', 01:55:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:55:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:55:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:37 INFO - 'XPC_FLAGS': '0x0', 01:55:37 INFO - 'XPC_SERVICE_NAME': '0', 01:55:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:55:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:37 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)) 01:55:37 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)) 01:55:37 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)) 01:55:37 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)) 01:55:37 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)) 01:55:37 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)) 01:55:37 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)) 01:55:37 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)) 01:55:37 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)) 01:55:37 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)) 01:55:37 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)) 01:55:37 INFO - Cleaning up... 01:55:37 INFO - Return code: 0 01:55:37 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:55:37 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')]} 01:55:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:37 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')]} 01:55:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:37 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 0x10f259a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f269420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd22a4bb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f8e00>, '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 0x10ef21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f3b20>, '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.IB9KLhQJ47/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.8PKkOIYtLy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 01:55:37 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 01:55:37 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 01:55:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IB9KLhQJ47/Render', 01:55:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:55:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:55:37 INFO - 'HOME': '/Users/cltbld', 01:55:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:55:37 INFO - 'LOGNAME': 'cltbld', 01:55:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:37 INFO - 'MOZ_NO_REMOTE': '1', 01:55:37 INFO - 'NO_EM_RESTART': '1', 01:55:37 INFO - 'PAGER': '/bin/cat', 01:55:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:55:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:37 INFO - 'PWD': '/builds/slave/test', 01:55:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:55:37 INFO - 'SHELL': '/bin/bash', 01:55:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8PKkOIYtLy/Listeners', 01:55:37 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 01:55:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:55:37 INFO - 'USER': 'cltbld', 01:55:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:55:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:55:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:37 INFO - 'XPC_FLAGS': '0x0', 01:55:37 INFO - 'XPC_SERVICE_NAME': '0', 01:55:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:55:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:37 INFO - Downloading/unpacking jsonschema 01:55:37 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 01:55:37 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 01:55:37 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 01:55:37 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 01:55:37 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 01:55:37 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 01:55:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:55:40 INFO - Downloading/unpacking functools32 (from jsonschema) 01:55:40 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 01:55:40 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 01:55:40 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 01:55:40 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 01:55:40 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 01:55:40 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 01:55:40 INFO - Downloading functools32-3.2.3-2.tar.gz 01:55:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:55:40 INFO - warning: no files found matching '*.txt' 01:55:40 INFO - no previously-included directories found matching 'build' 01:55:40 INFO - no previously-included directories found matching 'dist' 01:55:40 INFO - no previously-included directories found matching '.git*' 01:55:40 INFO - Installing collected packages: jsonschema, functools32 01:55:40 INFO - Running setup.py install for functools32 01:55:40 INFO - warning: no files found matching '*.txt' 01:55:40 INFO - no previously-included directories found matching 'build' 01:55:40 INFO - no previously-included directories found matching 'dist' 01:55:40 INFO - no previously-included directories found matching '.git*' 01:55:40 INFO - Successfully installed jsonschema functools32 01:55:40 INFO - Cleaning up... 01:55:40 INFO - Return code: 0 01:55:40 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:55:40 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')]} 01:55:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:40 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')]} 01:55:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:40 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 0x10f259a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f269420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd22a4bb450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f8e00>, '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 0x10ef21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f3b20>, '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.IB9KLhQJ47/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.8PKkOIYtLy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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 01:55:40 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 01:55:40 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 01:55:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IB9KLhQJ47/Render', 01:55:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:55:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:55:40 INFO - 'HOME': '/Users/cltbld', 01:55:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:55:40 INFO - 'LOGNAME': 'cltbld', 01:55:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:40 INFO - 'MOZ_NO_REMOTE': '1', 01:55:40 INFO - 'NO_EM_RESTART': '1', 01:55:40 INFO - 'PAGER': '/bin/cat', 01:55:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:55:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:40 INFO - 'PWD': '/builds/slave/test', 01:55:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:55:40 INFO - 'SHELL': '/bin/bash', 01:55:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8PKkOIYtLy/Listeners', 01:55:40 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 01:55:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:55:40 INFO - 'USER': 'cltbld', 01:55:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:55:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:55:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:40 INFO - 'XPC_FLAGS': '0x0', 01:55:40 INFO - 'XPC_SERVICE_NAME': '0', 01:55:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:55:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:41 INFO - Downloading/unpacking flake8 01:55:41 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 01:55:41 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 01:55:41 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 01:55:41 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 01:55:41 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 01:55:41 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 01:55:43 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:55:43 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:55:43 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 01:55:43 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 01:55:43 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 01:55:43 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 01:55:43 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 01:55:43 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 01:55:43 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:55:43 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:55:43 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 01:55:43 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 01:55:43 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 01:55:43 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 01:55:43 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 01:55:43 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 01:55:44 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:55:44 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 01:55:44 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 01:55:44 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 01:55:44 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 01:55:44 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 01:55:44 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 01:55:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:55:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:55:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:55:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:55:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:55:44 INFO - no previously-included directories found matching 'docs/_build' 01:55:44 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:55:44 INFO - Running setup.py install for pep8 01:55:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:55:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:55:44 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:55:44 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:55:44 INFO - no previously-included directories found matching 'docs/_build' 01:55:45 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:55:45 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:55:45 INFO - Cleaning up... 01:55:45 INFO - Return code: 0 01:55:45 INFO - Running post-action listener: _resource_record_post_action 01:55:45 INFO - Running post-action listener: _start_resource_monitoring 01:55:45 INFO - Starting resource monitoring. 01:55:45 INFO - ##### 01:55:45 INFO - ##### Running install step. 01:55:45 INFO - ##### 01:55:45 INFO - Running pre-action listener: _resource_record_pre_action 01:55:45 INFO - Running main action method: install 01:55:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:55:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:55:45 INFO - Reading from file tmpfile_stdout 01:55:45 INFO - Detecting whether we're running mozinstall >=1.0... 01:55:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:55:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:55:45 INFO - Reading from file tmpfile_stdout 01:55:45 INFO - Output received: 01:55:45 INFO - Usage: mozinstall [options] installer 01:55:45 INFO - Options: 01:55:45 INFO - -h, --help show this help message and exit 01:55:45 INFO - -d DEST, --destination=DEST 01:55:45 INFO - Directory to install application into. [default: 01:55:45 INFO - "/builds/slave/test"] 01:55:45 INFO - --app=APP Application being installed. [default: firefox] 01:55:45 INFO - mkdir: /builds/slave/test/build/application 01:55:45 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'] 01:55:45 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 01:56:19 INFO - Reading from file tmpfile_stdout 01:56:19 INFO - Output received: 01:56:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:56:19 INFO - Running post-action listener: _resource_record_post_action 01:56:19 INFO - ##### 01:56:19 INFO - ##### Running run-tests step. 01:56:19 INFO - ##### 01:56:19 INFO - Running pre-action listener: _resource_record_pre_action 01:56:19 INFO - Running main action method: run_tests 01:56:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:56:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:56:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:56:19 INFO - 2016-04-20 01:56:19.155 screenresolution[1637:7356] starting screenresolution argv=screenresolution get 01:56:19 INFO - 2016-04-20 01:56:19.157 screenresolution[1637:7356] Display 0: 1600x1200x32@60 01:56:19 INFO - 2016-04-20 01:56:19.164 screenresolution[1638:7360] starting screenresolution argv=screenresolution list 01:56:19 INFO - Available Modes on Display 0 01:56:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:56:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:56:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:56:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:56:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:56:19 INFO - Intel Iris: 01:56:19 INFO - Chipset Model: Intel Iris 01:56:19 INFO - Type: GPU 01:56:19 INFO - Bus: Built-In 01:56:19 INFO - VRAM (Dynamic, Max): 1536 MB 01:56:19 INFO - Vendor: Intel (0x8086) 01:56:19 INFO - Device ID: 0x0a2e 01:56:19 INFO - Revision ID: 0x0009 01:56:19 INFO - Displays: 01:56:19 INFO - Display: 01:56:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:56:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:56:19 INFO - Display Serial Number: 1600x1200 60 01:56:19 INFO - Main Display: Yes 01:56:19 INFO - Mirror: Off 01:56:19 INFO - Online: Yes 01:56:19 INFO - Rotation: Supported 01:56:19 INFO - Return code: 0 01:56:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:56:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:56:19 INFO - Python 2.7.3 01:56:19 INFO - Return code: 0 01:56:19 INFO - grabbing minidump binary from tooltool 01:56:19 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')]} 01:56:19 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 0x10f0f8e00>, '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 0x10ef21db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f0f3b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:56:19 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 01:56:19 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 01:56:19 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:56:19 INFO - Return code: 0 01:56:19 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:56:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:56:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:56:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:56:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:56:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:56:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:56:20 INFO - Return code: 0 01:56:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0159', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:56:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0159 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:56:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.IB9KLhQJ47/Render', 01:56:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:56:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:56:20 INFO - 'HOME': '/Users/cltbld', 01:56:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:56:20 INFO - 'LOGNAME': 'cltbld', 01:56:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:56:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:56:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:20 INFO - 'MOZ_NO_REMOTE': '1', 01:56:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:56:20 INFO - 'NO_EM_RESTART': '1', 01:56:20 INFO - 'PAGER': '/bin/cat', 01:56:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:56:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:20 INFO - 'PWD': '/builds/slave/test', 01:56:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:56:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:56:20 INFO - 'SHELL': '/bin/bash', 01:56:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8PKkOIYtLy/Listeners', 01:56:20 INFO - 'TMPDIR': '/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/', 01:56:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:56:20 INFO - 'USER': 'cltbld', 01:56:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:56:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:56:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:20 INFO - 'XPC_FLAGS': '0x0', 01:56:20 INFO - 'XPC_SERVICE_NAME': '0', 01:56:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:56:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0159', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:56:20 INFO - mozversion application_buildid: 20160420005033 01:56:20 INFO - mozversion application_changeset: f71acdbd0d45ebdd0c69621dbf0f2f6ac74f9f43 01:56:20 INFO - mozversion application_display_name: Nightly 01:56:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:56:20 INFO - mozversion application_name: Firefox 01:56:20 INFO - mozversion application_remotingname: firefox 01:56:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:56:20 INFO - mozversion application_vendor: Mozilla 01:56:20 INFO - mozversion application_version: 48.0a1 01:56:20 INFO - mozversion platform_buildid: 20160420005033 01:56:20 INFO - mozversion platform_changeset: f71acdbd0d45ebdd0c69621dbf0f2f6ac74f9f43 01:56:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:56:20 INFO - mozversion platform_version: 48.0a1 01:56:20 INFO - using testdate: 1461142580 01:56:20 INFO - actual date: 1461142580 01:56:20 INFO - starting webserver on 'localhost:49271' 01:56:20 INFO - SUITE-START | Running 2 tests 01:56:20 INFO - TEST-START | dromaeo_css 01:56:20 INFO - operating with platform_type : mac_ 01:56:20 INFO - Initialising browser for dromaeo_css test... 01:56:20 INFO - TEST-INFO | started process 1656 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpJJiKyb/profile http://localhost:49271/getInfo.html) 01:56:23 INFO - PROCESS | 1656 | __metrics Screen width/height:1600/1200 01:56:23 INFO - PROCESS | 1656 | colorDepth:24 01:56:23 INFO - PROCESS | 1656 | Browser inner width/height: 1024/689 01:56:23 INFO - PROCESS | 1656 | __metrics 01:56:23 INFO - PROCESS | 1656 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 01:56:23 ERROR - PROCESS | 1656 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:56:23 INFO - TEST-INFO | 1656: exit 0 01:56:23 INFO - Browser initialized. 01:56:23 INFO - Running cycle 1/1 for dromaeo_css test... 01:56:24 INFO - TEST-INFO | started process 1658 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpJJiKyb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:56:35 INFO - PROCESS | 1658 | RSS: Main: 237424640 01:56:35 INFO - PROCESS | 1658 | 01:57:26 INFO - PROCESS | 1658 | 1461142646932 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] 01:59:38 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 01:59:39 INFO - PROCESS | 1658 | RSS: Main: 369008640 01:59:39 INFO - PROCESS | 1658 | 02:02:42 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 02:02:43 INFO - PROCESS | 1658 | RSS: Main: 378281984 02:02:43 INFO - PROCESS | 1658 | 02:05:45 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 02:05:46 INFO - PROCESS | 1658 | RSS: Main: 373628928 02:05:46 INFO - PROCESS | 1658 | 02:08:48 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 02:08:49 INFO - PROCESS | 1658 | RSS: Main: 374865920 02:08:49 INFO - PROCESS | 1658 | 02:11:52 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 02:11:52 INFO - PROCESS | 1658 | RSS: Main: 342716416 02:11:52 INFO - PROCESS | 1658 | 02:14:55 INFO - PROCESS | 1658 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 02:14:56 INFO - PROCESS | 1658 | RSS: Main: 398962688 02:14:56 INFO - PROCESS | 1658 | 02:14:56 INFO - PROCESS | 1658 | __start_tp_report 02:14:56 INFO - PROCESS | 1658 | _x_x_mozilla_page_load 02:14:56 INFO - PROCESS | 1658 | _x_x_mozilla_page_load_details 02:14:56 INFO - PROCESS | 1658 | |i|pagename|runs| 02:14:56 INFO - PROCESS | 1658 | |0;dojo.html;3410.5225268462414;3468.2716629507786;3494.4408894576873;3527.3121741260447;3531.92936141277;5586.385497595261;5660;5736.311642602888;5743.971280143599;5762.567807414445;5709.600327977043;5740.5981581289325;5755.194272801811;5758.625689330191;5762.3949485304065;5149.922751158745;5167.121589329823;5181.015607034651;5195.376554813428;5228.79084836606;5230.34620672416;5230.424653288135;5238.13570760824;5241.633085684004;5244.003639308519;5169.147090730025;5222.529972302492;5232.398274198459;5238.371395432534;5292.259083728281;4382.978085109554;5244.265802787632;5266;5271;5274.736263186864;5101.081805275049;5137.8201762938115;5156.278121063054;5177.844664660066;5201.8959620807755;4893.339399181101;5635.774569017234;5642.548596112301;5663.7168141593165;5670.659760414347;6264.59280146789;6269.780557680505;6273.05904114382;6276.152719382916;6290.811275661737;6081.422264884829;6151.815445536597;6179.289381721114;6195.163652906845;6245.843853903689;5915.497182739429;5957.374475680078;5969.194158788595;5984.521238300969;6018;6334.904976425358;6340.239171299474;6341.365863413622;6347.841303967345;6353.777617783448;6075.635461872302;6115.510759139258;6156.353582873823;6182.783602573978;6189.442950134509;6206.007038873759;6212.4408803207025;6217.067439884054;6232.937670623326;6235.501159907197;6093.6039157454625;6150.569460137837;6154.353792851775;6155.47678447337;6174.197354343996;6142.447179753844;6154.907676384858;6180.289266734383;6184.134221208944;6185.690715464209;4921.966387058686;4944.1100601892;4949.752512374367;4954.058728841508;4996.800127994839;4434.800433980478;4443.022535042285;4471.128130014616;4488.685791994594;4519.412476378116;5734.111212761945;5749.8562535936935;5765.798197063083;5770.047942089508;5784.1902133701315;6199.318075011745;6242.438180563771;6265.749370025239;6339.873202535923;6348.492120630339;5701.71491425427;5752.395998420189;5765.4811067004175;5773.913391299134;5794.246747922743;5441.7279136043835;5443.809466668727;5444.292242008592;5447.972760136174;5465.617406781487;6204.565680402328;6377.521685873671;6392.680365981775;6435.967820160869;6442.581232219891;6304.5586808922935;6312.305646378986;6323.588966717149;6332.335104813928;6340.809775706552;6422.100905873088;6425.967870160806;6433.935660643334;6440.227172739301;6447.9355206447335;6100.520618786844;6163.96918015407;6281.057841323838;6284.622922624657;6292.18201633803;5071.670341427795;6269.404406581368;6294.874102518015;6306.779262725782;6334.809955701337;5979.073243647242;6169.876602467836;6174.567780255518;6190.226221722285;6200.193974783249;5103.489651034867;6122.326544080059;6193.752249909953;6201.782937597162;6201.96899015502;4979.601631869514;6022.789202377896;6050;6066.1204125402455;6089.54328425361;6043.033114701627;6131.682521312785;6192.473639740672;6199.1011303361665;6208.720607572761;5674.06377947634;5873.970630146822;5931.495822855106;5967.492763115184;5975.043992961106 02:14:56 INFO - PROCESS | 1658 | |1;ext.html;500.55200595467056;520.4457253025529;524.3445692883895;530.3635637235317;588.0326862311495;26412.603810942852;30570.38859222814;30592.69407305929;30598.847005764997;30647.54028689566;30768;31507.684923150762;31550.526742098886;39162.60837391625;40494.392584111265;9246.537673116334;9480.952595237015;9489.667861624845;9491.477968711719;9513.096255855682;9276.11876871696;9427.434353938752;9429.151376376125;9429.481378524179;9435.811283774321;8511.063782983867;8785.077566855483;8792.07683193265;8804.955975220115;9406.905930940671;8486.957565212166;11289.379084150409;11626.651200463915;11654.650360489199;11680.883191168065;11174.329540227613;11328.773424531464;11334.943325283402;11334.979851813294;11357.43212839363;31716.365672686647;38207.61792382068;38781.80609096937;38782.612173878464;38812;3145.764067694909;3228.7739858209934;3423.0415483664615;3673.8897833065053;3861.937967059081;27367.315817104532;27473;27981.300467488272;28206.576901346496;29078.854605727047;2665.9600105998425;2699.649045624076;2720.5239083160563;2840.4177143685497;2910.3742695320607;424516;425884;426084.8695756532;426156;427588;54470.63823404447;56624;56877;57041.42958570444;57159.428405716244;58350.7082464585;65143.69712605816;67651.32348676548;68241.3175868235;68314.9752753709;15971.281292341873;16041.839581604034;16202.837971620369;16224.513264602081;16257.430989915296;10944.671659850217;12279.956203722784;12529.310887901252;12626.989840812714;12644.367781610883;15159;17715.114244287735;17736.645267094587;17761.111944402986;17863.821361786217;5318.202269659505;5521.254630624814;6449.129367535416;6520.543561950618;6527.249366322839;1033.9092257668233;1052.2003277508995;1061.6145929561842;1081.1296905990596;1118.7762447510531;28588.571171432446;28658.85670571634;29618.555721664194;29640.258993525335;29888.55167172494;1120.551779288275;1125.294755589155;1149.6665966869682;1181.3266438130356;1218.7014181525406;15375.615609609626;15551.766723499157;15614.141222232885;15675.529734107995;16040;599521;609019;610836;610838;611630;59894;62552;62553.68723156355;62562.68718656377;62578;1315.8881495073026;1355.7085226676115;1476.8670819626286;1490.880729541634;1495.962600935007;26280.60579091277;29088.691008905073;30810.537841932837;31021.844890775403;31600.36799263956;52603;52725.47274527359;53652.463475366305;53817.192742109684;53899;395899;420843;554664;570991;571887.2811271833;41964.58035419607;42730.359044614976;43242;43277.56722432735;43370.78314608407;45798.77100614476;46094.30858537192;47994.520054799;48421.757891211724;49508.75245623749;37643.43534846925;39177.8041109804;39373.24387292862;39888.40167397433;40096.79951600223;37371.81314093412;37977;38308.425373619975;39132.80433597928;39173.41239881461;38262;39068;39552.604473956046;39585.60414395819;39622;33294.33411331808;33917.321653567284;34312;34788.65211347854;34876.9536913893;24832.255032349058;25169.37076573027;25207.96672532386;25429;25650.61524077178 02:14:56 INFO - PROCESS | 1658 | |2;jquery.html;390.17478033958184;391.58491998481605;392.3349921882411;393.9901502462438;403.0407629840978;19519.804801951977;19859.702104468426;20460;20513.38459846203;20631;16019.919900400511;19098.236070557163;19922.103505342257;20815.27146549871;20838.79161208391;5354.973225133869;5489.258950041753;5560.110382338827;5561.304836895388;5570.582206334521;5258.658187217838;5460.126379779236;5491.560675145979;5495.890082198353;5502.944970550303;5421.756020979065;5462.371827239858;5481.698506582136;5482.725863706819;5495.6153069285165;5336.252924590541;5488.56091512678;5525.696086715229;5526.972365138189;5532.3637781655225;5170.224466330043;5344.14493681013;5375.11310633745;5378.327709036371;5380.24676545284;23413.648795268084;25004.624930626054;25274.49451010988;25342.986280548757;25679.871600642065;2223.144089525528;2246.5169988452562;2253.808426283768;2266.9546609067725;2396.748341424143;8363.006113337646;9690.030996900325;9930.155936745385;10259.640912568024;10276.691699249035;1721.5954250751063;1756.3764863473411;1772.7961284452324;1850.9537261568435;1852.0832188066859;101356.98643013622;109361;114413.4279328598;115122;117605;11558.364289964133;11579.826302605468;11623.825642615368;11638.53445862156;11836.349000805038;15110.848891510945;15157.014794038572;15194.544163675107;15204;15220.401857804993;8382;8601.440906341068;8606.182412670787;8758.47449153053;8761.34289928258;8400.285975692135;8418.452800567944;8434.662613495391;8568.271696905707;8569.228769410784;4518.141553104965;4617.861464156081;4639.141758774637;4685.320628508847;4699.577038066591;1771.3446024970842;1793.6172903150564;1888.5184278009294;1971.6746736788268;1994.7706013808308;828.7348048624382;902.9729108126767;910.913463220993;933.8879334479906;982.7911668647461;18322.541936451697;19823.20707171697;19977.900110499355;20069.79930200679;20218.79781202169;927.0636656976368;937.6202637931649;971.159946646146;977.9804403911882;981.2885657897967;8783.385163038654;10182.949085254526;10670.679879603624;10800.837987430195;10909;548569;554917;556009;590312;596625;119567;122279;123262;130243;132681.67318326887;995.5520015992832;1008.8789345278614;1032.9431881246453;1034.1984961654778;1039.4906495817147;14217.360218789972;18046;18148.72776908374;18280.542986424913;18372.17325220395;47576.57270281897;48675.5132448671;48840;49029.2645610309;49117.75441122772;69018.27454313482;70882.64558677173;71137.64431177812;71226.64386678033;73599.26400736139;7923.366130709414;8107.513549187068;8166.632501537564;8220.424570280262;8324.791880203044;11179.496922638338;11915.940420297842;12288.938555307166;12549.121561490609;12621.936890315857;10389.428581427792;10442.530086146293;10784.730381740519;10963.232573719763;10970.451477426257;10607.151427885596;10611.787764244518;10635.787284254426;10787.6224332148;10797.838032429678;10275.794484110425;10848.67453976382;10860.076893464144;11039.006489415991;11054.115670746482;6971.024056632177;7349.889751653623;7431.554106753612;8054.23484768946;8444.197801208875;8130.796730081795;9663.178629816262;10443;10929.781404372026;11102.44487775592 02:14:56 INFO - PROCESS | 1658 | |3;mootools.html;1407.542548671682;1599.4561848971348;1627.3978627907672;1870.7755069391676;1984.265821645992;7953.72161974331;8664.696735614254;8877.467351958887;8879.467231966086;8912.816359991812;8507.872381914276;8706.738797836058;8725.38922275441;8727.738167854974;8730;2149.054416056938;2216.8891555422247;2222.7221597300336;2389.7012873390827;2424.260600516842;2050.456628993318;2227.8217742580637;2475.232677869866;2480.7643273889043;2481.007596961212;2399.7600239976036;2418.443757935676;2431.57447446697;2438.2319569335605;2439.134107391877;2119.8834064126468;2391.7249516305587;2400.615901455759;2405.0379848060743;2406.38637147528;2351.729551101628;2427.9028838846425;2435.062500937152;2435.1233555919853;2440.2923152285994;8622.180892815173;8695.173958473935;8709.390342676015;8713.825723485557;8718.607662655195;5090.287359769635;5251.86870328241;5255.894882102337;5264.684118952875;5300.867478313035;3330.550375699274;3422.349753546818;3527.5943266524164;3548.6628770267043;3551.8401671924566;1011.1001208924064;1031.6131450705984;1031.8555402243692;1039.9896001039967;1041.198277326462;11834.05327573792;11838;11859.822102668468;11870.287782733063;11870.940645296718;4582.77086145698;4592.173408786451;4783;4831.178699621073;4837.443693975168;9935.950320248352;10000;10002.49987500622;10019.348742331726;10071.597136114473;5235.685858848481;5263.736813159403;5374.48942350476;5375.543078838343;5388;4147.398627199039;4831.975840120777;4859.173940430135;4911.484294149134;4912;3917.3144699678014;3954.3277642800795;4011.679065674739;4037.37420699792;4086.6322031016757;1328.9867101329057;1330.8602596727399;1334.292824802856;1338.237204793278;1352;723.05641138315;768.2049079202998;878.4553576782308;894.3962825093037;932.8041111366689;5577.386487486373;5801.796937107181;5901.645901245939;6020.337762846083;6097.993831017921;934.1359242700474;937.128470522407;955.2071780422233;964.8311545479513;969.2875736333789;3724.404095344732;3817.7973938209375;3826.521684789401;3915.197384536163;3996.900077498086;9575.952120239353;10444.060034596923;10509.054185123376;10638.627648032436;10655.57377704883;10502.579896804195;10780.892191077988;10789.730256743644;10821.783564328827;10903.890961090447;6676.732930682815;7650.234976502416;8125.634346454423;8138.389620778347;8287.212714792086;5731.914021289767;5850.414958504116;5956.731947062306;5980.5215582754145;6089.33017368098;9435.339526233098;9685.031496850259;9775.413475191512;9830.606775728891;9893.65372211969;9206;9611.711648650551;9784.51077446139;9968.750781230527;10025.548850301608;7282.271772822675;7489.737859174903;7550.395968322631;7557.244275572399;7560.810979725551;8133.918660813316;8291.95854020726;8341.541215233221;8359.874601880854;8375.539345336065;7200.71197152108;7267.854642907218;7313.976043354041;7321.926780732338;7461.4403919705155;6066.908996364969;7133.928660713326;7275.381592564479;7299.635018249172;7389.113306403051;6764.323567643196;6781.593104413553;6849.691763870538;6889.311068893071;6913.343232392915;4409.735415875058;4604.976975115103;4804.8318308859025;4857.587105096107;4896.877578060577;3765.8870233893026;4804.5195480451675;4878.463369029333;4932.383452068491;5062.848114556569 02:14:56 INFO - PROCESS | 1658 | |4;prototype.html;286.5000573998372;313.02804791123566;322.517835835426;325.1837886903871;325.56374458225974;5090.338256026716;5637.238972738679;5760.654360738358;5836.241288632477;6011.75952961881;4753.738544380058;5548.805791797277;5738.139279108125;5758.157389635318;5768.144768339667;4120.114175452277;4260.616544510994;4341.218580655473;4349.238883195444;4383.627391671712;3813.31360355136;4419.889502762425;4431.822727090913;4435.512093669694;4479.499367711805;4162.209180255757;4298.292075992121;4405.185040767468;4419.668524860632;4427.977860110695;4168.478940132483;4357.847475338363;4398.560143985608;4423.336499525081;4430.468343798765;3437.5015622734563;3821.2804238092967;3825.9426108608395;3834.9837293117066;3848.6536211741077;4688.765561721901;5373.2208829719475;5599.580031497654;5640.971795140998;5694.601377903548;5107.4892510749;5111.642185047048;5158.3552055993005;5162.045021671003;5170;5244.632875698664;5556.361018482886;6177.845553861144;6259.780907668255;6261.217347831521;4056.7363121397016;4312.094460163369;4329;4340.153670034345;4364.629006534448;5824.271966004249;6524.739010439576;6578.3421657834315;6595.307492713292;6632.568883022636;4376.496702879146;4389.517153113155;4392.956070439319;4397.472303323558;4424.345392764316;4298.978505107517;4433.246348120762;4491.505934347219;4501.662375321864;4502.414686090788;4490.977545112253;4705.011947491065;4876.21980483121;5024.42219144803;5155.896882062413;6168.599041062316;6308.873822523524;6325.63998740273;6344.968275158594;6401.935980640134;1452.259347732643;1493.7759336099673;1509.4037855047195;1526.4123312524757;1544.9304781284868;1007.6019972110975;1019;1023.9692809215735;1027.912627426677;1041.4376236832177;5538.6399884007415;5831.825045248649;5838.38696936824;5870.884531938918;5883.558733095035;5397.217403476474;6443.5167362448;6466.870662586816;6485.837854053686;6487.318831522716;5117.923231151536;5401.594880383908;5806.68063256525;5820.388859169726;5832.154337621106;3034.544818277276;3405.5402520659395;3410.2838403934957;3413.658634136616;3428.6914177724125;6166.859131060768;6461.224653041665;6668.966655166693;6699.095622091053;6892.448604111659;6736.2590115087305;6764.289749576224;6785.898211526831;6789.660516974231;6802.8299292517095;6648.635455736447;6775.356341147583;6775.646055202509;6872.209695884937;6921.930780692129;5472.288602481811;6549.8690026200165;6573.441257493167;6597.835054123685;6617;5366.597505187205;6459.289478157305;6469.353064693493;6473.255575608865;6477.935220647733;5590.825926555469;5949.7620095197435;6134.9079763804475;6159.489091217963;6799.898001529882;4032.475778148822;4169.291220492463;4213.262679031096;4225;4240.194363071007;5774.372660439406;5994.130851026664;6119.938800611937;6272.2159730033745;6572.769953051811;5602.607817452739;6261.36840632423;6263.6241825490615;6297.275813281532;6316.399942005502;5510.972445137749;6290.591111577733;6293.433590976834;6307;6317.546964198168;6008.8798224036145;6167.198264225622;6174.6912654368;6184.350643182581;6202.255729312511;6198.318184999556;6264.780732674334;6275.215598050244;6283.2460104787715;6301.936980630135;4965.950340496694;5774.105013722879;6149.262088549223;6196.380361963767;6200.193974783249 02:14:56 INFO - PROCESS | 1658 | |5;yui.html;661.3849120318104;714.2999860137065;740.4335683202352;744.6909532543995;757.4167890724146;14595.854041459583;15017.549473515784;16807.495775126736;17569.385071522498;17586.82413175868;13891.235982020984;13914.165150091001;13994.860051399482;13996.930015349935;14004.929975350109;731.9341259286663;905.5653286422505;945.7493764152505;946.7917058247175;948.1087777489173;723.9710411583557;912.1243606138115;951.7620594851287;954.3224310739349;955.2358113509199;977.6431602465085;982.4694664880956;990.5740531571421;994.060612720979;999.3354419311149;761.8895260187242;976.24828881761;983.1888691829233;984.6061575369838;985.5466485416753;580.3760956971273;581.8254523642933;582.5543459253674;714.0931017607661;734.2877408913346;15194.620134496616;15217.086974781438;15245.542633721006;15251.923740381228;15253.6186595336;12776.808347874789;12854.22874627516;12906.741865162645;12951.417186226643;13279.46882124714;9387.155156035922;9689.612415503372;9871.703848884545;10108.241881858816;10710.946445267724;3511.6839484446523;3611.133328001287;3646.690031347312;3728.6457786510236;3757.7933213673236;87896;88127.55936220342;88551.55724221337;89362;93679.53160234223;9675.758106047264;9719.708408747749;9961.800763984824;9965.302428830057;10047.397156170653;23586.646200306666;23634.7636523636;23647.7635223649;23651.817409129475;23669.171578994654;7295.197528271886;7485.962570187115;7509.699612015567;7536.208698086732;7645.961770191114;3984.4820173377857;4050.9797451012555;4053.43251944728;4055.9797201013807;4059.9797001014804;3503.5445392098864;3606.4590311452966;3612.512310838003;3613.1689711366535;3617.149969757105;624.3537938233906;648.3581254558048;653.8398092467376;654.6628486329544;707.5966698981531;476.72826488900995;567.1153001317957;603.8165196215467;604.3593790581997;604.9455549000523;7652.234776522415;7919.604019798987;8040.477368970998;8065.798355041054;8159.428839981263;525.9263703081572;556.7077829931276;576.6477610004532;599.7271241585069;604.3412680178626;3581.1226249568504;3740.6446387593137;3742.607026262258;3835.6356146166067;3847.8076096195077;88365;89983.65024524638;90097.64853527202;90350.54824725834;90657;76197.23802761901;76468;76794.23205767982;76959.61520192363;78216.43567128625;68602.65698671475;68625.65687171533;69122.65438672775;69122.65438672775;69245.30754692388;7334.743283985035;7399.149097853816;7403.185649578434;7649.208039065812;7822.295993360397;35448.645513544536;36755.89732308035;36886.26227475489;38036.42945355877;40058;40917.59082409138;45282.73586320605;53751.46248537464;55271;55948.440515594324;10834.458277086273;11015.449227538431;11092.279001864854;11143.16426268017;11165.665030049111;11625.825612615987;11875.406229688653;12041.45813438415;12052.819207711716;12074.698132546406;11174.888251117385;11259.662210133709;11310.434478275889;11466.426678665866;11720.648380548597;8870.824711794316;11095.808976518187;11216.45492559944;11558.711032224262;12092.164801143017;11124.332540047622;11159.27464714791;11201.047910927662;11245;11480.770384592095;9215.354925155174;9277;9363.4381937084;9555.378900371454;9595.23238140961;9239.953800230956;9518.476483793458;9609.951950240204;9621.134097931219;9733.513324333897 02:14:56 INFO - PROCESS | 1658 | __end_tp_report 02:14:56 INFO - PROCESS | 1658 | __start_cc_report 02:14:56 INFO - PROCESS | 1658 | _x_x_mozilla_cycle_collect,1327 02:14:56 INFO - PROCESS | 1658 | __end_cc_report 02:14:56 INFO - PROCESS | 1658 | __startTimestamp1461143696026__endTimestamp 02:14:56 INFO - PROCESS | 1658 | 02:14:56 INFO - PROCESS | 1658 | ------- Summary: start ------- 02:14:56 INFO - PROCESS | 1658 | Number of tests: 6 02:14:56 INFO - PROCESS | 1658 | 02:14:56 INFO - PROCESS | 1658 | [#0] dojo.html Cycles:165 Average:5752.45 Median:5984.52 stddev:649.07 (10.8%) stddev-sans-first:624.52 02:14:56 INFO - PROCESS | 1658 | Values: 3410.5 3468.3 3494.4 3527.3 3531.9 5586.4 5660.0 5736.3 5744.0 5762.6 5709.6 5740.6 5755.2 5758.6 5762.4 5149.9 5167.1 5181.0 5195.4 5228.8 5230.3 5230.4 5238.1 5241.6 5244.0 5169.1 5222.5 5232.4 5238.4 5292.3 4383.0 5244.3 5266.0 5271.0 5274.7 5101.1 5137.8 5156.3 5177.8 5201.9 4893.3 5635.8 5642.5 5663.7 5670.7 6264.6 6269.8 6273.1 6276.2 6290.8 6081.4 6151.8 6179.3 6195.2 6245.8 5915.5 5957.4 5969.2 5984.5 6018.0 6334.9 6340.2 6341.4 6347.8 6353.8 6075.6 6115.5 6156.4 6182.8 6189.4 6206.0 6212.4 6217.1 6232.9 6235.5 6093.6 6150.6 6154.4 6155.5 6174.2 6142.4 6154.9 6180.3 6184.1 6185.7 4922.0 4944.1 4949.8 4954.1 4996.8 4434.8 4443.0 4471.1 4488.7 4519.4 5734.1 5749.9 5765.8 5770.0 5784.2 6199.3 6242.4 6265.7 6339.9 6348.5 5701.7 5752.4 5765.5 5773.9 5794.2 5441.7 5443.8 5444.3 5448.0 5465.6 6204.6 6377.5 6392.7 6436.0 6442.6 6304.6 6312.3 6323.6 6332.3 6340.8 6422.1 6426.0 6433.9 6440.2 6447.9 6100.5 6164.0 6281.1 6284.6 6292.2 5071.7 6269.4 6294.9 6306.8 6334.8 5979.1 6169.9 6174.6 6190.2 6200.2 5103.5 6122.3 6193.8 6201.8 6202.0 4979.6 6022.8 6050.0 6066.1 6089.5 6043.0 6131.7 6192.5 6199.1 6208.7 5674.1 5874.0 5931.5 5967.5 5975.0 02:14:56 INFO - PROCESS | 1658 | 02:14:56 INFO - PROCESS | 1658 | [#1] ext.html Cycles:180 Average:65497.49 Median:38234.81 stddev:138663.56 (362.7%) stddev-sans-first:138966.67 02:14:56 INFO - PROCESS | 1658 | Values: 500.6 520.4 524.3 530.4 588.0 26412.6 30570.4 30592.7 30598.8 30647.5 30768.0 31507.7 31550.5 39162.6 40494.4 9246.5 9481.0 9489.7 9491.5 9513.1 9276.1 9427.4 9429.2 9429.5 9435.8 8511.1 8785.1 8792.1 8805.0 9406.9 8487.0 11289.4 11626.7 11654.7 11680.9 11174.3 11328.8 11334.9 11335.0 11357.4 31716.4 38207.6 38781.8 38782.6 38812.0 3145.8 3228.8 3423.0 3673.9 3861.9 27367.3 27473.0 27981.3 28206.6 29078.9 2666.0 2699.6 2720.5 2840.4 2910.4 424516.0 425884.0 426084.9 426156.0 427588.0 54470.6 56624.0 56877.0 57041.4 57159.4 58350.7 65143.7 67651.3 68241.3 68315.0 15971.3 16041.8 16202.8 16224.5 16257.4 10944.7 12280.0 12529.3 12627.0 12644.4 15159.0 17715.1 17736.6 17761.1 17863.8 5318.2 5521.3 6449.1 6520.5 6527.2 1033.9 1052.2 1061.6 1081.1 1118.8 28588.6 28658.9 29618.6 29640.3 29888.6 1120.6 1125.3 1149.7 1181.3 1218.7 15375.6 15551.8 15614.1 15675.5 16040.0 599521.0 609019.0 610836.0 610838.0 611630.0 59894.0 62552.0 62553.7 62562.7 62578.0 1315.9 1355.7 1476.9 1490.9 1496.0 26280.6 29088.7 30810.5 31021.8 31600.4 52603.0 52725.5 53652.5 53817.2 53899.0 395899.0 420843.0 554664.0 570991.0 571887.3 41964.6 42730.4 43242.0 43277.6 43370.8 45798.8 46094.3 47994.5 48421.8 49508.8 37643.4 39177.8 39373.2 39888.4 40096.8 37371.8 37977.0 38308.4 39132.8 39173.4 38262.0 39068.0 39552.6 39585.6 39622.0 33294.3 33917.3 34312.0 34788.7 34877.0 24832.3 25169.4 25208.0 25429.0 25650.6 02:14:56 INFO - PROCESS | 1658 | 02:14:56 INFO - PROCESS | 1658 | [#2] jquery.html Cycles:180 Average:33417.66 Median:25308.74 stddev:95092.22 (375.7%) stddev-sans-first:95326.64 02:14:56 INFO - PROCESS | 1658 | Values: 390.2 391.6 392.3 394.0 403.0 19519.8 19859.7 20460.0 20513.4 20631.0 16019.9 19098.2 19922.1 20815.3 20838.8 5355.0 5489.3 5560.1 5561.3 5570.6 5258.7 5460.1 5491.6 5495.9 5502.9 5421.8 5462.4 5481.7 5482.7 5495.6 5336.3 5488.6 5525.7 5527.0 5532.4 5170.2 5344.1 5375.1 5378.3 5380.2 23413.6 25004.6 25274.5 25343.0 25679.9 2223.1 2246.5 2253.8 2267.0 2396.7 8363.0 9690.0 9930.2 10259.6 10276.7 1721.6 1756.4 1772.8 1851.0 1852.1 101357.0 109361.0 114413.4 115122.0 117605.0 11558.4 11579.8 11623.8 11638.5 11836.3 15110.8 15157.0 15194.5 15204.0 15220.4 8382.0 8601.4 8606.2 8758.5 8761.3 8400.3 8418.5 8434.7 8568.3 8569.2 4518.1 4617.9 4639.1 4685.3 4699.6 1771.3 1793.6 1888.5 1971.7 1994.8 828.7 903.0 910.9 933.9 982.8 18322.5 19823.2 19977.9 20069.8 20218.8 927.1 937.6 971.2 978.0 981.3 8783.4 10182.9 10670.7 10800.8 10909.0 548569.0 554917.0 556009.0 590312.0 596625.0 119567.0 122279.0 123262.0 130243.0 132681.7 995.6 1008.9 1032.9 1034.2 1039.5 14217.4 18046.0 18148.7 18280.5 18372.2 47576.6 48675.5 48840.0 49029.3 49117.8 69018.3 70882.6 71137.6 71226.6 73599.3 7923.4 8107.5 8166.6 8220.4 8324.8 11179.5 11915.9 12288.9 12549.1 12621.9 10389.4 10442.5 10784.7 10963.2 10970.5 10607.2 10611.8 10635.8 10787.6 10797.8 10275.8 10848.7 10860.1 11039.0 11054.1 6971.0 7349.9 7431.6 8054.2 8444.2 8130.8 9663.2 10443.0 10929.8 11102.4 02:14:56 INFO - PROCESS | 1658 | 02:14:56 INFO - PROCESS | 1658 | [#3] mootools.html Cycles:180 Average:5650.93 Median:4911.74 stddev:3164.19 (64.4%) stddev-sans-first:3157.00 02:14:56 INFO - PROCESS | 1658 | Values: 1407.5 1599.5 1627.4 1870.8 1984.3 7953.7 8664.7 8877.5 8879.5 8912.8 8507.9 8706.7 8725.4 8727.7 8730.0 2149.1 2216.9 2222.7 2389.7 2424.3 2050.5 2227.8 2475.2 2480.8 2481.0 2399.8 2418.4 2431.6 2438.2 2439.1 2119.9 2391.7 2400.6 2405.0 2406.4 2351.7 2427.9 2435.1 2435.1 2440.3 8622.2 8695.2 8709.4 8713.8 8718.6 5090.3 5251.9 5255.9 5264.7 5300.9 3330.6 3422.3 3527.6 3548.7 3551.8 1011.1 1031.6 1031.9 1040.0 1041.2 11834.1 11838.0 11859.8 11870.3 11870.9 4582.8 4592.2 4783.0 4831.2 4837.4 9936.0 10000.0 10002.5 10019.3 10071.6 5235.7 5263.7 5374.5 5375.5 5388.0 4147.4 4832.0 4859.2 4911.5 4912.0 3917.3 3954.3 4011.7 4037.4 4086.6 1329.0 1330.9 1334.3 1338.2 1352.0 723.1 768.2 878.5 894.4 932.8 5577.4 5801.8 5901.6 6020.3 6098.0 934.1 937.1 955.2 964.8 969.3 3724.4 3817.8 3826.5 3915.2 3996.9 9576.0 10444.1 10509.1 10638.6 10655.6 10502.6 10780.9 10789.7 10821.8 10903.9 6676.7 7650.2 8125.6 8138.4 8287.2 5731.9 5850.4 5956.7 5980.5 6089.3 9435.3 9685.0 9775.4 9830.6 9893.7 9206.0 9611.7 9784.5 9968.8 10025.5 7282.3 7489.7 7550.4 7557.2 7560.8 8133.9 8292.0 8341.5 8359.9 8375.5 7200.7 7267.9 7314.0 7321.9 7461.4 6066.9 7133.9 7275.4 7299.6 7389.1 6764.3 6781.6 6849.7 6889.3 6913.3 4409.7 4605.0 4804.8 4857.6 4896.9 3765.9 4804.5 4878.5 4932.4 5062.8 02:14:56 INFO - PROCESS | 1658 | 02:14:56 INFO - PROCESS | 1658 | [#4] prototype.html Cycles:180 Average:5083.24 Median:5595.20 stddev:1578.43 (28.2%) stddev-sans-first:1541.25 02:14:56 INFO - PROCESS | 1658 | Values: 286.5 313.0 322.5 325.2 325.6 5090.3 5637.2 5760.7 5836.2 6011.8 4753.7 5548.8 5738.1 5758.2 5768.1 4120.1 4260.6 4341.2 4349.2 4383.6 3813.3 4419.9 4431.8 4435.5 4479.5 4162.2 4298.3 4405.2 4419.7 4428.0 4168.5 4357.8 4398.6 4423.3 4430.5 3437.5 3821.3 3825.9 3835.0 3848.7 4688.8 5373.2 5599.6 5641.0 5694.6 5107.5 5111.6 5158.4 5162.0 5170.0 5244.6 5556.4 6177.8 6259.8 6261.2 4056.7 4312.1 4329.0 4340.2 4364.6 5824.3 6524.7 6578.3 6595.3 6632.6 4376.5 4389.5 4393.0 4397.5 4424.3 4299.0 4433.2 4491.5 4501.7 4502.4 4491.0 4705.0 4876.2 5024.4 5155.9 6168.6 6308.9 6325.6 6345.0 6401.9 1452.3 1493.8 1509.4 1526.4 1544.9 1007.6 1019.0 1024.0 1027.9 1041.4 5538.6 5831.8 5838.4 5870.9 5883.6 5397.2 6443.5 6466.9 6485.8 6487.3 5117.9 5401.6 5806.7 5820.4 5832.2 3034.5 3405.5 3410.3 3413.7 3428.7 6166.9 6461.2 6669.0 6699.1 6892.4 6736.3 6764.3 6785.9 6789.7 6802.8 6648.6 6775.4 6775.6 6872.2 6921.9 5472.3 6549.9 6573.4 6597.8 6617.0 5366.6 6459.3 6469.4 6473.3 6477.9 5590.8 5949.8 6134.9 6159.5 6799.9 4032.5 4169.3 4213.3 4225.0 4240.2 5774.4 5994.1 6119.9 6272.2 6572.8 5602.6 6261.4 6263.6 6297.3 6316.4 5511.0 6290.6 6293.4 6307.0 6317.5 6008.9 6167.2 6174.7 6184.4 6202.3 6198.3 6264.8 6275.2 6283.2 6301.9 4966.0 5774.1 6149.3 6196.4 6200.2 02:14:56 INFO - PROCESS | 1658 | 02:14:56 INFO - PROCESS | 1658 | [#5] yui.html Cycles:180 Average:17647.55 Median:601.77 stddev:24903.09 (4138.3%) stddev-sans-first:24940.28 02:14:56 INFO - PROCESS | 1658 | Values: 661.4 714.3 740.4 744.7 757.4 14595.9 15017.5 16807.5 17569.4 17586.8 13891.2 13914.2 13994.9 13996.9 14004.9 731.9 905.6 945.7 946.8 948.1 724.0 912.1 951.8 954.3 955.2 977.6 982.5 990.6 994.1 999.3 761.9 976.2 983.2 984.6 985.5 580.4 581.8 582.6 714.1 734.3 15194.6 15217.1 15245.5 15251.9 15253.6 12776.8 12854.2 12906.7 12951.4 13279.5 9387.2 9689.6 9871.7 10108.2 10710.9 3511.7 3611.1 3646.7 3728.6 3757.8 87896.0 88127.6 88551.6 89362.0 93679.5 9675.8 9719.7 9961.8 9965.3 10047.4 23586.6 23634.8 23647.8 23651.8 23669.2 7295.2 7486.0 7509.7 7536.2 7646.0 3984.5 4051.0 4053.4 4056.0 4060.0 3503.5 3606.5 3612.5 3613.2 3617.1 624.4 648.4 653.8 654.7 707.6 476.7 567.1 603.8 604.4 604.9 7652.2 7919.6 8040.5 8065.8 8159.4 525.9 556.7 576.6 599.7 604.3 3581.1 3740.6 3742.6 3835.6 3847.8 88365.0 89983.7 90097.6 90350.5 90657.0 76197.2 76468.0 76794.2 76959.6 78216.4 68602.7 68625.7 69122.7 69122.7 69245.3 7334.7 7399.1 7403.2 7649.2 7822.3 35448.6 36755.9 36886.3 38036.4 40058.0 40917.6 45282.7 53751.5 55271.0 55948.4 10834.5 11015.4 11092.3 11143.2 11165.7 11625.8 11875.4 12041.5 12052.8 12074.7 11174.9 11259.7 11310.4 11466.4 11720.6 8870.8 11095.8 11216.5 11558.7 12092.2 11124.3 11159.3 11201.0 11245.0 11480.8 9215.4 9277.0 9363.4 9555.4 9595.2 9240.0 9518.5 9610.0 9621.1 9733.5 02:14:56 INFO - PROCESS | 1658 | -------- Summary: end -------- 02:14:56 INFO - PROCESS | 1658 | 02:14:56 INFO - TEST-INFO | 1658: exit 0 02:14:56 INFO - TEST-OK | dromaeo_css | took 1115723ms 02:14:56 INFO - TEST-START | kraken 02:14:56 INFO - operating with platform_type : mac_ 02:14:56 INFO - Initialising browser for kraken test... 02:14:56 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpMR3FXh/profile http://localhost:49271/getInfo.html) 02:14:58 INFO - PROCESS | 1667 | __metrics Screen width/height:1600/1200 02:14:58 INFO - PROCESS | 1667 | colorDepth:24 02:14:58 INFO - PROCESS | 1667 | Browser inner width/height: 1024/689 02:14:58 INFO - PROCESS | 1667 | __metrics 02:14:58 INFO - PROCESS | 1667 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 02:14:58 ERROR - PROCESS | 1667 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:14:59 INFO - TEST-INFO | 1667: exit 0 02:14:59 INFO - Browser initialized. 02:14:59 INFO - Running cycle 1/1 for kraken test... 02:14:59 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/tmpMR3FXh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:15:11 INFO - PROCESS | 1669 | RSS: Main: 237707264 02:15:11 INFO - PROCESS | 1669 | 02:15:14 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 02:15:15 INFO - PROCESS | 1669 | RSS: Main: 285769728 02:15:15 INFO - PROCESS | 1669 | 02:15:17 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 02:15:18 INFO - PROCESS | 1669 | RSS: Main: 299159552 02:15:18 INFO - PROCESS | 1669 | 02:15:22 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 02:15:22 INFO - PROCESS | 1669 | RSS: Main: 385437696 02:15:22 INFO - PROCESS | 1669 | 02:15:24 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 02:15:25 INFO - PROCESS | 1669 | RSS: Main: 286449664 02:15:25 INFO - PROCESS | 1669 | 02:15:27 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:15:28 INFO - PROCESS | 1669 | RSS: Main: 290897920 02:15:28 INFO - PROCESS | 1669 | 02:15:30 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 02:15:31 INFO - PROCESS | 1669 | RSS: Main: 328650752 02:15:31 INFO - PROCESS | 1669 | 02:15:34 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 02:15:34 INFO - PROCESS | 1669 | RSS: Main: 330223616 02:15:34 INFO - PROCESS | 1669 | 02:15:37 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 02:15:38 INFO - PROCESS | 1669 | RSS: Main: 325779456 02:15:38 INFO - PROCESS | 1669 | 02:15:39 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:15:40 INFO - PROCESS | 1669 | RSS: Main: 319930368 02:15:40 INFO - PROCESS | 1669 | 02:15:42 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:15:43 INFO - PROCESS | 1669 | RSS: Main: 327372800 02:15:43 INFO - PROCESS | 1669 | 02:15:45 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:15:45 INFO - PROCESS | 1669 | RSS: Main: 330113024 02:15:45 INFO - PROCESS | 1669 | 02:15:48 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:15:49 INFO - PROCESS | 1669 | RSS: Main: 334888960 02:15:49 INFO - PROCESS | 1669 | 02:15:52 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:15:52 INFO - PROCESS | 1669 | RSS: Main: 332107776 02:15:52 INFO - PROCESS | 1669 | 02:15:54 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 02:15:54 INFO - PROCESS | 1669 | RSS: Main: 396902400 02:15:54 INFO - PROCESS | 1669 | 02:15:54 INFO - PROCESS | 1669 | __start_tp_report 02:15:54 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 02:15:54 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 02:15:54 INFO - PROCESS | 1669 | |i|pagename|runs| 02:15:54 INFO - PROCESS | 1669 | |0;ai-astar;111;109;111;111;112;113;120;113;112;111 02:15:54 INFO - PROCESS | 1669 | |1;audio-beat-detection;159;122;145;169;120;142;139;122;174;128 02:15:54 INFO - PROCESS | 1669 | |2;audio-dft;190;187;184;185;183;181;184;216;186;183 02:15:54 INFO - PROCESS | 1669 | |3;audio-fft;80;71;87;91;58;63;82;120;106;55 02:15:54 INFO - PROCESS | 1669 | |4;audio-oscillator;90;99;135;78;77;79;125;79;76;127 02:15:54 INFO - PROCESS | 1669 | |5;imaging-gaussian-blur;88;85;89;86;88;85;89;86;88;83 02:15:54 INFO - PROCESS | 1669 | |6;imaging-darkroom;94;94;93;93;92;93;94;94;93;93 02:15:54 INFO - PROCESS | 1669 | |7;imaging-desaturate;93;126;85;84;87;83;83;84;97;139 02:15:54 INFO - PROCESS | 1669 | |8;json-parse-financial;58;60;60;60;59;59;60;78;60;58 02:15:54 INFO - PROCESS | 1669 | |9;json-stringify-tinderbox;63;66;77;72;70;65;65;65;66;67 02:15:54 INFO - PROCESS | 1669 | |10;stanford-crypto-aes;82;81;83;81;83;71;79;94;104;106 02:15:54 INFO - PROCESS | 1669 | |11;stanford-crypto-ccm;139;137;139;137;161;152;149;138;169;155 02:15:54 INFO - PROCESS | 1669 | |12;stanford-crypto-pbkdf2;172;168;171;170;171;173;169;170;167;168 02:15:54 INFO - PROCESS | 1669 | |13;stanford-crypto-sha256-iterative;71;88;95;94;96;70;68;69;67;64 02:15:54 INFO - PROCESS | 1669 | __end_tp_report 02:15:54 INFO - PROCESS | 1669 | __start_cc_report 02:15:54 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1972 02:15:54 INFO - PROCESS | 1669 | __end_cc_report 02:15:54 INFO - PROCESS | 1669 | __startTimestamp1461143754940__endTimestamp 02:15:54 INFO - PROCESS | 1669 | 02:15:54 INFO - PROCESS | 1669 | ------- Summary: start ------- 02:15:54 INFO - PROCESS | 1669 | Number of tests: 14 02:15:54 INFO - PROCESS | 1669 | 02:15:54 INFO - PROCESS | 1669 | [#0] ai-astar Cycles:10 Average:112.30 Median:112.00 stddev:2.95 (2.6%) stddev-sans-first:3.09 02:15:54 INFO - PROCESS | 1669 | Values: 111.0 109.0 111.0 111.0 112.0 113.0 120.0 113.0 112.0 111.0 02:15:54 INFO - PROCESS | 1669 | 02:15:54 INFO - PROCESS | 1669 | [#1] audio-beat-detection Cycles:10 Average:142.00 Median:143.50 stddev:19.83 (13.8%) stddev-sans-first:20.06 02:15:54 INFO - PROCESS | 1669 | Values: 159.0 122.0 145.0 169.0 120.0 142.0 139.0 122.0 174.0 128.0 02:15:54 INFO - PROCESS | 1669 | 02:15:54 INFO - PROCESS | 1669 | [#2] audio-dft Cycles:10 Average:187.90 Median:185.50 stddev:10.18 (5.5%) stddev-sans-first:10.77 02:15:54 INFO - PROCESS | 1669 | Values: 190.0 187.0 184.0 185.0 183.0 181.0 184.0 216.0 186.0 183.0 02:15:54 INFO - PROCESS | 1669 | 02:15:54 INFO - PROCESS | 1669 | [#3] audio-fft Cycles:10 Average:81.30 Median:75.50 stddev:20.85 (27.6%) stddev-sans-first:22.11 02:15:54 INFO - PROCESS | 1669 | Values: 80.0 71.0 87.0 91.0 58.0 63.0 82.0 120.0 106.0 55.0 02:15:54 INFO - PROCESS | 1669 | 02:15:54 INFO - PROCESS | 1669 | [#4] audio-oscillator Cycles:10 Average:96.50 Median:78.50 stddev:23.64 (30.1%) stddev-sans-first:24.95 02:15:54 INFO - PROCESS | 1669 | Values: 90.0 99.0 135.0 78.0 77.0 79.0 125.0 79.0 76.0 127.0 02:15:54 INFO - PROCESS | 1669 | 02:15:54 INFO - PROCESS | 1669 | [#5] imaging-gaussian-blur Cycles:10 Average:86.70 Median:88.00 stddev:2.00 (2.3%) stddev-sans-first:2.07 02:15:54 INFO - PROCESS | 1669 | Values: 88.0 85.0 89.0 86.0 88.0 85.0 89.0 86.0 88.0 83.0 02:15:54 INFO - PROCESS | 1669 | 02:15:54 INFO - PROCESS | 1669 | [#6] imaging-darkroom Cycles:10 Average:93.30 Median:93.50 stddev:0.67 (0.7%) stddev-sans-first:0.67 02:15:54 INFO - PROCESS | 1669 | Values: 94.0 94.0 93.0 93.0 92.0 93.0 94.0 94.0 93.0 93.0 02:15:54 INFO - PROCESS | 1669 | 02:15:54 INFO - PROCESS | 1669 | [#7] imaging-desaturate Cycles:10 Average:96.10 Median:84.50 stddev:19.96 (23.6%) stddev-sans-first:21.14 02:15:54 INFO - PROCESS | 1669 | Values: 93.0 126.0 85.0 84.0 87.0 83.0 83.0 84.0 97.0 139.0 02:15:54 INFO - PROCESS | 1669 | 02:15:54 INFO - PROCESS | 1669 | [#8] json-parse-financial Cycles:10 Average:61.20 Median:60.00 stddev:5.96 (9.9%) stddev-sans-first:6.21 02:15:54 INFO - PROCESS | 1669 | Values: 58.0 60.0 60.0 60.0 59.0 59.0 60.0 78.0 60.0 58.0 02:15:54 INFO - PROCESS | 1669 | 02:15:54 INFO - PROCESS | 1669 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:66.50 stddev:4.22 (6.3%) stddev-sans-first:4.14 02:15:54 INFO - PROCESS | 1669 | Values: 63.0 66.0 77.0 72.0 70.0 65.0 65.0 65.0 66.0 67.0 02:15:54 INFO - PROCESS | 1669 | 02:15:54 INFO - PROCESS | 1669 | [#10] stanford-crypto-aes Cycles:10 Average:86.40 Median:81.50 stddev:11.28 (13.8%) stddev-sans-first:11.85 02:15:54 INFO - PROCESS | 1669 | Values: 82.0 81.0 83.0 81.0 83.0 71.0 79.0 94.0 104.0 106.0 02:15:54 INFO - PROCESS | 1669 | 02:15:54 INFO - PROCESS | 1669 | [#11] stanford-crypto-ccm Cycles:10 Average:147.60 Median:150.50 stddev:11.44 (7.6%) stddev-sans-first:11.71 02:15:54 INFO - PROCESS | 1669 | Values: 139.0 137.0 139.0 137.0 161.0 152.0 149.0 138.0 169.0 155.0 02:15:54 INFO - PROCESS | 1669 | 02:15:54 INFO - PROCESS | 1669 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.90 Median:170.50 stddev:1.91 (1.1%) stddev-sans-first:1.87 02:15:54 INFO - PROCESS | 1669 | Values: 172.0 168.0 171.0 170.0 171.0 173.0 169.0 170.0 167.0 168.0 02:15:54 INFO - PROCESS | 1669 | 02:15:54 INFO - PROCESS | 1669 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.20 Median:79.50 stddev:13.25 (16.7%) stddev-sans-first:13.79 02:15:54 INFO - PROCESS | 1669 | Values: 71.0 88.0 95.0 94.0 96.0 70.0 68.0 69.0 67.0 64.0 02:15:54 INFO - PROCESS | 1669 | -------- Summary: end -------- 02:15:54 INFO - PROCESS | 1669 | 02:15:55 INFO - TEST-INFO | 1669: exit 0 02:15:55 INFO - TEST-OK | kraken | took 59085ms 02:15:55 INFO - SUITE-END | took 1174s 02:15:56 INFO - Completed test suite (00:19:35) 02:15:56 INFO - javascript benchmark 02:15:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3410.5225268462414, 3468.2716629507786, 3494.4408894576873, 3527.3121741260447, 3531.92936141277, 5586.385497595261, 5660.0, 5736.311642602888, 5743.971280143599, 5762.567807414445, 5709.600327977043, 5740.5981581289325, 5755.194272801811, 5758.625689330191, 5762.3949485304065, 5149.922751158745, 5167.121589329823, 5181.015607034651, 5195.376554813428, 5228.79084836606, 5230.34620672416, 5230.424653288135, 5238.13570760824, 5241.633085684004, 5244.003639308519, 5169.147090730025, 5222.529972302492, 5232.398274198459, 5238.371395432534, 5292.259083728281, 4382.978085109554, 5244.265802787632, 5266.0, 5271.0, 5274.736263186864, 5101.081805275049, 5137.8201762938115, 5156.278121063054, 5177.844664660066, 5201.8959620807755, 4893.339399181101, 5635.774569017234, 5642.548596112301, 5663.7168141593165, 5670.659760414347, 6264.59280146789, 6269.780557680505, 6273.05904114382, 6276.152719382916, 6290.811275661737, 6081.422264884829, 6151.815445536597, 6179.289381721114, 6195.163652906845, 6245.843853903689, 5915.497182739429, 5957.374475680078, 5969.194158788595, 5984.521238300969, 6018.0, 6334.904976425358, 6340.239171299474, 6341.365863413622, 6347.841303967345, 6353.777617783448, 6075.635461872302, 6115.510759139258, 6156.353582873823, 6182.783602573978, 6189.442950134509, 6206.007038873759, 6212.4408803207025, 6217.067439884054, 6232.937670623326, 6235.501159907197, 6093.6039157454625, 6150.569460137837, 6154.353792851775, 6155.47678447337, 6174.197354343996, 6142.447179753844, 6154.907676384858, 6180.289266734383, 6184.134221208944, 6185.690715464209, 4921.966387058686, 4944.1100601892, 4949.752512374367, 4954.058728841508, 4996.800127994839, 4434.800433980478, 4443.022535042285, 4471.128130014616, 4488.685791994594, 4519.412476378116, 5734.111212761945, 5749.8562535936935, 5765.798197063083, 5770.047942089508, 5784.1902133701315, 6199.318075011745, 6242.438180563771, 6265.749370025239, 6339.873202535923, 6348.492120630339, 5701.71491425427, 5752.395998420189, 5765.4811067004175, 5773.913391299134, 5794.246747922743, 5441.7279136043835, 5443.809466668727, 5444.292242008592, 5447.972760136174, 5465.617406781487, 6204.565680402328, 6377.521685873671, 6392.680365981775, 6435.967820160869, 6442.581232219891, 6304.5586808922935, 6312.305646378986, 6323.588966717149, 6332.335104813928, 6340.809775706552, 6422.100905873088, 6425.967870160806, 6433.935660643334, 6440.227172739301, 6447.9355206447335, 6100.520618786844, 6163.96918015407, 6281.057841323838, 6284.622922624657, 6292.18201633803, 5071.670341427795, 6269.404406581368, 6294.874102518015, 6306.779262725782, 6334.809955701337, 5979.073243647242, 6169.876602467836, 6174.567780255518, 6190.226221722285, 6200.193974783249, 5103.489651034867, 6122.326544080059, 6193.752249909953, 6201.782937597162, 6201.96899015502, 4979.601631869514, 6022.789202377896, 6050.0, 6066.1204125402455, 6089.54328425361, 6043.033114701627, 6131.682521312785, 6192.473639740672, 6199.1011303361665, 6208.720607572761, 5674.06377947634, 5873.970630146822, 5931.495822855106, 5967.492763115184, 5975.043992961106], "value": 5712.707219721248, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [500.55200595467056, 520.4457253025529, 524.3445692883895, 530.3635637235317, 588.0326862311495, 26412.603810942852, 30570.38859222814, 30592.69407305929, 30598.847005764997, 30647.54028689566, 30768.0, 31507.684923150762, 31550.526742098886, 39162.60837391625, 40494.392584111265, 9246.537673116334, 9480.952595237015, 9489.667861624845, 9491.477968711719, 9513.096255855682, 9276.11876871696, 9427.434353938752, 9429.151376376125, 9429.481378524179, 9435.811283774321, 8511.063782983867, 8785.077566855483, 8792.07683193265, 8804.955975220115, 9406.905930940671, 8486.957565212166, 11289.379084150409, 11626.651200463915, 11654.650360489199, 11680.883191168065, 11174.329540227613, 11328.773424531464, 11334.943325283402, 11334.979851813294, 11357.43212839363, 31716.365672686647, 38207.61792382068, 38781.80609096937, 38782.612173878464, 38812.0, 3145.764067694909, 3228.7739858209934, 3423.0415483664615, 3673.8897833065053, 3861.937967059081, 27367.315817104532, 27473.0, 27981.300467488272, 28206.576901346496, 29078.854605727047, 2665.9600105998425, 2699.649045624076, 2720.5239083160563, 2840.4177143685497, 2910.3742695320607, 424516.0, 425884.0, 426084.8695756532, 426156.0, 427588.0, 54470.63823404447, 56624.0, 56877.0, 57041.42958570444, 57159.428405716244, 58350.7082464585, 65143.69712605816, 67651.32348676548, 68241.3175868235, 68314.9752753709, 15971.281292341873, 16041.839581604034, 16202.837971620369, 16224.513264602081, 16257.430989915296, 10944.671659850217, 12279.956203722784, 12529.310887901252, 12626.989840812714, 12644.367781610883, 15159.0, 17715.114244287735, 17736.645267094587, 17761.111944402986, 17863.821361786217, 5318.202269659505, 5521.254630624814, 6449.129367535416, 6520.543561950618, 6527.249366322839, 1033.9092257668233, 1052.2003277508995, 1061.6145929561842, 1081.1296905990596, 1118.7762447510531, 28588.571171432446, 28658.85670571634, 29618.555721664194, 29640.258993525335, 29888.55167172494, 1120.551779288275, 1125.294755589155, 1149.6665966869682, 1181.3266438130356, 1218.7014181525406, 15375.615609609626, 15551.766723499157, 15614.141222232885, 15675.529734107995, 16040.0, 599521.0, 609019.0, 610836.0, 610838.0, 611630.0, 59894.0, 62552.0, 62553.68723156355, 62562.68718656377, 62578.0, 1315.8881495073026, 1355.7085226676115, 1476.8670819626286, 1490.880729541634, 1495.962600935007, 26280.60579091277, 29088.691008905073, 30810.537841932837, 31021.844890775403, 31600.36799263956, 52603.0, 52725.47274527359, 53652.463475366305, 53817.192742109684, 53899.0, 395899.0, 420843.0, 554664.0, 570991.0, 571887.2811271833, 41964.58035419607, 42730.359044614976, 43242.0, 43277.56722432735, 43370.78314608407, 45798.77100614476, 46094.30858537192, 47994.520054799, 48421.757891211724, 49508.75245623749, 37643.43534846925, 39177.8041109804, 39373.24387292862, 39888.40167397433, 40096.79951600223, 37371.81314093412, 37977.0, 38308.425373619975, 39132.80433597928, 39173.41239881461, 38262.0, 39068.0, 39552.604473956046, 39585.60414395819, 39622.0, 33294.33411331808, 33917.321653567284, 34312.0, 34788.65211347854, 34876.9536913893, 24832.255032349058, 25169.37076573027, 25207.96672532386, 25429.0, 25650.61524077178], "value": 19761.103202112667, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.17478033958184, 391.58491998481605, 392.3349921882411, 393.9901502462438, 403.0407629840978, 19519.804801951977, 19859.702104468426, 20460.0, 20513.38459846203, 20631.0, 16019.919900400511, 19098.236070557163, 19922.103505342257, 20815.27146549871, 20838.79161208391, 5354.973225133869, 5489.258950041753, 5560.110382338827, 5561.304836895388, 5570.582206334521, 5258.658187217838, 5460.126379779236, 5491.560675145979, 5495.890082198353, 5502.944970550303, 5421.756020979065, 5462.371827239858, 5481.698506582136, 5482.725863706819, 5495.6153069285165, 5336.252924590541, 5488.56091512678, 5525.696086715229, 5526.972365138189, 5532.3637781655225, 5170.224466330043, 5344.14493681013, 5375.11310633745, 5378.327709036371, 5380.24676545284, 23413.648795268084, 25004.624930626054, 25274.49451010988, 25342.986280548757, 25679.871600642065, 2223.144089525528, 2246.5169988452562, 2253.808426283768, 2266.9546609067725, 2396.748341424143, 8363.006113337646, 9690.030996900325, 9930.155936745385, 10259.640912568024, 10276.691699249035, 1721.5954250751063, 1756.3764863473411, 1772.7961284452324, 1850.9537261568435, 1852.0832188066859, 101356.98643013622, 109361.0, 114413.4279328598, 115122.0, 117605.0, 11558.364289964133, 11579.826302605468, 11623.825642615368, 11638.53445862156, 11836.349000805038, 15110.848891510945, 15157.014794038572, 15194.544163675107, 15204.0, 15220.401857804993, 8382.0, 8601.440906341068, 8606.182412670787, 8758.47449153053, 8761.34289928258, 8400.285975692135, 8418.452800567944, 8434.662613495391, 8568.271696905707, 8569.228769410784, 4518.141553104965, 4617.861464156081, 4639.141758774637, 4685.320628508847, 4699.577038066591, 1771.3446024970842, 1793.6172903150564, 1888.5184278009294, 1971.6746736788268, 1994.7706013808308, 828.7348048624382, 902.9729108126767, 910.913463220993, 933.8879334479906, 982.7911668647461, 18322.541936451697, 19823.20707171697, 19977.900110499355, 20069.79930200679, 20218.79781202169, 927.0636656976368, 937.6202637931649, 971.159946646146, 977.9804403911882, 981.2885657897967, 8783.385163038654, 10182.949085254526, 10670.679879603624, 10800.837987430195, 10909.0, 548569.0, 554917.0, 556009.0, 590312.0, 596625.0, 119567.0, 122279.0, 123262.0, 130243.0, 132681.67318326887, 995.5520015992832, 1008.8789345278614, 1032.9431881246453, 1034.1984961654778, 1039.4906495817147, 14217.360218789972, 18046.0, 18148.72776908374, 18280.542986424913, 18372.17325220395, 47576.57270281897, 48675.5132448671, 48840.0, 49029.2645610309, 49117.75441122772, 69018.27454313482, 70882.64558677173, 71137.64431177812, 71226.64386678033, 73599.26400736139, 7923.366130709414, 8107.513549187068, 8166.632501537564, 8220.424570280262, 8324.791880203044, 11179.496922638338, 11915.940420297842, 12288.938555307166, 12549.121561490609, 12621.936890315857, 10389.428581427792, 10442.530086146293, 10784.730381740519, 10963.232573719763, 10970.451477426257, 10607.151427885596, 10611.787764244518, 10635.787284254426, 10787.6224332148, 10797.838032429678, 10275.794484110425, 10848.67453976382, 10860.076893464144, 11039.006489415991, 11054.115670746482, 6971.024056632177, 7349.889751653623, 7431.554106753612, 8054.23484768946, 8444.197801208875, 8130.796730081795, 9663.178629816262, 10443.0, 10929.781404372026, 11102.44487775592], "value": 9278.332015386852, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1407.542548671682, 1599.4561848971348, 1627.3978627907672, 1870.7755069391676, 1984.265821645992, 7953.72161974331, 8664.696735614254, 8877.467351958887, 8879.467231966086, 8912.816359991812, 8507.872381914276, 8706.738797836058, 8725.38922275441, 8727.738167854974, 8730.0, 2149.054416056938, 2216.8891555422247, 2222.7221597300336, 2389.7012873390827, 2424.260600516842, 2050.456628993318, 2227.8217742580637, 2475.232677869866, 2480.7643273889043, 2481.007596961212, 2399.7600239976036, 2418.443757935676, 2431.57447446697, 2438.2319569335605, 2439.134107391877, 2119.8834064126468, 2391.7249516305587, 2400.615901455759, 2405.0379848060743, 2406.38637147528, 2351.729551101628, 2427.9028838846425, 2435.062500937152, 2435.1233555919853, 2440.2923152285994, 8622.180892815173, 8695.173958473935, 8709.390342676015, 8713.825723485557, 8718.607662655195, 5090.287359769635, 5251.86870328241, 5255.894882102337, 5264.684118952875, 5300.867478313035, 3330.550375699274, 3422.349753546818, 3527.5943266524164, 3548.6628770267043, 3551.8401671924566, 1011.1001208924064, 1031.6131450705984, 1031.8555402243692, 1039.9896001039967, 1041.198277326462, 11834.05327573792, 11838.0, 11859.822102668468, 11870.287782733063, 11870.940645296718, 4582.77086145698, 4592.173408786451, 4783.0, 4831.178699621073, 4837.443693975168, 9935.950320248352, 10000.0, 10002.49987500622, 10019.348742331726, 10071.597136114473, 5235.685858848481, 5263.736813159403, 5374.48942350476, 5375.543078838343, 5388.0, 4147.398627199039, 4831.975840120777, 4859.173940430135, 4911.484294149134, 4912.0, 3917.3144699678014, 3954.3277642800795, 4011.679065674739, 4037.37420699792, 4086.6322031016757, 1328.9867101329057, 1330.8602596727399, 1334.292824802856, 1338.237204793278, 1352.0, 723.05641138315, 768.2049079202998, 878.4553576782308, 894.3962825093037, 932.8041111366689, 5577.386487486373, 5801.796937107181, 5901.645901245939, 6020.337762846083, 6097.993831017921, 934.1359242700474, 937.128470522407, 955.2071780422233, 964.8311545479513, 969.2875736333789, 3724.404095344732, 3817.7973938209375, 3826.521684789401, 3915.197384536163, 3996.900077498086, 9575.952120239353, 10444.060034596923, 10509.054185123376, 10638.627648032436, 10655.57377704883, 10502.579896804195, 10780.892191077988, 10789.730256743644, 10821.783564328827, 10903.890961090447, 6676.732930682815, 7650.234976502416, 8125.634346454423, 8138.389620778347, 8287.212714792086, 5731.914021289767, 5850.414958504116, 5956.731947062306, 5980.5215582754145, 6089.33017368098, 9435.339526233098, 9685.031496850259, 9775.413475191512, 9830.606775728891, 9893.65372211969, 9206.0, 9611.711648650551, 9784.51077446139, 9968.750781230527, 10025.548850301608, 7282.271772822675, 7489.737859174903, 7550.395968322631, 7557.244275572399, 7560.810979725551, 8133.918660813316, 8291.95854020726, 8341.541215233221, 8359.874601880854, 8375.539345336065, 7200.71197152108, 7267.854642907218, 7313.976043354041, 7321.926780732338, 7461.4403919705155, 6066.908996364969, 7133.928660713326, 7275.381592564479, 7299.635018249172, 7389.113306403051, 6764.323567643196, 6781.593104413553, 6849.691763870538, 6889.311068893071, 6913.343232392915, 4409.735415875058, 4604.976975115103, 4804.8318308859025, 4857.587105096107, 4896.877578060577, 3765.8870233893026, 4804.5195480451675, 4878.463369029333, 4932.383452068491, 5062.848114556569], "value": 4551.173488335339, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [286.5000573998372, 313.02804791123566, 322.517835835426, 325.1837886903871, 325.56374458225974, 5090.338256026716, 5637.238972738679, 5760.654360738358, 5836.241288632477, 6011.75952961881, 4753.738544380058, 5548.805791797277, 5738.139279108125, 5758.157389635318, 5768.144768339667, 4120.114175452277, 4260.616544510994, 4341.218580655473, 4349.238883195444, 4383.627391671712, 3813.31360355136, 4419.889502762425, 4431.822727090913, 4435.512093669694, 4479.499367711805, 4162.209180255757, 4298.292075992121, 4405.185040767468, 4419.668524860632, 4427.977860110695, 4168.478940132483, 4357.847475338363, 4398.560143985608, 4423.336499525081, 4430.468343798765, 3437.5015622734563, 3821.2804238092967, 3825.9426108608395, 3834.9837293117066, 3848.6536211741077, 4688.765561721901, 5373.2208829719475, 5599.580031497654, 5640.971795140998, 5694.601377903548, 5107.4892510749, 5111.642185047048, 5158.3552055993005, 5162.045021671003, 5170.0, 5244.632875698664, 5556.361018482886, 6177.845553861144, 6259.780907668255, 6261.217347831521, 4056.7363121397016, 4312.094460163369, 4329.0, 4340.153670034345, 4364.629006534448, 5824.271966004249, 6524.739010439576, 6578.3421657834315, 6595.307492713292, 6632.568883022636, 4376.496702879146, 4389.517153113155, 4392.956070439319, 4397.472303323558, 4424.345392764316, 4298.978505107517, 4433.246348120762, 4491.505934347219, 4501.662375321864, 4502.414686090788, 4490.977545112253, 4705.011947491065, 4876.21980483121, 5024.42219144803, 5155.896882062413, 6168.599041062316, 6308.873822523524, 6325.63998740273, 6344.968275158594, 6401.935980640134, 1452.259347732643, 1493.7759336099673, 1509.4037855047195, 1526.4123312524757, 1544.9304781284868, 1007.6019972110975, 1019.0, 1023.9692809215735, 1027.912627426677, 1041.4376236832177, 5538.6399884007415, 5831.825045248649, 5838.38696936824, 5870.884531938918, 5883.558733095035, 5397.217403476474, 6443.5167362448, 6466.870662586816, 6485.837854053686, 6487.318831522716, 5117.923231151536, 5401.594880383908, 5806.68063256525, 5820.388859169726, 5832.154337621106, 3034.544818277276, 3405.5402520659395, 3410.2838403934957, 3413.658634136616, 3428.6914177724125, 6166.859131060768, 6461.224653041665, 6668.966655166693, 6699.095622091053, 6892.448604111659, 6736.2590115087305, 6764.289749576224, 6785.898211526831, 6789.660516974231, 6802.8299292517095, 6648.635455736447, 6775.356341147583, 6775.646055202509, 6872.209695884937, 6921.930780692129, 5472.288602481811, 6549.8690026200165, 6573.441257493167, 6597.835054123685, 6617.0, 5366.597505187205, 6459.289478157305, 6469.353064693493, 6473.255575608865, 6477.935220647733, 5590.825926555469, 5949.7620095197435, 6134.9079763804475, 6159.489091217963, 6799.898001529882, 4032.475778148822, 4169.291220492463, 4213.262679031096, 4225.0, 4240.194363071007, 5774.372660439406, 5994.130851026664, 6119.938800611937, 6272.2159730033745, 6572.769953051811, 5602.607817452739, 6261.36840632423, 6263.6241825490615, 6297.275813281532, 6316.399942005502, 5510.972445137749, 6290.591111577733, 6293.433590976834, 6307.0, 6317.546964198168, 6008.8798224036145, 6167.198264225622, 6174.6912654368, 6184.350643182581, 6202.255729312511, 6198.318184999556, 6264.780732674334, 6275.215598050244, 6283.2460104787715, 6301.936980630135, 4965.950340496694, 5774.105013722879, 6149.262088549223, 6196.380361963767, 6200.193974783249], "value": 4573.887066447522, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.3849120318104, 714.2999860137065, 740.4335683202352, 744.6909532543995, 757.4167890724146, 14595.854041459583, 15017.549473515784, 16807.495775126736, 17569.385071522498, 17586.82413175868, 13891.235982020984, 13914.165150091001, 13994.860051399482, 13996.930015349935, 14004.929975350109, 731.9341259286663, 905.5653286422505, 945.7493764152505, 946.7917058247175, 948.1087777489173, 723.9710411583557, 912.1243606138115, 951.7620594851287, 954.3224310739349, 955.2358113509199, 977.6431602465085, 982.4694664880956, 990.5740531571421, 994.060612720979, 999.3354419311149, 761.8895260187242, 976.24828881761, 983.1888691829233, 984.6061575369838, 985.5466485416753, 580.3760956971273, 581.8254523642933, 582.5543459253674, 714.0931017607661, 734.2877408913346, 15194.620134496616, 15217.086974781438, 15245.542633721006, 15251.923740381228, 15253.6186595336, 12776.808347874789, 12854.22874627516, 12906.741865162645, 12951.417186226643, 13279.46882124714, 9387.155156035922, 9689.612415503372, 9871.703848884545, 10108.241881858816, 10710.946445267724, 3511.6839484446523, 3611.133328001287, 3646.690031347312, 3728.6457786510236, 3757.7933213673236, 87896.0, 88127.55936220342, 88551.55724221337, 89362.0, 93679.53160234223, 9675.758106047264, 9719.708408747749, 9961.800763984824, 9965.302428830057, 10047.397156170653, 23586.646200306666, 23634.7636523636, 23647.7635223649, 23651.817409129475, 23669.171578994654, 7295.197528271886, 7485.962570187115, 7509.699612015567, 7536.208698086732, 7645.961770191114, 3984.4820173377857, 4050.9797451012555, 4053.43251944728, 4055.9797201013807, 4059.9797001014804, 3503.5445392098864, 3606.4590311452966, 3612.512310838003, 3613.1689711366535, 3617.149969757105, 624.3537938233906, 648.3581254558048, 653.8398092467376, 654.6628486329544, 707.5966698981531, 476.72826488900995, 567.1153001317957, 603.8165196215467, 604.3593790581997, 604.9455549000523, 7652.234776522415, 7919.604019798987, 8040.477368970998, 8065.798355041054, 8159.428839981263, 525.9263703081572, 556.7077829931276, 576.6477610004532, 599.7271241585069, 604.3412680178626, 3581.1226249568504, 3740.6446387593137, 3742.607026262258, 3835.6356146166067, 3847.8076096195077, 88365.0, 89983.65024524638, 90097.64853527202, 90350.54824725834, 90657.0, 76197.23802761901, 76468.0, 76794.23205767982, 76959.61520192363, 78216.43567128625, 68602.65698671475, 68625.65687171533, 69122.65438672775, 69122.65438672775, 69245.30754692388, 7334.743283985035, 7399.149097853816, 7403.185649578434, 7649.208039065812, 7822.295993360397, 35448.645513544536, 36755.89732308035, 36886.26227475489, 38036.42945355877, 40058.0, 40917.59082409138, 45282.73586320605, 53751.46248537464, 55271.0, 55948.440515594324, 10834.458277086273, 11015.449227538431, 11092.279001864854, 11143.16426268017, 11165.665030049111, 11625.825612615987, 11875.406229688653, 12041.45813438415, 12052.819207711716, 12074.698132546406, 11174.888251117385, 11259.662210133709, 11310.434478275889, 11466.426678665866, 11720.648380548597, 8870.824711794316, 11095.808976518187, 11216.45492559944, 11558.711032224262, 12092.164801143017, 11124.332540047622, 11159.27464714791, 11201.047910927662, 11245.0, 11480.770384592095, 9215.354925155174, 9277.0, 9363.4381937084, 9555.378900371454, 9595.23238140961, 9239.953800230956, 9518.476483793458, 9609.951950240204, 9621.134097931219, 9733.513324333897], "value": 6799.691215070901, "unit": "score"}], "name": "dromaeo_css", "value": 7275.178585548496, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 109.0, 111.0, 111.0, 112.0, 113.0, 120.0, 113.0, 112.0, 111.0], "value": 112.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [159.0, 122.0, 145.0, 169.0, 120.0, 142.0, 139.0, 122.0, 174.0, 128.0], "value": 142.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [190.0, 187.0, 184.0, 185.0, 183.0, 181.0, 184.0, 216.0, 186.0, 183.0], "value": 187.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 71.0, 87.0, 91.0, 58.0, 63.0, 82.0, 120.0, 106.0, 55.0], "value": 81.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 99.0, 135.0, 78.0, 77.0, 79.0, 125.0, 79.0, 76.0, 127.0], "value": 96.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 89.0, 86.0, 88.0, 85.0, 89.0, 86.0, 88.0, 83.0], "value": 86.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 93.0, 93.0, 92.0, 93.0, 94.0, 94.0, 93.0, 93.0], "value": 93.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 126.0, 85.0, 84.0, 87.0, 83.0, 83.0, 84.0, 97.0, 139.0], "value": 96.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 60.0, 60.0, 60.0, 59.0, 59.0, 60.0, 78.0, 60.0, 58.0], "value": 61.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 77.0, 72.0, 70.0, 65.0, 65.0, 65.0, 66.0, 67.0], "value": 67.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 83.0, 81.0, 83.0, 71.0, 79.0, 94.0, 104.0, 106.0], "value": 86.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 137.0, 139.0, 137.0, 161.0, 152.0, 149.0, 138.0, 169.0, 155.0], "value": 147.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 168.0, 171.0, 170.0, 171.0, 173.0, 169.0, 170.0, 167.0, 168.0], "value": 169.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 88.0, 95.0, 94.0, 96.0, 70.0, 68.0, 69.0, 67.0, 64.0], "value": 78.2, "unit": "score"}], "name": "kraken", "value": 1507.0000000000002, "alertThreshold": 2.0}]} 02:15:56 INFO - Return code: 0 02:15:56 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:15:56 ERROR - # TBPL SUCCESS # 02:15:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:15:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:15:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:15:56 INFO - 2016-04-20 02:15:56.263 screenresolution[1673:9821] starting screenresolution argv=screenresolution get 02:15:56 INFO - 2016-04-20 02:15:56.266 screenresolution[1673:9821] Display 0: 1600x1200x32@60 02:15:56 INFO - 2016-04-20 02:15:56.272 screenresolution[1674:9824] starting screenresolution argv=screenresolution list 02:15:56 INFO - Available Modes on Display 0 02:15:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:15:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:15:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:15:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:15:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:15:56 INFO - Intel Iris: 02:15:56 INFO - Chipset Model: Intel Iris 02:15:56 INFO - Type: GPU 02:15:56 INFO - Bus: Built-In 02:15:56 INFO - VRAM (Dynamic, Max): 1536 MB 02:15:56 INFO - Vendor: Intel (0x8086) 02:15:56 INFO - Device ID: 0x0a2e 02:15:56 INFO - Revision ID: 0x0009 02:15:56 INFO - Displays: 02:15:56 INFO - Display: 02:15:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:15:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:15:56 INFO - Display Serial Number: 1600x1200 60 02:15:56 INFO - Main Display: Yes 02:15:56 INFO - Mirror: Off 02:15:56 INFO - Online: Yes 02:15:56 INFO - Rotation: Supported 02:15:56 INFO - Return code: 0 02:15:56 INFO - Running post-action listener: _resource_record_post_action 02:15:56 INFO - Running post-run listener: _resource_record_post_run 02:15:57 INFO - Total resource usage - Wall time: 1210s; CPU: 53.0%; Read bytes: 37361152; Write bytes: 693277696; Read time: 389; Write time: 2306 02:15:57 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 373498368; Write bytes: 366364160; Read time: 28123; Write time: 662 02:15:57 INFO - run-tests - Wall time: 1177s; CPU: 53.0%; Read bytes: 36398592; Write bytes: 296472064; Read time: 374; Write time: 1589 02:15:57 INFO - Running post-run listener: _upload_blobber_files 02:15:57 INFO - Blob upload gear active. 02:15:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:15:57 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 02:15:57 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'] 02:15:57 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 02:15:57 INFO - (blobuploader) - INFO - Open directory for files ... 02:15:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:15:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:15:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:15:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:15:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:15:59 INFO - (blobuploader) - INFO - Done attempting. 02:15:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:15:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:15:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:16:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:16:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:16:00 INFO - (blobuploader) - INFO - Done attempting. 02:16:00 INFO - (blobuploader) - INFO - Iteration through files over. 02:16:00 INFO - Return code: 0 02:16:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:16:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:16:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3958379dfa5fc0fac1e06a1b74e7f63d9afe645605fb64c86d0e3305cdb4fb6113582a88a3dded2868fb95012e071ae34c085932d7c113bfd892b7f11fe0be71", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c66e5fc120c70dea381e4c91b331b6d66b5aef694e6dec4b29a0c1411a0b2d80bad798800fc96377a4b36a7e1c03e18812b40d13db0a16c7b935ea29b35817e0"} 02:16:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:16:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:16:00 INFO - Contents: 02:16:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3958379dfa5fc0fac1e06a1b74e7f63d9afe645605fb64c86d0e3305cdb4fb6113582a88a3dded2868fb95012e071ae34c085932d7c113bfd892b7f11fe0be71", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c66e5fc120c70dea381e4c91b331b6d66b5aef694e6dec4b29a0c1411a0b2d80bad798800fc96377a4b36a7e1c03e18812b40d13db0a16c7b935ea29b35817e0"} 02:16:00 INFO - Running post-run listener: copy_logs_to_upload_dir 02:16:00 INFO - Copying logs to upload dir... 02:16:00 INFO - mkdir: /builds/slave/test/build/upload/logs 02:16:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.104235 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-04-20 02:16:00.264451) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 02:16:00.268141) ========= 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.IB9KLhQJ47/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.8PKkOIYtLy/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3958379dfa5fc0fac1e06a1b74e7f63d9afe645605fb64c86d0e3305cdb4fb6113582a88a3dded2868fb95012e071ae34c085932d7c113bfd892b7f11fe0be71", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c66e5fc120c70dea381e4c91b331b6d66b5aef694e6dec4b29a0c1411a0b2d80bad798800fc96377a4b36a7e1c03e18812b40d13db0a16c7b935ea29b35817e0"} 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.009845 build_url: 'https://queue.taskcluster.net/v1/task/Xa2a2XdPQS-UNfnskrv5fw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3958379dfa5fc0fac1e06a1b74e7f63d9afe645605fb64c86d0e3305cdb4fb6113582a88a3dded2868fb95012e071ae34c085932d7c113bfd892b7f11fe0be71", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c66e5fc120c70dea381e4c91b331b6d66b5aef694e6dec4b29a0c1411a0b2d80bad798800fc96377a4b36a7e1c03e18812b40d13db0a16c7b935ea29b35817e0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-20 02:16:00.292813) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 02:16:00.293215) ========= 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.IB9KLhQJ47/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.8PKkOIYtLy/Listeners TMPDIR=/var/folders/9_/5z1bxm9x17x0h1yxkxy862y400000w/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.004694 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-20 02:16:00.341772) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 02:16:00.342136) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-20 02:16:00.342609) ========= ========= Total master_lag: 0.15 =========