builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0048 starttime: 1461488070.22 results: success (0) buildid: 20160424000420 builduid: a279cdf618e84ad18bdb4811b2ce4caa revision: 67e03d012ea92d93c128bd8b20bbea7fd6f048a2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 01:54:30.215469) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-24 01:54:30.215830) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 01:54:30.216220) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-24 01:54:30.276933) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 01:54:30.277716) ========= 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.MxRvK42ukp/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.AWHCy4UKYy/Listeners TMPDIR=/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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-24 01:54:30-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 154M=0s 2016-04-24 01:54:30 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.634039 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 01:54:30.933839) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 01:54:30.934179) ========= 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.MxRvK42ukp/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.AWHCy4UKYy/Listeners TMPDIR=/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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.027073 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 01:54:30.989500) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-24 01:54:30.989800) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 67e03d012ea92d93c128bd8b20bbea7fd6f048a2 --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 67e03d012ea92d93c128bd8b20bbea7fd6f048a2 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MxRvK42ukp/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.AWHCy4UKYy/Listeners TMPDIR=/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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-24 01:54:31,068 truncating revision to first 12 chars 2016-04-24 01:54:31,069 Setting DEBUG logging. 2016-04-24 01:54:31,069 attempt 1/10 2016-04-24 01:54:31,069 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/67e03d012ea9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-24 01:54:32,087 unpacking tar archive at: fx-team-67e03d012ea9/testing/mozharness/ program finished with exit code 0 elapsedTime=1.256984 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-24 01:54:32.263371) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 01:54:32.263699) ========= script_repo_revision: 67e03d012ea92d93c128bd8b20bbea7fd6f048a2 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-24 01:54:32.264091) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 01:54:32.264376) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-24 01:54:32.280850) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-04-24 01:54:32.281164) ========= /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.MxRvK42ukp/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.AWHCy4UKYy/Listeners TMPDIR=/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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:32 INFO - MultiFileLogger online at 20160424 01:54:32 in /builds/slave/test 01:54:32 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:32 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:54:32 INFO - {'append_to_log': False, 01:54:32 INFO - 'base_work_dir': '/builds/slave/test', 01:54:32 INFO - 'blob_upload_branch': 'Fx-Team', 01:54:32 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:54:32 INFO - 'branch': 'Fx-Team', 01:54:32 INFO - 'buildbot_json_path': 'buildprops.json', 01:54:32 INFO - 'config_files': ('talos/mac_config.py',), 01:54:32 INFO - 'default_actions': ('clobber', 01:54:32 INFO - 'read-buildbot-config', 01:54:32 INFO - 'download-and-extract', 01:54:32 INFO - 'populate-webroot', 01:54:32 INFO - 'create-virtualenv', 01:54:32 INFO - 'install', 01:54:32 INFO - 'run-tests'), 01:54:32 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:54:32 INFO - 'download_minidump_stackwalk': True, 01:54:32 INFO - 'download_symbols': 'ondemand', 01:54:32 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:54:32 INFO - 'tooltool.py': '/tools/tooltool.py', 01:54:32 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:54:32 INFO - '/tools/misc-python/virtualenv.py')}, 01:54:32 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:54:32 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:54:32 INFO - 'installer_path': 'installer.exe', 01:54:32 INFO - 'log_level': 'info', 01:54:32 INFO - 'log_name': 'talos', 01:54:32 INFO - 'log_to_console': True, 01:54:32 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:54:32 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:54:32 INFO - 'opt_config_files': (), 01:54:32 INFO - 'pip_index': False, 01:54:32 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:54:32 INFO - 'cmd': ('bash', 01:54:32 INFO - '-c', 01:54:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:54:32 INFO - 'enabled': True, 01:54:32 INFO - 'halt_on_failure': False, 01:54:32 INFO - 'name': 'check_screen_resolution'},), 01:54:32 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:54:32 INFO - 'cmd': ('bash', 01:54:32 INFO - '-c', 01:54:32 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:54:32 INFO - 'enabled': True, 01:54:32 INFO - 'halt_on_failure': False, 01:54:32 INFO - 'name': 'check_screen_resolution'},), 01:54:32 INFO - 'run_cmd_checks_enabled': True, 01:54:32 INFO - 'sps_profile': False, 01:54:32 INFO - 'sps_profile_interval': 0, 01:54:32 INFO - 'suite': 'dromaeojs', 01:54:32 INFO - 'system_bits': '32', 01:54:32 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:54:32 INFO - 'title': 't-yosemite-r7-0048', 01:54:32 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:54:32 INFO - 'use_talos_json': True, 01:54:32 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:54:32 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:54:32 INFO - 'work_dir': 'build'} 01:54:32 INFO - ##### 01:54:32 INFO - ##### Running clobber step. 01:54:32 INFO - ##### 01:54:32 INFO - Running pre-action listener: _resource_record_pre_action 01:54:32 INFO - Running main action method: clobber 01:54:32 INFO - rmtree: /builds/slave/test/build 01:54:32 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:54:34 INFO - Running post-action listener: _resource_record_post_action 01:54:34 INFO - ##### 01:54:34 INFO - ##### Running read-buildbot-config step. 01:54:34 INFO - ##### 01:54:34 INFO - Running pre-action listener: _resource_record_pre_action 01:54:34 INFO - Running main action method: read_buildbot_config 01:54:34 INFO - Using buildbot properties: 01:54:34 INFO - { 01:54:34 INFO - "project": "", 01:54:34 INFO - "product": "firefox", 01:54:34 INFO - "script_repo_revision": "production", 01:54:34 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 01:54:34 INFO - "repository": "", 01:54:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 01:54:34 INFO - "buildid": "20160424000420", 01:54:34 INFO - "pgo_build": "False", 01:54:34 INFO - "basedir": "/builds/slave/test", 01:54:34 INFO - "buildnumber": 711, 01:54:34 INFO - "slavename": "t-yosemite-r7-0048", 01:54:34 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 01:54:34 INFO - "platform": "yosemite_r7", 01:54:34 INFO - "scheduler": "tests-fx-team-macosx64-talos", 01:54:34 INFO - "branch": "fx-team", 01:54:34 INFO - "repo_path": "integration/fx-team", 01:54:34 INFO - "revision": "67e03d012ea92d93c128bd8b20bbea7fd6f048a2", 01:54:34 INFO - "stage_platform": "macosx64", 01:54:34 INFO - "builduid": "a279cdf618e84ad18bdb4811b2ce4caa", 01:54:34 INFO - "slavebuilddir": "test" 01:54:34 INFO - } 01:54:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 01:54:34 INFO - Running post-action listener: _resource_record_post_action 01:54:34 INFO - ##### 01:54:34 INFO - ##### Running download-and-extract step. 01:54:34 INFO - ##### 01:54:34 INFO - Running pre-action listener: _resource_record_pre_action 01:54:34 INFO - Running main action method: download_and_extract 01:54:34 INFO - mkdir: /builds/slave/test/build/tests 01:54:34 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:34 INFO - https://queue.taskcluster.net/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:54:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 01:54:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 01:54:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/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:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/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:46 INFO - Downloaded 1199 bytes. 01:54:46 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 01:54:46 INFO - Using the following test package requirements: 01:54:46 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 01:54:46 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:54:46 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 01:54:46 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:54:46 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 01:54:46 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:54:46 INFO - u'jsshell-mac.zip'], 01:54:46 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:54:46 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 01:54:46 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 01:54:46 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:54:46 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 01:54:46 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:54:46 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 01:54:46 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:54:46 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 01:54:46 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 01:54:46 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 01:54:46 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:54:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:46 INFO - https://queue.taskcluster.net/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:54:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:54:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:54:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/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:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/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:47 INFO - Downloaded 18109650 bytes. 01:54:47 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:47 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:54:51 INFO - Return code: 0 01:54:51 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 01:54:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:54:51 INFO - https://queue.taskcluster.net/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:54:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:54:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 01:54:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/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:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/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:54 INFO - Downloaded 18109650 bytes. 01:54:54 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:54 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:54:58 INFO - Return code: 0 01:54:58 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:58 INFO - https://queue.taskcluster.net/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:54:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 01:54:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 01:54:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/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:54:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/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:54:59 INFO - Downloaded 10840145 bytes. 01:54:59 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:54:59 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:54:59 INFO - Return code: 0 01:54:59 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:59 INFO - https://queue.taskcluster.net/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:54:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:54:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:54:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 01:54:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/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:03 INFO - Downloaded 110123833 bytes. 01:55:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:55:03 INFO - mkdir: /builds/slave/test/properties 01:55:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:55:03 INFO - Writing to file /builds/slave/test/properties/build_url 01:55:03 INFO - Contents: 01:55:03 INFO - build_url:https://queue.taskcluster.net/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 01:55:05 INFO - Running post-action listener: _resource_record_post_action 01:55:05 INFO - Running post-action listener: set_extra_try_arguments 01:55:05 INFO - ##### 01:55:05 INFO - ##### Running populate-webroot step. 01:55:05 INFO - ##### 01:55:05 INFO - Running pre-action listener: _resource_record_pre_action 01:55:05 INFO - Running main action method: populate_webroot 01:55:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:55:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:55:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:55:05 INFO - '--tppagecycles', 01:55:05 INFO - '7'], 01:55:05 INFO - 'tests': ['tsvgm']}}, 01:55:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:55:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:55:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:55:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:55:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:55:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:55:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:05 INFO - 'talos_options': ['--disable-e10s'], 01:55:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:55:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:55:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:05 INFO - 'talos_options': ['--disable-e10s'], 01:55:05 INFO - 'tests': ['damp', 'tps']}, 01:55:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:05 INFO - 'tests': ['damp', 'tps']}, 01:55:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:55:05 INFO - 'tests': ['dromaeo_dom']}, 01:55:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:55:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:55:05 INFO - 'tests': ['a11yr', 01:55:05 INFO - 'ts_paint', 01:55:05 INFO - 'tpaint', 01:55:05 INFO - 'sessionrestore', 01:55:05 INFO - 'sessionrestore_no_auto_restore', 01:55:05 INFO - 'tabpaint']}, 01:55:05 INFO - 'other-e10s': {'tests': ['a11yr', 01:55:05 INFO - 'ts_paint', 01:55:05 INFO - 'tpaint', 01:55:05 INFO - 'sessionrestore', 01:55:05 INFO - 'sessionrestore_no_auto_restore', 01:55:05 INFO - 'tabpaint']}, 01:55:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:55:05 INFO - 'ts_paint', 01:55:05 INFO - 'tpaint', 01:55:05 INFO - 'sessionrestore', 01:55:05 INFO - 'sessionrestore_no_auto_restore', 01:55:05 INFO - 'tabpaint']}, 01:55:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:55:05 INFO - 'ts_paint', 01:55:05 INFO - 'tpaint', 01:55:05 INFO - 'sessionrestore', 01:55:05 INFO - 'sessionrestore_no_auto_restore', 01:55:05 INFO - 'tabpaint']}, 01:55:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:55:05 INFO - 'tests': ['a11yr', 01:55:05 INFO - 'ts_paint', 01:55:05 INFO - 'tpaint', 01:55:05 INFO - 'sessionrestore', 01:55:05 INFO - 'sessionrestore_no_auto_restore', 01:55:05 INFO - 'tabpaint']}, 01:55:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:55:05 INFO - 'tests': ['a11yr', 01:55:05 INFO - 'ts_paint', 01:55:05 INFO - 'tpaint', 01:55:05 INFO - 'sessionrestore', 01:55:05 INFO - 'sessionrestore_no_auto_restore', 01:55:05 INFO - 'tabpaint']}, 01:55:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:55:05 INFO - 'tests': ['tsvgx', 01:55:05 INFO - 'tsvgr_opacity', 01:55:05 INFO - 'tart', 01:55:05 INFO - 'tscrollx', 01:55:05 INFO - 'cart']}, 01:55:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:55:05 INFO - 'tsvgr_opacity', 01:55:05 INFO - 'tart', 01:55:05 INFO - 'tscrollx', 01:55:05 INFO - 'cart']}, 01:55:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:05 INFO - 'talos_options': ['--disable-e10s'], 01:55:05 INFO - 'tests': ['tp5o']}, 01:55:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:05 INFO - 'tests': ['tp5o']}, 01:55:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:05 INFO - 'talos_options': ['--disable-e10s', 01:55:05 INFO - '--xperf_path', 01:55:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:55:05 INFO - 'tests': ['tp5n']}, 01:55:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:55:05 INFO - 'talos_options': ['--xperf_path', 01:55:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:55:05 INFO - 'tests': ['tp5n']}}, 01:55:05 INFO - 'talos.zip': {'path': '', 01:55:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:55:05 INFO - Running post-action listener: _resource_record_post_action 01:55:05 INFO - ##### 01:55:05 INFO - ##### Running create-virtualenv step. 01:55:05 INFO - ##### 01:55:05 INFO - Running pre-action listener: _resource_record_pre_action 01:55:05 INFO - Running main action method: create_virtualenv 01:55:05 INFO - Creating virtualenv /builds/slave/test/build/venv 01:55:05 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:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:55:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:55:05 INFO - Using real prefix '/tools/python27' 01:55:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:55:06 INFO - Installing distribute.............................................................................................................................................................................................done. 01:55:08 INFO - Installing pip.................done. 01:55:09 INFO - Return code: 0 01:55:09 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10af69a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af79420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8babc8fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae08e00>, '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 0x10ac31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae03b20>, '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.MxRvK42ukp/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.AWHCy4UKYy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:55:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:55:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MxRvK42ukp/Render', 01:55:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:55:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:55:09 INFO - 'HOME': '/Users/cltbld', 01:55:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:55:09 INFO - 'LOGNAME': 'cltbld', 01:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:09 INFO - 'MOZ_NO_REMOTE': '1', 01:55:09 INFO - 'NO_EM_RESTART': '1', 01:55:09 INFO - 'PAGER': '/bin/cat', 01:55:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:09 INFO - 'PWD': '/builds/slave/test', 01:55:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:55:09 INFO - 'SHELL': '/bin/bash', 01:55:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AWHCy4UKYy/Listeners', 01:55:09 INFO - 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/', 01:55:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:55:09 INFO - 'USER': 'cltbld', 01:55:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:55:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:09 INFO - 'XPC_FLAGS': '0x0', 01:55:09 INFO - 'XPC_SERVICE_NAME': '0', 01:55:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:09 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:09 INFO - Cleaning up... 01:55:09 INFO - Return code: 0 01:55:09 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10af69a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af79420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8babc8fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae08e00>, '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 0x10ac31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae03b20>, '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.MxRvK42ukp/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.AWHCy4UKYy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:55:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:55:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MxRvK42ukp/Render', 01:55:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:55:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:55:09 INFO - 'HOME': '/Users/cltbld', 01:55:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:55:09 INFO - 'LOGNAME': 'cltbld', 01:55:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:09 INFO - 'MOZ_NO_REMOTE': '1', 01:55:09 INFO - 'NO_EM_RESTART': '1', 01:55:09 INFO - 'PAGER': '/bin/cat', 01:55:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:55:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:09 INFO - 'PWD': '/builds/slave/test', 01:55:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:55:09 INFO - 'SHELL': '/bin/bash', 01:55:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AWHCy4UKYy/Listeners', 01:55:09 INFO - 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/', 01:55:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:55:09 INFO - 'USER': 'cltbld', 01:55:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:55:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:55:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:09 INFO - 'XPC_FLAGS': '0x0', 01:55:09 INFO - 'XPC_SERVICE_NAME': '0', 01:55:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:55:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:09 INFO - Downloading/unpacking psutil>=0.7.1 01:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:55:13 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:55:13 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:55:13 INFO - Installing collected packages: psutil 01:55:13 INFO - Running setup.py install for psutil 01:55:13 INFO - building 'psutil._psutil_osx' extension 01:55:13 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:13 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:13 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:13 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:13 INFO - building 'psutil._psutil_posix' extension 01:55:13 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:14 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:55:14 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:55:14 INFO - ^ 01:55:14 INFO - 1 warning generated. 01:55:14 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:14 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:55:14 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:55:14 INFO - Successfully installed psutil 01:55:14 INFO - Cleaning up... 01:55:14 INFO - Return code: 0 01:55:14 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:55:14 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:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:14 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:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:14 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 0x10af69a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af79420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8babc8fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae08e00>, '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 0x10ac31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae03b20>, '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.MxRvK42ukp/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.AWHCy4UKYy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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:14 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:14 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:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MxRvK42ukp/Render', 01:55:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:55:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:55:14 INFO - 'HOME': '/Users/cltbld', 01:55:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:55:14 INFO - 'LOGNAME': 'cltbld', 01:55:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:14 INFO - 'MOZ_NO_REMOTE': '1', 01:55:14 INFO - 'NO_EM_RESTART': '1', 01:55:14 INFO - 'PAGER': '/bin/cat', 01:55:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:55:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:14 INFO - 'PWD': '/builds/slave/test', 01:55:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:55:14 INFO - 'SHELL': '/bin/bash', 01:55:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AWHCy4UKYy/Listeners', 01:55:14 INFO - 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/', 01:55:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:55:14 INFO - 'USER': 'cltbld', 01:55:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:55:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:55:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:14 INFO - 'XPC_FLAGS': '0x0', 01:55:14 INFO - 'XPC_SERVICE_NAME': '0', 01:55:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:55:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:14 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:16 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:55:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:55:17 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:17 INFO - Installing collected packages: mozsystemmonitor 01:55:17 INFO - Running setup.py install for mozsystemmonitor 01:55:17 INFO - Successfully installed mozsystemmonitor 01:55:17 INFO - Cleaning up... 01:55:17 INFO - Return code: 0 01:55:17 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:17 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 0x10af69a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af79420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8babc8fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae08e00>, '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 0x10ac31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae03b20>, '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.MxRvK42ukp/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.AWHCy4UKYy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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:17 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:17 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:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MxRvK42ukp/Render', 01:55:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:55:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:55:17 INFO - 'HOME': '/Users/cltbld', 01:55:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:55:17 INFO - 'LOGNAME': 'cltbld', 01:55:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:17 INFO - 'MOZ_NO_REMOTE': '1', 01:55:17 INFO - 'NO_EM_RESTART': '1', 01:55:17 INFO - 'PAGER': '/bin/cat', 01:55:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:55:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:17 INFO - 'PWD': '/builds/slave/test', 01:55:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:55:17 INFO - 'SHELL': '/bin/bash', 01:55:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AWHCy4UKYy/Listeners', 01:55:17 INFO - 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/', 01:55:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:55:17 INFO - 'USER': 'cltbld', 01:55:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:55:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:55:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:17 INFO - 'XPC_FLAGS': '0x0', 01:55:17 INFO - 'XPC_SERVICE_NAME': '0', 01:55:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:55:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:17 INFO - Downloading/unpacking blobuploader==1.2.4 01:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:19 INFO - Downloading blobuploader-1.2.4.tar.gz 01:55:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:55:20 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:55:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:21 INFO - Downloading docopt-0.6.1.tar.gz 01:55:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:55:21 INFO - Installing collected packages: blobuploader, requests, docopt 01:55:21 INFO - Running setup.py install for blobuploader 01:55:21 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:55:21 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:55:21 INFO - Running setup.py install for requests 01:55:21 INFO - Running setup.py install for docopt 01:55:21 INFO - Successfully installed blobuploader requests docopt 01:55:21 INFO - Cleaning up... 01:55:22 INFO - Return code: 0 01:55:22 INFO - Installing None 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', '--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 0x10af69a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af79420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8babc8fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae08e00>, '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 0x10ac31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae03b20>, '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.MxRvK42ukp/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.AWHCy4UKYy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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', '--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:22 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:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MxRvK42ukp/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.AWHCy4UKYy/Listeners', 01:55:22 INFO - 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:55:22 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-7DmkHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:55:22 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-Gce_Id-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:55:22 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-RXboP_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:55:22 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-L_dM9w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:55:22 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-eAmW5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:55:22 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-4kCxqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:55:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:55:22 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-NZ1Cq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:55:23 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-yOpvIu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:55:23 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-ZtI78Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:55:23 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-lLUDBU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:55:23 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-pkfgNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:55:23 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-fZBvnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:55:23 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-g0WvN0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:55:23 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-cUX_fv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:23 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-MyWHJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:55:23 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-mYIjWa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:55:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:55:23 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-8xjaUJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:55:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:55:24 INFO - Running setup.py install for manifestparser 01:55:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:55:24 INFO - Running setup.py install for mozcrash 01:55:24 INFO - Running setup.py install for mozdebug 01:55:24 INFO - Running setup.py install for mozdevice 01:55:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:55:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:55:24 INFO - Running setup.py install for mozfile 01:55:24 INFO - Running setup.py install for mozhttpd 01:55:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:55:24 INFO - Running setup.py install for mozinfo 01:55:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:55:25 INFO - Running setup.py install for mozInstall 01:55:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:55:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:55:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:55:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:55:25 INFO - Running setup.py install for mozleak 01:55:25 INFO - Running setup.py install for mozlog 01:55:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:55:25 INFO - Running setup.py install for moznetwork 01:55:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:55:25 INFO - Running setup.py install for mozprocess 01:55:25 INFO - Running setup.py install for mozprofile 01:55:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:55:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:55:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:55:26 INFO - Running setup.py install for mozrunner 01:55:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:55:26 INFO - Running setup.py install for mozscreenshot 01:55:26 INFO - Running setup.py install for moztest 01:55:26 INFO - Running setup.py install for mozversion 01:55:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:55:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:55:26 INFO - Cleaning up... 01:55:26 INFO - Return code: 0 01:55:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:55:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:26 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 0x10af69a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af79420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8babc8fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae08e00>, '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 0x10ac31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae03b20>, '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.MxRvK42ukp/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.AWHCy4UKYy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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:26 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:26 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:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MxRvK42ukp/Render', 01:55:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:55:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:55:26 INFO - 'HOME': '/Users/cltbld', 01:55:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:55:26 INFO - 'LOGNAME': 'cltbld', 01:55:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:26 INFO - 'MOZ_NO_REMOTE': '1', 01:55:26 INFO - 'NO_EM_RESTART': '1', 01:55:26 INFO - 'PAGER': '/bin/cat', 01:55:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:55:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:26 INFO - 'PWD': '/builds/slave/test', 01:55:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:55:26 INFO - 'SHELL': '/bin/bash', 01:55:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AWHCy4UKYy/Listeners', 01:55:26 INFO - 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/', 01:55:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:55:26 INFO - 'USER': 'cltbld', 01:55:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:55:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:55:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:26 INFO - 'XPC_FLAGS': '0x0', 01:55:26 INFO - 'XPC_SERVICE_NAME': '0', 01:55:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:55:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:55:26 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-DRIBbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:55:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:55:27 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-tk_84N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:55:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:55:27 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-xKBmgZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:55:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:55:27 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-e7deqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:55:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:55:27 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-OMxAFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:55:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:55:27 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-SVMVqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:55:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:55:27 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-lk8C3v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:55:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:55:27 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-lwVlr2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:55:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:55:27 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-xUeLwA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:55:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:55:27 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-kT3JnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:55:27 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:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:55:27 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-VMzZIq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:55:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:55:28 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-V6FfSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:55:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:55:28 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-5VLb88-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:55:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:55:28 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-R_u3Ic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:55:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:28 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-6z0cvZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:55:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:55:28 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-PDnj3z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:55:28 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:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:55:28 INFO - Running setup.py (path:/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/pip-tzlwKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:55:28 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:28 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:28 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:28 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:28 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:28 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:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:31 INFO - Downloading blessings-1.6.tar.gz 01:55:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:55:31 INFO - Installing collected packages: blessings 01:55:31 INFO - Running setup.py install for blessings 01:55:31 INFO - Successfully installed blessings 01:55:31 INFO - Cleaning up... 01:55:31 INFO - Return code: 0 01:55:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:55:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:55:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:55:31 INFO - Reading from file tmpfile_stdout 01:55:31 INFO - Current package versions: 01:55:31 INFO - blessings == 1.6 01:55:31 INFO - blobuploader == 1.2.4 01:55:31 INFO - docopt == 0.6.1 01:55:31 INFO - manifestparser == 1.1 01:55:31 INFO - mozInstall == 1.12 01:55:31 INFO - mozcrash == 0.17 01:55:31 INFO - mozdebug == 0.1 01:55:31 INFO - mozdevice == 0.48 01:55:31 INFO - mozfile == 1.2 01:55:31 INFO - mozhttpd == 0.7 01:55:31 INFO - mozinfo == 0.9 01:55:31 INFO - mozleak == 0.1 01:55:31 INFO - mozlog == 3.1 01:55:31 INFO - moznetwork == 0.27 01:55:31 INFO - mozprocess == 0.22 01:55:31 INFO - mozprofile == 0.28 01:55:31 INFO - mozrunner == 6.11 01:55:31 INFO - mozscreenshot == 0.1 01:55:31 INFO - mozsystemmonitor == 0.0 01:55:31 INFO - moztest == 0.7 01:55:31 INFO - mozversion == 1.4 01:55:31 INFO - psutil == 3.1.1 01:55:31 INFO - requests == 1.2.3 01:55:31 INFO - wsgiref == 0.1.2 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/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 0x10af69a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af79420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8babc8fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae08e00>, '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 0x10ac31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae03b20>, '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.MxRvK42ukp/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.AWHCy4UKYy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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/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:31 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:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MxRvK42ukp/Render', 01:55:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:55:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:55:31 INFO - 'HOME': '/Users/cltbld', 01:55:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:55:31 INFO - 'LOGNAME': 'cltbld', 01:55:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:31 INFO - 'MOZ_NO_REMOTE': '1', 01:55:31 INFO - 'NO_EM_RESTART': '1', 01:55:31 INFO - 'PAGER': '/bin/cat', 01:55:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:55:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:31 INFO - 'PWD': '/builds/slave/test', 01:55:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:55:31 INFO - 'SHELL': '/bin/bash', 01:55:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AWHCy4UKYy/Listeners', 01:55:31 INFO - 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/', 01:55:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:55:31 INFO - 'USER': 'cltbld', 01:55:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:55:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:55:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:31 INFO - 'XPC_FLAGS': '0x0', 01:55:31 INFO - 'XPC_SERVICE_NAME': '0', 01:55:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:55:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:31 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:31 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:31 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:31 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:31 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:31 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:31 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:31 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:31 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:31 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:31 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:31 INFO - Cleaning up... 01:55:31 INFO - Return code: 0 01:55:31 INFO - Installing jsonschema 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', '--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 0x10af69a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af79420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8babc8fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae08e00>, '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 0x10ac31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae03b20>, '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.MxRvK42ukp/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.AWHCy4UKYy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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', '--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:31 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:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MxRvK42ukp/Render', 01:55:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:55:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:55:31 INFO - 'HOME': '/Users/cltbld', 01:55:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:55:31 INFO - 'LOGNAME': 'cltbld', 01:55:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:31 INFO - 'MOZ_NO_REMOTE': '1', 01:55:31 INFO - 'NO_EM_RESTART': '1', 01:55:31 INFO - 'PAGER': '/bin/cat', 01:55:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:55:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:31 INFO - 'PWD': '/builds/slave/test', 01:55:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:55:31 INFO - 'SHELL': '/bin/bash', 01:55:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AWHCy4UKYy/Listeners', 01:55:31 INFO - 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/', 01:55:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:55:31 INFO - 'USER': 'cltbld', 01:55:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:55:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:55:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:31 INFO - 'XPC_FLAGS': '0x0', 01:55:31 INFO - 'XPC_SERVICE_NAME': '0', 01:55:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:55:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:32 INFO - Downloading/unpacking jsonschema 01:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:55:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:55:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:55:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:55:34 INFO - Downloading/unpacking functools32 (from jsonschema) 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:35 INFO - Downloading functools32-3.2.3-2.tar.gz 01:55:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:55:35 INFO - warning: no files found matching '*.txt' 01:55:35 INFO - no previously-included directories found matching 'build' 01:55:35 INFO - no previously-included directories found matching 'dist' 01:55:35 INFO - no previously-included directories found matching '.git*' 01:55:35 INFO - Installing collected packages: jsonschema, functools32 01:55:35 INFO - Running setup.py install for functools32 01:55:35 INFO - warning: no files found matching '*.txt' 01:55:35 INFO - no previously-included directories found matching 'build' 01:55:35 INFO - no previously-included directories found matching 'dist' 01:55:35 INFO - no previously-included directories found matching '.git*' 01:55:35 INFO - Successfully installed jsonschema functools32 01:55:35 INFO - Cleaning up... 01:55:35 INFO - Return code: 0 01:55:35 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:55:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:55:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:55:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:55:35 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 0x10af69a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10af79420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8babc8fd00>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ae08e00>, '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 0x10ac31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae03b20>, '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.MxRvK42ukp/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.AWHCy4UKYy/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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:35 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:35 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:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MxRvK42ukp/Render', 01:55:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:55:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:55:35 INFO - 'HOME': '/Users/cltbld', 01:55:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:55:35 INFO - 'LOGNAME': 'cltbld', 01:55:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:55:35 INFO - 'MOZ_NO_REMOTE': '1', 01:55:35 INFO - 'NO_EM_RESTART': '1', 01:55:35 INFO - 'PAGER': '/bin/cat', 01:55:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:55:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:55:35 INFO - 'PWD': '/builds/slave/test', 01:55:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:55:35 INFO - 'SHELL': '/bin/bash', 01:55:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AWHCy4UKYy/Listeners', 01:55:35 INFO - 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/', 01:55:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:55:35 INFO - 'USER': 'cltbld', 01:55:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:55:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:55:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:55:35 INFO - 'XPC_FLAGS': '0x0', 01:55:35 INFO - 'XPC_SERVICE_NAME': '0', 01:55:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:55:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:55:36 INFO - Downloading/unpacking flake8 01:55:36 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:36 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 - 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:36 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:36 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:36 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:38 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:55:38 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:55:38 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:38 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:38 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:38 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:38 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:38 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:38 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:55:38 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:55:38 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:38 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:38 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:38 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:38 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:38 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:39 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:55:39 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:39 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:39 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:39 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:39 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:39 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:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:55:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:55:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:55:39 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:55:39 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:55:39 INFO - no previously-included directories found matching 'docs/_build' 01:55:39 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:55:39 INFO - Running setup.py install for pep8 01:55:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:55:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:55:40 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:55:40 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:55:40 INFO - no previously-included directories found matching 'docs/_build' 01:55:40 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:55:40 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:55:40 INFO - Cleaning up... 01:55:40 INFO - Return code: 0 01:55:40 INFO - Running post-action listener: _resource_record_post_action 01:55:40 INFO - Running post-action listener: _start_resource_monitoring 01:55:40 INFO - Starting resource monitoring. 01:55:40 INFO - ##### 01:55:40 INFO - ##### Running install step. 01:55:40 INFO - ##### 01:55:40 INFO - Running pre-action listener: _resource_record_pre_action 01:55:40 INFO - Running main action method: install 01:55:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:55:40 INFO - Reading from file tmpfile_stdout 01:55:40 INFO - Detecting whether we're running mozinstall >=1.0... 01:55:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:55:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:55:40 INFO - Reading from file tmpfile_stdout 01:55:40 INFO - Output received: 01:55:40 INFO - Usage: mozinstall [options] installer 01:55:40 INFO - Options: 01:55:40 INFO - -h, --help show this help message and exit 01:55:40 INFO - -d DEST, --destination=DEST 01:55:40 INFO - Directory to install application into. [default: 01:55:40 INFO - "/builds/slave/test"] 01:55:40 INFO - --app=APP Application being installed. [default: firefox] 01:55:40 INFO - mkdir: /builds/slave/test/build/application 01:55:40 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:40 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:14 INFO - Reading from file tmpfile_stdout 01:56:14 INFO - Output received: 01:56:14 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:56:14 INFO - Running post-action listener: _resource_record_post_action 01:56:14 INFO - ##### 01:56:14 INFO - ##### Running run-tests step. 01:56:14 INFO - ##### 01:56:14 INFO - Running pre-action listener: _resource_record_pre_action 01:56:14 INFO - Running main action method: run_tests 01:56:14 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:56:14 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:56:14 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:56:14 INFO - 2016-04-24 01:56:14.648 screenresolution[1662:13472] starting screenresolution argv=screenresolution get 01:56:14 INFO - 2016-04-24 01:56:14.651 screenresolution[1662:13472] Display 0: 1600x1200x32@60 01:56:14 INFO - 2016-04-24 01:56:14.657 screenresolution[1663:13474] starting screenresolution argv=screenresolution list 01:56:14 INFO - Available Modes on Display 0 01:56:14 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:56:14 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:56:14 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:56:14 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:56:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:56:14 INFO - Intel Iris: 01:56:14 INFO - Chipset Model: Intel Iris 01:56:14 INFO - Type: GPU 01:56:14 INFO - Bus: Built-In 01:56:14 INFO - VRAM (Dynamic, Max): 1536 MB 01:56:14 INFO - Vendor: Intel (0x8086) 01:56:14 INFO - Device ID: 0x0a2e 01:56:14 INFO - Revision ID: 0x0009 01:56:14 INFO - Displays: 01:56:14 INFO - Display: 01:56:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:56:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:56:14 INFO - Display Serial Number: 1600x1200 60 01:56:14 INFO - Main Display: Yes 01:56:14 INFO - Mirror: Off 01:56:14 INFO - Online: Yes 01:56:14 INFO - Rotation: Supported 01:56:14 INFO - Return code: 0 01:56:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:56:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:56:14 INFO - Python 2.7.3 01:56:14 INFO - Return code: 0 01:56:14 INFO - grabbing minidump binary from tooltool 01:56:14 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:14 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 0x10ae08e00>, '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 0x10ac31db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ae03b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:56:14 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:14 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:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:56:14 INFO - Return code: 0 01:56:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:56:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:56:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:56:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:56:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:56:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:56:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:56:16 INFO - Return code: 0 01:56:16 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/TfsL5KkuTJ2Nr9j5VDTe_w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0048', '--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:16 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/TfsL5KkuTJ2Nr9j5VDTe_w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0048 --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:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MxRvK42ukp/Render', 01:56:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:56:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:56:16 INFO - 'HOME': '/Users/cltbld', 01:56:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:56:16 INFO - 'LOGNAME': 'cltbld', 01:56:16 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:56:16 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:56:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:56:16 INFO - 'MOZ_NO_REMOTE': '1', 01:56:16 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:56:16 INFO - 'NO_EM_RESTART': '1', 01:56:16 INFO - 'PAGER': '/bin/cat', 01:56:16 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:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:56:16 INFO - 'PWD': '/builds/slave/test', 01:56:16 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:56:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:56:16 INFO - 'SHELL': '/bin/bash', 01:56:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.AWHCy4UKYy/Listeners', 01:56:16 INFO - 'TMPDIR': '/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/', 01:56:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:56:16 INFO - 'USER': 'cltbld', 01:56:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:56:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:56:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:56:16 INFO - 'XPC_FLAGS': '0x0', 01:56:16 INFO - 'XPC_SERVICE_NAME': '0', 01:56:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:56:16 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/TfsL5KkuTJ2Nr9j5VDTe_w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0048', '--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:16 INFO - mozversion application_buildid: 20160424000420 01:56:16 INFO - mozversion application_changeset: 67e03d012ea92d93c128bd8b20bbea7fd6f048a2 01:56:16 INFO - mozversion application_display_name: Nightly 01:56:16 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:56:16 INFO - mozversion application_name: Firefox 01:56:16 INFO - mozversion application_remotingname: firefox 01:56:16 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:56:16 INFO - mozversion application_vendor: Mozilla 01:56:16 INFO - mozversion application_version: 48.0a1 01:56:16 INFO - mozversion platform_buildid: 20160424000420 01:56:16 INFO - mozversion platform_changeset: 67e03d012ea92d93c128bd8b20bbea7fd6f048a2 01:56:16 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:56:16 INFO - mozversion platform_version: 48.0a1 01:56:16 INFO - using testdate: 1461488176 01:56:16 INFO - actual date: 1461488176 01:56:16 INFO - starting webserver on 'localhost:49275' 01:56:16 INFO - SUITE-START | Running 2 tests 01:56:16 INFO - TEST-START | dromaeo_css 01:56:16 INFO - operating with platform_type : mac_ 01:56:16 INFO - Initialising browser for dromaeo_css test... 01:56:16 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/tmpdWRk7O/profile http://localhost:49275/getInfo.html) 01:56:18 INFO - PROCESS | 1681 | __metrics Screen width/height:1600/1200 01:56:18 INFO - PROCESS | 1681 | colorDepth:24 01:56:18 INFO - PROCESS | 1681 | Browser inner width/height: 1024/689 01:56:18 INFO - PROCESS | 1681 | __metrics 01:56:18 INFO - PROCESS | 1681 | 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:18 ERROR - PROCESS | 1681 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 01:56:19 INFO - TEST-INFO | 1681: exit 0 01:56:19 INFO - Browser initialized. 01:56:19 INFO - Running cycle 1/1 for dromaeo_css test... 01:56:19 INFO - TEST-INFO | started process 1684 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/tmpdWRk7O/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:56:31 INFO - PROCESS | 1684 | RSS: Main: 238866432 01:56:31 INFO - PROCESS | 1684 | 01:57:22 INFO - PROCESS | 1684 | 1461488242779 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:33 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 01:59:34 INFO - PROCESS | 1684 | RSS: Main: 349863936 01:59:34 INFO - PROCESS | 1684 | 02:02:37 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 02:02:37 INFO - PROCESS | 1684 | RSS: Main: 378400768 02:02:37 INFO - PROCESS | 1684 | 02:05:39 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 02:05:40 INFO - PROCESS | 1684 | RSS: Main: 377659392 02:05:40 INFO - PROCESS | 1684 | 02:08:42 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 02:08:43 INFO - PROCESS | 1684 | RSS: Main: 373166080 02:08:43 INFO - PROCESS | 1684 | 02:11:46 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 02:11:47 INFO - PROCESS | 1684 | RSS: Main: 338620416 02:11:47 INFO - PROCESS | 1684 | 02:14:50 INFO - PROCESS | 1684 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 02:14:50 INFO - PROCESS | 1684 | RSS: Main: 384270336 02:14:50 INFO - PROCESS | 1684 | 02:14:50 INFO - PROCESS | 1684 | __start_tp_report 02:14:50 INFO - PROCESS | 1684 | _x_x_mozilla_page_load 02:14:50 INFO - PROCESS | 1684 | _x_x_mozilla_page_load_details 02:14:50 INFO - PROCESS | 1684 | |i|pagename|runs| 02:14:50 INFO - PROCESS | 1684 | |0;dojo.html;3357.5803024621923;3422.9828850855743;3424.1268476538485;3437.879674211403;3484.547008888844;4204.873853784384;5598.104303311466;5613.298337707786;5632;5647.40702226266;5564.944350556493;5631.436856314366;5638.492535671789;5649.745761440735;5663.207150998853;5135.614828887829;5152.665076770017;5168.664036837594;5232.973835130819;5237;5197.376314842224;5253.789848406078;5265.842024739264;5267.420583735805;5268.209768534732;5132.076226279269;5172.069027575035;5197.766100525467;5206.817761378353;5312.76092575835;5197.740112994354;5238.161894096965;5239.13554263546;5242.580593552507;5302.946970530323;5042.823501177478;5085.440601533828;5126.282320475137;5165.948340516585;5166.457521960216;5552.805651802168;5564.721763911829;5585.888282234373;5588.86027849303;5589.916151257735;6100.664463454508;6158.414950579688;6158.753649854;6159.414855588712;6168.259808822925;6063.969680151571;6144.341027922481;6148.077788331741;6152.538559608002;6173.81478555644;5743.253377060955;5783.913241301384;5790.218320526759;5805.187273781674;5824.737886795062;6274.372562743689;6278.340774218733;6288.465480434214;6296.622202667854;6314.179156709598;5978.8206353809455;6051.273847138284;6139.6454669416935;6141.293751218578;6149.7847575335545;6239.844003899939;6254.15568898202;6255.030470277115;6260.029695397129;6261.749530018748;4588.7246765194195;6083.300420451616;6157.568970172045;6170.629762214192;6206.875862482725;6037.849053773691;6100.732564372368;6103.186149163621;6199.225096862892;6230.314665386803;4865.464798872121;4865.489123642037;4888.5111488850835;4897.314375987365;4897.4857639947295;4351.760653164043;4372.737635741865;4394.626456751212;4420.7126536775;4426.424564806554;5621.690807005572;5621.831345059655;5625.746841392147;5633.464820842096;5657.038303488417;6214.40963108504;6241.906371404432;6247.843803904939;6258.061290806416;6277.309495955441;5461.508464238238;5588.0779671354585;5604.915926261109;5605.80379686709;5683.0338842396895;5271.077561426811;5271.130263506555;5277.313949186581;5291.153415453586;5316.149416093406;6256.812295631138;6287.2769631492965;6299.653519056405;6301.40136687014;6302.968485157637;6108.75564977396;6143.143438301211;6150.446459818638;6173.104899789595;6240.812775616739;6263.123162757309;6281.371862813682;6299.811005669837;6300.180976473029;6304.432601065742;5984.341722410619;5994.70026498682;6002.069679199731;6006.219191505076;6012.715168236043;6089.391060893875;6123.9232566596775;6132.722655451077;6239.812805615838;6292.433680968735;6042.818715438544;6053.182820319201;6089.756409743738;6090.299615544269;6133.539984501091;6060.454559089703;6088.238970128734;6095.939040609537;6101.7559297627595;6104.481119104926;5606.523445507014;5719.628224165416;5842.123681447817;5889.852753681193;5954.880902382015;6079.513638908965;6102.328743838263;6105.938940610537;6112.113743507078;6114.449699527064;4481.395011673513;5771.538276937918;5886.470217680429;5909.6158749681135;5910.261217347832 02:14:50 INFO - PROCESS | 1684 | |1;ext.html;502.8767951851797;514.716905701864;539.0727947929561;546.3225600255681;581.6422899916553;30233.546496802537;31143.532847007256;31195.68804311956;31229;31231.531527027055;38676;40419.39370909439;40488;40507.39238911412;40537.79731101348;9410.106039926197;9619;9619.422834629944;9635.566399512003;9636.988116247798;7308.196098429168;8816.779580510474;9443.433393996347;9602.231821454267;9613.13481786639;8723.432976856515;8834.028256891768;8840.513771742551;11300.830487542693;11675.941620291887;11334.943325283402;11404.942975285154;11423.828642570368;11430.657080287605;11436.885631143665;11297.548098076068;11447.942760286145;11458.026067784249;11460.541578336857;11476.967072963389;31681.52477712836;39689.404658930136;40530.594694052976;40566;40616.37534498646;3189.521571764254;3198.440272952224;3425.246445781924;3499.4925735768425;3625.818709064536;28836.279093022633;29655.70344296551;29876.103716888312;30416.78332866683;30549.38901221963;2701.9594706079424;2713.050432348682;2738.986305068462;2814.268290244531;2825.095969289828;345587;346043.9999999975;346269.26865365513;346606;347258;55762;56501;56779.43220567824;56812.14781778277;59254.814903701685;61446.38553614496;61771.07343389853;61781;61960;62018;16508.42220522276;16714.749278760828;16762.245698943578;16878.74681879773;17249.482515524553;13072.477100916047;13089.672758181121;13126.409311581001;13137.277449740164;13155.276459794612;13551.119177253448;14822.407103715947;15545.611359715871;15566;15584.92207538955;5838.591298609056;7223.422126229889;7242.674079666428;7266.1280646322775;7269.709211631582;942.707760594218;946.4321407155652;983.6458874805207;1016.8423894296247;1089.8801131875487;27081.86459067692;28088.29779255535;28842.567361489593;28967.420651587272;29024.984125555926;1140.686311264409;1170.69561913903;1199.4782269712703;1213.854337479508;1222.3032871263295;14851.480198193012;14949.551513454397;15347.309371078105;15486.515534004759;15496.690066198838;523001;523244;530834;531184;532159;52157;58007.70996145077;58521.12218316729;59098.704506478054;60499.09251361233;1474.6018574984907;1477.047304488599;1478.36430334957;1492.4776328285232;1494.275276490901;22606.321810345715;27114.72885271122;27521;27837;28040.57939130874;46934.53065469438;47576.286355705386;47638.76180619075;47681;47777.522224777305;629617.5557366551;645801;646852.7657361683;647112.7644361748;763170;24371.878140609893;24627.261182164562;25026;25099.87450062738;25108.62337064982;41392.79303603583;42913.35629965491;43569.78215108904;45062.77468612767;47108.65415208492;34932.77735279253;35886.82056589805;36218.480673479025;36788.44817327688;36850.63149368472;36207.094822629646;36286.818565907;36683;37044;37938.62061379351;35441.82279088691;36520.45219321766;36655.633443665225;37381.6261837389;37482.43776343302;24603.261902142964;31020.75576328934;31607.84196079005;32119;32371.51442728408;22686.773132268467;23695.644565331877;23738.050477980687;23841.761582384646;24564.295573938398 02:14:50 INFO - PROCESS | 1684 | |2;jquery.html;348.9982550087249;392.9332013557695;393.13314142316193;394.8006256840296;416.3213961243173;16761;18907;21214.469638259012;21469.926503674833;21501.354959351243;20656.793432065675;21331.466713332135;21531.784682153175;21599.136034558636;21868.781312186915;5255.684658920477;5843.152742852294;6100.969495152518;6101.35935726749;6123.755049798003;5743.339515955677;6012.75948962041;6015.9398406016035;6053.75784968603;6073.271207455089;5953.3748956359605;5957.136215248786;5972.343042265347;5978.163057171978;5985.910211346833;5743.195952566644;5937.050071988461;6006.129111278862;6016.278046634388;6019.067044608093;5169.483051694838;5195.558377537914;5230.08473517133;5232.581393488512;5235.764390602432;25176;26010.86994565034;26392.60411093835;26415;26535.73464265352;2219.2676416782424;2311.5376924615143;2341.789238968501;2388.665586817847;2645.5899335603012;14239.928800355932;14885.255737213205;14984.850151498455;15022.774658380133;15340.693186136326;1675.899446033242;1700.379361533044;1717.6736420080144;1732.618823858749;1770.3715181110779;99313.50343248309;114992.42503787512;115647.99999999916;116021.41989290084;118592;10807.297525660806;11083.889161108447;11301.717457063474;11340.546378144947;11469.369184694922;14297.78553321701;14394.352254148589;14442.061266017885;14456.927715361357;14478.782818257734;8599.09709480508;8743.125687431206;8793.20861122502;8855.911440885637;8857.501286991732;8782.560871956377;8793.222803810913;8876.112388761072;8957.88026496688;8991.505467199237;6133.601315914451;6520.739170433224;6642.269350371455;6652.8669426611195;6657.367550082734;1563.7732528783263;1653.1568899861156;1838.9356372526897;1839.9172037258356;1843.3087592152942;936.686210119604;959.5934432763661;976.511744127936;1000.4597517340554;1042.3172821801732;19534.31629892947;19970;20830.479238019172;20844.491654324138;21115;919.5034681272172;962.4946902876046;989.5695372512836;1024.3904876598413;1044.9529771160317;10426.791464170674;10822.026017658449;11250;11274.943625281821;11286.887131128748;510423;546409;554828;558975.20512398;565434;108627;112798;114363;114602;115075;1046.5499835070993;1060.7189094889707;1066.4294602387686;1083.8861919498497;1086.1690806533009;18081.728774068662;18485.168167432228;18527.795693279895;18560.814391855907;18582.721259181395;45173.0965380684;46308;46636.7668161657;47038;47290.82069214485;64458;65374.50131482877;65480.67259663671;65615.67192164008;66091.00863486955;5939.960506911187;7577.54534727896;7937.8412431752195;8152.592370381576;8457;11733.413329333669;12244.448999794853;12433.254004759743;12606.306653133799;12640.431180596712;7282.453815963718;10568.524416401435;10754.89245107539;10918.53553768524;11068.059214966817;8903.955480222558;10951.123910087334;10977.506012229309;11134.721631958942;11276.041536469493;9481.203045101849;10978.451077445936;11370.829437558277;11579.88420115788;11694.29834209916;7892.68429262846;8143.104258531675;8310.916890831015;8370.330373569977;8370.58147092655;10137.493125343852;11051.668449946514;11333.433328333715;11355.261907975955;11380.374079425379 02:14:50 INFO - PROCESS | 1684 | |3;mootools.html;1400.3628349101148;1604.4625050608045;1616.9676606467872;1875.8217969292912;2008.417558907916;6502.219733631965;8580.184882436166;8781.42920710155;8791.032986371494;8800.735977920656;8390.91609083909;8644.394892357537;8659.393842431033;8659.523726195073;8663.826723465527;2130.6271402504576;2210.3921421609025;2213.513027134028;2405.9037638494483;2442.6091825307954;2219.4007617943143;2388.9761102389016;2476.616124500696;2479.1075212923333;2482.5407299649532;2404.95190096198;2420.1408499982517;2430.5017471418405;2432.8661923594195;2435;1998.6802111662137;2098.3495116513927;2407.4583218775633;2412.589859723851;2412.7345991940874;2378.3578433822945;2466;2468.0991438124956;2472;2474.4679893822736;8413.537255450949;8495.023072346636;8527.147285271485;8532.360072994488;8546.2308392245;5082.2122571001555;5250.343707036621;5287.762050707727;5297.284866543006;5303.4166241713765;3383.0547435224844;3453.671901169385;3597.010822023938;3598.7660802047785;3603.4414665726854;887.5296093070618;1007.1791489935679;1026.6560702164784;1028.7890982348601;1037.5019990404573;11107.888921110767;11329.603463878808;11330.433478326051;11336.829947550794;11347.092232621371;4621.260598304255;4653.837115700934;4884.5603895649565;4902.656814022984;4911.214205727067;9914.652987145415;9933.304668673269;9944.950275248577;9947.00529947014;9959.05388988045;4472.821087156477;5345.919811202835;5357.19642053695;5398.028354896078;5421.512063914267;4804.231322988305;4813.95186048142;4854.68444551103;4896.4124305083615;4919.655624106278;3778.5843557208686;3800.5819359870393;3882.3011857865854;3903.590123037097;3925.1953349563273;1275.2667216350635;1284.07546566472;1288.256014688707;1290.0969321475004;1313.8029295605736;764.636797521173;827.4952279109739;846.2341580869323;914.6387177065022;974.1378879691524;5546.417626149277;5750.108733146369;5978.133170690313;6025.427584379477;6123.08153776937;931.8648795924553;935.9064093590587;939.4128669581512;945.2438049560325;953.065995324572;3853.306404847154;3936.1340505088833;3991.5409727881665;4039.6768258539246;4044.595540445932;9859.50702464874;10555.89444105549;10636.52135653882;10680.465976701134;10688.51901664427;10314.226433017553;10360.378377297386;10484.737881553023;10581.947090264499;10605.25763196569;7977.242161994601;8092.8381432371025;8106.229908158715;8118.431709780377;8122.878156827653;5606.6636001840025;5775.9133612996675;5804.158397032322;5837.591368604157;5897.174395584536;8474.618642160995;9635.903640963501;9698.806023879342;9852.866920304257;9883.406995580288;8729.781755456164;9030.864537031819;9091.545422728705;10151.035651613085;10151.54318055704;6427.100205971261;6939.201991771011;6964.164300283998;6964.721411143498;6980.476464265099;7962.203779621991;7998.40011999114;8004.91995080065;8023.398245131521;8067.273945344947;7199.460040497089;7264.67308971087;7284.599347035964;7399.630018498946;7405.9629701851145;7029.121359830021;7199.352058314567;7270.600116993404;7318.1949985502615;7360.4479664026485;6837;6856;6902.309769023258;6924.930750692429;6931.896021559782;4681.531846815291;4900.191468407673;4994.300797888226;4996.175631020841;5144.125498665311;4888.437829649636;4901.3138160658245;4955.752212389438;4955.876103097451;5076.923846142237 02:14:50 INFO - PROCESS | 1684 | |4;prototype.html;308.69285061363934;313.2060227323734;322.04995263971284;324.8099861580975;327.9229381095442;4830.710157390559;4935.545118417109;5871.680686128976;5926.199963004993;5982.132590774335;5623.87874729525;5664.20701101845;5787.884242315151;5909.704514774255;5964.314103878055;4354.1944740223;4455.376247325361;4488.124815660947;4504.24801834065;4514.593686568208;3582.5163602913663;3917.001164703011;4481;4492.213862574053;4514.097180563884;4306.117245964585;4474.948387129039;4486.798094085758;4497.280435130379;4502.819887204508;4427.77861106945;4451.955480445186;4462.219111655448;4484.932726009112;4485.170243504946;3869.02679633389;3879.6828711451867;3879.9030024249337;3880.2239552089413;3912.56961734209;5355.634313250096;5380.542653874425;5673.234113394721;5718.170865224519;5793.391693872125;4126.298529250034;4445.733256004618;4814.253790662453;5071.315372424712;5072.442031376546;5125.410577783566;5651.06757385031;6252.937470625327;6336.52476064297;6350.428461438447;3890.280298144824;4151.481064866892;4162.854300099512;4182.456280683522;4194.119234960662;5785.595008349417;5876.7355469004;6515.739370425177;6575.520507885687;6620.933790662128;3699.2601479704167;4035.8901302142144;4225;4237.957620423818;4241.618254357123;3661.908452288714;4066.532348779869;4273.252180868336;4297.226499230169;4308.569143085666;4383.978080109643;4417.851358646711;4999.52504512078;5017.498250175026;5048.924266136011;6102.115193296947;6312.74893429884;6317.842053948688;6323.936760632427;6341.460975817107;1237.1525505029083;1262.4787131506696;1441.228942515749;1499.8275198352112;1500.407339101049;951.8667386565747;951.9190868776232;955.3933252384786;964.1033838530234;968.6851773173747;5778.913316300259;5793.681347525842;5805.970970145122;5829.854253643608;5835.387284335084;6434;6453.708608609549;6468.417842394207;6472.741090356333;6489.67551622417;5071.340725705709;5350.8662283442445;5738.532431054603;5759.078547432391;5796.362400136066;3091.5980922479935;3317.921675455438;3401.744869134825;3409.4715319125576;3415.436452985279;6059.48494377974;6549.967250163814;6699.631520266432;6748.831279218059;6757.493188010919;5172.612054095958;5923.526117910556;6539.50953678476;6674.597145027786;6679.398854103154;6417.903731444126;6710.261871194165;6752.358525940028;6763;6766.853413162903;5410.242566040836;6359.173307470184;6428.614283143026;6440.162778838909;6504.577202482013;5403.540699040625;6285.245770507386;6387;6410.230772307353;6420.743170273324;5637.774489020393;6485.416312531706;6524.934750652433;6800.489963252677;6902.8619427612175;3164.620245570546;3691.557013158438;4151.41880136775;4174.559776876972;4240.893977650583;5700.315962084576;5798.5651076168615;6546.574472659262;6569.605823650596;6581.177352830896;5656.60403771732;5898.174255604133;6319.146915166394;6323.810285691437;6338.58799178052;5296.682199068068;5338.3060202173465;5517.337919449692;6019.548533860066;6312.34881349825;4718.528147185254;6228.781992630236;6234.940060189688;6251.874962500816;6260.186175797117;5554.861128471659;5584.525315348241;6319.620822750466;6335.429811317003;6374.936250637435;5121.385433747974;6202.875942481215;6210.130581718653;6222.968885155546;6242 02:14:50 INFO - PROCESS | 1684 | |5;yui.html;638.3616383616384;716.2586722741961;718.3893690363192;748.4124961904906;755.6675062972295;14801.925990370046;14830;15001.549953501413;15010.474633387834;15028.173450460221;12096;13157;13702.794458083137;13714.657133571665;13776.724465510684;712.7042277454863;887.1926546842375;926.7219834049758;930.483581612205;931.310829985809;914.8170365926808;922.6309476209502;928.6935311347239;929.7768535551453;930.4556834251937;754.1327473405572;984.0356450678339;987.5111819649284;988.2538683294102;991.9931269761162;771.3405038691922;773.0877564473947;775.6276987046193;919.6573003415023;945.2768631996528;690;729.5039373226205;729.6752944939504;729.8248420379124;732.5787672088517;14558.272086395638;14587.562373128823;14617.78073328901;14631.561053168316;14633.195174265411;12246.938765306206;12268.754624907451;12408.56570020045;12424.56514022005;12467.438965246494;9826.557804898797;10006.649767258112;10071.143952764023;10367.948160259226;10757.892421075767;3113.7041981011766;3445.758796884219;3492.4237500812337;3587.497750314958;3588.8743893963588;76312.61843690801;77144;79311;79537.60231198807;79984.60007699924;9422.293328000427;9571.042895710512;9578.808423831484;9599.280053995979;9896.802063958825;21169.15323387047;21346;21350.57298854014;21352;21367.35897923065;7397.593132377771;7420;7445.883117532413;7492.944825041651;7502.062242219723;3343.264481813997;3498.7026102781547;4027.7180597357906;4145.1295228002455;4166.208420400114;3733.3280009598534;3920.4903362562686;3928.175083232496;3929.9214015719526;3932.134930315326;579.2730123694736;671.2984930747381;674.8380388706676;680.6426626021379;689.0972825598482;485.55571651938084;594.881023795234;609.3449541742644;610.0757352610798;613.3161524899793;6529.869402611921;7258.346748792528;7723.420743444264;7925.920740792633;8191.754247372588;556.7717235933247;573.5898832334817;574.643720893049;606.2240332374568;610.6793933185024;3657.8902632921054;3706.240220754739;3825.254075455315;3867.903302417462;3960.3069462844464;82717;83307.5834620823;83421.58289208515;84505;85555.5722221385;73916;74544.25455745481;74625.62687186638;75351.62324188344;77510.6124469374;67870;68189;69430;69916;70059.94910076352;7414.147373052168;7515.549067055994;7745.22547745221;7760.883586746316;7884.566348850868;37334;38678.2264354717;39163.804180978914;39257.607423926536;42458;61938.0709289352;62104.37895620986;63611.045834313445;65030;66438.66780666065;11142.108631309313;11517.942410287895;11568.13239007061;11584.884151158381;11623.88376116228;11666.824997624874;11687.240329378563;11812.527498899948;12349;12390.194637348544;11339.603113890975;11377.886221137682;11453.386746158736;11610.32648752029;11713.472893719632;9357.672481463389;11280.32318060919;11331.603393881174;11452.255603385753;11849.466773995018;10999.285046471954;11041.116710663287;11108.50011749457;11115.277506962022;11472.139589530985;9112.908870911206;9228.35401521887;9329.346945713734;9412.341136120405;9944.35361701487;6645.700943457653;9472.568195554928;9553.358540259629;9592.280578956466;9735.756606084904 02:14:50 INFO - PROCESS | 1684 | __end_tp_report 02:14:50 INFO - PROCESS | 1684 | __start_cc_report 02:14:50 INFO - PROCESS | 1684 | _x_x_mozilla_cycle_collect,1104 02:14:50 INFO - PROCESS | 1684 | __end_cc_report 02:14:50 INFO - PROCESS | 1684 | __startTimestamp1461489290364__endTimestamp 02:14:50 INFO - PROCESS | 1684 | 02:14:50 INFO - PROCESS | 1684 | ------- Summary: start ------- 02:14:50 INFO - PROCESS | 1684 | Number of tests: 6 02:14:50 INFO - PROCESS | 1684 | 02:14:50 INFO - PROCESS | 1684 | [#0] dojo.html Cycles:165 Average:5675.08 Median:5889.85 stddev:644.86 (10.9%) stddev-sans-first:620.68 02:14:50 INFO - PROCESS | 1684 | Values: 3357.6 3423.0 3424.1 3437.9 3484.5 4204.9 5598.1 5613.3 5632.0 5647.4 5564.9 5631.4 5638.5 5649.7 5663.2 5135.6 5152.7 5168.7 5233.0 5237.0 5197.4 5253.8 5265.8 5267.4 5268.2 5132.1 5172.1 5197.8 5206.8 5312.8 5197.7 5238.2 5239.1 5242.6 5302.9 5042.8 5085.4 5126.3 5165.9 5166.5 5552.8 5564.7 5585.9 5588.9 5589.9 6100.7 6158.4 6158.8 6159.4 6168.3 6064.0 6144.3 6148.1 6152.5 6173.8 5743.3 5783.9 5790.2 5805.2 5824.7 6274.4 6278.3 6288.5 6296.6 6314.2 5978.8 6051.3 6139.6 6141.3 6149.8 6239.8 6254.2 6255.0 6260.0 6261.7 4588.7 6083.3 6157.6 6170.6 6206.9 6037.8 6100.7 6103.2 6199.2 6230.3 4865.5 4865.5 4888.5 4897.3 4897.5 4351.8 4372.7 4394.6 4420.7 4426.4 5621.7 5621.8 5625.7 5633.5 5657.0 6214.4 6241.9 6247.8 6258.1 6277.3 5461.5 5588.1 5604.9 5605.8 5683.0 5271.1 5271.1 5277.3 5291.2 5316.1 6256.8 6287.3 6299.7 6301.4 6303.0 6108.8 6143.1 6150.4 6173.1 6240.8 6263.1 6281.4 6299.8 6300.2 6304.4 5984.3 5994.7 6002.1 6006.2 6012.7 6089.4 6123.9 6132.7 6239.8 6292.4 6042.8 6053.2 6089.8 6090.3 6133.5 6060.5 6088.2 6095.9 6101.8 6104.5 5606.5 5719.6 5842.1 5889.9 5954.9 6079.5 6102.3 6105.9 6112.1 6114.4 4481.4 5771.5 5886.5 5909.6 5910.3 02:14:50 INFO - PROCESS | 1684 | 02:14:50 INFO - PROCESS | 1684 | [#1] ext.html Cycles:180 Average:64469.55 Median:346437.63 stddev:142264.99 (41.1%) stddev-sans-first:142583.02 02:14:50 INFO - PROCESS | 1684 | Values: 502.9 514.7 539.1 546.3 581.6 30233.5 31143.5 31195.7 31229.0 31231.5 38676.0 40419.4 40488.0 40507.4 40537.8 9410.1 9619.0 9619.4 9635.6 9637.0 7308.2 8816.8 9443.4 9602.2 9613.1 8723.4 8834.0 8840.5 11300.8 11675.9 11334.9 11404.9 11423.8 11430.7 11436.9 11297.5 11447.9 11458.0 11460.5 11477.0 31681.5 39689.4 40530.6 40566.0 40616.4 3189.5 3198.4 3425.2 3499.5 3625.8 28836.3 29655.7 29876.1 30416.8 30549.4 2702.0 2713.1 2739.0 2814.3 2825.1 345587.0 346044.0 346269.3 346606.0 347258.0 55762.0 56501.0 56779.4 56812.1 59254.8 61446.4 61771.1 61781.0 61960.0 62018.0 16508.4 16714.7 16762.2 16878.7 17249.5 13072.5 13089.7 13126.4 13137.3 13155.3 13551.1 14822.4 15545.6 15566.0 15584.9 5838.6 7223.4 7242.7 7266.1 7269.7 942.7 946.4 983.6 1016.8 1089.9 27081.9 28088.3 28842.6 28967.4 29025.0 1140.7 1170.7 1199.5 1213.9 1222.3 14851.5 14949.6 15347.3 15486.5 15496.7 523001.0 523244.0 530834.0 531184.0 532159.0 52157.0 58007.7 58521.1 59098.7 60499.1 1474.6 1477.0 1478.4 1492.5 1494.3 22606.3 27114.7 27521.0 27837.0 28040.6 46934.5 47576.3 47638.8 47681.0 47777.5 629617.6 645801.0 646852.8 647112.8 763170.0 24371.9 24627.3 25026.0 25099.9 25108.6 41392.8 42913.4 43569.8 45062.8 47108.7 34932.8 35886.8 36218.5 36788.4 36850.6 36207.1 36286.8 36683.0 37044.0 37938.6 35441.8 36520.5 36655.6 37381.6 37482.4 24603.3 31020.8 31607.8 32119.0 32371.5 22686.8 23695.6 23738.1 23841.8 24564.3 02:14:50 INFO - PROCESS | 1684 | 02:14:50 INFO - PROCESS | 1684 | [#2] jquery.html Cycles:180 Average:32679.39 Median:2265.40 stddev:91160.68 (4024.0%) stddev-sans-first:91384.09 02:14:50 INFO - PROCESS | 1684 | Values: 349.0 392.9 393.1 394.8 416.3 16761.0 18907.0 21214.5 21469.9 21501.4 20656.8 21331.5 21531.8 21599.1 21868.8 5255.7 5843.2 6101.0 6101.4 6123.8 5743.3 6012.8 6015.9 6053.8 6073.3 5953.4 5957.1 5972.3 5978.2 5985.9 5743.2 5937.1 6006.1 6016.3 6019.1 5169.5 5195.6 5230.1 5232.6 5235.8 25176.0 26010.9 26392.6 26415.0 26535.7 2219.3 2311.5 2341.8 2388.7 2645.6 14239.9 14885.3 14984.9 15022.8 15340.7 1675.9 1700.4 1717.7 1732.6 1770.4 99313.5 114992.4 115648.0 116021.4 118592.0 10807.3 11083.9 11301.7 11340.5 11469.4 14297.8 14394.4 14442.1 14456.9 14478.8 8599.1 8743.1 8793.2 8855.9 8857.5 8782.6 8793.2 8876.1 8957.9 8991.5 6133.6 6520.7 6642.3 6652.9 6657.4 1563.8 1653.2 1838.9 1839.9 1843.3 936.7 959.6 976.5 1000.5 1042.3 19534.3 19970.0 20830.5 20844.5 21115.0 919.5 962.5 989.6 1024.4 1045.0 10426.8 10822.0 11250.0 11274.9 11286.9 510423.0 546409.0 554828.0 558975.2 565434.0 108627.0 112798.0 114363.0 114602.0 115075.0 1046.5 1060.7 1066.4 1083.9 1086.2 18081.7 18485.2 18527.8 18560.8 18582.7 45173.1 46308.0 46636.8 47038.0 47290.8 64458.0 65374.5 65480.7 65615.7 66091.0 5940.0 7577.5 7937.8 8152.6 8457.0 11733.4 12244.4 12433.3 12606.3 12640.4 7282.5 10568.5 10754.9 10918.5 11068.1 8904.0 10951.1 10977.5 11134.7 11276.0 9481.2 10978.5 11370.8 11579.9 11694.3 7892.7 8143.1 8310.9 8370.3 8370.6 10137.5 11051.7 11333.4 11355.3 11380.4 02:14:50 INFO - PROCESS | 1684 | 02:14:50 INFO - PROCESS | 1684 | [#3] mootools.html Cycles:180 Average:5598.83 Median:5113.17 stddev:3082.14 (60.3%) stddev-sans-first:3074.63 02:14:50 INFO - PROCESS | 1684 | Values: 1400.4 1604.5 1617.0 1875.8 2008.4 6502.2 8580.2 8781.4 8791.0 8800.7 8390.9 8644.4 8659.4 8659.5 8663.8 2130.6 2210.4 2213.5 2405.9 2442.6 2219.4 2389.0 2476.6 2479.1 2482.5 2405.0 2420.1 2430.5 2432.9 2435.0 1998.7 2098.3 2407.5 2412.6 2412.7 2378.4 2466.0 2468.1 2472.0 2474.5 8413.5 8495.0 8527.1 8532.4 8546.2 5082.2 5250.3 5287.8 5297.3 5303.4 3383.1 3453.7 3597.0 3598.8 3603.4 887.5 1007.2 1026.7 1028.8 1037.5 11107.9 11329.6 11330.4 11336.8 11347.1 4621.3 4653.8 4884.6 4902.7 4911.2 9914.7 9933.3 9945.0 9947.0 9959.1 4472.8 5345.9 5357.2 5398.0 5421.5 4804.2 4814.0 4854.7 4896.4 4919.7 3778.6 3800.6 3882.3 3903.6 3925.2 1275.3 1284.1 1288.3 1290.1 1313.8 764.6 827.5 846.2 914.6 974.1 5546.4 5750.1 5978.1 6025.4 6123.1 931.9 935.9 939.4 945.2 953.1 3853.3 3936.1 3991.5 4039.7 4044.6 9859.5 10555.9 10636.5 10680.5 10688.5 10314.2 10360.4 10484.7 10581.9 10605.3 7977.2 8092.8 8106.2 8118.4 8122.9 5606.7 5775.9 5804.2 5837.6 5897.2 8474.6 9635.9 9698.8 9852.9 9883.4 8729.8 9030.9 9091.5 10151.0 10151.5 6427.1 6939.2 6964.2 6964.7 6980.5 7962.2 7998.4 8004.9 8023.4 8067.3 7199.5 7264.7 7284.6 7399.6 7406.0 7029.1 7199.4 7270.6 7318.2 7360.4 6837.0 6856.0 6902.3 6924.9 6931.9 4681.5 4900.2 4994.3 4996.2 5144.1 4888.4 4901.3 4955.8 4955.9 5076.9 02:14:50 INFO - PROCESS | 1684 | 02:14:50 INFO - PROCESS | 1684 | [#4] prototype.html Cycles:180 Average:5018.89 Median:5660.41 stddev:1590.59 (28.1%) stddev-sans-first:1555.27 02:14:50 INFO - PROCESS | 1684 | Values: 308.7 313.2 322.0 324.8 327.9 4830.7 4935.5 5871.7 5926.2 5982.1 5623.9 5664.2 5787.9 5909.7 5964.3 4354.2 4455.4 4488.1 4504.2 4514.6 3582.5 3917.0 4481.0 4492.2 4514.1 4306.1 4474.9 4486.8 4497.3 4502.8 4427.8 4452.0 4462.2 4484.9 4485.2 3869.0 3879.7 3879.9 3880.2 3912.6 5355.6 5380.5 5673.2 5718.2 5793.4 4126.3 4445.7 4814.3 5071.3 5072.4 5125.4 5651.1 6252.9 6336.5 6350.4 3890.3 4151.5 4162.9 4182.5 4194.1 5785.6 5876.7 6515.7 6575.5 6620.9 3699.3 4035.9 4225.0 4238.0 4241.6 3661.9 4066.5 4273.3 4297.2 4308.6 4384.0 4417.9 4999.5 5017.5 5048.9 6102.1 6312.7 6317.8 6323.9 6341.5 1237.2 1262.5 1441.2 1499.8 1500.4 951.9 951.9 955.4 964.1 968.7 5778.9 5793.7 5806.0 5829.9 5835.4 6434.0 6453.7 6468.4 6472.7 6489.7 5071.3 5350.9 5738.5 5759.1 5796.4 3091.6 3317.9 3401.7 3409.5 3415.4 6059.5 6550.0 6699.6 6748.8 6757.5 5172.6 5923.5 6539.5 6674.6 6679.4 6417.9 6710.3 6752.4 6763.0 6766.9 5410.2 6359.2 6428.6 6440.2 6504.6 5403.5 6285.2 6387.0 6410.2 6420.7 5637.8 6485.4 6524.9 6800.5 6902.9 3164.6 3691.6 4151.4 4174.6 4240.9 5700.3 5798.6 6546.6 6569.6 6581.2 5656.6 5898.2 6319.1 6323.8 6338.6 5296.7 5338.3 5517.3 6019.5 6312.3 4718.5 6228.8 6234.9 6251.9 6260.2 5554.9 5584.5 6319.6 6335.4 6374.9 5121.4 6202.9 6210.1 6223.0 6242.0 02:14:50 INFO - PROCESS | 1684 | 02:14:50 INFO - PROCESS | 1684 | [#5] yui.html Cycles:180 Average:17394.70 Median:62857.71 stddev:24128.19 (38.4%) stddev-sans-first:24163.07 02:14:50 INFO - PROCESS | 1684 | Values: 638.4 716.3 718.4 748.4 755.7 14801.9 14830.0 15001.5 15010.5 15028.2 12096.0 13157.0 13702.8 13714.7 13776.7 712.7 887.2 926.7 930.5 931.3 914.8 922.6 928.7 929.8 930.5 754.1 984.0 987.5 988.3 992.0 771.3 773.1 775.6 919.7 945.3 690.0 729.5 729.7 729.8 732.6 14558.3 14587.6 14617.8 14631.6 14633.2 12246.9 12268.8 12408.6 12424.6 12467.4 9826.6 10006.6 10071.1 10367.9 10757.9 3113.7 3445.8 3492.4 3587.5 3588.9 76312.6 77144.0 79311.0 79537.6 79984.6 9422.3 9571.0 9578.8 9599.3 9896.8 21169.2 21346.0 21350.6 21352.0 21367.4 7397.6 7420.0 7445.9 7492.9 7502.1 3343.3 3498.7 4027.7 4145.1 4166.2 3733.3 3920.5 3928.2 3929.9 3932.1 579.3 671.3 674.8 680.6 689.1 485.6 594.9 609.3 610.1 613.3 6529.9 7258.3 7723.4 7925.9 8191.8 556.8 573.6 574.6 606.2 610.7 3657.9 3706.2 3825.3 3867.9 3960.3 82717.0 83307.6 83421.6 84505.0 85555.6 73916.0 74544.3 74625.6 75351.6 77510.6 67870.0 68189.0 69430.0 69916.0 70059.9 7414.1 7515.5 7745.2 7760.9 7884.6 37334.0 38678.2 39163.8 39257.6 42458.0 61938.1 62104.4 63611.0 65030.0 66438.7 11142.1 11517.9 11568.1 11584.9 11623.9 11666.8 11687.2 11812.5 12349.0 12390.2 11339.6 11377.9 11453.4 11610.3 11713.5 9357.7 11280.3 11331.6 11452.3 11849.5 10999.3 11041.1 11108.5 11115.3 11472.1 9112.9 9228.4 9329.3 9412.3 9944.4 6645.7 9472.6 9553.4 9592.3 9735.8 02:14:50 INFO - PROCESS | 1684 | -------- Summary: end -------- 02:14:50 INFO - PROCESS | 1684 | 02:14:50 INFO - TEST-INFO | 1684: exit 0 02:14:50 INFO - TEST-OK | dromaeo_css | took 1114673ms 02:14:50 INFO - TEST-START | kraken 02:14:50 INFO - operating with platform_type : mac_ 02:14:50 INFO - Initialising browser for kraken test... 02:14:50 INFO - TEST-INFO | started process 1692 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/tmp9hpz1A/profile http://localhost:49275/getInfo.html) 02:14:53 INFO - PROCESS | 1692 | __metrics Screen width/height:1600/1200 02:14:53 INFO - PROCESS | 1692 | colorDepth:24 02:14:53 INFO - PROCESS | 1692 | Browser inner width/height: 1024/689 02:14:53 INFO - PROCESS | 1692 | __metrics 02:14:53 INFO - PROCESS | 1692 | 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:53 ERROR - PROCESS | 1692 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 02:14:54 INFO - TEST-INFO | 1692: exit 0 02:14:54 INFO - Browser initialized. 02:14:54 INFO - Running cycle 1/1 for kraken test... 02:14:54 INFO - TEST-INFO | started process 1694 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/T/tmp9hpz1A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 02:15:06 INFO - PROCESS | 1694 | RSS: Main: 239108096 02:15:06 INFO - PROCESS | 1694 | 02:15:08 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 02:15:09 INFO - PROCESS | 1694 | RSS: Main: 286384128 02:15:09 INFO - PROCESS | 1694 | 02:15:12 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 02:15:13 INFO - PROCESS | 1694 | RSS: Main: 299769856 02:15:13 INFO - PROCESS | 1694 | 02:15:16 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 02:15:17 INFO - PROCESS | 1694 | RSS: Main: 387616768 02:15:17 INFO - PROCESS | 1694 | 02:15:19 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 02:15:19 INFO - PROCESS | 1694 | RSS: Main: 286957568 02:15:19 INFO - PROCESS | 1694 | 02:15:21 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 02:15:22 INFO - PROCESS | 1694 | RSS: Main: 291057664 02:15:22 INFO - PROCESS | 1694 | 02:15:25 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 02:15:25 INFO - PROCESS | 1694 | RSS: Main: 329781248 02:15:25 INFO - PROCESS | 1694 | 02:15:28 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 02:15:29 INFO - PROCESS | 1694 | RSS: Main: 330883072 02:15:29 INFO - PROCESS | 1694 | 02:15:32 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 02:15:32 INFO - PROCESS | 1694 | RSS: Main: 328949760 02:15:32 INFO - PROCESS | 1694 | 02:15:34 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 02:15:34 INFO - PROCESS | 1694 | RSS: Main: 321597440 02:15:34 INFO - PROCESS | 1694 | 02:15:36 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 02:15:37 INFO - PROCESS | 1694 | RSS: Main: 328761344 02:15:37 INFO - PROCESS | 1694 | 02:15:39 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 02:15:40 INFO - PROCESS | 1694 | RSS: Main: 330059776 02:15:40 INFO - PROCESS | 1694 | 02:15:42 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 02:15:43 INFO - PROCESS | 1694 | RSS: Main: 335282176 02:15:43 INFO - PROCESS | 1694 | 02:15:46 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 02:15:47 INFO - PROCESS | 1694 | RSS: Main: 333021184 02:15:47 INFO - PROCESS | 1694 | 02:15:48 INFO - PROCESS | 1694 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 02:15:49 INFO - PROCESS | 1694 | RSS: Main: 398012416 02:15:49 INFO - PROCESS | 1694 | 02:15:49 INFO - PROCESS | 1694 | __start_tp_report 02:15:49 INFO - PROCESS | 1694 | _x_x_mozilla_page_load 02:15:49 INFO - PROCESS | 1694 | _x_x_mozilla_page_load_details 02:15:49 INFO - PROCESS | 1694 | |i|pagename|runs| 02:15:49 INFO - PROCESS | 1694 | |0;ai-astar;113;111;108;112;112;112;112;111;105;112 02:15:49 INFO - PROCESS | 1694 | |1;audio-beat-detection;160;122;142;180;145;172;167;151;173;119 02:15:49 INFO - PROCESS | 1694 | |2;audio-dft;184;185;185;184;184;186;181;183;184;186 02:15:49 INFO - PROCESS | 1694 | |3;audio-fft;78;71;86;92;56;59;58;81;85;55 02:15:49 INFO - PROCESS | 1694 | |4;audio-oscillator;90;92;135;77;79;83;125;80;76;118 02:15:49 INFO - PROCESS | 1694 | |5;imaging-gaussian-blur;90;88;94;91;89;86;95;92;90;85 02:15:49 INFO - PROCESS | 1694 | |6;imaging-darkroom;95;95;95;95;95;94;94;92;95;93 02:15:49 INFO - PROCESS | 1694 | |7;imaging-desaturate;84;85;85;86;86;86;86;87;86;88 02:15:49 INFO - PROCESS | 1694 | |8;json-parse-financial;59;62;63;59;58;59;59;78;60;59 02:15:49 INFO - PROCESS | 1694 | |9;json-stringify-tinderbox;64;64;67;74;73;69;66;67;68;68 02:15:49 INFO - PROCESS | 1694 | |10;stanford-crypto-aes;83;81;82;83;82;81;82;81;81;85 02:15:49 INFO - PROCESS | 1694 | |11;stanford-crypto-ccm;138;139;140;139;137;137;136;136;179;139 02:15:49 INFO - PROCESS | 1694 | |12;stanford-crypto-pbkdf2;171;181;171;171;171;170;169;168;171;168 02:15:49 INFO - PROCESS | 1694 | |13;stanford-crypto-sha256-iterative;71;68;70;68;70;68;67;68;67;68 02:15:49 INFO - PROCESS | 1694 | __end_tp_report 02:15:49 INFO - PROCESS | 1694 | __start_cc_report 02:15:49 INFO - PROCESS | 1694 | _x_x_mozilla_cycle_collect,1988 02:15:49 INFO - PROCESS | 1694 | __end_cc_report 02:15:49 INFO - PROCESS | 1694 | __startTimestamp1461489349075__endTimestamp 02:15:49 INFO - PROCESS | 1694 | 02:15:49 INFO - PROCESS | 1694 | ------- Summary: start ------- 02:15:49 INFO - PROCESS | 1694 | Number of tests: 14 02:15:49 INFO - PROCESS | 1694 | 02:15:49 INFO - PROCESS | 1694 | [#0] ai-astar Cycles:10 Average:110.80 Median:112.00 stddev:2.44 (2.2%) stddev-sans-first:2.46 02:15:49 INFO - PROCESS | 1694 | Values: 113.0 111.0 108.0 112.0 112.0 112.0 112.0 111.0 105.0 112.0 02:15:49 INFO - PROCESS | 1694 | 02:15:49 INFO - PROCESS | 1694 | [#1] audio-beat-detection Cycles:10 Average:153.10 Median:163.50 stddev:21.19 (13.0%) stddev-sans-first:22.33 02:15:49 INFO - PROCESS | 1694 | Values: 160.0 122.0 142.0 180.0 145.0 172.0 167.0 151.0 173.0 119.0 02:15:49 INFO - PROCESS | 1694 | 02:15:49 INFO - PROCESS | 1694 | [#2] audio-dft Cycles:10 Average:184.20 Median:184.50 stddev:1.48 (0.8%) stddev-sans-first:1.56 02:15:49 INFO - PROCESS | 1694 | Values: 184.0 185.0 185.0 184.0 184.0 186.0 181.0 183.0 184.0 186.0 02:15:49 INFO - PROCESS | 1694 | 02:15:49 INFO - PROCESS | 1694 | [#3] audio-fft Cycles:10 Average:72.10 Median:79.50 stddev:14.11 (17.8%) stddev-sans-first:14.81 02:15:49 INFO - PROCESS | 1694 | Values: 78.0 71.0 86.0 92.0 56.0 59.0 58.0 81.0 85.0 55.0 02:15:49 INFO - PROCESS | 1694 | 02:15:49 INFO - PROCESS | 1694 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:79.50 stddev:22.04 (27.7%) stddev-sans-first:23.28 02:15:49 INFO - PROCESS | 1694 | Values: 90.0 92.0 135.0 77.0 79.0 83.0 125.0 80.0 76.0 118.0 02:15:49 INFO - PROCESS | 1694 | 02:15:49 INFO - PROCESS | 1694 | [#5] imaging-gaussian-blur Cycles:10 Average:90.00 Median:90.50 stddev:3.20 (3.5%) stddev-sans-first:3.39 02:15:49 INFO - PROCESS | 1694 | Values: 90.0 88.0 94.0 91.0 89.0 86.0 95.0 92.0 90.0 85.0 02:15:49 INFO - PROCESS | 1694 | 02:15:49 INFO - PROCESS | 1694 | [#6] imaging-darkroom Cycles:10 Average:94.30 Median:95.00 stddev:1.06 (1.1%) stddev-sans-first:1.09 02:15:49 INFO - PROCESS | 1694 | Values: 95.0 95.0 95.0 95.0 95.0 94.0 94.0 92.0 95.0 93.0 02:15:49 INFO - PROCESS | 1694 | 02:15:49 INFO - PROCESS | 1694 | [#7] imaging-desaturate Cycles:10 Average:85.90 Median:86.00 stddev:1.10 (1.3%) stddev-sans-first:0.93 02:15:49 INFO - PROCESS | 1694 | Values: 84.0 85.0 85.0 86.0 86.0 86.0 86.0 87.0 86.0 88.0 02:15:49 INFO - PROCESS | 1694 | 02:15:49 INFO - PROCESS | 1694 | [#8] json-parse-financial Cycles:10 Average:61.60 Median:59.50 stddev:5.97 (10.0%) stddev-sans-first:6.25 02:15:49 INFO - PROCESS | 1694 | Values: 59.0 62.0 63.0 59.0 58.0 59.0 59.0 78.0 60.0 59.0 02:15:49 INFO - PROCESS | 1694 | 02:15:49 INFO - PROCESS | 1694 | [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:3.33 (4.9%) stddev-sans-first:3.21 02:15:49 INFO - PROCESS | 1694 | Values: 64.0 64.0 67.0 74.0 73.0 69.0 66.0 67.0 68.0 68.0 02:15:49 INFO - PROCESS | 1694 | 02:15:49 INFO - PROCESS | 1694 | [#10] stanford-crypto-aes Cycles:10 Average:82.10 Median:82.00 stddev:1.29 (1.6%) stddev-sans-first:1.32 02:15:49 INFO - PROCESS | 1694 | Values: 83.0 81.0 82.0 83.0 82.0 81.0 82.0 81.0 81.0 85.0 02:15:49 INFO - PROCESS | 1694 | 02:15:49 INFO - PROCESS | 1694 | [#11] stanford-crypto-ccm Cycles:10 Average:142.00 Median:139.00 stddev:13.07 (9.4%) stddev-sans-first:13.79 02:15:49 INFO - PROCESS | 1694 | Values: 138.0 139.0 140.0 139.0 137.0 137.0 136.0 136.0 179.0 139.0 02:15:49 INFO - PROCESS | 1694 | 02:15:49 INFO - PROCESS | 1694 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.10 Median:171.00 stddev:3.70 (2.2%) stddev-sans-first:3.92 02:15:49 INFO - PROCESS | 1694 | Values: 171.0 181.0 171.0 171.0 171.0 170.0 169.0 168.0 171.0 168.0 02:15:49 INFO - PROCESS | 1694 | 02:15:49 INFO - PROCESS | 1694 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.00 stddev:1.35 (2.0%) stddev-sans-first:1.09 02:15:49 INFO - PROCESS | 1694 | Values: 71.0 68.0 70.0 68.0 70.0 68.0 67.0 68.0 67.0 68.0 02:15:49 INFO - PROCESS | 1694 | -------- Summary: end -------- 02:15:49 INFO - PROCESS | 1694 | 02:15:50 INFO - TEST-INFO | 1694: exit 0 02:15:50 INFO - TEST-OK | kraken | took 59088ms 02:15:50 INFO - SUITE-END | took 1173s 02:15:50 INFO - Completed test suite (00:19:33) 02:15:50 INFO - javascript benchmark 02:15:50 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3357.5803024621923, 3422.9828850855743, 3424.1268476538485, 3437.879674211403, 3484.547008888844, 4204.873853784384, 5598.104303311466, 5613.298337707786, 5632.0, 5647.40702226266, 5564.944350556493, 5631.436856314366, 5638.492535671789, 5649.745761440735, 5663.207150998853, 5135.614828887829, 5152.665076770017, 5168.664036837594, 5232.973835130819, 5237.0, 5197.376314842224, 5253.789848406078, 5265.842024739264, 5267.420583735805, 5268.209768534732, 5132.076226279269, 5172.069027575035, 5197.766100525467, 5206.817761378353, 5312.76092575835, 5197.740112994354, 5238.161894096965, 5239.13554263546, 5242.580593552507, 5302.946970530323, 5042.823501177478, 5085.440601533828, 5126.282320475137, 5165.948340516585, 5166.457521960216, 5552.805651802168, 5564.721763911829, 5585.888282234373, 5588.86027849303, 5589.916151257735, 6100.664463454508, 6158.414950579688, 6158.753649854, 6159.414855588712, 6168.259808822925, 6063.969680151571, 6144.341027922481, 6148.077788331741, 6152.538559608002, 6173.81478555644, 5743.253377060955, 5783.913241301384, 5790.218320526759, 5805.187273781674, 5824.737886795062, 6274.372562743689, 6278.340774218733, 6288.465480434214, 6296.622202667854, 6314.179156709598, 5978.8206353809455, 6051.273847138284, 6139.6454669416935, 6141.293751218578, 6149.7847575335545, 6239.844003899939, 6254.15568898202, 6255.030470277115, 6260.029695397129, 6261.749530018748, 4588.7246765194195, 6083.300420451616, 6157.568970172045, 6170.629762214192, 6206.875862482725, 6037.849053773691, 6100.732564372368, 6103.186149163621, 6199.225096862892, 6230.314665386803, 4865.464798872121, 4865.489123642037, 4888.5111488850835, 4897.314375987365, 4897.4857639947295, 4351.760653164043, 4372.737635741865, 4394.626456751212, 4420.7126536775, 4426.424564806554, 5621.690807005572, 5621.831345059655, 5625.746841392147, 5633.464820842096, 5657.038303488417, 6214.40963108504, 6241.906371404432, 6247.843803904939, 6258.061290806416, 6277.309495955441, 5461.508464238238, 5588.0779671354585, 5604.915926261109, 5605.80379686709, 5683.0338842396895, 5271.077561426811, 5271.130263506555, 5277.313949186581, 5291.153415453586, 5316.149416093406, 6256.812295631138, 6287.2769631492965, 6299.653519056405, 6301.40136687014, 6302.968485157637, 6108.75564977396, 6143.143438301211, 6150.446459818638, 6173.104899789595, 6240.812775616739, 6263.123162757309, 6281.371862813682, 6299.811005669837, 6300.180976473029, 6304.432601065742, 5984.341722410619, 5994.70026498682, 6002.069679199731, 6006.219191505076, 6012.715168236043, 6089.391060893875, 6123.9232566596775, 6132.722655451077, 6239.812805615838, 6292.433680968735, 6042.818715438544, 6053.182820319201, 6089.756409743738, 6090.299615544269, 6133.539984501091, 6060.454559089703, 6088.238970128734, 6095.939040609537, 6101.7559297627595, 6104.481119104926, 5606.523445507014, 5719.628224165416, 5842.123681447817, 5889.852753681193, 5954.880902382015, 6079.513638908965, 6102.328743838263, 6105.938940610537, 6112.113743507078, 6114.449699527064, 4481.395011673513, 5771.538276937918, 5886.470217680429, 5909.6158749681135, 5910.261217347832], "value": 5635.945317205989, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [502.8767951851797, 514.716905701864, 539.0727947929561, 546.3225600255681, 581.6422899916553, 30233.546496802537, 31143.532847007256, 31195.68804311956, 31229.0, 31231.531527027055, 38676.0, 40419.39370909439, 40488.0, 40507.39238911412, 40537.79731101348, 9410.106039926197, 9619.0, 9619.422834629944, 9635.566399512003, 9636.988116247798, 7308.196098429168, 8816.779580510474, 9443.433393996347, 9602.231821454267, 9613.13481786639, 8723.432976856515, 8834.028256891768, 8840.513771742551, 11300.830487542693, 11675.941620291887, 11334.943325283402, 11404.942975285154, 11423.828642570368, 11430.657080287605, 11436.885631143665, 11297.548098076068, 11447.942760286145, 11458.026067784249, 11460.541578336857, 11476.967072963389, 31681.52477712836, 39689.404658930136, 40530.594694052976, 40566.0, 40616.37534498646, 3189.521571764254, 3198.440272952224, 3425.246445781924, 3499.4925735768425, 3625.818709064536, 28836.279093022633, 29655.70344296551, 29876.103716888312, 30416.78332866683, 30549.38901221963, 2701.9594706079424, 2713.050432348682, 2738.986305068462, 2814.268290244531, 2825.095969289828, 345587.0, 346043.9999999975, 346269.26865365513, 346606.0, 347258.0, 55762.0, 56501.0, 56779.43220567824, 56812.14781778277, 59254.814903701685, 61446.38553614496, 61771.07343389853, 61781.0, 61960.0, 62018.0, 16508.42220522276, 16714.749278760828, 16762.245698943578, 16878.74681879773, 17249.482515524553, 13072.477100916047, 13089.672758181121, 13126.409311581001, 13137.277449740164, 13155.276459794612, 13551.119177253448, 14822.407103715947, 15545.611359715871, 15566.0, 15584.92207538955, 5838.591298609056, 7223.422126229889, 7242.674079666428, 7266.1280646322775, 7269.709211631582, 942.707760594218, 946.4321407155652, 983.6458874805207, 1016.8423894296247, 1089.8801131875487, 27081.86459067692, 28088.29779255535, 28842.567361489593, 28967.420651587272, 29024.984125555926, 1140.686311264409, 1170.69561913903, 1199.4782269712703, 1213.854337479508, 1222.3032871263295, 14851.480198193012, 14949.551513454397, 15347.309371078105, 15486.515534004759, 15496.690066198838, 523001.0, 523244.0, 530834.0, 531184.0, 532159.0, 52157.0, 58007.70996145077, 58521.12218316729, 59098.704506478054, 60499.09251361233, 1474.6018574984907, 1477.047304488599, 1478.36430334957, 1492.4776328285232, 1494.275276490901, 22606.321810345715, 27114.72885271122, 27521.0, 27837.0, 28040.57939130874, 46934.53065469438, 47576.286355705386, 47638.76180619075, 47681.0, 47777.522224777305, 629617.5557366551, 645801.0, 646852.7657361683, 647112.7644361748, 763170.0, 24371.878140609893, 24627.261182164562, 25026.0, 25099.87450062738, 25108.62337064982, 41392.79303603583, 42913.35629965491, 43569.78215108904, 45062.77468612767, 47108.65415208492, 34932.77735279253, 35886.82056589805, 36218.480673479025, 36788.44817327688, 36850.63149368472, 36207.094822629646, 36286.818565907, 36683.0, 37044.0, 37938.62061379351, 35441.82279088691, 36520.45219321766, 36655.633443665225, 37381.6261837389, 37482.43776343302, 24603.261902142964, 31020.75576328934, 31607.84196079005, 32119.0, 32371.51442728408, 22686.773132268467, 23695.644565331877, 23738.050477980687, 23841.761582384646, 24564.295573938398], "value": 19234.97930013645, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.9982550087249, 392.9332013557695, 393.13314142316193, 394.8006256840296, 416.3213961243173, 16761.0, 18907.0, 21214.469638259012, 21469.926503674833, 21501.354959351243, 20656.793432065675, 21331.466713332135, 21531.784682153175, 21599.136034558636, 21868.781312186915, 5255.684658920477, 5843.152742852294, 6100.969495152518, 6101.35935726749, 6123.755049798003, 5743.339515955677, 6012.75948962041, 6015.9398406016035, 6053.75784968603, 6073.271207455089, 5953.3748956359605, 5957.136215248786, 5972.343042265347, 5978.163057171978, 5985.910211346833, 5743.195952566644, 5937.050071988461, 6006.129111278862, 6016.278046634388, 6019.067044608093, 5169.483051694838, 5195.558377537914, 5230.08473517133, 5232.581393488512, 5235.764390602432, 25176.0, 26010.86994565034, 26392.60411093835, 26415.0, 26535.73464265352, 2219.2676416782424, 2311.5376924615143, 2341.789238968501, 2388.665586817847, 2645.5899335603012, 14239.928800355932, 14885.255737213205, 14984.850151498455, 15022.774658380133, 15340.693186136326, 1675.899446033242, 1700.379361533044, 1717.6736420080144, 1732.618823858749, 1770.3715181110779, 99313.50343248309, 114992.42503787512, 115647.99999999916, 116021.41989290084, 118592.0, 10807.297525660806, 11083.889161108447, 11301.717457063474, 11340.546378144947, 11469.369184694922, 14297.78553321701, 14394.352254148589, 14442.061266017885, 14456.927715361357, 14478.782818257734, 8599.09709480508, 8743.125687431206, 8793.20861122502, 8855.911440885637, 8857.501286991732, 8782.560871956377, 8793.222803810913, 8876.112388761072, 8957.88026496688, 8991.505467199237, 6133.601315914451, 6520.739170433224, 6642.269350371455, 6652.8669426611195, 6657.367550082734, 1563.7732528783263, 1653.1568899861156, 1838.9356372526897, 1839.9172037258356, 1843.3087592152942, 936.686210119604, 959.5934432763661, 976.511744127936, 1000.4597517340554, 1042.3172821801732, 19534.31629892947, 19970.0, 20830.479238019172, 20844.491654324138, 21115.0, 919.5034681272172, 962.4946902876046, 989.5695372512836, 1024.3904876598413, 1044.9529771160317, 10426.791464170674, 10822.026017658449, 11250.0, 11274.943625281821, 11286.887131128748, 510423.0, 546409.0, 554828.0, 558975.20512398, 565434.0, 108627.0, 112798.0, 114363.0, 114602.0, 115075.0, 1046.5499835070993, 1060.7189094889707, 1066.4294602387686, 1083.8861919498497, 1086.1690806533009, 18081.728774068662, 18485.168167432228, 18527.795693279895, 18560.814391855907, 18582.721259181395, 45173.0965380684, 46308.0, 46636.7668161657, 47038.0, 47290.82069214485, 64458.0, 65374.50131482877, 65480.67259663671, 65615.67192164008, 66091.00863486955, 5939.960506911187, 7577.54534727896, 7937.8412431752195, 8152.592370381576, 8457.0, 11733.413329333669, 12244.448999794853, 12433.254004759743, 12606.306653133799, 12640.431180596712, 7282.453815963718, 10568.524416401435, 10754.89245107539, 10918.53553768524, 11068.059214966817, 8903.955480222558, 10951.123910087334, 10977.506012229309, 11134.721631958942, 11276.041536469493, 9481.203045101849, 10978.451077445936, 11370.829437558277, 11579.88420115788, 11694.29834209916, 7892.68429262846, 8143.104258531675, 8310.916890831015, 8370.330373569977, 8370.58147092655, 10137.493125343852, 11051.668449946514, 11333.433328333715, 11355.261907975955, 11380.374079425379], "value": 9600.756465738847, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1400.3628349101148, 1604.4625050608045, 1616.9676606467872, 1875.8217969292912, 2008.417558907916, 6502.219733631965, 8580.184882436166, 8781.42920710155, 8791.032986371494, 8800.735977920656, 8390.91609083909, 8644.394892357537, 8659.393842431033, 8659.523726195073, 8663.826723465527, 2130.6271402504576, 2210.3921421609025, 2213.513027134028, 2405.9037638494483, 2442.6091825307954, 2219.4007617943143, 2388.9761102389016, 2476.616124500696, 2479.1075212923333, 2482.5407299649532, 2404.95190096198, 2420.1408499982517, 2430.5017471418405, 2432.8661923594195, 2435.0, 1998.6802111662137, 2098.3495116513927, 2407.4583218775633, 2412.589859723851, 2412.7345991940874, 2378.3578433822945, 2466.0, 2468.0991438124956, 2472.0, 2474.4679893822736, 8413.537255450949, 8495.023072346636, 8527.147285271485, 8532.360072994488, 8546.2308392245, 5082.2122571001555, 5250.343707036621, 5287.762050707727, 5297.284866543006, 5303.4166241713765, 3383.0547435224844, 3453.671901169385, 3597.010822023938, 3598.7660802047785, 3603.4414665726854, 887.5296093070618, 1007.1791489935679, 1026.6560702164784, 1028.7890982348601, 1037.5019990404573, 11107.888921110767, 11329.603463878808, 11330.433478326051, 11336.829947550794, 11347.092232621371, 4621.260598304255, 4653.837115700934, 4884.5603895649565, 4902.656814022984, 4911.214205727067, 9914.652987145415, 9933.304668673269, 9944.950275248577, 9947.00529947014, 9959.05388988045, 4472.821087156477, 5345.919811202835, 5357.19642053695, 5398.028354896078, 5421.512063914267, 4804.231322988305, 4813.95186048142, 4854.68444551103, 4896.4124305083615, 4919.655624106278, 3778.5843557208686, 3800.5819359870393, 3882.3011857865854, 3903.590123037097, 3925.1953349563273, 1275.2667216350635, 1284.07546566472, 1288.256014688707, 1290.0969321475004, 1313.8029295605736, 764.636797521173, 827.4952279109739, 846.2341580869323, 914.6387177065022, 974.1378879691524, 5546.417626149277, 5750.108733146369, 5978.133170690313, 6025.427584379477, 6123.08153776937, 931.8648795924553, 935.9064093590587, 939.4128669581512, 945.2438049560325, 953.065995324572, 3853.306404847154, 3936.1340505088833, 3991.5409727881665, 4039.6768258539246, 4044.595540445932, 9859.50702464874, 10555.89444105549, 10636.52135653882, 10680.465976701134, 10688.51901664427, 10314.226433017553, 10360.378377297386, 10484.737881553023, 10581.947090264499, 10605.25763196569, 7977.242161994601, 8092.8381432371025, 8106.229908158715, 8118.431709780377, 8122.878156827653, 5606.6636001840025, 5775.9133612996675, 5804.158397032322, 5837.591368604157, 5897.174395584536, 8474.618642160995, 9635.903640963501, 9698.806023879342, 9852.866920304257, 9883.406995580288, 8729.781755456164, 9030.864537031819, 9091.545422728705, 10151.035651613085, 10151.54318055704, 6427.100205971261, 6939.201991771011, 6964.164300283998, 6964.721411143498, 6980.476464265099, 7962.203779621991, 7998.40011999114, 8004.91995080065, 8023.398245131521, 8067.273945344947, 7199.460040497089, 7264.67308971087, 7284.599347035964, 7399.630018498946, 7405.9629701851145, 7029.121359830021, 7199.352058314567, 7270.600116993404, 7318.1949985502615, 7360.4479664026485, 6837.0, 6856.0, 6902.309769023258, 6924.930750692429, 6931.896021559782, 4681.531846815291, 4900.191468407673, 4994.300797888226, 4996.175631020841, 5144.125498665311, 4888.437829649636, 4901.3138160658245, 4955.752212389438, 4955.876103097451, 5076.923846142237], "value": 4528.316704171516, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [308.69285061363934, 313.2060227323734, 322.04995263971284, 324.8099861580975, 327.9229381095442, 4830.710157390559, 4935.545118417109, 5871.680686128976, 5926.199963004993, 5982.132590774335, 5623.87874729525, 5664.20701101845, 5787.884242315151, 5909.704514774255, 5964.314103878055, 4354.1944740223, 4455.376247325361, 4488.124815660947, 4504.24801834065, 4514.593686568208, 3582.5163602913663, 3917.001164703011, 4481.0, 4492.213862574053, 4514.097180563884, 4306.117245964585, 4474.948387129039, 4486.798094085758, 4497.280435130379, 4502.819887204508, 4427.77861106945, 4451.955480445186, 4462.219111655448, 4484.932726009112, 4485.170243504946, 3869.02679633389, 3879.6828711451867, 3879.9030024249337, 3880.2239552089413, 3912.56961734209, 5355.634313250096, 5380.542653874425, 5673.234113394721, 5718.170865224519, 5793.391693872125, 4126.298529250034, 4445.733256004618, 4814.253790662453, 5071.315372424712, 5072.442031376546, 5125.410577783566, 5651.06757385031, 6252.937470625327, 6336.52476064297, 6350.428461438447, 3890.280298144824, 4151.481064866892, 4162.854300099512, 4182.456280683522, 4194.119234960662, 5785.595008349417, 5876.7355469004, 6515.739370425177, 6575.520507885687, 6620.933790662128, 3699.2601479704167, 4035.8901302142144, 4225.0, 4237.957620423818, 4241.618254357123, 3661.908452288714, 4066.532348779869, 4273.252180868336, 4297.226499230169, 4308.569143085666, 4383.978080109643, 4417.851358646711, 4999.52504512078, 5017.498250175026, 5048.924266136011, 6102.115193296947, 6312.74893429884, 6317.842053948688, 6323.936760632427, 6341.460975817107, 1237.1525505029083, 1262.4787131506696, 1441.228942515749, 1499.8275198352112, 1500.407339101049, 951.8667386565747, 951.9190868776232, 955.3933252384786, 964.1033838530234, 968.6851773173747, 5778.913316300259, 5793.681347525842, 5805.970970145122, 5829.854253643608, 5835.387284335084, 6434.0, 6453.708608609549, 6468.417842394207, 6472.741090356333, 6489.67551622417, 5071.340725705709, 5350.8662283442445, 5738.532431054603, 5759.078547432391, 5796.362400136066, 3091.5980922479935, 3317.921675455438, 3401.744869134825, 3409.4715319125576, 3415.436452985279, 6059.48494377974, 6549.967250163814, 6699.631520266432, 6748.831279218059, 6757.493188010919, 5172.612054095958, 5923.526117910556, 6539.50953678476, 6674.597145027786, 6679.398854103154, 6417.903731444126, 6710.261871194165, 6752.358525940028, 6763.0, 6766.853413162903, 5410.242566040836, 6359.173307470184, 6428.614283143026, 6440.162778838909, 6504.577202482013, 5403.540699040625, 6285.245770507386, 6387.0, 6410.230772307353, 6420.743170273324, 5637.774489020393, 6485.416312531706, 6524.934750652433, 6800.489963252677, 6902.8619427612175, 3164.620245570546, 3691.557013158438, 4151.41880136775, 4174.559776876972, 4240.893977650583, 5700.315962084576, 5798.5651076168615, 6546.574472659262, 6569.605823650596, 6581.177352830896, 5656.60403771732, 5898.174255604133, 6319.146915166394, 6323.810285691437, 6338.58799178052, 5296.682199068068, 5338.3060202173465, 5517.337919449692, 6019.548533860066, 6312.34881349825, 4718.528147185254, 6228.781992630236, 6234.940060189688, 6251.874962500816, 6260.186175797117, 5554.861128471659, 5584.525315348241, 6319.620822750466, 6335.429811317003, 6374.936250637435, 5121.385433747974, 6202.875942481215, 6210.130581718653, 6222.968885155546, 6242.0], "value": 4504.7693529750095, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [638.3616383616384, 716.2586722741961, 718.3893690363192, 748.4124961904906, 755.6675062972295, 14801.925990370046, 14830.0, 15001.549953501413, 15010.474633387834, 15028.173450460221, 12096.0, 13157.0, 13702.794458083137, 13714.657133571665, 13776.724465510684, 712.7042277454863, 887.1926546842375, 926.7219834049758, 930.483581612205, 931.310829985809, 914.8170365926808, 922.6309476209502, 928.6935311347239, 929.7768535551453, 930.4556834251937, 754.1327473405572, 984.0356450678339, 987.5111819649284, 988.2538683294102, 991.9931269761162, 771.3405038691922, 773.0877564473947, 775.6276987046193, 919.6573003415023, 945.2768631996528, 690.0, 729.5039373226205, 729.6752944939504, 729.8248420379124, 732.5787672088517, 14558.272086395638, 14587.562373128823, 14617.78073328901, 14631.561053168316, 14633.195174265411, 12246.938765306206, 12268.754624907451, 12408.56570020045, 12424.56514022005, 12467.438965246494, 9826.557804898797, 10006.649767258112, 10071.143952764023, 10367.948160259226, 10757.892421075767, 3113.7041981011766, 3445.758796884219, 3492.4237500812337, 3587.497750314958, 3588.8743893963588, 76312.61843690801, 77144.0, 79311.0, 79537.60231198807, 79984.60007699924, 9422.293328000427, 9571.042895710512, 9578.808423831484, 9599.280053995979, 9896.802063958825, 21169.15323387047, 21346.0, 21350.57298854014, 21352.0, 21367.35897923065, 7397.593132377771, 7420.0, 7445.883117532413, 7492.944825041651, 7502.062242219723, 3343.264481813997, 3498.7026102781547, 4027.7180597357906, 4145.1295228002455, 4166.208420400114, 3733.3280009598534, 3920.4903362562686, 3928.175083232496, 3929.9214015719526, 3932.134930315326, 579.2730123694736, 671.2984930747381, 674.8380388706676, 680.6426626021379, 689.0972825598482, 485.55571651938084, 594.881023795234, 609.3449541742644, 610.0757352610798, 613.3161524899793, 6529.869402611921, 7258.346748792528, 7723.420743444264, 7925.920740792633, 8191.754247372588, 556.7717235933247, 573.5898832334817, 574.643720893049, 606.2240332374568, 610.6793933185024, 3657.8902632921054, 3706.240220754739, 3825.254075455315, 3867.903302417462, 3960.3069462844464, 82717.0, 83307.5834620823, 83421.58289208515, 84505.0, 85555.5722221385, 73916.0, 74544.25455745481, 74625.62687186638, 75351.62324188344, 77510.6124469374, 67870.0, 68189.0, 69430.0, 69916.0, 70059.94910076352, 7414.147373052168, 7515.549067055994, 7745.22547745221, 7760.883586746316, 7884.566348850868, 37334.0, 38678.2264354717, 39163.804180978914, 39257.607423926536, 42458.0, 61938.0709289352, 62104.37895620986, 63611.045834313445, 65030.0, 66438.66780666065, 11142.108631309313, 11517.942410287895, 11568.13239007061, 11584.884151158381, 11623.88376116228, 11666.824997624874, 11687.240329378563, 11812.527498899948, 12349.0, 12390.194637348544, 11339.603113890975, 11377.886221137682, 11453.386746158736, 11610.32648752029, 11713.472893719632, 9357.672481463389, 11280.32318060919, 11331.603393881174, 11452.255603385753, 11849.466773995018, 10999.285046471954, 11041.116710663287, 11108.50011749457, 11115.277506962022, 11472.139589530985, 9112.908870911206, 9228.35401521887, 9329.346945713734, 9412.341136120405, 9944.35361701487, 6645.700943457653, 9472.568195554928, 9553.358540259629, 9592.280578956466, 9735.756606084904], "value": 6737.377678726229, "unit": "score"}], "name": "dromaeo_css", "value": 7231.875129479246, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 111.0, 108.0, 112.0, 112.0, 112.0, 112.0, 111.0, 105.0, 112.0], "value": 110.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 122.0, 142.0, 180.0, 145.0, 172.0, 167.0, 151.0, 173.0, 119.0], "value": 153.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 185.0, 185.0, 184.0, 184.0, 186.0, 181.0, 183.0, 184.0, 186.0], "value": 184.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 71.0, 86.0, 92.0, 56.0, 59.0, 58.0, 81.0, 85.0, 55.0], "value": 72.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 92.0, 135.0, 77.0, 79.0, 83.0, 125.0, 80.0, 76.0, 118.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 88.0, 94.0, 91.0, 89.0, 86.0, 95.0, 92.0, 90.0, 85.0], "value": 90.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 94.0, 92.0, 95.0, 93.0], "value": 94.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 85.0, 85.0, 86.0, 86.0, 86.0, 86.0, 87.0, 86.0, 88.0], "value": 85.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 63.0, 59.0, 58.0, 59.0, 59.0, 78.0, 60.0, 59.0], "value": 61.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 67.0, 74.0, 73.0, 69.0, 66.0, 67.0, 68.0, 68.0], "value": 68.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 81.0, 82.0, 83.0, 82.0, 81.0, 82.0, 81.0, 81.0, 85.0], "value": 82.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 139.0, 140.0, 139.0, 137.0, 137.0, 136.0, 136.0, 179.0, 139.0], "value": 142.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [171.0, 181.0, 171.0, 171.0, 171.0, 170.0, 169.0, 168.0, 171.0, 168.0], "value": 171.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 68.0, 70.0, 68.0, 70.0, 68.0, 67.0, 68.0, 67.0, 68.0], "value": 68.5, "unit": "score"}], "name": "kraken", "value": 1479.1999999999998, "alertThreshold": 2.0}]} 02:15:50 INFO - Return code: 0 02:15:50 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 02:15:50 ERROR - # TBPL SUCCESS # 02:15:50 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 02:15:50 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 02:15:50 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 02:15:50 INFO - 2016-04-24 02:15:50.384 screenresolution[1698:15745] starting screenresolution argv=screenresolution get 02:15:50 INFO - 2016-04-24 02:15:50.387 screenresolution[1698:15745] Display 0: 1600x1200x32@60 02:15:50 INFO - 2016-04-24 02:15:50.394 screenresolution[1699:15748] starting screenresolution argv=screenresolution list 02:15:50 INFO - Available Modes on Display 0 02:15:50 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 02:15:50 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 02:15:50 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 02:15:50 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 02:15:50 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 02:15:50 INFO - Intel Iris: 02:15:50 INFO - Chipset Model: Intel Iris 02:15:50 INFO - Type: GPU 02:15:50 INFO - Bus: Built-In 02:15:50 INFO - VRAM (Dynamic, Max): 1536 MB 02:15:50 INFO - Vendor: Intel (0x8086) 02:15:50 INFO - Device ID: 0x0a2e 02:15:50 INFO - Revision ID: 0x0009 02:15:50 INFO - Displays: 02:15:50 INFO - Display: 02:15:50 INFO - Resolution: 1600 x 1200 @ 60 Hz 02:15:50 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 02:15:50 INFO - Display Serial Number: 1600x1200 60 02:15:50 INFO - Main Display: Yes 02:15:50 INFO - Mirror: Off 02:15:50 INFO - Online: Yes 02:15:50 INFO - Rotation: Supported 02:15:50 INFO - Return code: 0 02:15:50 INFO - Running post-action listener: _resource_record_post_action 02:15:50 INFO - Running post-run listener: _resource_record_post_run 02:15:51 INFO - Total resource usage - Wall time: 1209s; CPU: 53.0%; Read bytes: 33152512; Write bytes: 696841216; Read time: 331; Write time: 1976 02:15:51 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 388680192; Write bytes: 383559168; Read time: 29755; Write time: 747 02:15:51 INFO - run-tests - Wall time: 1176s; CPU: 53.0%; Read bytes: 31362560; Write bytes: 297635328; Read time: 312; Write time: 1190 02:15:51 INFO - Running post-run listener: _upload_blobber_files 02:15:51 INFO - Blob upload gear active. 02:15:51 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 02:15:51 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:51 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:51 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:52 INFO - (blobuploader) - INFO - Open directory for files ... 02:15:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 02:15:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:15:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:15:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 02:15:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:15:53 INFO - (blobuploader) - INFO - Done attempting. 02:15:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 02:15:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 02:15:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 02:15:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 02:15:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 02:15:54 INFO - (blobuploader) - INFO - Done attempting. 02:15:54 INFO - (blobuploader) - INFO - Iteration through files over. 02:15:54 INFO - Return code: 0 02:15:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 02:15:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 02:15:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6eed95ddb107240ae39025425c4b724f985b09f7d70ed74b41c7e6ea1d22b2f7cc307ec4d91f1ec866ba66c04076b05d9d9420d708ceb7211dc63cf68484cffd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/999f40ddd917d2e20943e96cd292c033ad6d150b3e6af5d74e8c047632c584f3ef61e5128545e43226176e53ebc84a28836c066f837354276afad4b39bf4cd78"} 02:15:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 02:15:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 02:15:54 INFO - Contents: 02:15:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/6eed95ddb107240ae39025425c4b724f985b09f7d70ed74b41c7e6ea1d22b2f7cc307ec4d91f1ec866ba66c04076b05d9d9420d708ceb7211dc63cf68484cffd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/999f40ddd917d2e20943e96cd292c033ad6d150b3e6af5d74e8c047632c584f3ef61e5128545e43226176e53ebc84a28836c066f837354276afad4b39bf4cd78"} 02:15:54 INFO - Running post-run listener: copy_logs_to_upload_dir 02:15:54 INFO - Copying logs to upload dir... 02:15:54 INFO - mkdir: /builds/slave/test/build/upload/logs 02:15:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1282.088836 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-04-24 02:15:54.404044) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 02:15:54.407589) ========= 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.MxRvK42ukp/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.AWHCy4UKYy/Listeners TMPDIR=/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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/6eed95ddb107240ae39025425c4b724f985b09f7d70ed74b41c7e6ea1d22b2f7cc307ec4d91f1ec866ba66c04076b05d9d9420d708ceb7211dc63cf68484cffd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/999f40ddd917d2e20943e96cd292c033ad6d150b3e6af5d74e8c047632c584f3ef61e5128545e43226176e53ebc84a28836c066f837354276afad4b39bf4cd78"} build_url:https://queue.taskcluster.net/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011301 build_url: 'https://queue.taskcluster.net/v1/task/TfsL5KkuTJ2Nr9j5VDTe_w/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/6eed95ddb107240ae39025425c4b724f985b09f7d70ed74b41c7e6ea1d22b2f7cc307ec4d91f1ec866ba66c04076b05d9d9420d708ceb7211dc63cf68484cffd", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/999f40ddd917d2e20943e96cd292c033ad6d150b3e6af5d74e8c047632c584f3ef61e5128545e43226176e53ebc84a28836c066f837354276afad4b39bf4cd78"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-24 02:15:54.435939) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 02:15:54.436306) ========= 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.MxRvK42ukp/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.AWHCy4UKYy/Listeners TMPDIR=/var/folders/yb/6_0vgb8j0qs3lyb34nncdvy400000w/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.005170 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-24 02:15:54.484999) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 02:15:54.486611) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-24 02:15:54.487006) ========= ========= Total master_lag: 0.16 =========