builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0148 starttime: 1461830986.04 results: success (0) buildid: 20160427231456 builduid: 31585a60898b4d318e511a0531223b03 revision: 096b59101cdcc89f01ab1cbf1fc482db2a36f49a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 01:09:46.036373) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-28 01:09:46.037114) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 01:09:46.037615) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-28 01:09:46.061581) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 01:09:46.061961) ========= 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.HMS2ghpZ4G/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.vL7HWApvW5/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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-28 01:09:46-- 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% 207M=0s 2016-04-28 01:09:46 (207 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.088679 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 01:09:46.169081) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 01:09:46.169445) ========= 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.HMS2ghpZ4G/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.vL7HWApvW5/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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.027131 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 01:09:46.220618) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-28 01:09:46.220985) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 096b59101cdcc89f01ab1cbf1fc482db2a36f49a --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 096b59101cdcc89f01ab1cbf1fc482db2a36f49a --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HMS2ghpZ4G/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.vL7HWApvW5/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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-28 01:09:46,299 truncating revision to first 12 chars 2016-04-28 01:09:46,299 Setting DEBUG logging. 2016-04-28 01:09:46,299 attempt 1/10 2016-04-28 01:09:46,299 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/096b59101cdc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-28 01:09:47,303 unpacking tar archive at: fx-team-096b59101cdc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.254523 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-28 01:09:47.492892) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 01:09:47.493227) ========= script_repo_revision: 096b59101cdcc89f01ab1cbf1fc482db2a36f49a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-28 01:09:47.493607) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 01:09:47.493884) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-28 01:09:47.508177) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-04-28 01:09:47.508542) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.HMS2ghpZ4G/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.vL7HWApvW5/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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:09:47 INFO - MultiFileLogger online at 20160428 01:09:47 in /builds/slave/test 01:09:47 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 01:09:47 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:09:47 INFO - {'append_to_log': False, 01:09:47 INFO - 'base_work_dir': '/builds/slave/test', 01:09:47 INFO - 'blob_upload_branch': 'Fx-Team', 01:09:47 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:09:47 INFO - 'branch': 'Fx-Team', 01:09:47 INFO - 'buildbot_json_path': 'buildprops.json', 01:09:47 INFO - 'config_files': ('talos/mac_config.py',), 01:09:47 INFO - 'default_actions': ('clobber', 01:09:47 INFO - 'read-buildbot-config', 01:09:47 INFO - 'download-and-extract', 01:09:47 INFO - 'populate-webroot', 01:09:47 INFO - 'create-virtualenv', 01:09:47 INFO - 'install', 01:09:47 INFO - 'run-tests'), 01:09:47 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:09:47 INFO - 'download_minidump_stackwalk': True, 01:09:47 INFO - 'download_symbols': 'ondemand', 01:09:47 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:09:47 INFO - 'tooltool.py': '/tools/tooltool.py', 01:09:47 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:09:47 INFO - '/tools/misc-python/virtualenv.py')}, 01:09:47 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:09:47 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:09:47 INFO - 'installer_path': 'installer.exe', 01:09:47 INFO - 'log_level': 'info', 01:09:47 INFO - 'log_name': 'talos', 01:09:47 INFO - 'log_to_console': True, 01:09:47 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:09:47 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:09:47 INFO - 'opt_config_files': (), 01:09:47 INFO - 'pip_index': False, 01:09:47 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:09:47 INFO - 'cmd': ('bash', 01:09:47 INFO - '-c', 01:09:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:09:47 INFO - 'enabled': True, 01:09:47 INFO - 'halt_on_failure': False, 01:09:47 INFO - 'name': 'check_screen_resolution'},), 01:09:47 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:09:47 INFO - 'cmd': ('bash', 01:09:47 INFO - '-c', 01:09:47 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:09:47 INFO - 'enabled': True, 01:09:47 INFO - 'halt_on_failure': False, 01:09:47 INFO - 'name': 'check_screen_resolution'},), 01:09:47 INFO - 'run_cmd_checks_enabled': True, 01:09:47 INFO - 'sps_profile': False, 01:09:47 INFO - 'sps_profile_interval': 0, 01:09:47 INFO - 'suite': 'dromaeojs-e10s', 01:09:47 INFO - 'system_bits': '32', 01:09:47 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:09:47 INFO - 'title': 't-yosemite-r7-0148', 01:09:47 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:09:47 INFO - 'use_talos_json': True, 01:09:47 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:09:47 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:09:47 INFO - 'work_dir': 'build'} 01:09:47 INFO - ##### 01:09:47 INFO - ##### Running clobber step. 01:09:47 INFO - ##### 01:09:47 INFO - Running pre-action listener: _resource_record_pre_action 01:09:47 INFO - Running main action method: clobber 01:09:47 INFO - rmtree: /builds/slave/test/build 01:09:47 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:09:49 INFO - Running post-action listener: _resource_record_post_action 01:09:49 INFO - ##### 01:09:49 INFO - ##### Running read-buildbot-config step. 01:09:49 INFO - ##### 01:09:49 INFO - Running pre-action listener: _resource_record_pre_action 01:09:49 INFO - Running main action method: read_buildbot_config 01:09:49 INFO - Using buildbot properties: 01:09:49 INFO - { 01:09:49 INFO - "project": "", 01:09:49 INFO - "product": "firefox", 01:09:49 INFO - "script_repo_revision": "production", 01:09:49 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 01:09:49 INFO - "repository": "", 01:09:49 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 01:09:49 INFO - "buildid": "20160427231456", 01:09:49 INFO - "pgo_build": "False", 01:09:49 INFO - "basedir": "/builds/slave/test", 01:09:49 INFO - "buildnumber": 651, 01:09:49 INFO - "slavename": "t-yosemite-r7-0148", 01:09:49 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 01:09:49 INFO - "platform": "yosemite_r7", 01:09:49 INFO - "scheduler": "tests-fx-team-macosx64-talos-7-3600", 01:09:49 INFO - "branch": "fx-team", 01:09:49 INFO - "repo_path": "integration/fx-team", 01:09:49 INFO - "revision": "096b59101cdcc89f01ab1cbf1fc482db2a36f49a", 01:09:49 INFO - "stage_platform": "macosx64", 01:09:49 INFO - "builduid": "31585a60898b4d318e511a0531223b03", 01:09:49 INFO - "slavebuilddir": "test" 01:09:49 INFO - } 01:09:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 01:09:49 INFO - Running post-action listener: _resource_record_post_action 01:09:49 INFO - ##### 01:09:49 INFO - ##### Running download-and-extract step. 01:09:49 INFO - ##### 01:09:49 INFO - Running pre-action listener: _resource_record_pre_action 01:09:49 INFO - Running main action method: download_and_extract 01:09:49 INFO - mkdir: /builds/slave/test/build/tests 01:09:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:09:49 INFO - https://queue.taskcluster.net/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:09:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 01:09:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 01:09:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 01:09:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json'}, attempt #1 01:09:58 INFO - Downloaded 1199 bytes. 01:09:58 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 01:09:58 INFO - Using the following test package requirements: 01:09:58 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 01:09:58 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 01:09:58 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 01:09:58 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 01:09:58 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 01:09:58 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 01:09:58 INFO - u'jsshell-mac.zip'], 01:09:58 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 01:09:58 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 01:09:58 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 01:09:58 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 01:09:58 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 01:09:58 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 01:09:58 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 01:09:58 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 01:09:58 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 01:09:58 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 01:09:58 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 01:09:58 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 01:09: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:09:58 INFO - https://queue.taskcluster.net/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:09:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 01:09:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 01:09:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 01:09:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:10:00 INFO - Downloaded 18116499 bytes. 01:10:00 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:10:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:10:03 INFO - Return code: 0 01:10:03 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip', u'firefox-49.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 01:10:03 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:10:03 INFO - https://queue.taskcluster.net/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:10:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 01:10:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 01:10:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip 01:10:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip'}, attempt #1 01:10:06 INFO - Downloaded 18116499 bytes. 01:10:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:10:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:10:10 INFO - Return code: 0 01:10:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:10:10 INFO - https://queue.taskcluster.net/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:10:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 01:10:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 01:10:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip 01:10:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip'}, attempt #1 01:10:11 INFO - Downloaded 10840145 bytes. 01:10:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:10:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-49.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 01:10:11 INFO - Return code: 0 01:10:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:10:11 INFO - https://queue.taskcluster.net/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 01:10:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 01:10:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 01:10:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 01:10:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg'}, attempt #1 01:10:17 INFO - Downloaded 110188066 bytes. 01:10:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 01:10:17 INFO - mkdir: /builds/slave/test/properties 01:10:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:10:17 INFO - Writing to file /builds/slave/test/properties/build_url 01:10:17 INFO - Contents: 01:10:17 INFO - build_url:https://queue.taskcluster.net/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 01:10:18 INFO - Running post-action listener: _resource_record_post_action 01:10:18 INFO - Running post-action listener: set_extra_try_arguments 01:10:18 INFO - ##### 01:10:18 INFO - ##### Running populate-webroot step. 01:10:18 INFO - ##### 01:10:18 INFO - Running pre-action listener: _resource_record_pre_action 01:10:18 INFO - Running main action method: populate_webroot 01:10:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:10:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:10:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:10:18 INFO - '--tppagecycles', 01:10:18 INFO - '7'], 01:10:18 INFO - 'tests': ['tsvgm']}}, 01:10:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:10:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:10:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:10:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:10:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:10:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:10:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:10:18 INFO - 'talos_options': ['--disable-e10s'], 01:10:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:10:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:10:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:10:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:10:18 INFO - 'talos_options': ['--disable-e10s'], 01:10:18 INFO - 'tests': ['damp', 'tps']}, 01:10:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:10:18 INFO - 'tests': ['damp', 'tps']}, 01:10:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:10:18 INFO - 'tests': ['dromaeo_dom']}, 01:10:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:10:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:10:18 INFO - 'tests': ['a11yr', 01:10:18 INFO - 'ts_paint', 01:10:18 INFO - 'tpaint', 01:10:18 INFO - 'sessionrestore', 01:10:18 INFO - 'sessionrestore_no_auto_restore', 01:10:18 INFO - 'tabpaint']}, 01:10:18 INFO - 'other-e10s': {'tests': ['a11yr', 01:10:18 INFO - 'ts_paint', 01:10:18 INFO - 'tpaint', 01:10:18 INFO - 'sessionrestore', 01:10:18 INFO - 'sessionrestore_no_auto_restore', 01:10:18 INFO - 'tabpaint']}, 01:10:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:10:18 INFO - 'ts_paint', 01:10:18 INFO - 'tpaint', 01:10:18 INFO - 'sessionrestore', 01:10:18 INFO - 'sessionrestore_no_auto_restore', 01:10:18 INFO - 'tabpaint']}, 01:10:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:10:18 INFO - 'ts_paint', 01:10:18 INFO - 'tpaint', 01:10:18 INFO - 'sessionrestore', 01:10:18 INFO - 'sessionrestore_no_auto_restore', 01:10:18 INFO - 'tabpaint']}, 01:10:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:10:18 INFO - 'tests': ['a11yr', 01:10:18 INFO - 'ts_paint', 01:10:18 INFO - 'tpaint', 01:10:18 INFO - 'sessionrestore', 01:10:18 INFO - 'sessionrestore_no_auto_restore', 01:10:18 INFO - 'tabpaint']}, 01:10:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:10:18 INFO - 'tests': ['a11yr', 01:10:18 INFO - 'ts_paint', 01:10:18 INFO - 'tpaint', 01:10:18 INFO - 'sessionrestore', 01:10:18 INFO - 'sessionrestore_no_auto_restore', 01:10:18 INFO - 'tabpaint']}, 01:10:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:10:18 INFO - 'tests': ['tsvgx', 01:10:18 INFO - 'tsvgr_opacity', 01:10:18 INFO - 'tart', 01:10:18 INFO - 'tscrollx', 01:10:18 INFO - 'cart']}, 01:10:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:10:18 INFO - 'tsvgr_opacity', 01:10:18 INFO - 'tart', 01:10:18 INFO - 'tscrollx', 01:10:18 INFO - 'cart']}, 01:10:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:10:18 INFO - 'talos_options': ['--disable-e10s'], 01:10:18 INFO - 'tests': ['tp5o']}, 01:10:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:10:18 INFO - 'tests': ['tp5o']}, 01:10:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:10:18 INFO - 'talos_options': ['--disable-e10s', 01:10:18 INFO - '--xperf_path', 01:10:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:10:18 INFO - 'tests': ['tp5n']}, 01:10:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:10:18 INFO - 'talos_options': ['--xperf_path', 01:10:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:10:18 INFO - 'tests': ['tp5n']}}, 01:10:18 INFO - 'talos.zip': {'path': '', 01:10:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:10:18 INFO - Running post-action listener: _resource_record_post_action 01:10:18 INFO - ##### 01:10:18 INFO - ##### Running create-virtualenv step. 01:10:18 INFO - ##### 01:10:18 INFO - Running pre-action listener: _resource_record_pre_action 01:10:18 INFO - Running main action method: create_virtualenv 01:10:18 INFO - Creating virtualenv /builds/slave/test/build/venv 01:10:18 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:10:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:10:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:10:18 INFO - Using real prefix '/tools/python27' 01:10:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:10:19 INFO - Installing distribute.............................................................................................................................................................................................done. 01:10:22 INFO - Installing pip.................done. 01:10:22 INFO - Return code: 0 01:10:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:10: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:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10: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:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100803a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100813420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f954059ec90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006a2e00>, '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 0x10050bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10069db20>, '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.HMS2ghpZ4G/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.vL7HWApvW5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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:10:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:10:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HMS2ghpZ4G/Render', 01:10:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:10:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:10:22 INFO - 'HOME': '/Users/cltbld', 01:10:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:10:22 INFO - 'LOGNAME': 'cltbld', 01:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:22 INFO - 'MOZ_NO_REMOTE': '1', 01:10:22 INFO - 'NO_EM_RESTART': '1', 01:10:22 INFO - 'PAGER': '/bin/cat', 01:10:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:22 INFO - 'PWD': '/builds/slave/test', 01:10:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:10:22 INFO - 'SHELL': '/bin/bash', 01:10:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vL7HWApvW5/Listeners', 01:10:22 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 01:10:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:10:22 INFO - 'USER': 'cltbld', 01:10:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:10:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:22 INFO - 'XPC_FLAGS': '0x0', 01:10:22 INFO - 'XPC_SERVICE_NAME': '0', 01:10:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:22 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:10:22 INFO - Cleaning up... 01:10:22 INFO - Return code: 0 01:10:22 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:10: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:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10: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:10:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100803a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100813420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f954059ec90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006a2e00>, '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 0x10050bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10069db20>, '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.HMS2ghpZ4G/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.vL7HWApvW5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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:10:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:10:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:10:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HMS2ghpZ4G/Render', 01:10:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:10:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:10:22 INFO - 'HOME': '/Users/cltbld', 01:10:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:10:22 INFO - 'LOGNAME': 'cltbld', 01:10:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:22 INFO - 'MOZ_NO_REMOTE': '1', 01:10:22 INFO - 'NO_EM_RESTART': '1', 01:10:22 INFO - 'PAGER': '/bin/cat', 01:10:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:10:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:22 INFO - 'PWD': '/builds/slave/test', 01:10:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:10:22 INFO - 'SHELL': '/bin/bash', 01:10:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vL7HWApvW5/Listeners', 01:10:22 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 01:10:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:10:22 INFO - 'USER': 'cltbld', 01:10:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:10:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:10:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:22 INFO - 'XPC_FLAGS': '0x0', 01:10:22 INFO - 'XPC_SERVICE_NAME': '0', 01:10:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:10:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:22 INFO - Downloading/unpacking psutil>=0.7.1 01:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:10:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:10:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:10:25 INFO - Installing collected packages: psutil 01:10:25 INFO - Running setup.py install for psutil 01:10:25 INFO - building 'psutil._psutil_osx' extension 01:10:25 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:10:26 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:10:26 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:10:26 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:10:26 INFO - building 'psutil._psutil_posix' extension 01:10:26 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:10:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:10:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:10:26 INFO - ^ 01:10:26 INFO - 1 warning generated. 01:10:26 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:10:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:10:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:10:26 INFO - Successfully installed psutil 01:10:26 INFO - Cleaning up... 01:10:26 INFO - Return code: 0 01:10:26 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:10: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:10:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10: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:10:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:26 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 0x100803a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100813420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f954059ec90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006a2e00>, '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 0x10050bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10069db20>, '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.HMS2ghpZ4G/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.vL7HWApvW5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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:10:26 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:10:26 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:10:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HMS2ghpZ4G/Render', 01:10:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:10:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:10:26 INFO - 'HOME': '/Users/cltbld', 01:10:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:10:26 INFO - 'LOGNAME': 'cltbld', 01:10:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:26 INFO - 'MOZ_NO_REMOTE': '1', 01:10:26 INFO - 'NO_EM_RESTART': '1', 01:10:26 INFO - 'PAGER': '/bin/cat', 01:10:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:10:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:26 INFO - 'PWD': '/builds/slave/test', 01:10:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:10:26 INFO - 'SHELL': '/bin/bash', 01:10:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vL7HWApvW5/Listeners', 01:10:26 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 01:10:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:10:26 INFO - 'USER': 'cltbld', 01:10:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:10:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:10:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:26 INFO - 'XPC_FLAGS': '0x0', 01:10:26 INFO - 'XPC_SERVICE_NAME': '0', 01:10:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:10:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:27 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:29 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:10:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:10:29 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:10:29 INFO - Installing collected packages: mozsystemmonitor 01:10:29 INFO - Running setup.py install for mozsystemmonitor 01:10:29 INFO - Successfully installed mozsystemmonitor 01:10:29 INFO - Cleaning up... 01:10:29 INFO - Return code: 0 01:10:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:10:29 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:10:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:29 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:10:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:29 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 0x100803a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100813420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f954059ec90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006a2e00>, '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 0x10050bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10069db20>, '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.HMS2ghpZ4G/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.vL7HWApvW5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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:10:29 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:10:29 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:10:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HMS2ghpZ4G/Render', 01:10:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:10:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:10:29 INFO - 'HOME': '/Users/cltbld', 01:10:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:10:29 INFO - 'LOGNAME': 'cltbld', 01:10:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:29 INFO - 'MOZ_NO_REMOTE': '1', 01:10:29 INFO - 'NO_EM_RESTART': '1', 01:10:29 INFO - 'PAGER': '/bin/cat', 01:10:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:10:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:29 INFO - 'PWD': '/builds/slave/test', 01:10:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:10:29 INFO - 'SHELL': '/bin/bash', 01:10:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vL7HWApvW5/Listeners', 01:10:29 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 01:10:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:10:29 INFO - 'USER': 'cltbld', 01:10:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:10:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:10:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:29 INFO - 'XPC_FLAGS': '0x0', 01:10:29 INFO - 'XPC_SERVICE_NAME': '0', 01:10:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:10:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:30 INFO - Downloading/unpacking blobuploader==1.2.4 01:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:32 INFO - Downloading blobuploader-1.2.4.tar.gz 01:10:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:10:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:10: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:10: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:10: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:10: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:10: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:10: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:10:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:10:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:10:33 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:10:33 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:10:33 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:10:33 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:10:33 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:10:33 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:10:33 INFO - Downloading docopt-0.6.1.tar.gz 01:10:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:10:33 INFO - Installing collected packages: blobuploader, requests, docopt 01:10:33 INFO - Running setup.py install for blobuploader 01:10:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:10:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:10:34 INFO - Running setup.py install for requests 01:10:34 INFO - Running setup.py install for docopt 01:10:34 INFO - Successfully installed blobuploader requests docopt 01:10:34 INFO - Cleaning up... 01:10:34 INFO - Return code: 0 01:10:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:10: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:10:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10: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:10:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:34 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 0x100803a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100813420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f954059ec90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006a2e00>, '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 0x10050bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10069db20>, '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.HMS2ghpZ4G/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.vL7HWApvW5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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:10:34 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:10:34 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:10:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HMS2ghpZ4G/Render', 01:10:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:10:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:10:34 INFO - 'HOME': '/Users/cltbld', 01:10:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:10:34 INFO - 'LOGNAME': 'cltbld', 01:10:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:34 INFO - 'MOZ_NO_REMOTE': '1', 01:10:34 INFO - 'NO_EM_RESTART': '1', 01:10:34 INFO - 'PAGER': '/bin/cat', 01:10:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:10:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:34 INFO - 'PWD': '/builds/slave/test', 01:10:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:10:34 INFO - 'SHELL': '/bin/bash', 01:10:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vL7HWApvW5/Listeners', 01:10:34 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 01:10:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:10:34 INFO - 'USER': 'cltbld', 01:10:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:10:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:10:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:34 INFO - 'XPC_FLAGS': '0x0', 01:10:34 INFO - 'XPC_SERVICE_NAME': '0', 01:10:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:10:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:10:35 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-xJ1JHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:10:35 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-krtHxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:10:35 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-lLeVpp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:10:35 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-36pJpi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:10:35 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-14uTgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:10:35 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-P6UBMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:10:35 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-1BWb2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:10:35 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-HFHopc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:10:35 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-_RhXWy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:10:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:10:35 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-5OYFDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:10:36 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-VxV0gB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:10:36 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-eTN6DP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:10:36 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-ZhST7H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:10:36 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-HolnCQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:10:36 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-Csac30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:10:36 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-gAVTmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:10:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:10:36 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-iT0dpJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:10:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:10:36 INFO - Running setup.py install for manifestparser 01:10:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:10:36 INFO - Running setup.py install for mozcrash 01:10:37 INFO - Running setup.py install for mozdebug 01:10:37 INFO - Running setup.py install for mozdevice 01:10:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:10:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:10:37 INFO - Running setup.py install for mozfile 01:10:37 INFO - Running setup.py install for mozhttpd 01:10:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:10:37 INFO - Running setup.py install for mozinfo 01:10:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:10:37 INFO - Running setup.py install for mozInstall 01:10:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:10:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:10:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:10:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:10:37 INFO - Running setup.py install for mozleak 01:10:38 INFO - Running setup.py install for mozlog 01:10:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:10:38 INFO - Running setup.py install for moznetwork 01:10:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:10:38 INFO - Running setup.py install for mozprocess 01:10:38 INFO - Running setup.py install for mozprofile 01:10:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:10:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:10:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:10:38 INFO - Running setup.py install for mozrunner 01:10:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:10:38 INFO - Running setup.py install for mozscreenshot 01:10:39 INFO - Running setup.py install for moztest 01:10:39 INFO - Running setup.py install for mozversion 01:10:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:10:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:10:39 INFO - Cleaning up... 01:10:39 INFO - Return code: 0 01:10:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:10:39 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:10:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:39 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:10:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:39 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 0x100803a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100813420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f954059ec90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006a2e00>, '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 0x10050bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10069db20>, '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.HMS2ghpZ4G/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.vL7HWApvW5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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:10:39 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:10:39 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:10:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HMS2ghpZ4G/Render', 01:10:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:10:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:10:39 INFO - 'HOME': '/Users/cltbld', 01:10:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:10:39 INFO - 'LOGNAME': 'cltbld', 01:10:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:39 INFO - 'MOZ_NO_REMOTE': '1', 01:10:39 INFO - 'NO_EM_RESTART': '1', 01:10:39 INFO - 'PAGER': '/bin/cat', 01:10:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:10:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:39 INFO - 'PWD': '/builds/slave/test', 01:10:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:10:39 INFO - 'SHELL': '/bin/bash', 01:10:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vL7HWApvW5/Listeners', 01:10:39 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 01:10:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:10:39 INFO - 'USER': 'cltbld', 01:10:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:10:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:10:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:39 INFO - 'XPC_FLAGS': '0x0', 01:10:39 INFO - 'XPC_SERVICE_NAME': '0', 01:10:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:10:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:10:39 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-HTxFwD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:10:39 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:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:10:39 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-wuH4cO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:10:39 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:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:10:39 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-XUFoTF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:10:39 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:10:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:10:39 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-h6RD3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:10:40 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:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:10:40 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-hHmDVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:10:40 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:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:10:40 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-lEqIzp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:10:40 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:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:10:40 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-8PwlM_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:10:40 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:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:10:40 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-mzIFXa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:10:40 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:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:10:40 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-kvZprm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:10:40 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:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:10:40 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-hSb2Pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:10:40 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:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:10:40 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-Kb_pKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:10:40 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:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:10:40 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-Ad6iLT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:10:40 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:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:10:40 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-XSgS8P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:10:40 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:10:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:10:40 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-wsQA9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:10:41 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:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:10:41 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-WLOesv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:10:41 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:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:10:41 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-XNwp5M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:10:41 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:10:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:10:41 INFO - Running setup.py (path:/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/pip-Gp9Her-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:10:41 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:10:41 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:10:41 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:10:41 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:10:41 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:10:41 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:10:41 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:10:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:10:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:10:43 INFO - Downloading blessings-1.6.tar.gz 01:10:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:10:43 INFO - Installing collected packages: blessings 01:10:43 INFO - Running setup.py install for blessings 01:10:44 INFO - Successfully installed blessings 01:10:44 INFO - Cleaning up... 01:10:44 INFO - Return code: 0 01:10:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:10:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:10:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:10:44 INFO - Reading from file tmpfile_stdout 01:10:44 INFO - Current package versions: 01:10:44 INFO - blessings == 1.6 01:10:44 INFO - blobuploader == 1.2.4 01:10:44 INFO - docopt == 0.6.1 01:10:44 INFO - manifestparser == 1.1 01:10:44 INFO - mozInstall == 1.12 01:10:44 INFO - mozcrash == 0.17 01:10:44 INFO - mozdebug == 0.1 01:10:44 INFO - mozdevice == 0.48 01:10:44 INFO - mozfile == 1.2 01:10:44 INFO - mozhttpd == 0.7 01:10:44 INFO - mozinfo == 0.9 01:10:44 INFO - mozleak == 0.1 01:10:44 INFO - mozlog == 3.1 01:10:44 INFO - moznetwork == 0.27 01:10:44 INFO - mozprocess == 0.22 01:10:44 INFO - mozprofile == 0.28 01:10:44 INFO - mozrunner == 6.11 01:10:44 INFO - mozscreenshot == 0.1 01:10:44 INFO - mozsystemmonitor == 0.0 01:10:44 INFO - moztest == 0.7 01:10:44 INFO - mozversion == 1.4 01:10:44 INFO - psutil == 3.1.1 01:10:44 INFO - requests == 1.2.3 01:10:44 INFO - wsgiref == 0.1.2 01:10:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:10:44 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:10:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:44 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:10:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:44 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 0x100803a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100813420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f954059ec90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006a2e00>, '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 0x10050bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10069db20>, '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.HMS2ghpZ4G/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.vL7HWApvW5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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:10:44 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:10:44 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:10:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HMS2ghpZ4G/Render', 01:10:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:10:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:10:44 INFO - 'HOME': '/Users/cltbld', 01:10:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:10:44 INFO - 'LOGNAME': 'cltbld', 01:10:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:44 INFO - 'MOZ_NO_REMOTE': '1', 01:10:44 INFO - 'NO_EM_RESTART': '1', 01:10:44 INFO - 'PAGER': '/bin/cat', 01:10:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:10:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:44 INFO - 'PWD': '/builds/slave/test', 01:10:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:10:44 INFO - 'SHELL': '/bin/bash', 01:10:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vL7HWApvW5/Listeners', 01:10:44 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 01:10:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:10:44 INFO - 'USER': 'cltbld', 01:10:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:10:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:10:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:44 INFO - 'XPC_FLAGS': '0x0', 01:10:44 INFO - 'XPC_SERVICE_NAME': '0', 01:10:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:45 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:10:45 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:10:45 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:10:45 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:10:45 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:10:45 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:10:45 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:10:45 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:10:45 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:10:45 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:10:45 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:10:45 INFO - Cleaning up... 01:10:45 INFO - Return code: 0 01:10:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:10:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:10:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100803a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100813420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f954059ec90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006a2e00>, '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 0x10050bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10069db20>, '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.HMS2ghpZ4G/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.vL7HWApvW5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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:10:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:10:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:10:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HMS2ghpZ4G/Render', 01:10:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:10:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:10:45 INFO - 'HOME': '/Users/cltbld', 01:10:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:10:45 INFO - 'LOGNAME': 'cltbld', 01:10:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:45 INFO - 'MOZ_NO_REMOTE': '1', 01:10:45 INFO - 'NO_EM_RESTART': '1', 01:10:45 INFO - 'PAGER': '/bin/cat', 01:10:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:10:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:45 INFO - 'PWD': '/builds/slave/test', 01:10:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:10:45 INFO - 'SHELL': '/bin/bash', 01:10:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vL7HWApvW5/Listeners', 01:10:45 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 01:10:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:10:45 INFO - 'USER': 'cltbld', 01:10:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:10:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:10:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:45 INFO - 'XPC_FLAGS': '0x0', 01:10:45 INFO - 'XPC_SERVICE_NAME': '0', 01:10:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:10:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:45 INFO - Downloading/unpacking jsonschema 01:10:45 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:10:45 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:10:45 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:10:45 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:10:45 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:10:45 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:10:48 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:10:48 INFO - Downloading/unpacking functools32 (from jsonschema) 01:10:48 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:10:48 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:10:48 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:10:48 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:10:48 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:10:48 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:10:48 INFO - Downloading functools32-3.2.3-2.tar.gz 01:10:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:10:48 INFO - warning: no files found matching '*.txt' 01:10:48 INFO - no previously-included directories found matching 'build' 01:10:48 INFO - no previously-included directories found matching 'dist' 01:10:48 INFO - no previously-included directories found matching '.git*' 01:10:48 INFO - Installing collected packages: jsonschema, functools32 01:10:48 INFO - Running setup.py install for functools32 01:10:48 INFO - warning: no files found matching '*.txt' 01:10:48 INFO - no previously-included directories found matching 'build' 01:10:48 INFO - no previously-included directories found matching 'dist' 01:10:48 INFO - no previously-included directories found matching '.git*' 01:10:48 INFO - Successfully installed jsonschema functools32 01:10:48 INFO - Cleaning up... 01:10:48 INFO - Return code: 0 01:10:48 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:10:48 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:10:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:10:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:48 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:10:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:10:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:10:48 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 0x100803a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100813420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f954059ec90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1006a2e00>, '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 0x10050bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10069db20>, '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.HMS2ghpZ4G/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.vL7HWApvW5/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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:10:48 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:10:48 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:10:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HMS2ghpZ4G/Render', 01:10:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:10:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:10:48 INFO - 'HOME': '/Users/cltbld', 01:10:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:10:48 INFO - 'LOGNAME': 'cltbld', 01:10:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:10:48 INFO - 'MOZ_NO_REMOTE': '1', 01:10:48 INFO - 'NO_EM_RESTART': '1', 01:10:48 INFO - 'PAGER': '/bin/cat', 01:10:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:10:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:10:48 INFO - 'PWD': '/builds/slave/test', 01:10:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:10:48 INFO - 'SHELL': '/bin/bash', 01:10:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vL7HWApvW5/Listeners', 01:10:48 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 01:10:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:10:48 INFO - 'USER': 'cltbld', 01:10:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:10:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:10:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:10:48 INFO - 'XPC_FLAGS': '0x0', 01:10:48 INFO - 'XPC_SERVICE_NAME': '0', 01:10:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:10:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:10:49 INFO - Downloading/unpacking flake8 01:10:49 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:10:49 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:10:49 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:10:49 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:10:49 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:10:49 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:10:52 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:10:52 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:10:52 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:10:52 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:10:52 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:10:52 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:10:52 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:10:52 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:10:52 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:10:52 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:10:52 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:10:52 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:10:52 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:10:52 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:10:52 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:10:52 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:10:52 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:10:52 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:10:52 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:10:52 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:10:52 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:10:52 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:10:52 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:10:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:10:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:10:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:10:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:10:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:10:53 INFO - no previously-included directories found matching 'docs/_build' 01:10:53 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:10:53 INFO - Running setup.py install for pep8 01:10:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:10:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:10:53 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:10:53 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:10:53 INFO - no previously-included directories found matching 'docs/_build' 01:10:53 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:10:53 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:10:53 INFO - Cleaning up... 01:10:53 INFO - Return code: 0 01:10:53 INFO - Running post-action listener: _resource_record_post_action 01:10:53 INFO - Running post-action listener: _start_resource_monitoring 01:10:53 INFO - Starting resource monitoring. 01:10:53 INFO - ##### 01:10:53 INFO - ##### Running install step. 01:10:53 INFO - ##### 01:10:53 INFO - Running pre-action listener: _resource_record_pre_action 01:10:53 INFO - Running main action method: install 01:10:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:10:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:10:54 INFO - Reading from file tmpfile_stdout 01:10:54 INFO - Detecting whether we're running mozinstall >=1.0... 01:10:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:10:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:10:54 INFO - Reading from file tmpfile_stdout 01:10:54 INFO - Output received: 01:10:54 INFO - Usage: mozinstall [options] installer 01:10:54 INFO - Options: 01:10:54 INFO - -h, --help show this help message and exit 01:10:54 INFO - -d DEST, --destination=DEST 01:10:54 INFO - Directory to install application into. [default: 01:10:54 INFO - "/builds/slave/test"] 01:10:54 INFO - --app=APP Application being installed. [default: firefox] 01:10:54 INFO - mkdir: /builds/slave/test/build/application 01:10:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:10:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 01:11:27 INFO - Reading from file tmpfile_stdout 01:11:27 INFO - Output received: 01:11:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 01:11:27 INFO - Running post-action listener: _resource_record_post_action 01:11:27 INFO - ##### 01:11:27 INFO - ##### Running run-tests step. 01:11:27 INFO - ##### 01:11:27 INFO - Running pre-action listener: _resource_record_pre_action 01:11:27 INFO - Running main action method: run_tests 01:11:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:11:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:11:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:11:27 INFO - 2016-04-28 01:11:27.751 screenresolution[1633:7549] starting screenresolution argv=screenresolution get 01:11:27 INFO - 2016-04-28 01:11:27.754 screenresolution[1633:7549] Display 0: 1600x1200x32@60 01:11:27 INFO - 2016-04-28 01:11:27.759 screenresolution[1634:7551] starting screenresolution argv=screenresolution list 01:11:27 INFO - Available Modes on Display 0 01:11:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:11:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:11:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:11:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:11:27 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:11:27 INFO - Intel Iris: 01:11:27 INFO - Chipset Model: Intel Iris 01:11:27 INFO - Type: GPU 01:11:27 INFO - Bus: Built-In 01:11:27 INFO - VRAM (Dynamic, Max): 1536 MB 01:11:27 INFO - Vendor: Intel (0x8086) 01:11:27 INFO - Device ID: 0x0a2e 01:11:27 INFO - Revision ID: 0x0009 01:11:27 INFO - Displays: 01:11:27 INFO - Display: 01:11:27 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:11:27 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:11:27 INFO - Display Serial Number: 1600x1200 60 01:11:27 INFO - Main Display: Yes 01:11:27 INFO - Mirror: Off 01:11:27 INFO - Online: Yes 01:11:27 INFO - Rotation: Supported 01:11:27 INFO - Return code: 0 01:11:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:11:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:11:27 INFO - Python 2.7.3 01:11:27 INFO - Return code: 0 01:11:27 INFO - grabbing minidump binary from tooltool 01:11:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:11:27 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 0x1006a2e00>, '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 0x10050bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10069db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:11:27 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:11:27 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:11:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:11:28 INFO - Return code: 0 01:11:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:11:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:11:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:11:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:11:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:11:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:11:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:11:29 INFO - Return code: 0 01:11:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0148', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:11:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0148 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:11:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.HMS2ghpZ4G/Render', 01:11:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:11:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:11:29 INFO - 'HOME': '/Users/cltbld', 01:11:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:11:29 INFO - 'LOGNAME': 'cltbld', 01:11:29 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:11:29 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:29 INFO - 'MOZ_NO_REMOTE': '1', 01:11:29 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:11:29 INFO - 'NO_EM_RESTART': '1', 01:11:29 INFO - 'PAGER': '/bin/cat', 01:11:29 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:29 INFO - 'PWD': '/builds/slave/test', 01:11:29 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:11:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:11:29 INFO - 'SHELL': '/bin/bash', 01:11:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.vL7HWApvW5/Listeners', 01:11:29 INFO - 'TMPDIR': '/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/', 01:11:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:11:29 INFO - 'USER': 'cltbld', 01:11:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:11:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:29 INFO - 'XPC_FLAGS': '0x0', 01:11:29 INFO - 'XPC_SERVICE_NAME': '0', 01:11:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:11:29 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0148', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:11:29 INFO - mozversion application_buildid: 20160427231456 01:11:29 INFO - mozversion application_changeset: 096b59101cdcc89f01ab1cbf1fc482db2a36f49a 01:11:29 INFO - mozversion application_display_name: Nightly 01:11:29 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:11:29 INFO - mozversion application_name: Firefox 01:11:29 INFO - mozversion application_remotingname: firefox 01:11:29 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:11:29 INFO - mozversion application_vendor: Mozilla 01:11:29 INFO - mozversion application_version: 49.0a1 01:11:29 INFO - mozversion platform_buildid: 20160427231456 01:11:29 INFO - mozversion platform_changeset: 096b59101cdcc89f01ab1cbf1fc482db2a36f49a 01:11:29 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:11:29 INFO - mozversion platform_version: 49.0a1 01:11:29 INFO - using testdate: 1461831089 01:11:29 INFO - actual date: 1461831089 01:11:29 INFO - starting webserver on 'localhost:49271' 01:11:29 INFO - SUITE-START | Running 2 tests 01:11:29 INFO - TEST-START | dromaeo_css 01:11:29 INFO - operating with platform_type : mac_ 01:11:29 INFO - Initialising browser for dromaeo_css test... 01:11:29 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/tmpdt4r0c/profile http://localhost:49271/getInfo.html) 01:11:32 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 01:11:32 INFO - PROCESS | 1652 | colorDepth:24 01:11:32 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 01:11:32 INFO - PROCESS | 1652 | __metrics 01:11:32 ERROR - PROCESS | 1652 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 01:11:33 INFO - TEST-INFO | 1652: exit 0 01:11:33 INFO - Browser initialized. 01:11:33 INFO - Running cycle 1/1 for dromaeo_css test... 01:11:33 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/tmpdt4r0c/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:11:44 INFO - PROCESS | 1655 | RSS: Main: 249896960 01:11:44 INFO - PROCESS | 1655 | 01:12:34 INFO - PROCESS | 1655 | 1461831154619 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:14:46 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49271/tests/dromaeo/cssquery-ext.html) 01:14:47 INFO - PROCESS | 1655 | RSS: Main: 261689344 01:14:47 INFO - PROCESS | 1655 | 01:17:49 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-ext.html (next: http://localhost:49271/tests/dromaeo/cssquery-jquery.html) 01:17:50 INFO - PROCESS | 1655 | RSS: Main: 274051072 01:17:50 INFO - PROCESS | 1655 | 01:20:52 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49271/tests/dromaeo/cssquery-mootools.html) 01:20:52 INFO - PROCESS | 1655 | RSS: Main: 275697664 01:20:52 INFO - PROCESS | 1655 | 01:23:54 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49271/tests/dromaeo/cssquery-prototype.html) 01:23:55 INFO - PROCESS | 1655 | RSS: Main: 277348352 01:23:55 INFO - PROCESS | 1655 | 01:26:58 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49271/tests/dromaeo/cssquery-yui.html) 01:26:58 INFO - PROCESS | 1655 | RSS: Main: 280190976 01:26:58 INFO - PROCESS | 1655 | 01:30:01 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49271/tests/dromaeo/cssquery-yui.html (next: http://localhost:49271/tests/dromaeo/cssquery-dojo.html) 01:30:01 INFO - PROCESS | 1655 | RSS: Main: 281460736 01:30:01 INFO - PROCESS | 1655 | 01:30:01 INFO - PROCESS | 1655 | __start_tp_report 01:30:01 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 01:30:01 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 01:30:01 INFO - PROCESS | 1655 | |i|pagename|runs| 01:30:01 INFO - PROCESS | 1655 | |0;dojo.html;3325.617553981292;3447.2243745157334;3487.668671476209;3494.7903125812454;3537.964620353796;4467.9329810052795;5744.339400968885;5806.767729290823;5828.737706803194;5839.854003649905;5586.720663966806;5625.465580769831;5701.515371193454;5790.189373487715;5929.080992446177;5126.30794842697;5153.304303918979;5199.350081239845;5205.531502164805;5275.261463395128;5252.6323157379;5282.286891269668;5282.7622756976025;5313.787448502056;5343.919841202385;5147.48525147486;5237.031149237403;5241.3186285782795;5270.472952704698;5272.894542109175;4136;5117.155669314596;5117.82087626935;5120.15517439622;5191.0656081905245;4331.155424692155;5071.746412679351;5096.261042148904;5133.332666753336;5136.332276803992;5536.584756143265;5639.661620302754;5641.407652196502;5684.971575142098;5710.600257981943;6116.3577824328695;6145.139680444741;6155.569110162291;6156.938430615682;6227.06594010902;6126.090206827809;6179.474744646665;6232.532560057968;6237.126802247689;6243.2508099027955;5954.196183515257;5981.312149102821;5989.431004054652;6011.3086994995265;6029;6060;6149.5080393568405;6320.968395158086;6326.177596912372;6352.6823658816875;6065.302490213594;6126.456603435028;6153.341549715768;6202.069689546604;6208.348123446973;6168.8766224675255;6203.47270482005;6208.9689551551955;6220.502359811204;6243.344448832898;6119.326874043852;6172.938270617236;6182.381761823782;6220.377962203744;6235.251769787655;5724.856878578069;6135.509159267248;6213.409726076015;6213.844653883599;6238.376162383725;4898.853034408973;4920.089783390084;4964.404271487445;4978.178600530872;5012.523810238022;4419.580139886705;4460.843870464518;4509.436320459942;4514.683972121986;4521.977390113028;5866.911996320058;5889.823305300848;5909.320428150818;5910.261217347832;5942.286925568873;6131.223750760645;6176.938230617637;6221.253449586078;6240.687965601702;6259.061140828821;5873;5918.911216331759;5930.9406905931255;5944.613600115978;5950.761969521171;5433;5436.103042997861;5453.154761011971;5478.287822583039;5482.972585137049;6155.446009859134;6340;6400.167978162809;6421.293657697743;6435.903461448176;6177.876442471215;6203;6225.688715564113;6235.438810507076;6244.625322480666;6150.477209437069;6459;6464.2889282177985;6465.77369792055;6470.838229044311;6129.633877547049;6182.752689892354;6210.378962103753;6220.129181914626;6258.405451482102;6085.726142323695;6201.81394558164;6216.627002379691;6232.314445411092;6248.562600618095;5352.9732351338;5583.748731307182;6060.606060606046;6204.968975155095;6212;4951.430585482715;6095.299040610386;6109.192117492145;6109.6639684817765;6201.81394558164;5046.419661738947;5929.2884853816095;6084.878302433838;6102.4812890902995;6115.6330620162935;5062.544371006627;5500;6139.508839292936;6195.876082478415;6223.564350495421;6008.369121242382;6016.789412370546;6034.366391528826;6049.153118563493;6109.694515274307 01:30:01 INFO - PROCESS | 1655 | |1;ext.html;513.5044681881984;516.5609232152668;572.2132068405942;591.639100148909;625.7309356976501;36647.51848574384;37413.064673383145;37472.62527374729;37507.812460937654;37579.812100939525;38232.80883595585;38304.04239894004;38896.22207555847;38928.80535597325;39064.80467597658;9122.179003889649;9363.48500832454;9368.110029547182;9386;9404.952975235114;9206.539673016356;9431.104045115737;9511.334206605541;9523.285753568476;9524.666636667718;9416.576254068548;9444.952775236148;9461.148496635302;9548.42709437436;9553.426794392359;9424.198943089845;9475.241980641533;9515.666951656658;9531.38046027013;9531.571079301448;9369.48467834269;9498.382605130644;9499.572519236652;9511.714648560554;9540.856887146698;36982.445263321075;37420;37954.81022594897;38000.619993799985;38004.61995380066;3166.7624928130253;3173.1908363367424;3358.2947581008016;3474.5830500339866;3520.4719292106133;27762.444751104864;28023.87904483818;28377.148685539465;28632.570511442344;28661.57007644887;2735.7401046900513;2735.931601709953;2750.2574304937557;2857.8142420742583;2897.463969165711;401205;404413;404715.99999999703;405445;408257;32407.51388729171;61247;61583.38416615777;61969.760604787654;62127;34030.65969340275;34151.48772768411;34547.65452345445;34552.65447345545;34595.82702086474;12134.817977730341;14463.78304325436;14596.562103136923;14639.48761793332;14851.777223341658;11849.052075833913;11853.34806585646;11861.822072668916;11909.166358354832;11922.76154476923;7921.801954951173;7939.841203175904;7997.080335761462;8036.357091432788;8071.5157090573575;3352.3295340931913;3355.412802759556;3387.9491807622903;3399.9490007649906;3413.0784688134063;948.7770373962113;1028.7376718936623;1042.5100202904623;1055.3509591601264;1135.8977692007593;25840.612390814153;26113.869430653103;28675;28919.71080289212;29478.705212947596;1004.4174378860243;1016.7356487313203;1084.251866212311;1103.2828661370013;1285.6014635463036;11115.555377784798;13786.724265514835;14868.776968345483;15040.323185456462;15267;397932.0103399464;407273;408342;408563;500677;56526.43473565294;56997.715011424676;57910;57952.420475795545;57970.710146449;1453.128123126116;1489.4786824611515;1492.1718446262212;1497.7528707763315;1501.1368463133742;28636.85681571579;29062.85468572728;29084.56373154362;29547.113586592437;29751.55372669455;46585.835354115065;46607.30089048735;46707.53292467032;47312;47636.761816190694;405240;416702;418060;418184;418536;26572.46855062849;26614.866925665247;26921.461570768868;26979.78590963372;27048;42620.360694588984;42816.35775463433;42847.3572896413;43209.78395108004;43615.781921090194;30912.608932598538;32575.674243257265;35894.8205258972;36185.81907090448;36659.63340366562;34992.600295987875;35160.64839351676;35511.46732798959;35600.821995889855;36260.637393626785;33396;34125.82937085398;34322.65677343195;34778;35836.28327433489;28654.57018144771;30732.815754592397;30768.310792628985;30823.2294192638;31091.533626996064;22931.197408090637;23422.297331080095;23869.522609548058;24230.87884560566;24334.63498047495 01:30:01 INFO - PROCESS | 1655 | |2;jquery.html;351.5693275737222;386.58895033129073;398.31887472422164;400.66144108228536;402.13540887092745;17797;18599.442016739504;20081.497962550944;20595;20623.69064464034;19943.60112797747;20387.08258128384;20651.793482065175;20821.27125550606;20965.790342096574;5256.842294731145;5895.115732640095;6069.878602427949;6091.2995005574485;6109.175261339707;5228.607854410915;5974.462298393144;5989.341172471047;5990.251218597676;6055.485283750886;4678.883027924295;5197.558207552363;5563.332400111992;5948.7620495180145;5980.132880732292;4915.336429582015;5904.321003084614;5912.17229587858;5976.88046239075;6141.785037523665;5862.677552734598;5938.792142275;5951.285845698544;5965.075413310944;5992.161097446361;13752.518661846787;14974.550763477113;19914.307283880888;20188.89905550463;25271.115510957214;2051.7230173926478;2102.211670623516;2138.337115494186;2175.8476906616543;2223.3330000999636;9307.162355388047;9927.305088643798;10100.89899101007;10135.695929122137;10157.847632285522;1705.9658806823793;1715.7083295839736;1743.3636722596161;1764.4353806781835;1778.2975724588844;76256;99486.51797187136;104457;106373;106999;11582.88417115835;11667.599888013492;11728.648140555797;11766.058715302755;11870.703232419259;11719.472623731952;14579;14945;14969.625759355886;14998.775018374734;8805.339599530062;8812.427192232613;8825.38222324444;8870.42342247752;8923.107689231025;8743.475391476532;8784.692535761218;8806.427582207136;8894.911050889537;8921.420107692978;4575.2450845610765;4616.953830461653;4656.837010704677;4678.526264226825;4697.271922851964;1920.3470819921295;1988.9204431822855;1996.7004949257728;2011.5976804638838;2041.173324803457;854.9871751923727;908.8909330880336;922.0871337376084;972.9562169702381;993.6273897288517;20166.798332016784;20744;20906.26828061041;21089.472763180736;21138.260160894293;936.9156775890202;944.9338546301831;980.8724865767405;995.3430735714538;1080.4165750494801;10470.895291046992;10507.634007578967;10835.21444695259;10870.239083264254;10905.781884362268;531212;533208;563344;639757;640246;88497.11502885018;105956.47021764841;107978;122542.387288063;128047.35976320245;878.6880657366543;1013.3615822032073;1034.1674951663833;1067.530286673861;1070.3898777696638;14675.779863302272;15930.681386371976;16979.660406791547;17504.337087976623;18451.16969736392;41675.95810104772;46924.7653761729;47710;49317;49852;65894;68451;74243;74273.51452971018;76606.23393766214;7592.506487078323;8013.759587212393;8081.83836323282;8160.959195204224;8329.83340333202;9198.494082825242;11907.702307442383;12055.397230138633;12078.27530348182;12397.44211510466;10489.265751397328;10604.575816967235;10626.787464250827;10775.568977240822;10801;9011.459312441275;10194.541245643815;10501.527431265764;10581.418022008864;10670.73323166927;10803.567857285621;10945.069669078217;11026.724331891766;11221.270617409842;11261.436928153724;7380.483366164317;8267.917320826715;8285.792855178668;8495.915040849512;8528.019277783134;8112.959435202786;9481.905180948102;9726.416415015121;10818.56725730962;10978.341299521735 01:30:01 INFO - PROCESS | 1655 | |3;mootools.html;1603.2865374908167;1634.460627992762;1881.1910878322317;1932.565172836112;1959.284861025726;8036.638351274192;8606.268467180282;8608.698695545658;8980.101989801016;8998.775030624238;8593.957030214855;8656.437331573443;8720.738377848675;8727.73816785496;8730.301575873915;2396.628522578999;2404.1705611563984;2430;2433.5862903306393;2435.659007738918;2389.5101504191684;2434.7686969737933;2436.415260337524;2459.7909177719825;2459.86470744109;2400.195934361991;2413.3604594782396;2424.0425032112307;2425.442148305891;2448.840825346356;2382.785549300554;2411.360989337827;2412.3245491262473;2422;2423.6728041714496;2370.573296806574;2394.724606670238;2413.9758602413926;2416.359664688859;2416.830821842472;8693.434926729742;8712.607932643046;8732.432391894507;8872.46765194084;8883.11168883113;5313.468653134694;5386.434424385422;5468.781248750045;5536.529395001429;5541.833744987657;3328.96801991381;3410.2326976430354;3449.3101379723903;3659.8170091495585;3672.192117734094;1030.99484502577;1055.171690223171;1056.0917610854658;1059.3961441978076;1086.8152414089623;11447.656570302905;11492.540298388054;11516.596919107791;11600;11646.126540509411;4649.186392381387;4661.487236403993;4799;4802.807887684523;4814.446338671028;9059.320550958704;9297.116773906468;9311.255099592016;9324.720258392259;9325.580348884316;5370.650907690988;5377.139657654757;5389.83830485086;5404.54061404785;5443.265159203457;4453.977730111329;4851;4996.875078123004;5003.949960500348;5016.5485106339875;3012.9096127116222;3793.3551296279697;3810.657040866335;3852.903677408031;3894.1238221400527;1217.0446199733344;1232.5193174661888;1233.907456940733;1235.4440501774059;1246.535320997842;850.3494826457764;920.8756817829508;929.7536152919482;948.4830767231875;955.507913424587;5784.913226301609;5840.59115861894;6011;6038.5772995889865;6104.4200800923845;446.8771087950839;467.16144520584953;467.5675000624409;478.30884372082005;480.329939734069;3856.7107466940092;3939.113699417608;3975.900602484903;3996.0609256824623;4029.37544680575;10468.900765419674;10858.34849909008;11036.28264162843;11045.613403530839;11076.889231107585;10732.624358147428;10946.233763636468;10948.014678678957;10986.780264394667;10993.505292261867;7859.449838511364;8154.06228283755;8309.086000539935;8378.287845533076;8385.119562445856;5709.371969083314;5811.970940145272;5880.794172203952;5953.523718102455;5977.790777322773;8580.65677372898;9971.50142492858;10092.596296148366;10129.898701012895;10199.7450063749;10013.749656258651;10109.090181883666;10160.745981350525;10255.538500767632;10380.584776608852;6429.8714025720155;6850.45196384298;6998.6150761708595;7013.509054366145;7067.2579379164445;8376.748697539084;8376.916230837614;8471.745847624581;8477.576121193792;8480.363972701949;7272.418206543358;7355.852882942204;7411.295926886937;7573;7649.9617501912135;7238.457115716447;7273.854522909406;7322;7372.262773722585;7386.889196662162;6935.6878940446795;6974.337437943387;7000.844860597945;7028.8594228114125;7035.577865328097;4240.491141063092;4281.807318670605;4756.16767065769;4959.578435832995;5084.51697088776;4924.630652701134;4948.331975183448;4955.132851750857;4959.528844759742;5155.149400348901 01:30:01 INFO - PROCESS | 1655 | |4;prototype.html;261.4796554855837;274.3634767339771;281.6873270669556;322.46631824330734;325.1773014273888;4497.100579884024;4736.792118009903;4739.360186374838;5533.924778208172;5575.330960284767;4339.739615623065;5156.175011998081;5461.853010867712;5471.455773065533;5477.972610136943;3970.3845903884944;4089.0595163112503;4183.832646694129;4197.16056788642;4244.474537650093;3568;4141.254574176647;4155.646770024551;4190.518090419595;4196.412502249687;3623.6376362363817;3654.269146170763;3662.9194387655707;3916.0992971616547;4065.166640838621;3777.490038844748;3805.429185622151;3899.337112690849;4181.1010632714115;4197.244495990721;2934.8679309430913;2984.7015298470196;3520.6479352064844;3554.5201397811225;3584.8566057357675;4400.053988392511;4839.491853355417;5133.512316329943;5259.476150978853;5306.7611957462;4477.350784136314;4706.1999460091865;4767.880802979918;4779.330893674888;4832.888435659783;5091.923621145649;5172.672297466155;5850.473457388855;5859.29688437386;5895.322037965646;3992.48097747291;4001.479807625019;4010.218007488541;4011.338129208677;4030.234255491447;5726.31284245889;5862.412761714855;5893.882122357529;5990.981533139377;6139.785107521216;3914.2758589661003;3982.362821948532;3998.8400463981698;4003.6997225208224;4027.8791636250958;3471.7222622190166;3617.7829330239742;4050.3519436889956;4089.1190052575553;4097.795110244476;4405.757683327448;4578.793954272066;4739.881502962454;4772.854514916395;4796.208625576741;4902.926456103161;5240.790368385298;5410.675359478444;5483.917741233885;5866.178734977107;1465.8094447721942;1487.5462983790048;1492.2389581313391;1495.0730547060891;1495.5662857771342;904.9819003619891;942.7643089227693;949.6960972488737;965.0735294117726;987.8370068938544;5151.278820965068;5289.576833853283;5863.648181109147;5876.001079816441;5918.940810591925;5254.3169387979315;5691.8861622768145;6098.32918378978;6544.869102617921;6568.67156642166;5380.569554435636;5575.330960284792;5694.572907031989;5868.501177399969;5933.9406605934255;2705.9729402706116;2767.875445604953;2981.2397838551033;3417.060308415156;3420.6921377076183;5385.030694475032;5541.362743284493;5608.719564021782;6516.478681705452;6756.7972960810275;5902.232709747791;6226;6665;6721.6975236114495;6771.221309549464;6540.313267106981;6684.498662600325;6757.898631520531;6761.594304341656;6786.59280443175;5477.3427188737605;5806.042003069615;6104.85731693928;6183.876322473436;6451.741930322923;4826.227803551415;5509;6327.810165695037;6365.949618312927;6434.64609446485;5617.775288988395;6194.318624951342;6335.841603959938;6789.93210067893;6790.66046697673;3355.473259666797;3392.6607339265875;3926.862559810393;3976.886471787904;4021.1354558768835;4891.608671306358;5061.544460998528;6037.667928263988;6086.995645718407;6150.50795936333;4695.694779839299;4999.975000124976;5907.261592300963;5910.438508341701;5946.851328716643;4865.829695960624;5234.947650523446;5844.47399734026;5932.525397968066;5944.851378715567;5514.255575497256;5604.187392828098;5767.7981270657;5781.485054001523;5813.82558523245;5539.750711218086;5816.185733997159;5844.707764611838;5868.911966320594;5878.002218868322;5722.284714410699;5739.71301434935;5743.4543718346695;5791.362950075572;5798.449147330997 01:30:01 INFO - PROCESS | 1655 | |5;yui.html;662.8641128568644;715.2311265389706;716.9103862017248;735.9411247100232;751.6429695894451;14016.369263383147;14427.350769215383;14950.252487375616;14952.252387380642;14996.40014399424;13873.028887977845;13911.095778774397;13950.79073813891;13955.44178232872;14897.553073407787;907.9364444488889;918.7978644698155;921.1525396635112;923.5705396990398;925.1303774452027;703.753686209825;895.122779675918;912.4890061565511;923.1922068190333;923.5797712041006;966.8743063401748;968.1335204991528;968.4044312747644;968.7578105473632;969.205251693608;941.2187884056217;941.2611100286276;952.3143336797494;966.6133546581353;972.479723348009;687.2886562407883;713.4363852556475;713.707379974208;713.7751608243386;716.8136284565999;15047.398104075824;15095.094294342265;15099.245037748178;15400.768988465183;15407.998480098759;12168.51325946961;12184.268943863308;12254.326012069332;12268.938655306667;12493.750124997448;9938.751531211705;9977.600895964153;9986.900130998742;10202.540885660163;10806.314246667604;3487.128217945514;3559.341521818446;3570.535830342065;3625.6374362563797;3665.560132784083;83885.58057209736;84213;84604.88487787855;85203;85905;8814.91185088141;9294.535273236312;9415.529223538795;9630.903690963001;9669.226461883032;20486.59026819455;20988.58022839565;21069.78930210709;21093.367198984055;21194.364169074954;7222.74720384784;7255.201927787939;7287;7364.668589913466;7371.078615173104;4021.1153546219784;4076.775777332275;4081.5306239782212;4091.6317531422314;4098.200850834119;3063.7702172337163;3531.752777305564;3598.2623562169692;3608.963910360863;3612.5303710517464;533.8096045817848;603.3905755187204;628.8773689130667;640.7725257533601;649.2468736265909;461.1952143509597;490.5388934401651;571.5341996273024;608.7869245763948;628.1959092361693;7931.603419828985;8124.918750812534;8130.430869839172;8195.95902020486;8265.52695829594;525.7539631074378;535.7000079955237;539.304297456277;550.8788066625416;589.7080944932286;3774.8112594370173;3856.2094770571966;3861.7296789224483;3937.645611894886;3946.960530394659;95310.52344738232;95619.55541460622;96810;97084.54373184408;98534.50732746291;78253;78942.2105778935;79716.60141699255;80987;81371.5931420339;71298;71523.2847671527;73125.6343718278;73432.63283683654;74770.25229747742;6393.6163830170335;7684.385249180164;7813.335866451415;7850.411219158472;7899.921000789918;45902.54097459116;45952.540474594825;45996.240225586575;46042.76978615086;46284.842878926946;50363;64576.35423645703;65870.67064664645;66022.66988665218;67847.98228026682;8571.442856214326;9844.409335439897;9897.901020989699;10226.130778883879;10735.570577176826;11557.82663260035;11586.594469193538;11615.070794336263;12034.097442691658;12127.393630318273;9982.900170998197;11037.39294338787;11447;11577.59478418285;11770.17608767378;11633.243839150427;11752.764944700886;11774.293542387142;11904.76190476203;12077.456514457046;11376.43117844088;11580.6525804226;11654.825177622173;11751.412429378668;11781.646550603497;9757.073078057572;9853.704388868346;9998.300118991601;10032.247581431277;10073.748156296151;9817.558209880715;9873.40759554429;9878.407295562001;10005.599776008878;10021.997800220212 01:30:01 INFO - PROCESS | 1655 | __end_tp_report 01:30:01 INFO - PROCESS | 1655 | __start_cc_report 01:30:01 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,427 01:30:01 INFO - PROCESS | 1655 | __end_cc_report 01:30:01 INFO - PROCESS | 1655 | __startTimestamp1461832201664__endTimestamp 01:30:01 INFO - PROCESS | 1655 | 01:30:01 INFO - PROCESS | 1655 | ------- Summary: start ------- 01:30:01 INFO - PROCESS | 1655 | Number of tests: 6 01:30:01 INFO - PROCESS | 1655 | 01:30:01 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5728.00 Median:6011.31 stddev:659.57 (11.0%) stddev-sans-first:634.09 01:30:01 INFO - PROCESS | 1655 | Values: 3325.6 3447.2 3487.7 3494.8 3538.0 4467.9 5744.3 5806.8 5828.7 5839.9 5586.7 5625.5 5701.5 5790.2 5929.1 5126.3 5153.3 5199.4 5205.5 5275.3 5252.6 5282.3 5282.8 5313.8 5343.9 5147.5 5237.0 5241.3 5270.5 5272.9 4136.0 5117.2 5117.8 5120.2 5191.1 4331.2 5071.7 5096.3 5133.3 5136.3 5536.6 5639.7 5641.4 5685.0 5710.6 6116.4 6145.1 6155.6 6156.9 6227.1 6126.1 6179.5 6232.5 6237.1 6243.3 5954.2 5981.3 5989.4 6011.3 6029.0 6060.0 6149.5 6321.0 6326.2 6352.7 6065.3 6126.5 6153.3 6202.1 6208.3 6168.9 6203.5 6209.0 6220.5 6243.3 6119.3 6172.9 6182.4 6220.4 6235.3 5724.9 6135.5 6213.4 6213.8 6238.4 4898.9 4920.1 4964.4 4978.2 5012.5 4419.6 4460.8 4509.4 4514.7 4522.0 5866.9 5889.8 5909.3 5910.3 5942.3 6131.2 6176.9 6221.3 6240.7 6259.1 5873.0 5918.9 5930.9 5944.6 5950.8 5433.0 5436.1 5453.2 5478.3 5483.0 6155.4 6340.0 6400.2 6421.3 6435.9 6177.9 6203.0 6225.7 6235.4 6244.6 6150.5 6459.0 6464.3 6465.8 6470.8 6129.6 6182.8 6210.4 6220.1 6258.4 6085.7 6201.8 6216.6 6232.3 6248.6 5353.0 5583.7 6060.6 6205.0 6212.0 4951.4 6095.3 6109.2 6109.7 6201.8 5046.4 5929.3 6084.9 6102.5 6115.6 5062.5 5500.0 6139.5 6195.9 6223.6 6008.4 6016.8 6034.4 6049.2 6109.7 01:30:01 INFO - PROCESS | 1655 | 01:30:01 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:54883.84 Median:35865.55 stddev:110251.49 (307.4%) stddev-sans-first:110485.20 01:30:01 INFO - PROCESS | 1655 | Values: 513.5 516.6 572.2 591.6 625.7 36647.5 37413.1 37472.6 37507.8 37579.8 38232.8 38304.0 38896.2 38928.8 39064.8 9122.2 9363.5 9368.1 9386.0 9405.0 9206.5 9431.1 9511.3 9523.3 9524.7 9416.6 9445.0 9461.1 9548.4 9553.4 9424.2 9475.2 9515.7 9531.4 9531.6 9369.5 9498.4 9499.6 9511.7 9540.9 36982.4 37420.0 37954.8 38000.6 38004.6 3166.8 3173.2 3358.3 3474.6 3520.5 27762.4 28023.9 28377.1 28632.6 28661.6 2735.7 2735.9 2750.3 2857.8 2897.5 401205.0 404413.0 404716.0 405445.0 408257.0 32407.5 61247.0 61583.4 61969.8 62127.0 34030.7 34151.5 34547.7 34552.7 34595.8 12134.8 14463.8 14596.6 14639.5 14851.8 11849.1 11853.3 11861.8 11909.2 11922.8 7921.8 7939.8 7997.1 8036.4 8071.5 3352.3 3355.4 3387.9 3399.9 3413.1 948.8 1028.7 1042.5 1055.4 1135.9 25840.6 26113.9 28675.0 28919.7 29478.7 1004.4 1016.7 1084.3 1103.3 1285.6 11115.6 13786.7 14868.8 15040.3 15267.0 397932.0 407273.0 408342.0 408563.0 500677.0 56526.4 56997.7 57910.0 57952.4 57970.7 1453.1 1489.5 1492.2 1497.8 1501.1 28636.9 29062.9 29084.6 29547.1 29751.6 46585.8 46607.3 46707.5 47312.0 47636.8 405240.0 416702.0 418060.0 418184.0 418536.0 26572.5 26614.9 26921.5 26979.8 27048.0 42620.4 42816.4 42847.4 43209.8 43615.8 30912.6 32575.7 35894.8 36185.8 36659.6 34992.6 35160.6 35511.5 35600.8 36260.6 33396.0 34125.8 34322.7 34778.0 35836.3 28654.6 30732.8 30768.3 30823.2 31091.5 22931.2 23422.3 23869.5 24230.9 24334.6 01:30:01 INFO - PROCESS | 1655 | 01:30:01 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:32855.94 Median:369.08 stddev:96730.74 (26208.7%) stddev-sans-first:96971.30 01:30:01 INFO - PROCESS | 1655 | Values: 351.6 386.6 398.3 400.7 402.1 17797.0 18599.4 20081.5 20595.0 20623.7 19943.6 20387.1 20651.8 20821.3 20965.8 5256.8 5895.1 6069.9 6091.3 6109.2 5228.6 5974.5 5989.3 5990.3 6055.5 4678.9 5197.6 5563.3 5948.8 5980.1 4915.3 5904.3 5912.2 5976.9 6141.8 5862.7 5938.8 5951.3 5965.1 5992.2 13752.5 14974.6 19914.3 20188.9 25271.1 2051.7 2102.2 2138.3 2175.8 2223.3 9307.2 9927.3 10100.9 10135.7 10157.8 1706.0 1715.7 1743.4 1764.4 1778.3 76256.0 99486.5 104457.0 106373.0 106999.0 11582.9 11667.6 11728.6 11766.1 11870.7 11719.5 14579.0 14945.0 14969.6 14998.8 8805.3 8812.4 8825.4 8870.4 8923.1 8743.5 8784.7 8806.4 8894.9 8921.4 4575.2 4617.0 4656.8 4678.5 4697.3 1920.3 1988.9 1996.7 2011.6 2041.2 855.0 908.9 922.1 973.0 993.6 20166.8 20744.0 20906.3 21089.5 21138.3 936.9 944.9 980.9 995.3 1080.4 10470.9 10507.6 10835.2 10870.2 10905.8 531212.0 533208.0 563344.0 639757.0 640246.0 88497.1 105956.5 107978.0 122542.4 128047.4 878.7 1013.4 1034.2 1067.5 1070.4 14675.8 15930.7 16979.7 17504.3 18451.2 41676.0 46924.8 47710.0 49317.0 49852.0 65894.0 68451.0 74243.0 74273.5 76606.2 7592.5 8013.8 8081.8 8161.0 8329.8 9198.5 11907.7 12055.4 12078.3 12397.4 10489.3 10604.6 10626.8 10775.6 10801.0 9011.5 10194.5 10501.5 10581.4 10670.7 10803.6 10945.1 11026.7 11221.3 11261.4 7380.5 8267.9 8285.8 8495.9 8528.0 8113.0 9481.9 9726.4 10818.6 10978.3 01:30:01 INFO - PROCESS | 1655 | 01:30:01 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:5684.62 Median:4808.63 stddev:3192.33 (66.4%) stddev-sans-first:3186.55 01:30:01 INFO - PROCESS | 1655 | Values: 1603.3 1634.5 1881.2 1932.6 1959.3 8036.6 8606.3 8608.7 8980.1 8998.8 8594.0 8656.4 8720.7 8727.7 8730.3 2396.6 2404.2 2430.0 2433.6 2435.7 2389.5 2434.8 2436.4 2459.8 2459.9 2400.2 2413.4 2424.0 2425.4 2448.8 2382.8 2411.4 2412.3 2422.0 2423.7 2370.6 2394.7 2414.0 2416.4 2416.8 8693.4 8712.6 8732.4 8872.5 8883.1 5313.5 5386.4 5468.8 5536.5 5541.8 3329.0 3410.2 3449.3 3659.8 3672.2 1031.0 1055.2 1056.1 1059.4 1086.8 11447.7 11492.5 11516.6 11600.0 11646.1 4649.2 4661.5 4799.0 4802.8 4814.4 9059.3 9297.1 9311.3 9324.7 9325.6 5370.7 5377.1 5389.8 5404.5 5443.3 4454.0 4851.0 4996.9 5003.9 5016.5 3012.9 3793.4 3810.7 3852.9 3894.1 1217.0 1232.5 1233.9 1235.4 1246.5 850.3 920.9 929.8 948.5 955.5 5784.9 5840.6 6011.0 6038.6 6104.4 446.9 467.2 467.6 478.3 480.3 3856.7 3939.1 3975.9 3996.1 4029.4 10468.9 10858.3 11036.3 11045.6 11076.9 10732.6 10946.2 10948.0 10986.8 10993.5 7859.4 8154.1 8309.1 8378.3 8385.1 5709.4 5812.0 5880.8 5953.5 5977.8 8580.7 9971.5 10092.6 10129.9 10199.7 10013.7 10109.1 10160.7 10255.5 10380.6 6429.9 6850.5 6998.6 7013.5 7067.3 8376.7 8376.9 8471.7 8477.6 8480.4 7272.4 7355.9 7411.3 7573.0 7650.0 7238.5 7273.9 7322.0 7372.3 7386.9 6935.7 6974.3 7000.8 7028.9 7035.6 4240.5 4281.8 4756.2 4959.6 5084.5 4924.6 4948.3 4955.1 4959.5 5155.1 01:30:01 INFO - PROCESS | 1655 | 01:30:01 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4742.65 Median:5256.90 stddev:1527.57 (29.1%) stddev-sans-first:1494.37 01:30:01 INFO - PROCESS | 1655 | Values: 261.5 274.4 281.7 322.5 325.2 4497.1 4736.8 4739.4 5533.9 5575.3 4339.7 5156.2 5461.9 5471.5 5478.0 3970.4 4089.1 4183.8 4197.2 4244.5 3568.0 4141.3 4155.6 4190.5 4196.4 3623.6 3654.3 3662.9 3916.1 4065.2 3777.5 3805.4 3899.3 4181.1 4197.2 2934.9 2984.7 3520.6 3554.5 3584.9 4400.1 4839.5 5133.5 5259.5 5306.8 4477.4 4706.2 4767.9 4779.3 4832.9 5091.9 5172.7 5850.5 5859.3 5895.3 3992.5 4001.5 4010.2 4011.3 4030.2 5726.3 5862.4 5893.9 5991.0 6139.8 3914.3 3982.4 3998.8 4003.7 4027.9 3471.7 3617.8 4050.4 4089.1 4097.8 4405.8 4578.8 4739.9 4772.9 4796.2 4902.9 5240.8 5410.7 5483.9 5866.2 1465.8 1487.5 1492.2 1495.1 1495.6 905.0 942.8 949.7 965.1 987.8 5151.3 5289.6 5863.6 5876.0 5918.9 5254.3 5691.9 6098.3 6544.9 6568.7 5380.6 5575.3 5694.6 5868.5 5933.9 2706.0 2767.9 2981.2 3417.1 3420.7 5385.0 5541.4 5608.7 6516.5 6756.8 5902.2 6226.0 6665.0 6721.7 6771.2 6540.3 6684.5 6757.9 6761.6 6786.6 5477.3 5806.0 6104.9 6183.9 6451.7 4826.2 5509.0 6327.8 6365.9 6434.6 5617.8 6194.3 6335.8 6789.9 6790.7 3355.5 3392.7 3926.9 3976.9 4021.1 4891.6 5061.5 6037.7 6087.0 6150.5 4695.7 5000.0 5907.3 5910.4 5946.9 4865.8 5234.9 5844.5 5932.5 5944.9 5514.3 5604.2 5767.8 5781.5 5813.8 5539.8 5816.2 5844.7 5868.9 5878.0 5722.3 5739.7 5743.5 5791.4 5798.4 01:30:01 INFO - PROCESS | 1655 | 01:30:01 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:18356.10 Median:3511.25 stddev:26270.65 (748.2%) stddev-sans-first:26310.75 01:30:01 INFO - PROCESS | 1655 | Values: 662.9 715.2 716.9 735.9 751.6 14016.4 14427.4 14950.3 14952.3 14996.4 13873.0 13911.1 13950.8 13955.4 14897.6 907.9 918.8 921.2 923.6 925.1 703.8 895.1 912.5 923.2 923.6 966.9 968.1 968.4 968.8 969.2 941.2 941.3 952.3 966.6 972.5 687.3 713.4 713.7 713.8 716.8 15047.4 15095.1 15099.2 15400.8 15408.0 12168.5 12184.3 12254.3 12268.9 12493.8 9938.8 9977.6 9986.9 10202.5 10806.3 3487.1 3559.3 3570.5 3625.6 3665.6 83885.6 84213.0 84604.9 85203.0 85905.0 8814.9 9294.5 9415.5 9630.9 9669.2 20486.6 20988.6 21069.8 21093.4 21194.4 7222.7 7255.2 7287.0 7364.7 7371.1 4021.1 4076.8 4081.5 4091.6 4098.2 3063.8 3531.8 3598.3 3609.0 3612.5 533.8 603.4 628.9 640.8 649.2 461.2 490.5 571.5 608.8 628.2 7931.6 8124.9 8130.4 8196.0 8265.5 525.8 535.7 539.3 550.9 589.7 3774.8 3856.2 3861.7 3937.6 3947.0 95310.5 95619.6 96810.0 97084.5 98534.5 78253.0 78942.2 79716.6 80987.0 81371.6 71298.0 71523.3 73125.6 73432.6 74770.3 6393.6 7684.4 7813.3 7850.4 7899.9 45902.5 45952.5 45996.2 46042.8 46284.8 50363.0 64576.4 65870.7 66022.7 67848.0 8571.4 9844.4 9897.9 10226.1 10735.6 11557.8 11586.6 11615.1 12034.1 12127.4 9982.9 11037.4 11447.0 11577.6 11770.2 11633.2 11752.8 11774.3 11904.8 12077.5 11376.4 11580.7 11654.8 11751.4 11781.6 9757.1 9853.7 9998.3 10032.2 10073.7 9817.6 9873.4 9878.4 10005.6 10022.0 01:30:01 INFO - PROCESS | 1655 | -------- Summary: end -------- 01:30:01 INFO - PROCESS | 1655 | 01:30:02 INFO - TEST-INFO | 1655: exit 0 01:30:02 INFO - TEST-OK | dromaeo_css | took 1112836ms 01:30:02 INFO - TEST-START | kraken 01:30:02 INFO - operating with platform_type : mac_ 01:30:02 INFO - Initialising browser for kraken test... 01:30:02 INFO - TEST-INFO | started process 1668 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/tmpSqdsj4/profile http://localhost:49271/getInfo.html) 01:30:05 INFO - PROCESS | 1668 | __metrics Screen width/height:1600/1200 01:30:05 INFO - PROCESS | 1668 | colorDepth:24 01:30:05 INFO - PROCESS | 1668 | Browser inner width/height: 1024/689 01:30:05 INFO - PROCESS | 1668 | __metrics 01:30:05 ERROR - PROCESS | 1668 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2936: TypeError: this.tabs is undefined 01:30:05 INFO - TEST-INFO | 1668: exit 0 01:30:05 INFO - Browser initialized. 01:30:05 INFO - Running cycle 1/1 for kraken test... 01:30:05 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/tmpSqdsj4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:30:17 INFO - PROCESS | 1671 | RSS: Main: 250200064 01:30:17 INFO - PROCESS | 1671 | 01:30:20 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection) 01:30:21 INFO - PROCESS | 1671 | RSS: Main: 262344704 01:30:21 INFO - PROCESS | 1671 | 01:30:24 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-dft) 01:30:24 INFO - PROCESS | 1671 | RSS: Main: 271806464 01:30:24 INFO - PROCESS | 1671 | 01:30:28 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-fft) 01:30:28 INFO - PROCESS | 1671 | RSS: Main: 274481152 01:30:28 INFO - PROCESS | 1671 | 01:30:30 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator) 01:30:31 INFO - PROCESS | 1671 | RSS: Main: 275640320 01:30:31 INFO - PROCESS | 1671 | 01:30:33 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:30:34 INFO - PROCESS | 1671 | RSS: Main: 277286912 01:30:34 INFO - PROCESS | 1671 | 01:30:37 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom) 01:30:37 INFO - PROCESS | 1671 | RSS: Main: 277745664 01:30:37 INFO - PROCESS | 1671 | 01:30:41 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate) 01:30:41 INFO - PROCESS | 1671 | RSS: Main: 277893120 01:30:41 INFO - PROCESS | 1671 | 01:30:44 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial) 01:30:45 INFO - PROCESS | 1671 | RSS: Main: 277921792 01:30:45 INFO - PROCESS | 1671 | 01:30:46 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:30:47 INFO - PROCESS | 1671 | RSS: Main: 277377024 01:30:47 INFO - PROCESS | 1671 | 01:30:49 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:30:50 INFO - PROCESS | 1671 | RSS: Main: 277504000 01:30:50 INFO - PROCESS | 1671 | 01:30:52 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:30:53 INFO - PROCESS | 1671 | RSS: Main: 277938176 01:30:53 INFO - PROCESS | 1671 | 01:30:56 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:30:56 INFO - PROCESS | 1671 | RSS: Main: 277803008 01:30:56 INFO - PROCESS | 1671 | 01:31:00 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:31:00 INFO - PROCESS | 1671 | RSS: Main: 277962752 01:31:00 INFO - PROCESS | 1671 | 01:31:02 INFO - PROCESS | 1671 | Cycle 1(1): loaded http://localhost:49271/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49271/tests/kraken/driver.html?testName=ai-astar) 01:31:02 INFO - PROCESS | 1671 | RSS: Main: 279732224 01:31:02 INFO - PROCESS | 1671 | 01:31:02 INFO - PROCESS | 1671 | __start_tp_report 01:31:02 INFO - PROCESS | 1671 | _x_x_mozilla_page_load 01:31:02 INFO - PROCESS | 1671 | _x_x_mozilla_page_load_details 01:31:02 INFO - PROCESS | 1671 | |i|pagename|runs| 01:31:02 INFO - PROCESS | 1671 | |0;ai-astar;117;108;110;149;100;159;171;173;114;116 01:31:02 INFO - PROCESS | 1671 | |1;audio-beat-detection;154;122;147;200;108;176;172;154;204;152 01:31:02 INFO - PROCESS | 1671 | |2;audio-dft;267;265;202;198;197;200;198;197;202;194 01:31:02 INFO - PROCESS | 1671 | |3;audio-fft;69;77;74;134;58;66;90;92;95;57 01:31:02 INFO - PROCESS | 1671 | |4;audio-oscillator;80;85;136;77;79;80;119;83;80;122 01:31:02 INFO - PROCESS | 1671 | |5;imaging-gaussian-blur;91;101;134;87;128;78;78;74;77;115 01:31:02 INFO - PROCESS | 1671 | |6;imaging-darkroom;98;96;129;152;110;137;103;132;135;148 01:31:02 INFO - PROCESS | 1671 | |7;imaging-desaturate;90;94;90;91;112;127;90;122;88;133 01:31:02 INFO - PROCESS | 1671 | |8;json-parse-financial;54;64;62;62;58;74;73;81;62;63 01:31:02 INFO - PROCESS | 1671 | |9;json-stringify-tinderbox;86;67;73;67;73;78;70;66;64;66 01:31:02 INFO - PROCESS | 1671 | |10;stanford-crypto-aes;85;106;112;107;94;84;78;80;84;85 01:31:02 INFO - PROCESS | 1671 | |11;stanford-crypto-ccm;145;161;166;137;157;156;165;164;269;169 01:31:02 INFO - PROCESS | 1671 | |12;stanford-crypto-pbkdf2;199;196;205;197;201;197;209;189;264;185 01:31:02 INFO - PROCESS | 1671 | |13;stanford-crypto-sha256-iterative;64;97;61;98;98;101;102;100;65;97 01:31:02 INFO - PROCESS | 1671 | __end_tp_report 01:31:02 INFO - PROCESS | 1671 | __start_cc_report 01:31:02 INFO - PROCESS | 1671 | _x_x_mozilla_cycle_collect,1099 01:31:02 INFO - PROCESS | 1671 | __end_cc_report 01:31:02 INFO - PROCESS | 1671 | __startTimestamp1461832262837__endTimestamp 01:31:02 INFO - PROCESS | 1671 | 01:31:02 INFO - PROCESS | 1671 | ------- Summary: start ------- 01:31:02 INFO - PROCESS | 1671 | Number of tests: 14 01:31:02 INFO - PROCESS | 1671 | 01:31:02 INFO - PROCESS | 1671 | [#0] ai-astar Cycles:10 Average:131.70 Median:133.00 stddev:28.10 (21.1%) stddev-sans-first:29.30 01:31:02 INFO - PROCESS | 1671 | Values: 117.0 108.0 110.0 149.0 100.0 159.0 171.0 173.0 114.0 116.0 01:31:02 INFO - PROCESS | 1671 | 01:31:02 INFO - PROCESS | 1671 | [#1] audio-beat-detection Cycles:10 Average:158.90 Median:163.00 stddev:30.51 (18.7%) stddev-sans-first:32.31 01:31:02 INFO - PROCESS | 1671 | Values: 154.0 122.0 147.0 200.0 108.0 176.0 172.0 154.0 204.0 152.0 01:31:02 INFO - PROCESS | 1671 | 01:31:02 INFO - PROCESS | 1671 | [#2] audio-dft Cycles:10 Average:212.00 Median:201.00 stddev:28.57 (14.2%) stddev-sans-first:22.31 01:31:02 INFO - PROCESS | 1671 | Values: 267.0 265.0 202.0 198.0 197.0 200.0 198.0 197.0 202.0 194.0 01:31:02 INFO - PROCESS | 1671 | 01:31:02 INFO - PROCESS | 1671 | [#3] audio-fft Cycles:10 Average:81.20 Median:75.50 stddev:22.96 (30.4%) stddev-sans-first:23.93 01:31:02 INFO - PROCESS | 1671 | Values: 69.0 77.0 74.0 134.0 58.0 66.0 90.0 92.0 95.0 57.0 01:31:02 INFO - PROCESS | 1671 | 01:31:02 INFO - PROCESS | 1671 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:80.00 stddev:22.30 (27.9%) stddev-sans-first:23.07 01:31:02 INFO - PROCESS | 1671 | Values: 80.0 85.0 136.0 77.0 79.0 80.0 119.0 83.0 80.0 122.0 01:31:02 INFO - PROCESS | 1671 | 01:31:02 INFO - PROCESS | 1671 | [#5] imaging-gaussian-blur Cycles:10 Average:96.30 Median:77.50 stddev:22.24 (28.7%) stddev-sans-first:23.51 01:31:02 INFO - PROCESS | 1671 | Values: 91.0 101.0 134.0 87.0 128.0 78.0 78.0 74.0 77.0 115.0 01:31:02 INFO - PROCESS | 1671 | 01:31:02 INFO - PROCESS | 1671 | [#6] imaging-darkroom Cycles:10 Average:124.00 Median:142.50 stddev:20.65 (14.5%) stddev-sans-first:19.64 01:31:02 INFO - PROCESS | 1671 | Values: 98.0 96.0 129.0 152.0 110.0 137.0 103.0 132.0 135.0 148.0 01:31:02 INFO - PROCESS | 1671 | 01:31:02 INFO - PROCESS | 1671 | [#7] imaging-desaturate Cycles:10 Average:103.70 Median:90.00 stddev:17.86 (19.8%) stddev-sans-first:18.24 01:31:02 INFO - PROCESS | 1671 | Values: 90.0 94.0 90.0 91.0 112.0 127.0 90.0 122.0 88.0 133.0 01:31:02 INFO - PROCESS | 1671 | 01:31:02 INFO - PROCESS | 1671 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:63.50 stddev:8.18 (12.9%) stddev-sans-first:7.58 01:31:02 INFO - PROCESS | 1671 | Values: 54.0 64.0 62.0 62.0 58.0 74.0 73.0 81.0 62.0 63.0 01:31:02 INFO - PROCESS | 1671 | 01:31:02 INFO - PROCESS | 1671 | [#9] json-stringify-tinderbox Cycles:10 Average:71.00 Median:71.50 stddev:6.78 (9.5%) stddev-sans-first:4.53 01:31:02 INFO - PROCESS | 1671 | Values: 86.0 67.0 73.0 67.0 73.0 78.0 70.0 66.0 64.0 66.0 01:31:02 INFO - PROCESS | 1671 | 01:31:02 INFO - PROCESS | 1671 | [#10] stanford-crypto-aes Cycles:10 Average:91.50 Median:84.00 stddev:12.42 (14.8%) stddev-sans-first:12.95 01:31:02 INFO - PROCESS | 1671 | Values: 85.0 106.0 112.0 107.0 94.0 84.0 78.0 80.0 84.0 85.0 01:31:02 INFO - PROCESS | 1671 | 01:31:02 INFO - PROCESS | 1671 | [#11] stanford-crypto-ccm Cycles:10 Average:168.90 Median:164.50 stddev:36.56 (22.2%) stddev-sans-first:37.74 01:31:02 INFO - PROCESS | 1671 | Values: 145.0 161.0 166.0 137.0 157.0 156.0 165.0 164.0 269.0 169.0 01:31:02 INFO - PROCESS | 1671 | 01:31:02 INFO - PROCESS | 1671 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:204.20 Median:200.00 stddev:22.13 (11.1%) stddev-sans-first:23.39 01:31:02 INFO - PROCESS | 1671 | Values: 199.0 196.0 205.0 197.0 201.0 197.0 209.0 189.0 264.0 185.0 01:31:02 INFO - PROCESS | 1671 | 01:31:02 INFO - PROCESS | 1671 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:88.30 Median:81.00 stddev:17.33 (21.4%) stddev-sans-first:16.00 01:31:02 INFO - PROCESS | 1671 | Values: 64.0 97.0 61.0 98.0 98.0 101.0 102.0 100.0 65.0 97.0 01:31:02 INFO - PROCESS | 1671 | -------- Summary: end -------- 01:31:02 INFO - PROCESS | 1671 | 01:31:03 INFO - TEST-INFO | 1671: exit 0 01:31:03 INFO - TEST-OK | kraken | took 61540ms 01:31:03 INFO - SUITE-END | took 1174s 01:31:03 INFO - Completed test suite (00:19:34) 01:31:03 INFO - javascript benchmark 01:31:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3325.617553981292, 3447.2243745157334, 3487.668671476209, 3494.7903125812454, 3537.964620353796, 4467.9329810052795, 5744.339400968885, 5806.767729290823, 5828.737706803194, 5839.854003649905, 5586.720663966806, 5625.465580769831, 5701.515371193454, 5790.189373487715, 5929.080992446177, 5126.30794842697, 5153.304303918979, 5199.350081239845, 5205.531502164805, 5275.261463395128, 5252.6323157379, 5282.286891269668, 5282.7622756976025, 5313.787448502056, 5343.919841202385, 5147.48525147486, 5237.031149237403, 5241.3186285782795, 5270.472952704698, 5272.894542109175, 4136.0, 5117.155669314596, 5117.82087626935, 5120.15517439622, 5191.0656081905245, 4331.155424692155, 5071.746412679351, 5096.261042148904, 5133.332666753336, 5136.332276803992, 5536.584756143265, 5639.661620302754, 5641.407652196502, 5684.971575142098, 5710.600257981943, 6116.3577824328695, 6145.139680444741, 6155.569110162291, 6156.938430615682, 6227.06594010902, 6126.090206827809, 6179.474744646665, 6232.532560057968, 6237.126802247689, 6243.2508099027955, 5954.196183515257, 5981.312149102821, 5989.431004054652, 6011.3086994995265, 6029.0, 6060.0, 6149.5080393568405, 6320.968395158086, 6326.177596912372, 6352.6823658816875, 6065.302490213594, 6126.456603435028, 6153.341549715768, 6202.069689546604, 6208.348123446973, 6168.8766224675255, 6203.47270482005, 6208.9689551551955, 6220.502359811204, 6243.344448832898, 6119.326874043852, 6172.938270617236, 6182.381761823782, 6220.377962203744, 6235.251769787655, 5724.856878578069, 6135.509159267248, 6213.409726076015, 6213.844653883599, 6238.376162383725, 4898.853034408973, 4920.089783390084, 4964.404271487445, 4978.178600530872, 5012.523810238022, 4419.580139886705, 4460.843870464518, 4509.436320459942, 4514.683972121986, 4521.977390113028, 5866.911996320058, 5889.823305300848, 5909.320428150818, 5910.261217347832, 5942.286925568873, 6131.223750760645, 6176.938230617637, 6221.253449586078, 6240.687965601702, 6259.061140828821, 5873.0, 5918.911216331759, 5930.9406905931255, 5944.613600115978, 5950.761969521171, 5433.0, 5436.103042997861, 5453.154761011971, 5478.287822583039, 5482.972585137049, 6155.446009859134, 6340.0, 6400.167978162809, 6421.293657697743, 6435.903461448176, 6177.876442471215, 6203.0, 6225.688715564113, 6235.438810507076, 6244.625322480666, 6150.477209437069, 6459.0, 6464.2889282177985, 6465.77369792055, 6470.838229044311, 6129.633877547049, 6182.752689892354, 6210.378962103753, 6220.129181914626, 6258.405451482102, 6085.726142323695, 6201.81394558164, 6216.627002379691, 6232.314445411092, 6248.562600618095, 5352.9732351338, 5583.748731307182, 6060.606060606046, 6204.968975155095, 6212.0, 4951.430585482715, 6095.299040610386, 6109.192117492145, 6109.6639684817765, 6201.81394558164, 5046.419661738947, 5929.2884853816095, 6084.878302433838, 6102.4812890902995, 6115.6330620162935, 5062.544371006627, 5500.0, 6139.508839292936, 6195.876082478415, 6223.564350495421, 6008.369121242382, 6016.789412370546, 6034.366391528826, 6049.153118563493, 6109.694515274307], "value": 5688.122394536805, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [513.5044681881984, 516.5609232152668, 572.2132068405942, 591.639100148909, 625.7309356976501, 36647.51848574384, 37413.064673383145, 37472.62527374729, 37507.812460937654, 37579.812100939525, 38232.80883595585, 38304.04239894004, 38896.22207555847, 38928.80535597325, 39064.80467597658, 9122.179003889649, 9363.48500832454, 9368.110029547182, 9386.0, 9404.952975235114, 9206.539673016356, 9431.104045115737, 9511.334206605541, 9523.285753568476, 9524.666636667718, 9416.576254068548, 9444.952775236148, 9461.148496635302, 9548.42709437436, 9553.426794392359, 9424.198943089845, 9475.241980641533, 9515.666951656658, 9531.38046027013, 9531.571079301448, 9369.48467834269, 9498.382605130644, 9499.572519236652, 9511.714648560554, 9540.856887146698, 36982.445263321075, 37420.0, 37954.81022594897, 38000.619993799985, 38004.61995380066, 3166.7624928130253, 3173.1908363367424, 3358.2947581008016, 3474.5830500339866, 3520.4719292106133, 27762.444751104864, 28023.87904483818, 28377.148685539465, 28632.570511442344, 28661.57007644887, 2735.7401046900513, 2735.931601709953, 2750.2574304937557, 2857.8142420742583, 2897.463969165711, 401205.0, 404413.0, 404715.99999999703, 405445.0, 408257.0, 32407.51388729171, 61247.0, 61583.38416615777, 61969.760604787654, 62127.0, 34030.65969340275, 34151.48772768411, 34547.65452345445, 34552.65447345545, 34595.82702086474, 12134.817977730341, 14463.78304325436, 14596.562103136923, 14639.48761793332, 14851.777223341658, 11849.052075833913, 11853.34806585646, 11861.822072668916, 11909.166358354832, 11922.76154476923, 7921.801954951173, 7939.841203175904, 7997.080335761462, 8036.357091432788, 8071.5157090573575, 3352.3295340931913, 3355.412802759556, 3387.9491807622903, 3399.9490007649906, 3413.0784688134063, 948.7770373962113, 1028.7376718936623, 1042.5100202904623, 1055.3509591601264, 1135.8977692007593, 25840.612390814153, 26113.869430653103, 28675.0, 28919.71080289212, 29478.705212947596, 1004.4174378860243, 1016.7356487313203, 1084.251866212311, 1103.2828661370013, 1285.6014635463036, 11115.555377784798, 13786.724265514835, 14868.776968345483, 15040.323185456462, 15267.0, 397932.0103399464, 407273.0, 408342.0, 408563.0, 500677.0, 56526.43473565294, 56997.715011424676, 57910.0, 57952.420475795545, 57970.710146449, 1453.128123126116, 1489.4786824611515, 1492.1718446262212, 1497.7528707763315, 1501.1368463133742, 28636.85681571579, 29062.85468572728, 29084.56373154362, 29547.113586592437, 29751.55372669455, 46585.835354115065, 46607.30089048735, 46707.53292467032, 47312.0, 47636.761816190694, 405240.0, 416702.0, 418060.0, 418184.0, 418536.0, 26572.46855062849, 26614.866925665247, 26921.461570768868, 26979.78590963372, 27048.0, 42620.360694588984, 42816.35775463433, 42847.3572896413, 43209.78395108004, 43615.781921090194, 30912.608932598538, 32575.674243257265, 35894.8205258972, 36185.81907090448, 36659.63340366562, 34992.600295987875, 35160.64839351676, 35511.46732798959, 35600.821995889855, 36260.637393626785, 33396.0, 34125.82937085398, 34322.65677343195, 34778.0, 35836.28327433489, 28654.57018144771, 30732.815754592397, 30768.310792628985, 30823.2294192638, 31091.533626996064, 22931.197408090637, 23422.297331080095, 23869.522609548058, 24230.87884560566, 24334.63498047495], "value": 17608.374002901634, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.5693275737222, 386.58895033129073, 398.31887472422164, 400.66144108228536, 402.13540887092745, 17797.0, 18599.442016739504, 20081.497962550944, 20595.0, 20623.69064464034, 19943.60112797747, 20387.08258128384, 20651.793482065175, 20821.27125550606, 20965.790342096574, 5256.842294731145, 5895.115732640095, 6069.878602427949, 6091.2995005574485, 6109.175261339707, 5228.607854410915, 5974.462298393144, 5989.341172471047, 5990.251218597676, 6055.485283750886, 4678.883027924295, 5197.558207552363, 5563.332400111992, 5948.7620495180145, 5980.132880732292, 4915.336429582015, 5904.321003084614, 5912.17229587858, 5976.88046239075, 6141.785037523665, 5862.677552734598, 5938.792142275, 5951.285845698544, 5965.075413310944, 5992.161097446361, 13752.518661846787, 14974.550763477113, 19914.307283880888, 20188.89905550463, 25271.115510957214, 2051.7230173926478, 2102.211670623516, 2138.337115494186, 2175.8476906616543, 2223.3330000999636, 9307.162355388047, 9927.305088643798, 10100.89899101007, 10135.695929122137, 10157.847632285522, 1705.9658806823793, 1715.7083295839736, 1743.3636722596161, 1764.4353806781835, 1778.2975724588844, 76256.0, 99486.51797187136, 104457.0, 106373.0, 106999.0, 11582.88417115835, 11667.599888013492, 11728.648140555797, 11766.058715302755, 11870.703232419259, 11719.472623731952, 14579.0, 14945.0, 14969.625759355886, 14998.775018374734, 8805.339599530062, 8812.427192232613, 8825.38222324444, 8870.42342247752, 8923.107689231025, 8743.475391476532, 8784.692535761218, 8806.427582207136, 8894.911050889537, 8921.420107692978, 4575.2450845610765, 4616.953830461653, 4656.837010704677, 4678.526264226825, 4697.271922851964, 1920.3470819921295, 1988.9204431822855, 1996.7004949257728, 2011.5976804638838, 2041.173324803457, 854.9871751923727, 908.8909330880336, 922.0871337376084, 972.9562169702381, 993.6273897288517, 20166.798332016784, 20744.0, 20906.26828061041, 21089.472763180736, 21138.260160894293, 936.9156775890202, 944.9338546301831, 980.8724865767405, 995.3430735714538, 1080.4165750494801, 10470.895291046992, 10507.634007578967, 10835.21444695259, 10870.239083264254, 10905.781884362268, 531212.0, 533208.0, 563344.0, 639757.0, 640246.0, 88497.11502885018, 105956.47021764841, 107978.0, 122542.387288063, 128047.35976320245, 878.6880657366543, 1013.3615822032073, 1034.1674951663833, 1067.530286673861, 1070.3898777696638, 14675.779863302272, 15930.681386371976, 16979.660406791547, 17504.337087976623, 18451.16969736392, 41675.95810104772, 46924.7653761729, 47710.0, 49317.0, 49852.0, 65894.0, 68451.0, 74243.0, 74273.51452971018, 76606.23393766214, 7592.506487078323, 8013.759587212393, 8081.83836323282, 8160.959195204224, 8329.83340333202, 9198.494082825242, 11907.702307442383, 12055.397230138633, 12078.27530348182, 12397.44211510466, 10489.265751397328, 10604.575816967235, 10626.787464250827, 10775.568977240822, 10801.0, 9011.459312441275, 10194.541245643815, 10501.527431265764, 10581.418022008864, 10670.73323166927, 10803.567857285621, 10945.069669078217, 11026.724331891766, 11221.270617409842, 11261.436928153724, 7380.483366164317, 8267.917320826715, 8285.792855178668, 8495.915040849512, 8528.019277783134, 8112.959435202786, 9481.905180948102, 9726.416415015121, 10818.56725730962, 10978.341299521735], "value": 9233.737173112833, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1603.2865374908167, 1634.460627992762, 1881.1910878322317, 1932.565172836112, 1959.284861025726, 8036.638351274192, 8606.268467180282, 8608.698695545658, 8980.101989801016, 8998.775030624238, 8593.957030214855, 8656.437331573443, 8720.738377848675, 8727.73816785496, 8730.301575873915, 2396.628522578999, 2404.1705611563984, 2430.0, 2433.5862903306393, 2435.659007738918, 2389.5101504191684, 2434.7686969737933, 2436.415260337524, 2459.7909177719825, 2459.86470744109, 2400.195934361991, 2413.3604594782396, 2424.0425032112307, 2425.442148305891, 2448.840825346356, 2382.785549300554, 2411.360989337827, 2412.3245491262473, 2422.0, 2423.6728041714496, 2370.573296806574, 2394.724606670238, 2413.9758602413926, 2416.359664688859, 2416.830821842472, 8693.434926729742, 8712.607932643046, 8732.432391894507, 8872.46765194084, 8883.11168883113, 5313.468653134694, 5386.434424385422, 5468.781248750045, 5536.529395001429, 5541.833744987657, 3328.96801991381, 3410.2326976430354, 3449.3101379723903, 3659.8170091495585, 3672.192117734094, 1030.99484502577, 1055.171690223171, 1056.0917610854658, 1059.3961441978076, 1086.8152414089623, 11447.656570302905, 11492.540298388054, 11516.596919107791, 11600.0, 11646.126540509411, 4649.186392381387, 4661.487236403993, 4799.0, 4802.807887684523, 4814.446338671028, 9059.320550958704, 9297.116773906468, 9311.255099592016, 9324.720258392259, 9325.580348884316, 5370.650907690988, 5377.139657654757, 5389.83830485086, 5404.54061404785, 5443.265159203457, 4453.977730111329, 4851.0, 4996.875078123004, 5003.949960500348, 5016.5485106339875, 3012.9096127116222, 3793.3551296279697, 3810.657040866335, 3852.903677408031, 3894.1238221400527, 1217.0446199733344, 1232.5193174661888, 1233.907456940733, 1235.4440501774059, 1246.535320997842, 850.3494826457764, 920.8756817829508, 929.7536152919482, 948.4830767231875, 955.507913424587, 5784.913226301609, 5840.59115861894, 6011.0, 6038.5772995889865, 6104.4200800923845, 446.8771087950839, 467.16144520584953, 467.5675000624409, 478.30884372082005, 480.329939734069, 3856.7107466940092, 3939.113699417608, 3975.900602484903, 3996.0609256824623, 4029.37544680575, 10468.900765419674, 10858.34849909008, 11036.28264162843, 11045.613403530839, 11076.889231107585, 10732.624358147428, 10946.233763636468, 10948.014678678957, 10986.780264394667, 10993.505292261867, 7859.449838511364, 8154.06228283755, 8309.086000539935, 8378.287845533076, 8385.119562445856, 5709.371969083314, 5811.970940145272, 5880.794172203952, 5953.523718102455, 5977.790777322773, 8580.65677372898, 9971.50142492858, 10092.596296148366, 10129.898701012895, 10199.7450063749, 10013.749656258651, 10109.090181883666, 10160.745981350525, 10255.538500767632, 10380.584776608852, 6429.8714025720155, 6850.45196384298, 6998.6150761708595, 7013.509054366145, 7067.2579379164445, 8376.748697539084, 8376.916230837614, 8471.745847624581, 8477.576121193792, 8480.363972701949, 7272.418206543358, 7355.852882942204, 7411.295926886937, 7573.0, 7649.9617501912135, 7238.457115716447, 7273.854522909406, 7322.0, 7372.262773722585, 7386.889196662162, 6935.6878940446795, 6974.337437943387, 7000.844860597945, 7028.8594228114125, 7035.577865328097, 4240.491141063092, 4281.807318670605, 4756.16767065769, 4959.578435832995, 5084.51697088776, 4924.630652701134, 4948.331975183448, 4955.132851750857, 4959.528844759742, 5155.149400348901], "value": 4511.637897592038, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [261.4796554855837, 274.3634767339771, 281.6873270669556, 322.46631824330734, 325.1773014273888, 4497.100579884024, 4736.792118009903, 4739.360186374838, 5533.924778208172, 5575.330960284767, 4339.739615623065, 5156.175011998081, 5461.853010867712, 5471.455773065533, 5477.972610136943, 3970.3845903884944, 4089.0595163112503, 4183.832646694129, 4197.16056788642, 4244.474537650093, 3568.0, 4141.254574176647, 4155.646770024551, 4190.518090419595, 4196.412502249687, 3623.6376362363817, 3654.269146170763, 3662.9194387655707, 3916.0992971616547, 4065.166640838621, 3777.490038844748, 3805.429185622151, 3899.337112690849, 4181.1010632714115, 4197.244495990721, 2934.8679309430913, 2984.7015298470196, 3520.6479352064844, 3554.5201397811225, 3584.8566057357675, 4400.053988392511, 4839.491853355417, 5133.512316329943, 5259.476150978853, 5306.7611957462, 4477.350784136314, 4706.1999460091865, 4767.880802979918, 4779.330893674888, 4832.888435659783, 5091.923621145649, 5172.672297466155, 5850.473457388855, 5859.29688437386, 5895.322037965646, 3992.48097747291, 4001.479807625019, 4010.218007488541, 4011.338129208677, 4030.234255491447, 5726.31284245889, 5862.412761714855, 5893.882122357529, 5990.981533139377, 6139.785107521216, 3914.2758589661003, 3982.362821948532, 3998.8400463981698, 4003.6997225208224, 4027.8791636250958, 3471.7222622190166, 3617.7829330239742, 4050.3519436889956, 4089.1190052575553, 4097.795110244476, 4405.757683327448, 4578.793954272066, 4739.881502962454, 4772.854514916395, 4796.208625576741, 4902.926456103161, 5240.790368385298, 5410.675359478444, 5483.917741233885, 5866.178734977107, 1465.8094447721942, 1487.5462983790048, 1492.2389581313391, 1495.0730547060891, 1495.5662857771342, 904.9819003619891, 942.7643089227693, 949.6960972488737, 965.0735294117726, 987.8370068938544, 5151.278820965068, 5289.576833853283, 5863.648181109147, 5876.001079816441, 5918.940810591925, 5254.3169387979315, 5691.8861622768145, 6098.32918378978, 6544.869102617921, 6568.67156642166, 5380.569554435636, 5575.330960284792, 5694.572907031989, 5868.501177399969, 5933.9406605934255, 2705.9729402706116, 2767.875445604953, 2981.2397838551033, 3417.060308415156, 3420.6921377076183, 5385.030694475032, 5541.362743284493, 5608.719564021782, 6516.478681705452, 6756.7972960810275, 5902.232709747791, 6226.0, 6665.0, 6721.6975236114495, 6771.221309549464, 6540.313267106981, 6684.498662600325, 6757.898631520531, 6761.594304341656, 6786.59280443175, 5477.3427188737605, 5806.042003069615, 6104.85731693928, 6183.876322473436, 6451.741930322923, 4826.227803551415, 5509.0, 6327.810165695037, 6365.949618312927, 6434.64609446485, 5617.775288988395, 6194.318624951342, 6335.841603959938, 6789.93210067893, 6790.66046697673, 3355.473259666797, 3392.6607339265875, 3926.862559810393, 3976.886471787904, 4021.1354558768835, 4891.608671306358, 5061.544460998528, 6037.667928263988, 6086.995645718407, 6150.50795936333, 4695.694779839299, 4999.975000124976, 5907.261592300963, 5910.438508341701, 5946.851328716643, 4865.829695960624, 5234.947650523446, 5844.47399734026, 5932.525397968066, 5944.851378715567, 5514.255575497256, 5604.187392828098, 5767.7981270657, 5781.485054001523, 5813.82558523245, 5539.750711218086, 5816.185733997159, 5844.707764611838, 5868.911966320594, 5878.002218868322, 5722.284714410699, 5739.71301434935, 5743.4543718346695, 5791.362950075572, 5798.449147330997], "value": 4259.424907497386, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [662.8641128568644, 715.2311265389706, 716.9103862017248, 735.9411247100232, 751.6429695894451, 14016.369263383147, 14427.350769215383, 14950.252487375616, 14952.252387380642, 14996.40014399424, 13873.028887977845, 13911.095778774397, 13950.79073813891, 13955.44178232872, 14897.553073407787, 907.9364444488889, 918.7978644698155, 921.1525396635112, 923.5705396990398, 925.1303774452027, 703.753686209825, 895.122779675918, 912.4890061565511, 923.1922068190333, 923.5797712041006, 966.8743063401748, 968.1335204991528, 968.4044312747644, 968.7578105473632, 969.205251693608, 941.2187884056217, 941.2611100286276, 952.3143336797494, 966.6133546581353, 972.479723348009, 687.2886562407883, 713.4363852556475, 713.707379974208, 713.7751608243386, 716.8136284565999, 15047.398104075824, 15095.094294342265, 15099.245037748178, 15400.768988465183, 15407.998480098759, 12168.51325946961, 12184.268943863308, 12254.326012069332, 12268.938655306667, 12493.750124997448, 9938.751531211705, 9977.600895964153, 9986.900130998742, 10202.540885660163, 10806.314246667604, 3487.128217945514, 3559.341521818446, 3570.535830342065, 3625.6374362563797, 3665.560132784083, 83885.58057209736, 84213.0, 84604.88487787855, 85203.0, 85905.0, 8814.91185088141, 9294.535273236312, 9415.529223538795, 9630.903690963001, 9669.226461883032, 20486.59026819455, 20988.58022839565, 21069.78930210709, 21093.367198984055, 21194.364169074954, 7222.74720384784, 7255.201927787939, 7287.0, 7364.668589913466, 7371.078615173104, 4021.1153546219784, 4076.775777332275, 4081.5306239782212, 4091.6317531422314, 4098.200850834119, 3063.7702172337163, 3531.752777305564, 3598.2623562169692, 3608.963910360863, 3612.5303710517464, 533.8096045817848, 603.3905755187204, 628.8773689130667, 640.7725257533601, 649.2468736265909, 461.1952143509597, 490.5388934401651, 571.5341996273024, 608.7869245763948, 628.1959092361693, 7931.603419828985, 8124.918750812534, 8130.430869839172, 8195.95902020486, 8265.52695829594, 525.7539631074378, 535.7000079955237, 539.304297456277, 550.8788066625416, 589.7080944932286, 3774.8112594370173, 3856.2094770571966, 3861.7296789224483, 3937.645611894886, 3946.960530394659, 95310.52344738232, 95619.55541460622, 96810.0, 97084.54373184408, 98534.50732746291, 78253.0, 78942.2105778935, 79716.60141699255, 80987.0, 81371.5931420339, 71298.0, 71523.2847671527, 73125.6343718278, 73432.63283683654, 74770.25229747742, 6393.6163830170335, 7684.385249180164, 7813.335866451415, 7850.411219158472, 7899.921000789918, 45902.54097459116, 45952.540474594825, 45996.240225586575, 46042.76978615086, 46284.842878926946, 50363.0, 64576.35423645703, 65870.67064664645, 66022.66988665218, 67847.98228026682, 8571.442856214326, 9844.409335439897, 9897.901020989699, 10226.130778883879, 10735.570577176826, 11557.82663260035, 11586.594469193538, 11615.070794336263, 12034.097442691658, 12127.393630318273, 9982.900170998197, 11037.39294338787, 11447.0, 11577.59478418285, 11770.17608767378, 11633.243839150427, 11752.764944700886, 11774.293542387142, 11904.76190476203, 12077.456514457046, 11376.43117844088, 11580.6525804226, 11654.825177622173, 11751.412429378668, 11781.646550603497, 9757.073078057572, 9853.704388868346, 9998.300118991601, 10032.247581431277, 10073.748156296151, 9817.558209880715, 9873.40759554429, 9878.407295562001, 10005.599776008878, 10021.997800220212], "value": 6841.29191613425, "unit": "score"}], "name": "dromaeo_css", "value": 7038.629281284644, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 108.0, 110.0, 149.0, 100.0, 159.0, 171.0, 173.0, 114.0, 116.0], "value": 131.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 122.0, 147.0, 200.0, 108.0, 176.0, 172.0, 154.0, 204.0, 152.0], "value": 158.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [267.0, 265.0, 202.0, 198.0, 197.0, 200.0, 198.0, 197.0, 202.0, 194.0], "value": 212.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 77.0, 74.0, 134.0, 58.0, 66.0, 90.0, 92.0, 95.0, 57.0], "value": 81.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 85.0, 136.0, 77.0, 79.0, 80.0, 119.0, 83.0, 80.0, 122.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 101.0, 134.0, 87.0, 128.0, 78.0, 78.0, 74.0, 77.0, 115.0], "value": 96.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [98.0, 96.0, 129.0, 152.0, 110.0, 137.0, 103.0, 132.0, 135.0, 148.0], "value": 124.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 94.0, 90.0, 91.0, 112.0, 127.0, 90.0, 122.0, 88.0, 133.0], "value": 103.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 64.0, 62.0, 62.0, 58.0, 74.0, 73.0, 81.0, 62.0, 63.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 67.0, 73.0, 67.0, 73.0, 78.0, 70.0, 66.0, 64.0, 66.0], "value": 71.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 106.0, 112.0, 107.0, 94.0, 84.0, 78.0, 80.0, 84.0, 85.0], "value": 91.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 161.0, 166.0, 137.0, 157.0, 156.0, 165.0, 164.0, 269.0, 169.0], "value": 168.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 196.0, 205.0, 197.0, 201.0, 197.0, 209.0, 189.0, 264.0, 185.0], "value": 204.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 97.0, 61.0, 98.0, 98.0, 101.0, 102.0, 100.0, 65.0, 97.0], "value": 88.3, "unit": "score"}], "name": "kraken", "value": 1691.1000000000001, "alertThreshold": 2.0}]} 01:31:04 INFO - Return code: 0 01:31:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:31:04 ERROR - # TBPL SUCCESS # 01:31:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:31:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:31:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:31:04 INFO - 2016-04-28 01:31:04.112 screenresolution[1676:10591] starting screenresolution argv=screenresolution get 01:31:04 INFO - 2016-04-28 01:31:04.115 screenresolution[1676:10591] Display 0: 1600x1200x32@60 01:31:04 INFO - 2016-04-28 01:31:04.121 screenresolution[1677:10594] starting screenresolution argv=screenresolution list 01:31:04 INFO - Available Modes on Display 0 01:31:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:31:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:31:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:31:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:31:04 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:31:04 INFO - Intel Iris: 01:31:04 INFO - Chipset Model: Intel Iris 01:31:04 INFO - Type: GPU 01:31:04 INFO - Bus: Built-In 01:31:04 INFO - VRAM (Dynamic, Max): 1536 MB 01:31:04 INFO - Vendor: Intel (0x8086) 01:31:04 INFO - Device ID: 0x0a2e 01:31:04 INFO - Revision ID: 0x0009 01:31:04 INFO - Displays: 01:31:04 INFO - Display: 01:31:04 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:31:04 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:31:04 INFO - Display Serial Number: 1600x1200 60 01:31:04 INFO - Main Display: Yes 01:31:04 INFO - Mirror: Off 01:31:04 INFO - Online: Yes 01:31:04 INFO - Rotation: Supported 01:31:04 INFO - Return code: 0 01:31:04 INFO - Running post-action listener: _resource_record_post_action 01:31:04 INFO - Running post-run listener: _resource_record_post_run 01:31:05 INFO - Total resource usage - Wall time: 1210s; CPU: 54.0%; Read bytes: 38118912; Write bytes: 699747328; Read time: 403; Write time: 1968 01:31:05 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 374540800; Write bytes: 370358272; Read time: 28093; Write time: 690 01:31:05 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 37164544; Write bytes: 299901952; Read time: 389; Write time: 1223 01:31:05 INFO - Running post-run listener: _upload_blobber_files 01:31:05 INFO - Blob upload gear active. 01:31:05 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:31:05 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 01:31:05 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'] 01:31:05 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 01:31:05 INFO - (blobuploader) - INFO - Open directory for files ... 01:31:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:31:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:31:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:31:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:31:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:31:07 INFO - (blobuploader) - INFO - Done attempting. 01:31:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:31:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:31:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:31:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:31:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:31:08 INFO - (blobuploader) - INFO - Done attempting. 01:31:08 INFO - (blobuploader) - INFO - Iteration through files over. 01:31:08 INFO - Return code: 0 01:31:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:31:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:31:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f42ed88b373ccac8f22d1f67831c776a11c37ef3d9ec5a3cba3e09757efc0bc13bb3df76cdd4c00ef04e844c188635fbc07876b401b1010376c92412a3ccb119", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5255d159cc732734a8d5847c993e7786affccc08d100e0fdbb140e6b0907d1765b5e9d6cdcea86ece0e47d81fe30d9a74c69e13f5cfd3c7258e9c4e329b2b3fd"} 01:31:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:31:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:31:08 INFO - Contents: 01:31:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f42ed88b373ccac8f22d1f67831c776a11c37ef3d9ec5a3cba3e09757efc0bc13bb3df76cdd4c00ef04e844c188635fbc07876b401b1010376c92412a3ccb119", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5255d159cc732734a8d5847c993e7786affccc08d100e0fdbb140e6b0907d1765b5e9d6cdcea86ece0e47d81fe30d9a74c69e13f5cfd3c7258e9c4e329b2b3fd"} 01:31:08 INFO - Running post-run listener: copy_logs_to_upload_dir 01:31:08 INFO - Copying logs to upload dir... 01:31:08 INFO - mkdir: /builds/slave/test/build/upload/logs 01:31:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1280.551188 ========= master_lag: 1.80 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2016-04-28 01:31:09.861196) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 01:31:09.864415) ========= 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.HMS2ghpZ4G/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.vL7HWApvW5/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f42ed88b373ccac8f22d1f67831c776a11c37ef3d9ec5a3cba3e09757efc0bc13bb3df76cdd4c00ef04e844c188635fbc07876b401b1010376c92412a3ccb119", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5255d159cc732734a8d5847c993e7786affccc08d100e0fdbb140e6b0907d1765b5e9d6cdcea86ece0e47d81fe30d9a74c69e13f5cfd3c7258e9c4e329b2b3fd"} build_url:https://queue.taskcluster.net/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011254 build_url: 'https://queue.taskcluster.net/v1/task/QZmVoBt0RtKybHynciIPIg/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f42ed88b373ccac8f22d1f67831c776a11c37ef3d9ec5a3cba3e09757efc0bc13bb3df76cdd4c00ef04e844c188635fbc07876b401b1010376c92412a3ccb119", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5255d159cc732734a8d5847c993e7786affccc08d100e0fdbb140e6b0907d1765b5e9d6cdcea86ece0e47d81fe30d9a74c69e13f5cfd3c7258e9c4e329b2b3fd"}' ========= master_lag: 0.69 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-28 01:31:10.570635) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 01:31:10.570973) ========= 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.HMS2ghpZ4G/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.vL7HWApvW5/Listeners TMPDIR=/var/folders/jj/s59qmh6s1dz_jfxlkd9gr08000000w/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.005315 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-28 01:31:10.595578) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 01:31:10.596191) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-28 01:31:10.599504) ========= ========= Total master_lag: 2.58 =========