builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0062 starttime: 1461766539.91 results: success (0) buildid: 20160427052757 builduid: 3aa542c441f54db4a05b356d7bdc99e3 revision: c3983f53698acf6fb89233470f25fcb249330fff ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 07:15:39.912095) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-27 07:15:39.912570) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 07:15:39.912980) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-27 07:15:39.999119) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:15:39.999421) ========= 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.eVnzz6s2wC/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.MtoXLDudoJ/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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-27 07:15:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 154M=0s 2016-04-27 07:15:40 (154 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.450121 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:15:40.467066) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:15:40.467384) ========= 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.eVnzz6s2wC/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.MtoXLDudoJ/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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.026122 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-27 07:15:40.515777) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-27 07:15:40.516145) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev c3983f53698acf6fb89233470f25fcb249330fff --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 c3983f53698acf6fb89233470f25fcb249330fff --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eVnzz6s2wC/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.MtoXLDudoJ/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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-27 07:15:40,588 truncating revision to first 12 chars 2016-04-27 07:15:40,588 Setting DEBUG logging. 2016-04-27 07:15:40,588 attempt 1/10 2016-04-27 07:15:40,589 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/c3983f53698a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-27 07:15:41,339 unpacking tar archive at: fx-team-c3983f53698a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.001866 ========= master_lag: 0.30 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-04-27 07:15:41.822384) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 07:15:41.822684) ========= script_repo_revision: c3983f53698acf6fb89233470f25fcb249330fff ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-27 07:15:41.823074) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 07:15:41.823383) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-27 07:15:42.154585) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2016-04-27 07:15:42.155018) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.eVnzz6s2wC/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.MtoXLDudoJ/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 07:15:42 INFO - MultiFileLogger online at 20160427 07:15:42 in /builds/slave/test 07:15:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 07:15:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:15:42 INFO - {'append_to_log': False, 07:15:42 INFO - 'base_work_dir': '/builds/slave/test', 07:15:42 INFO - 'blob_upload_branch': 'Fx-Team', 07:15:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:15:42 INFO - 'branch': 'Fx-Team', 07:15:42 INFO - 'buildbot_json_path': 'buildprops.json', 07:15:42 INFO - 'config_files': ('talos/mac_config.py',), 07:15:42 INFO - 'default_actions': ('clobber', 07:15:42 INFO - 'read-buildbot-config', 07:15:42 INFO - 'download-and-extract', 07:15:42 INFO - 'populate-webroot', 07:15:42 INFO - 'create-virtualenv', 07:15:42 INFO - 'install', 07:15:42 INFO - 'run-tests'), 07:15:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:15:42 INFO - 'download_minidump_stackwalk': True, 07:15:42 INFO - 'download_symbols': 'ondemand', 07:15:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:15:42 INFO - 'tooltool.py': '/tools/tooltool.py', 07:15:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:15:42 INFO - '/tools/misc-python/virtualenv.py')}, 07:15:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:15:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:15:42 INFO - 'installer_path': 'installer.exe', 07:15:42 INFO - 'log_level': 'info', 07:15:42 INFO - 'log_name': 'talos', 07:15:42 INFO - 'log_to_console': True, 07:15:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:15:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:15:42 INFO - 'opt_config_files': (), 07:15:42 INFO - 'pip_index': False, 07:15:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:15:42 INFO - 'cmd': ('bash', 07:15:42 INFO - '-c', 07:15:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:15:42 INFO - 'enabled': True, 07:15:42 INFO - 'halt_on_failure': False, 07:15:42 INFO - 'name': 'check_screen_resolution'},), 07:15:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:15:42 INFO - 'cmd': ('bash', 07:15:42 INFO - '-c', 07:15:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:15:42 INFO - 'enabled': True, 07:15:42 INFO - 'halt_on_failure': False, 07:15:42 INFO - 'name': 'check_screen_resolution'},), 07:15:42 INFO - 'run_cmd_checks_enabled': True, 07:15:42 INFO - 'sps_profile': False, 07:15:42 INFO - 'sps_profile_interval': 0, 07:15:42 INFO - 'suite': 'dromaeojs', 07:15:42 INFO - 'system_bits': '32', 07:15:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:15:42 INFO - 'title': 't-yosemite-r7-0062', 07:15:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:15:42 INFO - 'use_talos_json': True, 07:15:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:15:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:15:42 INFO - 'work_dir': 'build'} 07:15:42 INFO - ##### 07:15:42 INFO - ##### Running clobber step. 07:15:42 INFO - ##### 07:15:42 INFO - Running pre-action listener: _resource_record_pre_action 07:15:42 INFO - Running main action method: clobber 07:15:42 INFO - rmtree: /builds/slave/test/build 07:15:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:15:43 INFO - Running post-action listener: _resource_record_post_action 07:15:44 INFO - ##### 07:15:44 INFO - ##### Running read-buildbot-config step. 07:15:44 INFO - ##### 07:15:44 INFO - Running pre-action listener: _resource_record_pre_action 07:15:44 INFO - Running main action method: read_buildbot_config 07:15:44 INFO - Using buildbot properties: 07:15:44 INFO - { 07:15:44 INFO - "project": "", 07:15:44 INFO - "product": "firefox", 07:15:44 INFO - "script_repo_revision": "production", 07:15:44 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 07:15:44 INFO - "repository": "", 07:15:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 07:15:44 INFO - "buildid": "20160427052757", 07:15:44 INFO - "pgo_build": "False", 07:15:44 INFO - "basedir": "/builds/slave/test", 07:15:44 INFO - "buildnumber": 673, 07:15:44 INFO - "slavename": "t-yosemite-r7-0062", 07:15:44 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 07:15:44 INFO - "platform": "yosemite_r7", 07:15:44 INFO - "scheduler": "tests-fx-team-macosx64-talos", 07:15:44 INFO - "branch": "fx-team", 07:15:44 INFO - "repo_path": "integration/fx-team", 07:15:44 INFO - "revision": "c3983f53698acf6fb89233470f25fcb249330fff", 07:15:44 INFO - "stage_platform": "macosx64", 07:15:44 INFO - "builduid": "3aa542c441f54db4a05b356d7bdc99e3", 07:15:44 INFO - "slavebuilddir": "test" 07:15:44 INFO - } 07:15:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg. 07:15:44 INFO - Running post-action listener: _resource_record_post_action 07:15:44 INFO - ##### 07:15:44 INFO - ##### Running download-and-extract step. 07:15:44 INFO - ##### 07:15:44 INFO - Running pre-action listener: _resource_record_pre_action 07:15:44 INFO - Running main action method: download_and_extract 07:15:44 INFO - mkdir: /builds/slave/test/build/tests 07:15: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')]} 07:15:44 INFO - https://queue.taskcluster.net/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 07:15:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 07:15:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/artifacts/public/build/firefox-49.0a1.en-US.mac.test_packages.json 07:15:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/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 07:15:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/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 07:15:58 INFO - Downloaded 1199 bytes. 07:15:58 INFO - Reading from file /builds/slave/test/build/firefox-49.0a1.en-US.mac.test_packages.json 07:15:58 INFO - Using the following test package requirements: 07:15:58 INFO - {u'common': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 07:15:58 INFO - u'cppunittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:15:58 INFO - u'firefox-49.0a1.en-US.mac.cppunittest.tests.zip'], 07:15:58 INFO - u'gtest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:15:58 INFO - u'firefox-49.0a1.en-US.mac.gtest.tests.zip'], 07:15:58 INFO - u'jittest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:15:58 INFO - u'jsshell-mac.zip'], 07:15:58 INFO - u'mochitest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:15:58 INFO - u'firefox-49.0a1.en-US.mac.mochitest.tests.zip'], 07:15:58 INFO - u'mozbase': [u'firefox-49.0a1.en-US.mac.common.tests.zip'], 07:15:58 INFO - u'reftest': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:15:58 INFO - u'firefox-49.0a1.en-US.mac.reftest.tests.zip'], 07:15:58 INFO - u'talos': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:15:58 INFO - u'firefox-49.0a1.en-US.mac.talos.tests.zip'], 07:15:58 INFO - u'web-platform': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:15:58 INFO - u'firefox-49.0a1.en-US.mac.web-platform.tests.zip'], 07:15:58 INFO - u'xpcshell': [u'firefox-49.0a1.en-US.mac.common.tests.zip', 07:15:58 INFO - u'firefox-49.0a1.en-US.mac.xpcshell.tests.zip']} 07:15:58 INFO - Downloading packages: [u'firefox-49.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:15: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')]} 07:15:58 INFO - https://queue.taskcluster.net/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:15:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 07:15:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 07:15:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/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 07:15:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/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 07:16:12 INFO - Downloaded 18117644 bytes. 07:16:12 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'] 07:16:12 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 07:16:15 INFO - Return code: 0 07:16:15 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 07:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:15 INFO - https://queue.taskcluster.net/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 07:16:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 07:16:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/artifacts/public/build/firefox-49.0a1.en-US.mac.common.tests.zip 07:16:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/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 07:16:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/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 07:16:18 INFO - Downloaded 18117644 bytes. 07:16:18 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'] 07:16:18 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 07:16:21 INFO - Return code: 0 07:16:21 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')]} 07:16:21 INFO - https://queue.taskcluster.net/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 07:16:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 07:16:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/artifacts/public/build/firefox-49.0a1.en-US.mac.talos.tests.zip 07:16:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/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 07:16:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/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 07:16:22 INFO - Downloaded 10840145 bytes. 07:16:22 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'] 07:16:22 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 07:16:23 INFO - Return code: 0 07:16:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:23 INFO - https://queue.taskcluster.net/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 07:16:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 07:16:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 07:16:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-49.0a1.en-US.mac.dmg 07:16:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/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 07:16:26 INFO - Downloaded 110190434 bytes. 07:16:26 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 07:16:26 INFO - mkdir: /builds/slave/test/properties 07:16:26 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:16:26 INFO - Writing to file /builds/slave/test/properties/build_url 07:16:26 INFO - Contents: 07:16:26 INFO - build_url:https://queue.taskcluster.net/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg 07:16:27 INFO - Running post-action listener: _resource_record_post_action 07:16:27 INFO - Running post-action listener: set_extra_try_arguments 07:16:27 INFO - ##### 07:16:27 INFO - ##### Running populate-webroot step. 07:16:27 INFO - ##### 07:16:27 INFO - Running pre-action listener: _resource_record_pre_action 07:16:27 INFO - Running main action method: populate_webroot 07:16:27 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:16:27 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:16:27 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:16:27 INFO - '--tppagecycles', 07:16:27 INFO - '7'], 07:16:27 INFO - 'tests': ['tsvgm']}}, 07:16:27 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:16:27 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:16:27 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:16:27 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:16:27 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:16:27 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:16:27 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:27 INFO - 'talos_options': ['--disable-e10s'], 07:16:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:16:27 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:27 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:16:27 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:27 INFO - 'talos_options': ['--disable-e10s'], 07:16:27 INFO - 'tests': ['damp', 'tps']}, 07:16:27 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:27 INFO - 'tests': ['damp', 'tps']}, 07:16:27 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:16:27 INFO - 'tests': ['dromaeo_dom']}, 07:16:27 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:16:27 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:16:27 INFO - 'tests': ['a11yr', 07:16:27 INFO - 'ts_paint', 07:16:27 INFO - 'tpaint', 07:16:27 INFO - 'sessionrestore', 07:16:27 INFO - 'sessionrestore_no_auto_restore', 07:16:27 INFO - 'tabpaint']}, 07:16:27 INFO - 'other-e10s': {'tests': ['a11yr', 07:16:27 INFO - 'ts_paint', 07:16:27 INFO - 'tpaint', 07:16:27 INFO - 'sessionrestore', 07:16:27 INFO - 'sessionrestore_no_auto_restore', 07:16:27 INFO - 'tabpaint']}, 07:16:27 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:16:27 INFO - 'ts_paint', 07:16:27 INFO - 'tpaint', 07:16:27 INFO - 'sessionrestore', 07:16:27 INFO - 'sessionrestore_no_auto_restore', 07:16:27 INFO - 'tabpaint']}, 07:16:27 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:16:27 INFO - 'ts_paint', 07:16:27 INFO - 'tpaint', 07:16:27 INFO - 'sessionrestore', 07:16:27 INFO - 'sessionrestore_no_auto_restore', 07:16:27 INFO - 'tabpaint']}, 07:16:27 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:16:27 INFO - 'tests': ['a11yr', 07:16:27 INFO - 'ts_paint', 07:16:27 INFO - 'tpaint', 07:16:27 INFO - 'sessionrestore', 07:16:27 INFO - 'sessionrestore_no_auto_restore', 07:16:27 INFO - 'tabpaint']}, 07:16:27 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:16:27 INFO - 'tests': ['a11yr', 07:16:27 INFO - 'ts_paint', 07:16:27 INFO - 'tpaint', 07:16:27 INFO - 'sessionrestore', 07:16:27 INFO - 'sessionrestore_no_auto_restore', 07:16:27 INFO - 'tabpaint']}, 07:16:27 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:16:27 INFO - 'tests': ['tsvgx', 07:16:27 INFO - 'tsvgr_opacity', 07:16:27 INFO - 'tart', 07:16:27 INFO - 'tscrollx', 07:16:27 INFO - 'cart']}, 07:16:27 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:16:27 INFO - 'tsvgr_opacity', 07:16:27 INFO - 'tart', 07:16:27 INFO - 'tscrollx', 07:16:27 INFO - 'cart']}, 07:16:27 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:27 INFO - 'talos_options': ['--disable-e10s'], 07:16:27 INFO - 'tests': ['tp5o']}, 07:16:27 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:27 INFO - 'tests': ['tp5o']}, 07:16:27 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:27 INFO - 'talos_options': ['--disable-e10s', 07:16:27 INFO - '--xperf_path', 07:16:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:16:27 INFO - 'tests': ['tp5n']}, 07:16:27 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:16:27 INFO - 'talos_options': ['--xperf_path', 07:16:27 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:16:27 INFO - 'tests': ['tp5n']}}, 07:16:27 INFO - 'talos.zip': {'path': '', 07:16:27 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:16:27 INFO - Running post-action listener: _resource_record_post_action 07:16:27 INFO - ##### 07:16:27 INFO - ##### Running create-virtualenv step. 07:16:27 INFO - ##### 07:16:27 INFO - Running pre-action listener: _resource_record_pre_action 07:16:27 INFO - Running main action method: create_virtualenv 07:16:27 INFO - Creating virtualenv /builds/slave/test/build/venv 07:16:27 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 07:16:27 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:16:27 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:16:27 INFO - Using real prefix '/tools/python27' 07:16:27 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:16:28 INFO - Installing distribute.............................................................................................................................................................................................done. 07:16:30 INFO - Installing pip.................done. 07:16:30 INFO - Return code: 0 07:16:30 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:30 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 0x109798a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097a8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02bc90910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109637e00>, '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 0x109460db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109632b20>, '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.eVnzz6s2wC/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.MtoXLDudoJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 07:16:30 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 07:16:30 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 07:16:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eVnzz6s2wC/Render', 07:16:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:16:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:16:30 INFO - 'HOME': '/Users/cltbld', 07:16:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:16:30 INFO - 'LOGNAME': 'cltbld', 07:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:30 INFO - 'MOZ_NO_REMOTE': '1', 07:16:30 INFO - 'NO_EM_RESTART': '1', 07:16:30 INFO - 'PAGER': '/bin/cat', 07:16:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:30 INFO - 'PWD': '/builds/slave/test', 07:16:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:16:30 INFO - 'SHELL': '/bin/bash', 07:16:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MtoXLDudoJ/Listeners', 07:16:30 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 07:16:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:16:30 INFO - 'USER': 'cltbld', 07:16:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:16:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:30 INFO - 'XPC_FLAGS': '0x0', 07:16:30 INFO - 'XPC_SERVICE_NAME': '0', 07:16:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:31 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 07:16:31 INFO - Cleaning up... 07:16:31 INFO - Return code: 0 07:16:31 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109798a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097a8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02bc90910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109637e00>, '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 0x109460db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109632b20>, '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.eVnzz6s2wC/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.MtoXLDudoJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 07:16:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 07:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 07:16:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eVnzz6s2wC/Render', 07:16:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:16:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:16:31 INFO - 'HOME': '/Users/cltbld', 07:16:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:16:31 INFO - 'LOGNAME': 'cltbld', 07:16:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:31 INFO - 'MOZ_NO_REMOTE': '1', 07:16:31 INFO - 'NO_EM_RESTART': '1', 07:16:31 INFO - 'PAGER': '/bin/cat', 07:16:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:16:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:31 INFO - 'PWD': '/builds/slave/test', 07:16:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:16:31 INFO - 'SHELL': '/bin/bash', 07:16:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MtoXLDudoJ/Listeners', 07:16:31 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 07:16:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:16:31 INFO - 'USER': 'cltbld', 07:16:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:16:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:16:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:31 INFO - 'XPC_FLAGS': '0x0', 07:16:31 INFO - 'XPC_SERVICE_NAME': '0', 07:16:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:16:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:31 INFO - Downloading/unpacking psutil>=0.7.1 07:16:31 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 07:16:31 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 07:16:31 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 07:16:31 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 07:16:31 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 07:16:31 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 07:16:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:16:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:16:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:16:34 INFO - Installing collected packages: psutil 07:16:34 INFO - Running setup.py install for psutil 07:16:34 INFO - building 'psutil._psutil_osx' extension 07:16:34 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 07:16:35 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 07:16:35 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 07:16:35 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 07:16:35 INFO - building 'psutil._psutil_posix' extension 07:16:35 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 07:16:35 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:16:35 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:16:35 INFO - ^ 07:16:35 INFO - 1 warning generated. 07:16:35 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 07:16:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:16:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:16:35 INFO - Successfully installed psutil 07:16:35 INFO - Cleaning up... 07:16:35 INFO - Return code: 0 07:16:35 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x109798a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097a8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02bc90910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109637e00>, '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 0x109460db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109632b20>, '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.eVnzz6s2wC/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.MtoXLDudoJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 07:16:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 07:16:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 07:16:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eVnzz6s2wC/Render', 07:16:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:16:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:16:35 INFO - 'HOME': '/Users/cltbld', 07:16:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:16:35 INFO - 'LOGNAME': 'cltbld', 07:16:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:35 INFO - 'MOZ_NO_REMOTE': '1', 07:16:35 INFO - 'NO_EM_RESTART': '1', 07:16:35 INFO - 'PAGER': '/bin/cat', 07:16:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:16:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:35 INFO - 'PWD': '/builds/slave/test', 07:16:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:16:35 INFO - 'SHELL': '/bin/bash', 07:16:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MtoXLDudoJ/Listeners', 07:16:35 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 07:16:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:16:35 INFO - 'USER': 'cltbld', 07:16:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:16:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:16:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:35 INFO - 'XPC_FLAGS': '0x0', 07:16:35 INFO - 'XPC_SERVICE_NAME': '0', 07:16:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:16:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:35 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:16:35 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 07:16:35 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 07:16:35 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 07:16:35 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 07:16:35 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 07:16:35 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 07:16:38 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:16:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:16:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:16:38 INFO - Installing collected packages: mozsystemmonitor 07:16:38 INFO - Running setup.py install for mozsystemmonitor 07:16:38 INFO - Successfully installed mozsystemmonitor 07:16:38 INFO - Cleaning up... 07:16:38 INFO - Return code: 0 07:16:38 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:16:38 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')]} 07:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:38 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')]} 07:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:38 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 0x109798a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097a8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02bc90910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109637e00>, '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 0x109460db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109632b20>, '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.eVnzz6s2wC/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.MtoXLDudoJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 07:16:38 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 07:16:38 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 07:16:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eVnzz6s2wC/Render', 07:16:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:16:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:16:38 INFO - 'HOME': '/Users/cltbld', 07:16:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:16:38 INFO - 'LOGNAME': 'cltbld', 07:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:38 INFO - 'MOZ_NO_REMOTE': '1', 07:16:38 INFO - 'NO_EM_RESTART': '1', 07:16:38 INFO - 'PAGER': '/bin/cat', 07:16:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:38 INFO - 'PWD': '/builds/slave/test', 07:16:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:16:38 INFO - 'SHELL': '/bin/bash', 07:16:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MtoXLDudoJ/Listeners', 07:16:38 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 07:16:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:16:38 INFO - 'USER': 'cltbld', 07:16:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:16:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:38 INFO - 'XPC_FLAGS': '0x0', 07:16:38 INFO - 'XPC_SERVICE_NAME': '0', 07:16:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:38 INFO - Downloading/unpacking blobuploader==1.2.4 07:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:41 INFO - Downloading blobuploader-1.2.4.tar.gz 07:16:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:16:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:16: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 07:16: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 07:16: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 07:16: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 07:16: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 07:16: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 07:16:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:16:41 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:16: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 07:16: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 07:16: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 07:16: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 07:16: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 07:16: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 07:16:42 INFO - Downloading docopt-0.6.1.tar.gz 07:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:16:42 INFO - Installing collected packages: blobuploader, requests, docopt 07:16:42 INFO - Running setup.py install for blobuploader 07:16:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:16:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:16:42 INFO - Running setup.py install for requests 07:16:43 INFO - Running setup.py install for docopt 07:16:43 INFO - Successfully installed blobuploader requests docopt 07:16:43 INFO - Cleaning up... 07:16:43 INFO - Return code: 0 07:16:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:16:43 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')]} 07:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:43 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')]} 07:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:43 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 0x109798a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097a8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02bc90910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109637e00>, '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 0x109460db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109632b20>, '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.eVnzz6s2wC/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.MtoXLDudoJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 07:16:43 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 07:16:43 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 07:16:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eVnzz6s2wC/Render', 07:16:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:16:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:16:43 INFO - 'HOME': '/Users/cltbld', 07:16:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:16:43 INFO - 'LOGNAME': 'cltbld', 07:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:43 INFO - 'MOZ_NO_REMOTE': '1', 07:16:43 INFO - 'NO_EM_RESTART': '1', 07:16:43 INFO - 'PAGER': '/bin/cat', 07:16:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:43 INFO - 'PWD': '/builds/slave/test', 07:16:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:16:43 INFO - 'SHELL': '/bin/bash', 07:16:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MtoXLDudoJ/Listeners', 07:16:43 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 07:16:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:16:43 INFO - 'USER': 'cltbld', 07:16:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:16:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:43 INFO - 'XPC_FLAGS': '0x0', 07:16:43 INFO - 'XPC_SERVICE_NAME': '0', 07:16:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:16:43 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-yzHDNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:16:43 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-0CtAIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:16:43 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-bkdvAi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:16:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:16:43 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-gTN3ui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:16:44 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-oIgDh8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:16:44 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-Nv21tg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:16:44 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-YFm5zR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:16:44 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-6r2rxj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:16:44 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-6kpAUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:16:44 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-oeH5jM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:16:44 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-j3TdXp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:16:44 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-JEN2vm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:16:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:16:44 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-22IAxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:16:45 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-M5HaPu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:45 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-ITDqMC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:16:45 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-bE7vwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:16:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:16:45 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-DjxXnv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:16:45 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:16:45 INFO - Running setup.py install for manifestparser 07:16:45 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:16:45 INFO - Running setup.py install for mozcrash 07:16:45 INFO - Running setup.py install for mozdebug 07:16:45 INFO - Running setup.py install for mozdevice 07:16:46 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:16:46 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:16:46 INFO - Running setup.py install for mozfile 07:16:46 INFO - Running setup.py install for mozhttpd 07:16:46 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:16:46 INFO - Running setup.py install for mozinfo 07:16:46 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:16:46 INFO - Running setup.py install for mozInstall 07:16:46 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:16:46 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:16:46 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:16:46 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:16:46 INFO - Running setup.py install for mozleak 07:16:46 INFO - Running setup.py install for mozlog 07:16:46 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:16:46 INFO - Running setup.py install for moznetwork 07:16:47 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:16:47 INFO - Running setup.py install for mozprocess 07:16:47 INFO - Running setup.py install for mozprofile 07:16:47 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:16:47 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:16:47 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:16:47 INFO - Running setup.py install for mozrunner 07:16:47 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:16:47 INFO - Running setup.py install for mozscreenshot 07:16:47 INFO - Running setup.py install for moztest 07:16:47 INFO - Running setup.py install for mozversion 07:16:48 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:16:48 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:16:48 INFO - Cleaning up... 07:16:48 INFO - Return code: 0 07:16:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:16: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')]} 07:16:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16: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')]} 07:16:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:48 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 0x109798a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097a8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02bc90910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109637e00>, '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 0x109460db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109632b20>, '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.eVnzz6s2wC/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.MtoXLDudoJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 07:16:48 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 07:16:48 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 07:16:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eVnzz6s2wC/Render', 07:16:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:16:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:16:48 INFO - 'HOME': '/Users/cltbld', 07:16:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:16:48 INFO - 'LOGNAME': 'cltbld', 07:16:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:48 INFO - 'MOZ_NO_REMOTE': '1', 07:16:48 INFO - 'NO_EM_RESTART': '1', 07:16:48 INFO - 'PAGER': '/bin/cat', 07:16:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:16:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:48 INFO - 'PWD': '/builds/slave/test', 07:16:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:16:48 INFO - 'SHELL': '/bin/bash', 07:16:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MtoXLDudoJ/Listeners', 07:16:48 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 07:16:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:16:48 INFO - 'USER': 'cltbld', 07:16:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:16:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:16:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:48 INFO - 'XPC_FLAGS': '0x0', 07:16:48 INFO - 'XPC_SERVICE_NAME': '0', 07:16:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:16:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:16:48 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-VQDiUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:16:48 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)) 07:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:16:48 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-o7pmNs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:16:48 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)) 07:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:16:48 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-TtTxt4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:16:48 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)) 07:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:16:48 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-3LpWTm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:16:48 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)) 07:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:16:48 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-mYxppz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:16:48 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)) 07:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:16:48 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-yrhlk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:16:48 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)) 07:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:16:48 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-_bwwj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:16:49 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)) 07:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:16:49 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-YcvNek-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:16:49 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)) 07:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:16:49 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-d2dMDa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:16:49 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)) 07:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:16:49 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-6GE9ZN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:16:49 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)) 07:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:16:49 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-W338Bn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:16:49 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)) 07:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:16:49 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-HGPoQO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:16:49 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)) 07:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:16:49 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-7qij8Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:16:49 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)) 07:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:16:49 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-VXepz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:16:49 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)) 07:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:49 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-K4v7pS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:16:49 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)) 07:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:16:49 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-JHEySN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:16:50 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)) 07:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:16:50 INFO - Running setup.py (path:/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/pip-8y7IcA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:16:50 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)) 07:16:50 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)) 07:16:50 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)) 07:16:50 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)) 07:16:50 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)) 07:16:50 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)) 07:16:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:52 INFO - Downloading blessings-1.6.tar.gz 07:16:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:16:52 INFO - Installing collected packages: blessings 07:16:52 INFO - Running setup.py install for blessings 07:16:53 INFO - Successfully installed blessings 07:16:53 INFO - Cleaning up... 07:16:53 INFO - Return code: 0 07:16:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:16:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:16:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:16:53 INFO - Reading from file tmpfile_stdout 07:16:53 INFO - Current package versions: 07:16:53 INFO - blessings == 1.6 07:16:53 INFO - blobuploader == 1.2.4 07:16:53 INFO - docopt == 0.6.1 07:16:53 INFO - manifestparser == 1.1 07:16:53 INFO - mozInstall == 1.12 07:16:53 INFO - mozcrash == 0.17 07:16:53 INFO - mozdebug == 0.1 07:16:53 INFO - mozdevice == 0.48 07:16:53 INFO - mozfile == 1.2 07:16:53 INFO - mozhttpd == 0.7 07:16:53 INFO - mozinfo == 0.9 07:16:53 INFO - mozleak == 0.1 07:16:53 INFO - mozlog == 3.1 07:16:53 INFO - moznetwork == 0.27 07:16:53 INFO - mozprocess == 0.22 07:16:53 INFO - mozprofile == 0.28 07:16:53 INFO - mozrunner == 6.11 07:16:53 INFO - mozscreenshot == 0.1 07:16:53 INFO - mozsystemmonitor == 0.0 07:16:53 INFO - moztest == 0.7 07:16:53 INFO - mozversion == 1.4 07:16:53 INFO - psutil == 3.1.1 07:16:53 INFO - requests == 1.2.3 07:16:53 INFO - wsgiref == 0.1.2 07:16:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:53 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 0x109798a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097a8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02bc90910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109637e00>, '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 0x109460db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109632b20>, '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.eVnzz6s2wC/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.MtoXLDudoJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 07:16:53 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 07:16:53 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 07:16:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eVnzz6s2wC/Render', 07:16:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:16:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:16:53 INFO - 'HOME': '/Users/cltbld', 07:16:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:16:53 INFO - 'LOGNAME': 'cltbld', 07:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:53 INFO - 'MOZ_NO_REMOTE': '1', 07:16:53 INFO - 'NO_EM_RESTART': '1', 07:16:53 INFO - 'PAGER': '/bin/cat', 07:16:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:53 INFO - 'PWD': '/builds/slave/test', 07:16:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:16:53 INFO - 'SHELL': '/bin/bash', 07:16:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MtoXLDudoJ/Listeners', 07:16:53 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 07:16:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:16:53 INFO - 'USER': 'cltbld', 07:16:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:16:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:53 INFO - 'XPC_FLAGS': '0x0', 07:16:53 INFO - 'XPC_SERVICE_NAME': '0', 07:16:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:53 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)) 07:16:53 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)) 07:16:53 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)) 07:16:53 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)) 07:16:53 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)) 07:16:53 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)) 07:16:53 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)) 07:16:53 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)) 07:16:53 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)) 07:16:53 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)) 07:16:53 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)) 07:16:53 INFO - Cleaning up... 07:16:53 INFO - Return code: 0 07:16:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x109798a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097a8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02bc90910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109637e00>, '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 0x109460db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109632b20>, '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.eVnzz6s2wC/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.MtoXLDudoJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 07:16:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 07:16:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 07:16:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eVnzz6s2wC/Render', 07:16:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:16:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:16:53 INFO - 'HOME': '/Users/cltbld', 07:16:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:16:53 INFO - 'LOGNAME': 'cltbld', 07:16:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:53 INFO - 'MOZ_NO_REMOTE': '1', 07:16:53 INFO - 'NO_EM_RESTART': '1', 07:16:53 INFO - 'PAGER': '/bin/cat', 07:16:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:16:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:53 INFO - 'PWD': '/builds/slave/test', 07:16:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:16:53 INFO - 'SHELL': '/bin/bash', 07:16:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MtoXLDudoJ/Listeners', 07:16:53 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 07:16:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:16:53 INFO - 'USER': 'cltbld', 07:16:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:16:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:16:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:53 INFO - 'XPC_FLAGS': '0x0', 07:16:53 INFO - 'XPC_SERVICE_NAME': '0', 07:16:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:16:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:54 INFO - Downloading/unpacking jsonschema 07:16:54 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 07:16:54 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 07:16:54 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 07:16:54 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 07:16:54 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 07:16:54 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 07:16:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:16:56 INFO - Downloading/unpacking functools32 (from jsonschema) 07:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:16:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:16:56 INFO - Downloading functools32-3.2.3-2.tar.gz 07:16:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:16:56 INFO - warning: no files found matching '*.txt' 07:16:56 INFO - no previously-included directories found matching 'build' 07:16:56 INFO - no previously-included directories found matching 'dist' 07:16:56 INFO - no previously-included directories found matching '.git*' 07:16:56 INFO - Installing collected packages: jsonschema, functools32 07:16:57 INFO - Running setup.py install for functools32 07:16:57 INFO - warning: no files found matching '*.txt' 07:16:57 INFO - no previously-included directories found matching 'build' 07:16:57 INFO - no previously-included directories found matching 'dist' 07:16:57 INFO - no previously-included directories found matching '.git*' 07:16:57 INFO - Successfully installed jsonschema functools32 07:16:57 INFO - Cleaning up... 07:16:57 INFO - Return code: 0 07:16:57 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:16:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:16:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:16:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:16:57 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 0x109798a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1097a8420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa02bc90910>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x109637e00>, '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 0x109460db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109632b20>, '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.eVnzz6s2wC/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.MtoXLDudoJ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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 07:16:57 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 07:16:57 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 07:16:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eVnzz6s2wC/Render', 07:16:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:16:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:16:57 INFO - 'HOME': '/Users/cltbld', 07:16:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:16:57 INFO - 'LOGNAME': 'cltbld', 07:16:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:16:57 INFO - 'MOZ_NO_REMOTE': '1', 07:16:57 INFO - 'NO_EM_RESTART': '1', 07:16:57 INFO - 'PAGER': '/bin/cat', 07:16:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:16:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:16:57 INFO - 'PWD': '/builds/slave/test', 07:16:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:16:57 INFO - 'SHELL': '/bin/bash', 07:16:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MtoXLDudoJ/Listeners', 07:16:57 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 07:16:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:16:57 INFO - 'USER': 'cltbld', 07:16:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:16:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:16:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:16:57 INFO - 'XPC_FLAGS': '0x0', 07:16:57 INFO - 'XPC_SERVICE_NAME': '0', 07:16:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:16:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:16:57 INFO - Downloading/unpacking flake8 07:16:57 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 07:16:57 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 07:16:57 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 07:16:57 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 07:16:57 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 07:16:57 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 07:16:59 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:16:59 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:16:59 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 07:16:59 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 07:16:59 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 07:16:59 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 07:16:59 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 07:16:59 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 07:17:00 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:17:00 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:17:00 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 07:17:00 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 07:17:00 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 07:17:00 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 07:17:00 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 07:17:00 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 07:17:00 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:17:00 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 07:17:00 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 07:17:00 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 07:17:00 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 07:17:00 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 07:17:00 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 07:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:17:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:17:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:17:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:17:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:17:01 INFO - no previously-included directories found matching 'docs/_build' 07:17:01 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:17:01 INFO - Running setup.py install for pep8 07:17:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:17:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:17:01 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:17:01 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:17:01 INFO - no previously-included directories found matching 'docs/_build' 07:17:01 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:17:01 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:17:01 INFO - Cleaning up... 07:17:01 INFO - Return code: 0 07:17:01 INFO - Running post-action listener: _resource_record_post_action 07:17:01 INFO - Running post-action listener: _start_resource_monitoring 07:17:01 INFO - Starting resource monitoring. 07:17:01 INFO - ##### 07:17:01 INFO - ##### Running install step. 07:17:01 INFO - ##### 07:17:01 INFO - Running pre-action listener: _resource_record_pre_action 07:17:01 INFO - Running main action method: install 07:17:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:17:01 INFO - Reading from file tmpfile_stdout 07:17:01 INFO - Detecting whether we're running mozinstall >=1.0... 07:17:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:17:02 INFO - Reading from file tmpfile_stdout 07:17:02 INFO - Output received: 07:17:02 INFO - Usage: mozinstall [options] installer 07:17:02 INFO - Options: 07:17:02 INFO - -h, --help show this help message and exit 07:17:02 INFO - -d DEST, --destination=DEST 07:17:02 INFO - Directory to install application into. [default: 07:17:02 INFO - "/builds/slave/test"] 07:17:02 INFO - --app=APP Application being installed. [default: firefox] 07:17:02 INFO - mkdir: /builds/slave/test/build/application 07:17:02 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'] 07:17:02 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 07:17:35 INFO - Reading from file tmpfile_stdout 07:17:35 INFO - Output received: 07:17:35 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:17:35 INFO - Running post-action listener: _resource_record_post_action 07:17:35 INFO - ##### 07:17:35 INFO - ##### Running run-tests step. 07:17:35 INFO - ##### 07:17:35 INFO - Running pre-action listener: _resource_record_pre_action 07:17:35 INFO - Running main action method: run_tests 07:17:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:17:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:17:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:17:35 INFO - 2016-04-27 07:17:35.236 screenresolution[1647:9488] starting screenresolution argv=screenresolution get 07:17:35 INFO - 2016-04-27 07:17:35.239 screenresolution[1647:9488] Display 0: 1600x1200x32@60 07:17:35 INFO - 2016-04-27 07:17:35.245 screenresolution[1648:9490] starting screenresolution argv=screenresolution list 07:17:35 INFO - Available Modes on Display 0 07:17:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:17:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:17:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:17:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:17:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:17:35 INFO - Intel Iris: 07:17:35 INFO - Chipset Model: Intel Iris 07:17:35 INFO - Type: GPU 07:17:35 INFO - Bus: Built-In 07:17:35 INFO - VRAM (Dynamic, Max): 1536 MB 07:17:35 INFO - Vendor: Intel (0x8086) 07:17:35 INFO - Device ID: 0x0a2e 07:17:35 INFO - Revision ID: 0x0009 07:17:35 INFO - Displays: 07:17:35 INFO - Display: 07:17:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:17:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:17:35 INFO - Display Serial Number: 1600x1200 60 07:17:35 INFO - Main Display: Yes 07:17:35 INFO - Mirror: Off 07:17:35 INFO - Online: Yes 07:17:35 INFO - Rotation: Supported 07:17:35 INFO - Return code: 0 07:17:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:17:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:17:35 INFO - Python 2.7.3 07:17:35 INFO - Return code: 0 07:17:35 INFO - grabbing minidump binary from tooltool 07:17:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:17:35 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 0x109637e00>, '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 0x109460db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x109632b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:17:35 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 07:17:35 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 07:17:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:17:35 INFO - Return code: 0 07:17:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:17:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:17:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:17:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:17:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:17:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:17:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:17:36 INFO - Return code: 0 07:17:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:17:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0062 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:17:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.eVnzz6s2wC/Render', 07:17:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:17:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:17:36 INFO - 'HOME': '/Users/cltbld', 07:17:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:17:36 INFO - 'LOGNAME': 'cltbld', 07:17:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:17:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:17:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:17:36 INFO - 'MOZ_NO_REMOTE': '1', 07:17:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:17:36 INFO - 'NO_EM_RESTART': '1', 07:17:36 INFO - 'PAGER': '/bin/cat', 07:17:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:17:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:17:36 INFO - 'PWD': '/builds/slave/test', 07:17:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:17:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:17:36 INFO - 'SHELL': '/bin/bash', 07:17:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.MtoXLDudoJ/Listeners', 07:17:36 INFO - 'TMPDIR': '/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/', 07:17:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:17:36 INFO - 'USER': 'cltbld', 07:17:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:17:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:17:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:17:36 INFO - 'XPC_FLAGS': '0x0', 07:17:36 INFO - 'XPC_SERVICE_NAME': '0', 07:17:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:17:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/artifacts/public/build/firefox-49.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0062', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:17:36 INFO - mozversion application_buildid: 20160427052757 07:17:36 INFO - mozversion application_changeset: c3983f53698acf6fb89233470f25fcb249330fff 07:17:36 INFO - mozversion application_display_name: Nightly 07:17:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:17:36 INFO - mozversion application_name: Firefox 07:17:36 INFO - mozversion application_remotingname: firefox 07:17:36 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 07:17:36 INFO - mozversion application_vendor: Mozilla 07:17:36 INFO - mozversion application_version: 49.0a1 07:17:36 INFO - mozversion platform_buildid: 20160427052757 07:17:36 INFO - mozversion platform_changeset: c3983f53698acf6fb89233470f25fcb249330fff 07:17:36 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 07:17:36 INFO - mozversion platform_version: 49.0a1 07:17:36 INFO - using testdate: 1461766656 07:17:36 INFO - actual date: 1461766656 07:17:36 INFO - starting webserver on 'localhost:49279' 07:17:36 INFO - SUITE-START | Running 2 tests 07:17:36 INFO - TEST-START | dromaeo_css 07:17:36 INFO - operating with platform_type : mac_ 07:17:36 INFO - Initialising browser for dromaeo_css test... 07:17:36 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpEb9DO_/profile http://localhost:49279/getInfo.html) 07:17:39 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 07:17:39 INFO - PROCESS | 1666 | colorDepth:24 07:17:39 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 07:17:39 INFO - PROCESS | 1666 | __metrics 07:17:39 INFO - PROCESS | 1666 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:17:39 ERROR - PROCESS | 1666 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:17:39 INFO - TEST-INFO | 1666: exit 0 07:17:39 INFO - Browser initialized. 07:17:39 INFO - Running cycle 1/1 for dromaeo_css test... 07:17:39 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpEb9DO_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:17:51 INFO - PROCESS | 1669 | RSS: Main: 239173632 07:17:51 INFO - PROCESS | 1669 | 07:18:43 INFO - PROCESS | 1669 | 1461766723268 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] 07:20:53 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49279/tests/dromaeo/cssquery-ext.html) 07:20:54 INFO - PROCESS | 1669 | RSS: Main: 358932480 07:20:54 INFO - PROCESS | 1669 | 07:23:57 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-ext.html (next: http://localhost:49279/tests/dromaeo/cssquery-jquery.html) 07:23:58 INFO - PROCESS | 1669 | RSS: Main: 371470336 07:23:58 INFO - PROCESS | 1669 | 07:27:00 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49279/tests/dromaeo/cssquery-mootools.html) 07:27:01 INFO - PROCESS | 1669 | RSS: Main: 377843712 07:27:01 INFO - PROCESS | 1669 | 07:30:03 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49279/tests/dromaeo/cssquery-prototype.html) 07:30:04 INFO - PROCESS | 1669 | RSS: Main: 377257984 07:30:04 INFO - PROCESS | 1669 | 07:33:07 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49279/tests/dromaeo/cssquery-yui.html) 07:33:08 INFO - PROCESS | 1669 | RSS: Main: 349876224 07:33:08 INFO - PROCESS | 1669 | 07:36:10 INFO - PROCESS | 1669 | Cycle 1(1): loaded http://localhost:49279/tests/dromaeo/cssquery-yui.html (next: http://localhost:49279/tests/dromaeo/cssquery-dojo.html) 07:36:11 INFO - PROCESS | 1669 | RSS: Main: 404160512 07:36:11 INFO - PROCESS | 1669 | 07:36:11 INFO - PROCESS | 1669 | __start_tp_report 07:36:11 INFO - PROCESS | 1669 | _x_x_mozilla_page_load 07:36:11 INFO - PROCESS | 1669 | _x_x_mozilla_page_load_details 07:36:11 INFO - PROCESS | 1669 | |i|pagename|runs| 07:36:11 INFO - PROCESS | 1669 | |0;dojo.html;3353.1114254722497;3416.5729283839505;3421.1618153552386;3445.9827700861492;3490.5636795400574;5501.477359650837;5535.640183388077;5569.443055694429;5614.691191984439;5627.577931655127;4687.601553867917;5601.915971260434;5654.038813401721;5740.5981581289325;5747.655140691561;5069.44236134025;5079.288899554065;5111.539961403473;5120.743962801864;5266;5191.351081114861;5207.6354655174155;5209.7134657593815;5221.765020574083;5253;5049.747512624354;5089.262057001751;5145.048166089286;5147.279380886697;5165.328507294028;5087.949120508784;5139.357580302462;5202.635815492917;5220.4779522047875;5221.73891305437;4100.835966561334;5102.744862756885;5133.798502891135;5137.332146820927;5198.428172901015;5590.413006634286;5590.496855283003;5591.161325801122;5606.915896261559;5619.213310136584;5153.433122356538;6033.3664965178905;6119.204503414572;6131.835460087213;6201.193844800147;5156.92264616031;6223.315435302113;6256.244255285149;6280.466160376373;6295.496360291166;5575.693336866511;5751.626144300607;5758.913616295801;5770.653760774367;5786.161006654053;6194.876102478015;6273.717682704198;6275.058741188858;6293.590916590407;6295.181626388632;6078.209832721806;6103.877922441527;6104.481119104926;6125.081237814364;6135.202423684892;6084.39156084388;6145.66198859067;6222.62664240147;6230.844228894314;6246.219222597176;6122.755089796358;6140.078988151813;6183.350748171467;6201.596896201822;6205.596636218631;6161.938380616226;6172.8765424691255;6190.2571691397325;6200.689965501707;6221.129041934133;4831.710097394097;4888.462269150391;4894.363732714724;4894.388201474816;4932.038252540792;4331.112122014979;4361.06237159006;4437.423134992495;4441.289393696993;4481.058977614673;5634.830955071355;5702.54379649627;5704.686242256716;5709.65742055478;5717;6074.42292982166;6307.810765677037;6319.210098737658;6339.619622822645;6373.075903993988;5623.5220006299105;5624.21261023457;5637.126245431965;5643.181738647873;5667.773289068474;5342.385625653022;5359.464053594609;5372.274742909657;5373.0059938910645;5380.838574842761;6195.070739389128;6229.5327850410495;6243.125962365272;6313.77901773445;6318.368163183737;6194.845128871814;6260.937390626218;6280.905786413116;6293.213348331458;6304.306526282197;6299;6299.4645455135;6303.432691057827;6303.621782693053;6310.337414571404;5965.164876917148;6030;6104.76233045773;6129.816105516842;6136.662483563447;6136.549713441251;6148.938510614837;6158.815235542941;6167.537434692326;6178.289496707756;5837.76456575576;5840.883182336244;5952.553558483044;6011;6027.849303767441;5822;5883.499902508334;5893.911591326219;5905.793297234576;5952.940470595238;5892.292924849045;5897.70511474416;5907.3501914790195;5918.940810591839;5920.200772895604;5940.821775346746;6089.604175728564;6090.299615544269;6097.054956481575;6109.602875813236;5514.61397702157;5736.569757268305;5839.678817665069;5849.736761845642;5940.79207227745 07:36:11 INFO - PROCESS | 1669 | |1;ext.html;501.60874517876044;509.06332348478793;526.0872386409579;550.8815604645001;571.4143003421495;29937.55093673594;30385.39229215417;30465.847670761672;30470.542941855863;30521.542176867366;30693.539596906063;31302.53046204303;39012;40122.39816402756;40466.59533404665;9342.392744471621;9524.571394287274;9529.571169297398;9534.618615255382;9551;9166.450012999208;9384.155426011657;9393.436393816393;9415.387999780027;9435;8362.790930226733;8571.828563428728;11057;11324.773504529905;11336.546538138464;11325.263857849213;11466.541338346457;11468.4839182237;11470.311781293149;11473.827892581618;8280.420370574062;10967.012968832763;11195.60815371458;11338.886611133865;11389.202755807097;37031.074223144366;37628.81185594055;37639.4354084689;37672.43491347632;37685.24629507394;3202.343519578504;3223.161977885743;3483.4600636901323;3687.797171155585;4044.3326851069537;26646.600300995502;26811.463770724673;26953.787079581467;27099.593506097423;27120.1863944082;2664.9333766655795;2705.878235479408;2724.3733941193636;2884.769218462518;2933.31067199208;346692;347105;349328;349667.99999999744;351573;33018.3396332072;33545.66454335425;33574.66425335715;33713;33738;34372.82813585966;34543.65456345455;34687.306253875286;34706.479402808975;34755.65244347524;14634.634134146732;14875.47935822241;14878.256087195598;14888.404463821542;14907.92546037263;12522.749545009048;12552.686182845502;12580.87419125797;12665.620031399072;12681.365931703378;7366.521176123535;7528.774136775905;7834.608269586612;7995.320397766139;8132.552709601029;3271.8200498972783;3359.7480188985924;3368.7305015598695;3394.575678040245;3406.982965085159;912.8311262416474;984.1290457944771;1005.8792944846665;1008.369768894441;1118.608487029533;27871.44257114887;28141;28417.147485575464;28470.430591388056;28544.429111417656;1021.4790456866903;1073.4793625091825;1160.6808127764932;1172.7334478762916;1274.8215249865027;14474.782878256834;14734.410623574937;14737.778933316009;15052.698946021019;15516.224188790515;480304;483049;483519;485240;488008;56269.155962660596;56775.43224567784;56832.71583642055;57153;57259.713701431225;1446.8697817196503;1482.4589025006012;1484.0872863189277;1495.229956572366;1497.9925100374428;26183.476330473666;28057.298567535974;28163.155105346872;28175;28719.282017949718;50357.49642503528;50664.74667626638;50928;51075;51082;349326.5202043943;354758;356657;359634;359845;21722.022508986818;22076.88961555182;22650;26350.604740928517;26775.464490709688;41016.58983410247;41622.95942601459;41827.954301142716;42299;43069.784651076545;33352.49971250385;34665;35136.29727405489;35584.82207588945;35616.64383356237;33175.66824331822;33650.49524257089;34274;34604;34614.82692586521;34753.30493390169;35450.82274588611;35588.48378501336;35696.28607427889;36433.81783091067;30023.69976300209;30312.09063728092;30491.390172196876;31055.223619409695;31641.36717265688;22690.43273918165;23361.41596460102;23607;23763.1682891098;24345.026198951844 07:36:11 INFO - PROCESS | 1669 | |2;jquery.html;398.79661372699917;398.8105649816338;400.43738547340996;401.4279651496618;410.44794751059817;13354.866451335483;19504.317348892793;19798.010099495004;20185.798142018575;20214.393568192958;19121.139548720304;19121.426357209308;19184.712229316538;19668;19734.407967760955;5656.462636049569;5868.295804503444;5913.201717768111;5919.052951527735;5920.733566989496;5595.580331475136;5765.942340576583;5797.449242321994;5847.093700476433;5848.67832269225;5700.486956173943;5870.70646467677;5894.233749612566;5896.498797602209;5918.1418694289305;5646.774129034834;5875.882482350329;5885.087811389241;5889.234399528055;6016.879662406771;5743.54051675865;5767.394423585547;5774.5091667208335;5774.769009239625;5776.277965254343;13013.804792928113;22272.777272227395;22674.546509069725;24932;24947;2024.8683835550642;2066.0909199951975;2120.459282882855;2253.5380247049316;2570.69151701797;8187.877181842277;10400.167986561057;13724.862751372459;14590.489332873405;14638.048526845721;1617.8705703543687;1624.2041399714174;1687.5106219196418;1716.2362748576888;1739.226044410238;99659;107794.46102769514;108641.45679271632;110319.44840275828;111034.44482777534;11427.028702560208;11607.535698571963;11745.47145378443;11765.52937882475;11917.404129793476;12780.041496887585;13509.500742362694;14534.563963081124;14567.854321456862;14573.489927852686;8056.436049476481;8351.791205219919;8361.832763344699;8448.788780280542;8476.23713865755;8010.519368837889;8022;8092.069412017693;8155.10293867674;8163.265306122477;3758.530183727034;3996.0009997500624;4350.630196433339;4415.911681766347;4579.717679049872;1687.7468379743136;1893.646043079205;1941.4078705994807;1956.5010922214744;1982.137770070024;741.7552207771422;814.9511029338258;859.1494420523636;994.4679596415883;1026.373911913732;17814.46556603304;18816.811831881507;19399.515012124808;19440;19592.682358655657;881.5900606218139;914.9725508234764;959.3764053365229;977.2524019125375;985.84719368498;7049.647517624098;9340.532973351304;10412.68761937143;10476.580936762597;10532.947335263274;600798;608244;615024;621952;627206;74125.62937185279;81162;111531.44234278776;116551;117851;981.1169947047714;1007.4207330784682;1025.1440047560222;1025.5128813813528;1026.3174988632625;16928.915355423145;17020.148992550075;17321.74017389715;17714.468565943043;17748.201330940396;45347.77326113348;45723.31415028844;46354.536454635025;46597;46848.297275541576;56463;58484.4151558479;58807.70596146992;61519.38480615136;68621.97067044098;7447.5531468112085;7897.289243968071;8098.190180981855;8125.674973001013;8138.3082437993435;8967.685000644433;10761.730956726144;11860.525578976743;12066.336351500751;12465.93767031159;10326.01902819231;10595.205359598214;10767.569297228023;10837.945810270898;11167.553297868319;10499.94750026245;10505.317154385246;10537.683869483928;10785;10809.621663241749;10735.570577177137;10818.891811081789;11225.15811314171;11244.550217991517;11309.264897781617;8032.4778889372;8181.713640022571;8215.424920255764;8306.958465207636;8325.370695843607;9686.32195746291;10663.626773062906;10726.195535335037;11038.889611103787;11070.169737269576 07:36:11 INFO - PROCESS | 1669 | |3;mootools.html;1399.6570840144154;1524.8780097592191;1609.8390160983904;1852.823981721736;1993.2525303011362;7815.218478152189;8617.698380556674;8824.205821476065;8834.293256539477;8839.381243312962;8449.788755281106;8659.35054870884;8667.783305417368;8669.869951950726;8679;2139.5399989002362;2211.6682497625407;2212.325240801555;2415.1064106280655;2458.299384675368;2200.6038912995655;2411.445367565461;2504.787093097089;2508.097085049381;2509.874506274679;2401.00358351284;2427.611582146857;2436.8903399347073;2440.4021014851387;2443.059422122478;2116.9364919052455;2414.9396265093424;2429.5869702150676;2434.160214725917;2438.926832195037;2328.348062542491;2409.1086298069827;2415.7221919479307;2416.2026531244646;2420.5037967216676;8533.14668533148;8593.699220527315;8601.096884827128;8602.913970860274;8612.52631105289;5141.614378921596;5374.059539580558;5375.75809088592;5376.086065368858;5376.946230537723;3343.063942096217;3476.9652303476896;3573.714102871764;3577.749557530974;3592.6586974237407;1017.699778565325;1018.5162048027202;1021.1983592879554;1024.6721049264238;1026.943518106504;11701.473433695419;11704.297742135414;11715.53137874484;11715.765684686345;11732.237404568676;4561.840335588238;4567.086582683477;4698.765061746899;4717.669763116549;4736.171170045228;9964.651237206808;9975.45135017581;9977.900220997697;9990.250731195045;9998.900010999942;5370.194470829407;5393.191021346829;5401.054815407367;5402.729863506809;5439.755211015514;4740.786664600101;4883.877903052381;4961.826336078292;4967.205247160437;4998.175301075282;3700.5189325388064;3724.1806802503406;3733.4213196954515;3771.642208804828;3807.961920380816;1205.9095567832449;1208.7582483503334;1211.5335595795682;1212.5210541835925;1219.920705154162;786.4809225910985;792.0614072324314;888.1651247827022;891.7592250092569;941.9481928493861;5362.758675859595;5446.21029950655;5597.216389705444;5785.681787501728;5918.408159184133;896.8744375787395;898.2185498616245;939.1876027236391;956.6651671914914;1006.3863020740716;3146.1819926819194;3791;3875.1862108957434;3898.96101038986;3936.0356712605594;10202.744931376776;10475.1096156826;10629.5216715248;10773.353598784099;10809.135269178447;10699.358038517714;10861.67414977552;10885;10885.020348168702;10898.07366373867;8212.507249565046;8240.917590824016;8347.66609335632;8440.915590844135;8454.492730436194;5663.8867222656145;5732.082866741302;5755.913661295168;5756.884862302647;5771.7402716877;8539.444936079135;9718.805623887623;10133.138683211715;10242.129418999468;10242.436665983443;9204.677836275698;10169.542370593193;10217;10351.327163734333;10370.481475926324;6540.247871494648;6942.757003504853;7154.713811447484;7158.964205178941;7166.140063192451;6986.825329366603;8198.426110172231;8217.301529369832;8236.217559331853;8293.129221431904;7402.777916662509;7469.439792015512;7501.962490187514;7592.8861067082935;7593.506422082547;7058.153021637437;7190.712371505081;7275.090613673291;7290.890636640349;7452.739154129579;5737.512311453574;6824.829379265558;6827.21487028998;6829.726810927507;6844.21291551458;4588.334691469785;4831.541003604652;4844.128056949642;4854.708717476963;4868.196747536616;4748.857534273978;4860;4909.68087074339;4926.187179115549;5096 07:36:11 INFO - PROCESS | 1669 | |4;prototype.html;295.82398472908613;312.7754839802175;318.50949537711915;326.58523674932826;331.63685764088314;5218.7651555679995;5254.842354729355;5271.604629652772;5285.8942821143555;5312.893742125155;4213.262679031172;4351;4559.697352836813;5217.399999000116;5221.164613661815;3428.9828550857274;3538.044727923459;3905.2775236581183;3934.6655534279475;4098.815553300094;3388.9322213555715;3965.246603145408;4044.534878488982;4072.796360181994;4089.284375234337;3681.4109742441215;3997.5602683704915;4003.4595329630565;4015.0966032642714;4034.596540345957;3299.4720844664857;3860.864869729546;4027.51669799623;4056.6349028587274;4062.228176646457;3159.557661927332;3524.594671612746;3534.91162720934;3543.263800737646;3587.246678197582;5104.438511763703;5122.84840367043;5123.615728820316;5145;5147.639665223436;4005.6595189408936;4286.76422796746;4293.098449325646;4310.913781724348;4317.266064768997;5476.3702174250075;5491.670499769986;5492.258545096401;5499.752511137009;5501.779928802843;3785.2240290740333;3798;3798.2593394288124;3809.466674665521;3810.657040866335;5505.229267902497;5760.164776107441;5825.097109947965;5832.096025116114;5849.561282903799;3523.9647603523636;3786.67813235878;3808.143167787281;3827.885163445101;3835.2137811748526;3282.473649752829;3495.528103705967;3580.997320750194;3829.0235989822972;3849.1147036181833;4489.326601009875;4527.230370836965;4529.479109902338;4572.4055872736335;4584.066197633517;5224.947750522522;5614.6631202128;5637.802676906289;5677.772889084473;5684.943150568524;1412.3220853989937;1432.641839540115;1447.29082749452;1447.7755947828105;1451.8620731030535;896.121800635368;916.4237511480243;946.4936259101348;948.966786162481;964.4984608003799;4953.777080031407;5616.073347897551;5618.690971996498;5629.521490673339;5687.544996400278;5201.661891977009;5427.755750991215;5603.915941260802;6220.968895155495;6268.811935641938;4799.056382165229;5579.581531385081;5607.355154157242;5614.550835933115;5637.295338082739;3252.317013427207;3270.3132342207928;3281.819499927527;3302.5871766029245;3309.387763263804;5699.401562835926;6404.423601875854;6457.225132984072;6503.349665033554;6504.861649211369;5449.346078470529;5654.74553645087;6330.525210609223;6358.078078678658;6374.9681251594375;5962.493188078975;6439.195100612424;6448.677566121675;6515.446187074152;6547.934520654732;5893.764249429974;6189.876202476015;6196.690165491617;6218.253809542884;6233.844153896189;5362.302900622894;5584.806130298861;5937.2578427696535;6062.969685151546;6111.572189946661;6194.4115309045565;6458.967705161444;6481.157449531531;6493.772717954849;6499.870002599827;4071.7556946582113;4098.139390727981;4101.215971052602;4104.912198267401;4114.835406583823;5469.179623056414;6175.197224360804;6190;6193.876122477615;6242.500599952084;5090.847274581768;5293.682379057269;5626.409227031103;5670.319561652628;5678.488935995781;4961.776720047535;5331.626786124934;5580.330360356621;5638.830835074954;5662;4976.601871850316;5227.973860130827;5309.628326017141;5477.849651573214;5515.972420137874;4968.503149685002;5415.6479828811;5556.722163891708;5647.943520564741;5656.264685590847;4959.851204463872;5217.530422262014;5461.170507879746;5489.34127904638;5510.602887743844 07:36:11 INFO - PROCESS | 1669 | |5;yui.html;695.1970474102413;717.103620474407;738.1326940844508;765.8085478630343;777.3858651665183;14133;14588.416463341453;14628.926855365708;14642.560723178309;14695.26523673816;13379.197248165092;13464.730705385886;13524.526641567547;13536.39086241119;13541.458341666346;726.1939247435342;748.0761259844088;749.0150452155425;749.4491548711693;890.6392910871091;739.5045319635857;744.1405177020523;884.9867251991225;926.7868390270241;928.3594319919268;855.2217482091298;974.8927617962054;976.6484065736329;978.7699890525721;979.211734553684;970.5341436110671;971.4317124482221;974.2644303550844;975.5756246032998;976.9839367058322;562.4207066721284;702.6065403374075;723.5730918757905;728.5264578024273;730.5397599512327;14364.856351436561;14446.638834029129;14448.71102577953;14452.638684032878;14464.059836110619;12084.697882552919;12173.452194651174;12230.327331996737;12368.690782730413;12426.813597796041;9734.805303893952;9945.500715272143;10025;10030.548625311878;10341.741456463573;3167.841607919595;3198.4082944655315;3227.951580726291;3252.4633435483115;3263.543103965447;73406.53186936285;73949;74286.25713742901;74866.62566687132;76810.61594692047;9200.723978280663;9401.905980940102;9548.809023819624;9721.368111072758;9836.901630983743;20388.28640997558;20709.792902070785;20737.27419540309;20750.169993200103;20807.1677132916;7063.187733410621;7234.710611575478;7252.709891604382;7336.669849856769;7417.851642967111;3898.2398432305426;3944.4872166618156;3953.466282051886;4034.495688038995;4041.8989525261513;3502.562179727534;3573.9821300893327;3580.212353282274;3583.3191693578137;3583.552055993001;644.1561554363799;651.4169818012851;661.6327937994363;663.5852592129919;666.8366250268715;501.16074008389296;535.9973200134052;590.6279044202125;598.4285007817524;601.2424345324922;6871.415929645936;7370.852582948418;7380.261973802684;7485.663145158481;7507.324340809353;512.6539585779584;521.1193083688554;578.8855461993253;592.351375244107;595.4432605513858;2889.9711002889703;3840.8655697050467;3901.8634347797692;3949.38784488399;4049.595040495986;63891;85740.14259857322;88591;89632;90184;55018;78474;79498.60250698825;79790.80313795297;80168.59915700385;71132.93300600495;71536.64231678809;71683;72157.27842721611;73138;8097.906896946072;8339.12439193876;8363.372747043873;8388.286995605442;8443.408961372645;40746.1850762989;40885.540733683134;42119;42446;43180.13639727251;55411.72294138504;59524.107138393825;60259;60422.79154416975;60590.697046514484;10778.407187604756;10879.129669626253;10949.945250274017;11205.935436133554;11267.098632109575;11018.1185505161;11651;11889.405529723652;11905.46425410876;12134.878651213729;11409.657710268706;11429.657110286706;11508.021818145551;11525.538978440769;11744.119191060534;11383;11405;11526.423678816192;11741;11763.764724705628;11256.831147532957;11299.943500282447;11482.311061336346;11595.8260626089;11633.360165190996;8020.478668886737;9347.989850130794;9480.146786789222;9543.522823858919;9639.855402169112;9428.434293942386;9672.177864881283;9678.903210967801;9696.660616878375;9849.655262065793 07:36:11 INFO - PROCESS | 1669 | __end_tp_report 07:36:11 INFO - PROCESS | 1669 | __start_cc_report 07:36:11 INFO - PROCESS | 1669 | _x_x_mozilla_cycle_collect,1236 07:36:11 INFO - PROCESS | 1669 | __end_cc_report 07:36:11 INFO - PROCESS | 1669 | __startTimestamp1461767771139__endTimestamp 07:36:11 INFO - PROCESS | 1669 | 07:36:11 INFO - PROCESS | 1669 | ------- Summary: start ------- 07:36:11 INFO - PROCESS | 1669 | Number of tests: 6 07:36:11 INFO - PROCESS | 1669 | 07:36:11 INFO - PROCESS | 1669 | [#0] dojo.html Cycles:165 Average:5672.50 Median:5840.88 stddev:641.73 (11.0%) stddev-sans-first:617.36 07:36:11 INFO - PROCESS | 1669 | Values: 3353.1 3416.6 3421.2 3446.0 3490.6 5501.5 5535.6 5569.4 5614.7 5627.6 4687.6 5601.9 5654.0 5740.6 5747.7 5069.4 5079.3 5111.5 5120.7 5266.0 5191.4 5207.6 5209.7 5221.8 5253.0 5049.7 5089.3 5145.0 5147.3 5165.3 5087.9 5139.4 5202.6 5220.5 5221.7 4100.8 5102.7 5133.8 5137.3 5198.4 5590.4 5590.5 5591.2 5606.9 5619.2 5153.4 6033.4 6119.2 6131.8 6201.2 5156.9 6223.3 6256.2 6280.5 6295.5 5575.7 5751.6 5758.9 5770.7 5786.2 6194.9 6273.7 6275.1 6293.6 6295.2 6078.2 6103.9 6104.5 6125.1 6135.2 6084.4 6145.7 6222.6 6230.8 6246.2 6122.8 6140.1 6183.4 6201.6 6205.6 6161.9 6172.9 6190.3 6200.7 6221.1 4831.7 4888.5 4894.4 4894.4 4932.0 4331.1 4361.1 4437.4 4441.3 4481.1 5634.8 5702.5 5704.7 5709.7 5717.0 6074.4 6307.8 6319.2 6339.6 6373.1 5623.5 5624.2 5637.1 5643.2 5667.8 5342.4 5359.5 5372.3 5373.0 5380.8 6195.1 6229.5 6243.1 6313.8 6318.4 6194.8 6260.9 6280.9 6293.2 6304.3 6299.0 6299.5 6303.4 6303.6 6310.3 5965.2 6030.0 6104.8 6129.8 6136.7 6136.5 6148.9 6158.8 6167.5 6178.3 5837.8 5840.9 5952.6 6011.0 6027.8 5822.0 5883.5 5893.9 5905.8 5952.9 5892.3 5897.7 5907.4 5918.9 5920.2 5940.8 6089.6 6090.3 6097.1 6109.6 5514.6 5736.6 5839.7 5849.7 5940.8 07:36:11 INFO - PROCESS | 1669 | 07:36:11 INFO - PROCESS | 1669 | [#1] ext.html Cycles:180 Average:52547.16 Median:18505.12 stddev:106518.65 (575.6%) stddev-sans-first:106745.79 07:36:11 INFO - PROCESS | 1669 | Values: 501.6 509.1 526.1 550.9 571.4 29937.6 30385.4 30465.8 30470.5 30521.5 30693.5 31302.5 39012.0 40122.4 40466.6 9342.4 9524.6 9529.6 9534.6 9551.0 9166.5 9384.2 9393.4 9415.4 9435.0 8362.8 8571.8 11057.0 11324.8 11336.5 11325.3 11466.5 11468.5 11470.3 11473.8 8280.4 10967.0 11195.6 11338.9 11389.2 37031.1 37628.8 37639.4 37672.4 37685.2 3202.3 3223.2 3483.5 3687.8 4044.3 26646.6 26811.5 26953.8 27099.6 27120.2 2664.9 2705.9 2724.4 2884.8 2933.3 346692.0 347105.0 349328.0 349668.0 351573.0 33018.3 33545.7 33574.7 33713.0 33738.0 34372.8 34543.7 34687.3 34706.5 34755.7 14634.6 14875.5 14878.3 14888.4 14907.9 12522.7 12552.7 12580.9 12665.6 12681.4 7366.5 7528.8 7834.6 7995.3 8132.6 3271.8 3359.7 3368.7 3394.6 3407.0 912.8 984.1 1005.9 1008.4 1118.6 27871.4 28141.0 28417.1 28470.4 28544.4 1021.5 1073.5 1160.7 1172.7 1274.8 14474.8 14734.4 14737.8 15052.7 15516.2 480304.0 483049.0 483519.0 485240.0 488008.0 56269.2 56775.4 56832.7 57153.0 57259.7 1446.9 1482.5 1484.1 1495.2 1498.0 26183.5 28057.3 28163.2 28175.0 28719.3 50357.5 50664.7 50928.0 51075.0 51082.0 349326.5 354758.0 356657.0 359634.0 359845.0 21722.0 22076.9 22650.0 26350.6 26775.5 41016.6 41623.0 41828.0 42299.0 43069.8 33352.5 34665.0 35136.3 35584.8 35616.6 33175.7 33650.5 34274.0 34604.0 34614.8 34753.3 35450.8 35588.5 35696.3 36433.8 30023.7 30312.1 30491.4 31055.2 31641.4 22690.4 23361.4 23607.0 23763.2 24345.0 07:36:11 INFO - PROCESS | 1669 | 07:36:11 INFO - PROCESS | 1669 | [#2] jquery.html Cycles:180 Average:33389.58 Median:13758.85 stddev:101535.09 (738.0%) stddev-sans-first:101789.70 07:36:11 INFO - PROCESS | 1669 | Values: 398.8 398.8 400.4 401.4 410.4 13354.9 19504.3 19798.0 20185.8 20214.4 19121.1 19121.4 19184.7 19668.0 19734.4 5656.5 5868.3 5913.2 5919.1 5920.7 5595.6 5765.9 5797.4 5847.1 5848.7 5700.5 5870.7 5894.2 5896.5 5918.1 5646.8 5875.9 5885.1 5889.2 6016.9 5743.5 5767.4 5774.5 5774.8 5776.3 13013.8 22272.8 22674.5 24932.0 24947.0 2024.9 2066.1 2120.5 2253.5 2570.7 8187.9 10400.2 13724.9 14590.5 14638.0 1617.9 1624.2 1687.5 1716.2 1739.2 99659.0 107794.5 108641.5 110319.4 111034.4 11427.0 11607.5 11745.5 11765.5 11917.4 12780.0 13509.5 14534.6 14567.9 14573.5 8056.4 8351.8 8361.8 8448.8 8476.2 8010.5 8022.0 8092.1 8155.1 8163.3 3758.5 3996.0 4350.6 4415.9 4579.7 1687.7 1893.6 1941.4 1956.5 1982.1 741.8 815.0 859.1 994.5 1026.4 17814.5 18816.8 19399.5 19440.0 19592.7 881.6 915.0 959.4 977.3 985.8 7049.6 9340.5 10412.7 10476.6 10532.9 600798.0 608244.0 615024.0 621952.0 627206.0 74125.6 81162.0 111531.4 116551.0 117851.0 981.1 1007.4 1025.1 1025.5 1026.3 16928.9 17020.1 17321.7 17714.5 17748.2 45347.8 45723.3 46354.5 46597.0 46848.3 56463.0 58484.4 58807.7 61519.4 68622.0 7447.6 7897.3 8098.2 8125.7 8138.3 8967.7 10761.7 11860.5 12066.3 12465.9 10326.0 10595.2 10767.6 10837.9 11167.6 10499.9 10505.3 10537.7 10785.0 10809.6 10735.6 10818.9 11225.2 11244.6 11309.3 8032.5 8181.7 8215.4 8307.0 8325.4 9686.3 10663.6 10726.2 11038.9 11070.2 07:36:11 INFO - PROCESS | 1669 | 07:36:11 INFO - PROCESS | 1669 | [#3] mootools.html Cycles:180 Average:5650.62 Median:4876.04 stddev:3183.58 (65.3%) stddev-sans-first:3176.48 07:36:11 INFO - PROCESS | 1669 | Values: 1399.7 1524.9 1609.8 1852.8 1993.3 7815.2 8617.7 8824.2 8834.3 8839.4 8449.8 8659.4 8667.8 8669.9 8679.0 2139.5 2211.7 2212.3 2415.1 2458.3 2200.6 2411.4 2504.8 2508.1 2509.9 2401.0 2427.6 2436.9 2440.4 2443.1 2116.9 2414.9 2429.6 2434.2 2438.9 2328.3 2409.1 2415.7 2416.2 2420.5 8533.1 8593.7 8601.1 8602.9 8612.5 5141.6 5374.1 5375.8 5376.1 5376.9 3343.1 3477.0 3573.7 3577.7 3592.7 1017.7 1018.5 1021.2 1024.7 1026.9 11701.5 11704.3 11715.5 11715.8 11732.2 4561.8 4567.1 4698.8 4717.7 4736.2 9964.7 9975.5 9977.9 9990.3 9998.9 5370.2 5393.2 5401.1 5402.7 5439.8 4740.8 4883.9 4961.8 4967.2 4998.2 3700.5 3724.2 3733.4 3771.6 3808.0 1205.9 1208.8 1211.5 1212.5 1219.9 786.5 792.1 888.2 891.8 941.9 5362.8 5446.2 5597.2 5785.7 5918.4 896.9 898.2 939.2 956.7 1006.4 3146.2 3791.0 3875.2 3899.0 3936.0 10202.7 10475.1 10629.5 10773.4 10809.1 10699.4 10861.7 10885.0 10885.0 10898.1 8212.5 8240.9 8347.7 8440.9 8454.5 5663.9 5732.1 5755.9 5756.9 5771.7 8539.4 9718.8 10133.1 10242.1 10242.4 9204.7 10169.5 10217.0 10351.3 10370.5 6540.2 6942.8 7154.7 7159.0 7166.1 6986.8 8198.4 8217.3 8236.2 8293.1 7402.8 7469.4 7502.0 7592.9 7593.5 7058.2 7190.7 7275.1 7290.9 7452.7 5737.5 6824.8 6827.2 6829.7 6844.2 4588.3 4831.5 4844.1 4854.7 4868.2 4748.9 4860.0 4909.7 4926.2 5096.0 07:36:11 INFO - PROCESS | 1669 | 07:36:11 INFO - PROCESS | 1669 | [#4] prototype.html Cycles:180 Average:4660.04 Median:5226.46 stddev:1481.02 (28.3%) stddev-sans-first:1448.50 07:36:11 INFO - PROCESS | 1669 | Values: 295.8 312.8 318.5 326.6 331.6 5218.8 5254.8 5271.6 5285.9 5312.9 4213.3 4351.0 4559.7 5217.4 5221.2 3429.0 3538.0 3905.3 3934.7 4098.8 3388.9 3965.2 4044.5 4072.8 4089.3 3681.4 3997.6 4003.5 4015.1 4034.6 3299.5 3860.9 4027.5 4056.6 4062.2 3159.6 3524.6 3534.9 3543.3 3587.2 5104.4 5122.8 5123.6 5145.0 5147.6 4005.7 4286.8 4293.1 4310.9 4317.3 5476.4 5491.7 5492.3 5499.8 5501.8 3785.2 3798.0 3798.3 3809.5 3810.7 5505.2 5760.2 5825.1 5832.1 5849.6 3524.0 3786.7 3808.1 3827.9 3835.2 3282.5 3495.5 3581.0 3829.0 3849.1 4489.3 4527.2 4529.5 4572.4 4584.1 5224.9 5614.7 5637.8 5677.8 5684.9 1412.3 1432.6 1447.3 1447.8 1451.9 896.1 916.4 946.5 949.0 964.5 4953.8 5616.1 5618.7 5629.5 5687.5 5201.7 5427.8 5603.9 6221.0 6268.8 4799.1 5579.6 5607.4 5614.6 5637.3 3252.3 3270.3 3281.8 3302.6 3309.4 5699.4 6404.4 6457.2 6503.3 6504.9 5449.3 5654.7 6330.5 6358.1 6375.0 5962.5 6439.2 6448.7 6515.4 6547.9 5893.8 6189.9 6196.7 6218.3 6233.8 5362.3 5584.8 5937.3 6063.0 6111.6 6194.4 6459.0 6481.2 6493.8 6499.9 4071.8 4098.1 4101.2 4104.9 4114.8 5469.2 6175.2 6190.0 6193.9 6242.5 5090.8 5293.7 5626.4 5670.3 5678.5 4961.8 5331.6 5580.3 5638.8 5662.0 4976.6 5228.0 5309.6 5477.8 5516.0 4968.5 5415.6 5556.7 5647.9 5656.3 4959.9 5217.5 5461.2 5489.3 5510.6 07:36:11 INFO - PROCESS | 1669 | 07:36:11 INFO - PROCESS | 1669 | [#5] yui.html Cycles:180 Average:17254.59 Median:599.84 stddev:23923.76 (3988.4%) stddev-sans-first:23958.56 07:36:11 INFO - PROCESS | 1669 | Values: 695.2 717.1 738.1 765.8 777.4 14133.0 14588.4 14628.9 14642.6 14695.3 13379.2 13464.7 13524.5 13536.4 13541.5 726.2 748.1 749.0 749.4 890.6 739.5 744.1 885.0 926.8 928.4 855.2 974.9 976.6 978.8 979.2 970.5 971.4 974.3 975.6 977.0 562.4 702.6 723.6 728.5 730.5 14364.9 14446.6 14448.7 14452.6 14464.1 12084.7 12173.5 12230.3 12368.7 12426.8 9734.8 9945.5 10025.0 10030.5 10341.7 3167.8 3198.4 3228.0 3252.5 3263.5 73406.5 73949.0 74286.3 74866.6 76810.6 9200.7 9401.9 9548.8 9721.4 9836.9 20388.3 20709.8 20737.3 20750.2 20807.2 7063.2 7234.7 7252.7 7336.7 7417.9 3898.2 3944.5 3953.5 4034.5 4041.9 3502.6 3574.0 3580.2 3583.3 3583.6 644.2 651.4 661.6 663.6 666.8 501.2 536.0 590.6 598.4 601.2 6871.4 7370.9 7380.3 7485.7 7507.3 512.7 521.1 578.9 592.4 595.4 2890.0 3840.9 3901.9 3949.4 4049.6 63891.0 85740.1 88591.0 89632.0 90184.0 55018.0 78474.0 79498.6 79790.8 80168.6 71132.9 71536.6 71683.0 72157.3 73138.0 8097.9 8339.1 8363.4 8388.3 8443.4 40746.2 40885.5 42119.0 42446.0 43180.1 55411.7 59524.1 60259.0 60422.8 60590.7 10778.4 10879.1 10949.9 11205.9 11267.1 11018.1 11651.0 11889.4 11905.5 12134.9 11409.7 11429.7 11508.0 11525.5 11744.1 11383.0 11405.0 11526.4 11741.0 11763.8 11256.8 11299.9 11482.3 11595.8 11633.4 8020.5 9348.0 9480.1 9543.5 9639.9 9428.4 9672.2 9678.9 9696.7 9849.7 07:36:11 INFO - PROCESS | 1669 | -------- Summary: end -------- 07:36:11 INFO - PROCESS | 1669 | 07:36:11 INFO - TEST-INFO | 1669: exit 0 07:36:11 INFO - TEST-OK | dromaeo_css | took 1114826ms 07:36:11 INFO - TEST-START | kraken 07:36:11 INFO - operating with platform_type : mac_ 07:36:11 INFO - Initialising browser for kraken test... 07:36:11 INFO - TEST-INFO | started process 1676 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpcGyyiC/profile http://localhost:49279/getInfo.html) 07:36:13 INFO - PROCESS | 1676 | __metrics Screen width/height:1600/1200 07:36:13 INFO - PROCESS | 1676 | colorDepth:24 07:36:13 INFO - PROCESS | 1676 | Browser inner width/height: 1024/689 07:36:13 INFO - PROCESS | 1676 | __metrics 07:36:14 INFO - PROCESS | 1676 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:36:14 ERROR - PROCESS | 1676 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 07:36:14 INFO - TEST-INFO | 1676: exit 0 07:36:14 INFO - Browser initialized. 07:36:14 INFO - Running cycle 1/1 for kraken test... 07:36:14 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/tmpcGyyiC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:36:26 INFO - PROCESS | 1678 | RSS: Main: 239271936 07:36:26 INFO - PROCESS | 1678 | 07:36:29 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection) 07:36:30 INFO - PROCESS | 1678 | RSS: Main: 286720000 07:36:30 INFO - PROCESS | 1678 | 07:36:32 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-dft) 07:36:33 INFO - PROCESS | 1678 | RSS: Main: 299638784 07:36:33 INFO - PROCESS | 1678 | 07:36:36 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-fft) 07:36:37 INFO - PROCESS | 1678 | RSS: Main: 388067328 07:36:37 INFO - PROCESS | 1678 | 07:36:39 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator) 07:36:40 INFO - PROCESS | 1678 | RSS: Main: 289296384 07:36:40 INFO - PROCESS | 1678 | 07:36:42 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 07:36:42 INFO - PROCESS | 1678 | RSS: Main: 293359616 07:36:42 INFO - PROCESS | 1678 | 07:36:45 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom) 07:36:46 INFO - PROCESS | 1678 | RSS: Main: 331907072 07:36:46 INFO - PROCESS | 1678 | 07:36:49 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate) 07:36:49 INFO - PROCESS | 1678 | RSS: Main: 332464128 07:36:49 INFO - PROCESS | 1678 | 07:36:52 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial) 07:36:53 INFO - PROCESS | 1678 | RSS: Main: 332910592 07:36:53 INFO - PROCESS | 1678 | 07:36:54 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 07:36:55 INFO - PROCESS | 1678 | RSS: Main: 321916928 07:36:55 INFO - PROCESS | 1678 | 07:36:57 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes) 07:36:57 INFO - PROCESS | 1678 | RSS: Main: 326397952 07:36:57 INFO - PROCESS | 1678 | 07:36:59 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 07:37:00 INFO - PROCESS | 1678 | RSS: Main: 330383360 07:37:00 INFO - PROCESS | 1678 | 07:37:03 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 07:37:04 INFO - PROCESS | 1678 | RSS: Main: 334458880 07:37:04 INFO - PROCESS | 1678 | 07:37:07 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 07:37:07 INFO - PROCESS | 1678 | RSS: Main: 332206080 07:37:07 INFO - PROCESS | 1678 | 07:37:09 INFO - PROCESS | 1678 | Cycle 1(1): loaded http://localhost:49279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49279/tests/kraken/driver.html?testName=ai-astar) 07:37:09 INFO - PROCESS | 1678 | RSS: Main: 396873728 07:37:09 INFO - PROCESS | 1678 | 07:37:09 INFO - PROCESS | 1678 | __start_tp_report 07:37:09 INFO - PROCESS | 1678 | _x_x_mozilla_page_load 07:37:09 INFO - PROCESS | 1678 | _x_x_mozilla_page_load_details 07:37:09 INFO - PROCESS | 1678 | |i|pagename|runs| 07:37:09 INFO - PROCESS | 1678 | |0;ai-astar;112;113;108;113;113;112;112;114;103;113 07:37:09 INFO - PROCESS | 1678 | |1;audio-beat-detection;161;124;144;168;120;143;141;123;169;119 07:37:09 INFO - PROCESS | 1678 | |2;audio-dft;189;187;186;185;184;185;181;182;185;184 07:37:09 INFO - PROCESS | 1678 | |3;audio-fft;75;75;77;150;74;81;81;94;132;55 07:37:09 INFO - PROCESS | 1678 | |4;audio-oscillator;90;95;132;77;82;84;120;80;76;124 07:37:09 INFO - PROCESS | 1678 | |5;imaging-gaussian-blur;90;86;88;85;86;85;89;87;88;91 07:37:09 INFO - PROCESS | 1678 | |6;imaging-darkroom;92;92;92;92;92;92;92;93;92;92 07:37:09 INFO - PROCESS | 1678 | |7;imaging-desaturate;83;86;84;86;83;86;84;85;84;85 07:37:09 INFO - PROCESS | 1678 | |8;json-parse-financial;58;58;60;59;60;60;59;74;59;56 07:37:09 INFO - PROCESS | 1678 | |9;json-stringify-tinderbox;65;63;75;62;71;69;67;67;69;68 07:37:09 INFO - PROCESS | 1678 | |10;stanford-crypto-aes;82;82;83;83;82;82;82;82;82;83 07:37:09 INFO - PROCESS | 1678 | |11;stanford-crypto-ccm;126;148;160;156;159;151;150;142;192;162 07:37:09 INFO - PROCESS | 1678 | |12;stanford-crypto-pbkdf2;196;202;197;205;201;198;197;194;199;195 07:37:09 INFO - PROCESS | 1678 | |13;stanford-crypto-sha256-iterative;61;69;71;63;58;100;99;70;69;70 07:37:09 INFO - PROCESS | 1678 | __end_tp_report 07:37:09 INFO - PROCESS | 1678 | __start_cc_report 07:37:09 INFO - PROCESS | 1678 | _x_x_mozilla_cycle_collect,1991 07:37:09 INFO - PROCESS | 1678 | __end_cc_report 07:37:09 INFO - PROCESS | 1678 | __startTimestamp1461767829890__endTimestamp 07:37:09 INFO - PROCESS | 1678 | 07:37:09 INFO - PROCESS | 1678 | ------- Summary: start ------- 07:37:09 INFO - PROCESS | 1678 | Number of tests: 14 07:37:09 INFO - PROCESS | 1678 | 07:37:09 INFO - PROCESS | 1678 | [#0] ai-astar Cycles:10 Average:111.30 Median:113.00 stddev:3.33 (3.0%) stddev-sans-first:3.53 07:37:09 INFO - PROCESS | 1678 | Values: 112.0 113.0 108.0 113.0 113.0 112.0 112.0 114.0 103.0 113.0 07:37:09 INFO - PROCESS | 1678 | 07:37:09 INFO - PROCESS | 1678 | [#1] audio-beat-detection Cycles:10 Average:141.20 Median:143.50 stddev:19.62 (13.7%) stddev-sans-first:19.46 07:37:09 INFO - PROCESS | 1678 | Values: 161.0 124.0 144.0 168.0 120.0 143.0 141.0 123.0 169.0 119.0 07:37:09 INFO - PROCESS | 1678 | 07:37:09 INFO - PROCESS | 1678 | [#2] audio-dft Cycles:10 Average:184.80 Median:185.00 stddev:2.30 (1.2%) stddev-sans-first:1.87 07:37:09 INFO - PROCESS | 1678 | Values: 189.0 187.0 186.0 185.0 184.0 185.0 181.0 182.0 185.0 184.0 07:37:09 INFO - PROCESS | 1678 | 07:37:09 INFO - PROCESS | 1678 | [#3] audio-fft Cycles:10 Average:89.40 Median:76.00 stddev:29.13 (38.3%) stddev-sans-first:30.43 07:37:09 INFO - PROCESS | 1678 | Values: 75.0 75.0 77.0 150.0 74.0 81.0 81.0 94.0 132.0 55.0 07:37:09 INFO - PROCESS | 1678 | 07:37:09 INFO - PROCESS | 1678 | [#4] audio-oscillator Cycles:10 Average:96.00 Median:81.00 stddev:21.21 (26.2%) stddev-sans-first:22.39 07:37:09 INFO - PROCESS | 1678 | Values: 90.0 95.0 132.0 77.0 82.0 84.0 120.0 80.0 76.0 124.0 07:37:09 INFO - PROCESS | 1678 | 07:37:09 INFO - PROCESS | 1678 | [#5] imaging-gaussian-blur Cycles:10 Average:87.50 Median:88.00 stddev:2.07 (2.4%) stddev-sans-first:1.99 07:37:09 INFO - PROCESS | 1678 | Values: 90.0 86.0 88.0 85.0 86.0 85.0 89.0 87.0 88.0 91.0 07:37:09 INFO - PROCESS | 1678 | 07:37:09 INFO - PROCESS | 1678 | [#6] imaging-darkroom Cycles:10 Average:92.10 Median:92.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 07:37:09 INFO - PROCESS | 1678 | Values: 92.0 92.0 92.0 92.0 92.0 92.0 92.0 93.0 92.0 92.0 07:37:09 INFO - PROCESS | 1678 | 07:37:09 INFO - PROCESS | 1678 | [#7] imaging-desaturate Cycles:10 Average:84.60 Median:85.00 stddev:1.17 (1.4%) stddev-sans-first:1.09 07:37:09 INFO - PROCESS | 1678 | Values: 83.0 86.0 84.0 86.0 83.0 86.0 84.0 85.0 84.0 85.0 07:37:09 INFO - PROCESS | 1678 | 07:37:09 INFO - PROCESS | 1678 | [#8] json-parse-financial Cycles:10 Average:60.30 Median:59.50 stddev:4.97 (8.3%) stddev-sans-first:5.20 07:37:09 INFO - PROCESS | 1678 | Values: 58.0 58.0 60.0 59.0 60.0 60.0 59.0 74.0 59.0 56.0 07:37:09 INFO - PROCESS | 1678 | 07:37:09 INFO - PROCESS | 1678 | [#9] json-stringify-tinderbox Cycles:10 Average:67.60 Median:68.50 stddev:3.81 (5.6%) stddev-sans-first:3.92 07:37:09 INFO - PROCESS | 1678 | Values: 65.0 63.0 75.0 62.0 71.0 69.0 67.0 67.0 69.0 68.0 07:37:09 INFO - PROCESS | 1678 | 07:37:09 INFO - PROCESS | 1678 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.00 stddev:0.48 (0.6%) stddev-sans-first:0.50 07:37:09 INFO - PROCESS | 1678 | Values: 82.0 82.0 83.0 83.0 82.0 82.0 82.0 82.0 82.0 83.0 07:37:09 INFO - PROCESS | 1678 | 07:37:09 INFO - PROCESS | 1678 | [#11] stanford-crypto-ccm Cycles:10 Average:154.60 Median:157.50 stddev:16.86 (10.7%) stddev-sans-first:14.36 07:37:09 INFO - PROCESS | 1678 | Values: 126.0 148.0 160.0 156.0 159.0 151.0 150.0 142.0 192.0 162.0 07:37:09 INFO - PROCESS | 1678 | 07:37:09 INFO - PROCESS | 1678 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.40 Median:198.50 stddev:3.41 (1.7%) stddev-sans-first:3.50 07:37:09 INFO - PROCESS | 1678 | Values: 196.0 202.0 197.0 205.0 201.0 198.0 197.0 194.0 199.0 195.0 07:37:09 INFO - PROCESS | 1678 | 07:37:09 INFO - PROCESS | 1678 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:73.00 Median:69.50 stddev:14.64 (21.1%) stddev-sans-first:14.87 07:37:09 INFO - PROCESS | 1678 | Values: 61.0 69.0 71.0 63.0 58.0 100.0 99.0 70.0 69.0 70.0 07:37:09 INFO - PROCESS | 1678 | -------- Summary: end -------- 07:37:09 INFO - PROCESS | 1678 | 07:37:10 INFO - TEST-INFO | 1678: exit 0 07:37:10 INFO - TEST-OK | kraken | took 58977ms 07:37:10 INFO - SUITE-END | took 1173s 07:37:11 INFO - Completed test suite (00:19:34) 07:37:11 INFO - javascript benchmark 07:37:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3353.1114254722497, 3416.5729283839505, 3421.1618153552386, 3445.9827700861492, 3490.5636795400574, 5501.477359650837, 5535.640183388077, 5569.443055694429, 5614.691191984439, 5627.577931655127, 4687.601553867917, 5601.915971260434, 5654.038813401721, 5740.5981581289325, 5747.655140691561, 5069.44236134025, 5079.288899554065, 5111.539961403473, 5120.743962801864, 5266.0, 5191.351081114861, 5207.6354655174155, 5209.7134657593815, 5221.765020574083, 5253.0, 5049.747512624354, 5089.262057001751, 5145.048166089286, 5147.279380886697, 5165.328507294028, 5087.949120508784, 5139.357580302462, 5202.635815492917, 5220.4779522047875, 5221.73891305437, 4100.835966561334, 5102.744862756885, 5133.798502891135, 5137.332146820927, 5198.428172901015, 5590.413006634286, 5590.496855283003, 5591.161325801122, 5606.915896261559, 5619.213310136584, 5153.433122356538, 6033.3664965178905, 6119.204503414572, 6131.835460087213, 6201.193844800147, 5156.92264616031, 6223.315435302113, 6256.244255285149, 6280.466160376373, 6295.496360291166, 5575.693336866511, 5751.626144300607, 5758.913616295801, 5770.653760774367, 5786.161006654053, 6194.876102478015, 6273.717682704198, 6275.058741188858, 6293.590916590407, 6295.181626388632, 6078.209832721806, 6103.877922441527, 6104.481119104926, 6125.081237814364, 6135.202423684892, 6084.39156084388, 6145.66198859067, 6222.62664240147, 6230.844228894314, 6246.219222597176, 6122.755089796358, 6140.078988151813, 6183.350748171467, 6201.596896201822, 6205.596636218631, 6161.938380616226, 6172.8765424691255, 6190.2571691397325, 6200.689965501707, 6221.129041934133, 4831.710097394097, 4888.462269150391, 4894.363732714724, 4894.388201474816, 4932.038252540792, 4331.112122014979, 4361.06237159006, 4437.423134992495, 4441.289393696993, 4481.058977614673, 5634.830955071355, 5702.54379649627, 5704.686242256716, 5709.65742055478, 5717.0, 6074.42292982166, 6307.810765677037, 6319.210098737658, 6339.619622822645, 6373.075903993988, 5623.5220006299105, 5624.21261023457, 5637.126245431965, 5643.181738647873, 5667.773289068474, 5342.385625653022, 5359.464053594609, 5372.274742909657, 5373.0059938910645, 5380.838574842761, 6195.070739389128, 6229.5327850410495, 6243.125962365272, 6313.77901773445, 6318.368163183737, 6194.845128871814, 6260.937390626218, 6280.905786413116, 6293.213348331458, 6304.306526282197, 6299.0, 6299.4645455135, 6303.432691057827, 6303.621782693053, 6310.337414571404, 5965.164876917148, 6030.0, 6104.76233045773, 6129.816105516842, 6136.662483563447, 6136.549713441251, 6148.938510614837, 6158.815235542941, 6167.537434692326, 6178.289496707756, 5837.76456575576, 5840.883182336244, 5952.553558483044, 6011.0, 6027.849303767441, 5822.0, 5883.499902508334, 5893.911591326219, 5905.793297234576, 5952.940470595238, 5892.292924849045, 5897.70511474416, 5907.3501914790195, 5918.940810591839, 5920.200772895604, 5940.821775346746, 6089.604175728564, 6090.299615544269, 6097.054956481575, 6109.602875813236, 5514.61397702157, 5736.569757268305, 5839.678817665069, 5849.736761845642, 5940.79207227745], "value": 5632.808324438161, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [501.60874517876044, 509.06332348478793, 526.0872386409579, 550.8815604645001, 571.4143003421495, 29937.55093673594, 30385.39229215417, 30465.847670761672, 30470.542941855863, 30521.542176867366, 30693.539596906063, 31302.53046204303, 39012.0, 40122.39816402756, 40466.59533404665, 9342.392744471621, 9524.571394287274, 9529.571169297398, 9534.618615255382, 9551.0, 9166.450012999208, 9384.155426011657, 9393.436393816393, 9415.387999780027, 9435.0, 8362.790930226733, 8571.828563428728, 11057.0, 11324.773504529905, 11336.546538138464, 11325.263857849213, 11466.541338346457, 11468.4839182237, 11470.311781293149, 11473.827892581618, 8280.420370574062, 10967.012968832763, 11195.60815371458, 11338.886611133865, 11389.202755807097, 37031.074223144366, 37628.81185594055, 37639.4354084689, 37672.43491347632, 37685.24629507394, 3202.343519578504, 3223.161977885743, 3483.4600636901323, 3687.797171155585, 4044.3326851069537, 26646.600300995502, 26811.463770724673, 26953.787079581467, 27099.593506097423, 27120.1863944082, 2664.9333766655795, 2705.878235479408, 2724.3733941193636, 2884.769218462518, 2933.31067199208, 346692.0, 347105.0, 349328.0, 349667.99999999744, 351573.0, 33018.3396332072, 33545.66454335425, 33574.66425335715, 33713.0, 33738.0, 34372.82813585966, 34543.65456345455, 34687.306253875286, 34706.479402808975, 34755.65244347524, 14634.634134146732, 14875.47935822241, 14878.256087195598, 14888.404463821542, 14907.92546037263, 12522.749545009048, 12552.686182845502, 12580.87419125797, 12665.620031399072, 12681.365931703378, 7366.521176123535, 7528.774136775905, 7834.608269586612, 7995.320397766139, 8132.552709601029, 3271.8200498972783, 3359.7480188985924, 3368.7305015598695, 3394.575678040245, 3406.982965085159, 912.8311262416474, 984.1290457944771, 1005.8792944846665, 1008.369768894441, 1118.608487029533, 27871.44257114887, 28141.0, 28417.147485575464, 28470.430591388056, 28544.429111417656, 1021.4790456866903, 1073.4793625091825, 1160.6808127764932, 1172.7334478762916, 1274.8215249865027, 14474.782878256834, 14734.410623574937, 14737.778933316009, 15052.698946021019, 15516.224188790515, 480304.0, 483049.0, 483519.0, 485240.0, 488008.0, 56269.155962660596, 56775.43224567784, 56832.71583642055, 57153.0, 57259.713701431225, 1446.8697817196503, 1482.4589025006012, 1484.0872863189277, 1495.229956572366, 1497.9925100374428, 26183.476330473666, 28057.298567535974, 28163.155105346872, 28175.0, 28719.282017949718, 50357.49642503528, 50664.74667626638, 50928.0, 51075.0, 51082.0, 349326.5202043943, 354758.0, 356657.0, 359634.0, 359845.0, 21722.022508986818, 22076.88961555182, 22650.0, 26350.604740928517, 26775.464490709688, 41016.58983410247, 41622.95942601459, 41827.954301142716, 42299.0, 43069.784651076545, 33352.49971250385, 34665.0, 35136.29727405489, 35584.82207588945, 35616.64383356237, 33175.66824331822, 33650.49524257089, 34274.0, 34604.0, 34614.82692586521, 34753.30493390169, 35450.82274588611, 35588.48378501336, 35696.28607427889, 36433.81783091067, 30023.69976300209, 30312.09063728092, 30491.390172196876, 31055.223619409695, 31641.36717265688, 22690.43273918165, 23361.41596460102, 23607.0, 23763.1682891098, 24345.026198951844], "value": 17318.613542977888, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [398.79661372699917, 398.8105649816338, 400.43738547340996, 401.4279651496618, 410.44794751059817, 13354.866451335483, 19504.317348892793, 19798.010099495004, 20185.798142018575, 20214.393568192958, 19121.139548720304, 19121.426357209308, 19184.712229316538, 19668.0, 19734.407967760955, 5656.462636049569, 5868.295804503444, 5913.201717768111, 5919.052951527735, 5920.733566989496, 5595.580331475136, 5765.942340576583, 5797.449242321994, 5847.093700476433, 5848.67832269225, 5700.486956173943, 5870.70646467677, 5894.233749612566, 5896.498797602209, 5918.1418694289305, 5646.774129034834, 5875.882482350329, 5885.087811389241, 5889.234399528055, 6016.879662406771, 5743.54051675865, 5767.394423585547, 5774.5091667208335, 5774.769009239625, 5776.277965254343, 13013.804792928113, 22272.777272227395, 22674.546509069725, 24932.0, 24947.0, 2024.8683835550642, 2066.0909199951975, 2120.459282882855, 2253.5380247049316, 2570.69151701797, 8187.877181842277, 10400.167986561057, 13724.862751372459, 14590.489332873405, 14638.048526845721, 1617.8705703543687, 1624.2041399714174, 1687.5106219196418, 1716.2362748576888, 1739.226044410238, 99659.0, 107794.46102769514, 108641.45679271632, 110319.44840275828, 111034.44482777534, 11427.028702560208, 11607.535698571963, 11745.47145378443, 11765.52937882475, 11917.404129793476, 12780.041496887585, 13509.500742362694, 14534.563963081124, 14567.854321456862, 14573.489927852686, 8056.436049476481, 8351.791205219919, 8361.832763344699, 8448.788780280542, 8476.23713865755, 8010.519368837889, 8022.0, 8092.069412017693, 8155.10293867674, 8163.265306122477, 3758.530183727034, 3996.0009997500624, 4350.630196433339, 4415.911681766347, 4579.717679049872, 1687.7468379743136, 1893.646043079205, 1941.4078705994807, 1956.5010922214744, 1982.137770070024, 741.7552207771422, 814.9511029338258, 859.1494420523636, 994.4679596415883, 1026.373911913732, 17814.46556603304, 18816.811831881507, 19399.515012124808, 19440.0, 19592.682358655657, 881.5900606218139, 914.9725508234764, 959.3764053365229, 977.2524019125375, 985.84719368498, 7049.647517624098, 9340.532973351304, 10412.68761937143, 10476.580936762597, 10532.947335263274, 600798.0, 608244.0, 615024.0, 621952.0, 627206.0, 74125.62937185279, 81162.0, 111531.44234278776, 116551.0, 117851.0, 981.1169947047714, 1007.4207330784682, 1025.1440047560222, 1025.5128813813528, 1026.3174988632625, 16928.915355423145, 17020.148992550075, 17321.74017389715, 17714.468565943043, 17748.201330940396, 45347.77326113348, 45723.31415028844, 46354.536454635025, 46597.0, 46848.297275541576, 56463.0, 58484.4151558479, 58807.70596146992, 61519.38480615136, 68621.97067044098, 7447.5531468112085, 7897.289243968071, 8098.190180981855, 8125.674973001013, 8138.3082437993435, 8967.685000644433, 10761.730956726144, 11860.525578976743, 12066.336351500751, 12465.93767031159, 10326.01902819231, 10595.205359598214, 10767.569297228023, 10837.945810270898, 11167.553297868319, 10499.94750026245, 10505.317154385246, 10537.683869483928, 10785.0, 10809.621663241749, 10735.570577177137, 10818.891811081789, 11225.15811314171, 11244.550217991517, 11309.264897781617, 8032.4778889372, 8181.713640022571, 8215.424920255764, 8306.958465207636, 8325.370695843607, 9686.32195746291, 10663.626773062906, 10726.195535335037, 11038.889611103787, 11070.169737269576], "value": 9152.865130576922, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1399.6570840144154, 1524.8780097592191, 1609.8390160983904, 1852.823981721736, 1993.2525303011362, 7815.218478152189, 8617.698380556674, 8824.205821476065, 8834.293256539477, 8839.381243312962, 8449.788755281106, 8659.35054870884, 8667.783305417368, 8669.869951950726, 8679.0, 2139.5399989002362, 2211.6682497625407, 2212.325240801555, 2415.1064106280655, 2458.299384675368, 2200.6038912995655, 2411.445367565461, 2504.787093097089, 2508.097085049381, 2509.874506274679, 2401.00358351284, 2427.611582146857, 2436.8903399347073, 2440.4021014851387, 2443.059422122478, 2116.9364919052455, 2414.9396265093424, 2429.5869702150676, 2434.160214725917, 2438.926832195037, 2328.348062542491, 2409.1086298069827, 2415.7221919479307, 2416.2026531244646, 2420.5037967216676, 8533.14668533148, 8593.699220527315, 8601.096884827128, 8602.913970860274, 8612.52631105289, 5141.614378921596, 5374.059539580558, 5375.75809088592, 5376.086065368858, 5376.946230537723, 3343.063942096217, 3476.9652303476896, 3573.714102871764, 3577.749557530974, 3592.6586974237407, 1017.699778565325, 1018.5162048027202, 1021.1983592879554, 1024.6721049264238, 1026.943518106504, 11701.473433695419, 11704.297742135414, 11715.53137874484, 11715.765684686345, 11732.237404568676, 4561.840335588238, 4567.086582683477, 4698.765061746899, 4717.669763116549, 4736.171170045228, 9964.651237206808, 9975.45135017581, 9977.900220997697, 9990.250731195045, 9998.900010999942, 5370.194470829407, 5393.191021346829, 5401.054815407367, 5402.729863506809, 5439.755211015514, 4740.786664600101, 4883.877903052381, 4961.826336078292, 4967.205247160437, 4998.175301075282, 3700.5189325388064, 3724.1806802503406, 3733.4213196954515, 3771.642208804828, 3807.961920380816, 1205.9095567832449, 1208.7582483503334, 1211.5335595795682, 1212.5210541835925, 1219.920705154162, 786.4809225910985, 792.0614072324314, 888.1651247827022, 891.7592250092569, 941.9481928493861, 5362.758675859595, 5446.21029950655, 5597.216389705444, 5785.681787501728, 5918.408159184133, 896.8744375787395, 898.2185498616245, 939.1876027236391, 956.6651671914914, 1006.3863020740716, 3146.1819926819194, 3791.0, 3875.1862108957434, 3898.96101038986, 3936.0356712605594, 10202.744931376776, 10475.1096156826, 10629.5216715248, 10773.353598784099, 10809.135269178447, 10699.358038517714, 10861.67414977552, 10885.0, 10885.020348168702, 10898.07366373867, 8212.507249565046, 8240.917590824016, 8347.66609335632, 8440.915590844135, 8454.492730436194, 5663.8867222656145, 5732.082866741302, 5755.913661295168, 5756.884862302647, 5771.7402716877, 8539.444936079135, 9718.805623887623, 10133.138683211715, 10242.129418999468, 10242.436665983443, 9204.677836275698, 10169.542370593193, 10217.0, 10351.327163734333, 10370.481475926324, 6540.247871494648, 6942.757003504853, 7154.713811447484, 7158.964205178941, 7166.140063192451, 6986.825329366603, 8198.426110172231, 8217.301529369832, 8236.217559331853, 8293.129221431904, 7402.777916662509, 7469.439792015512, 7501.962490187514, 7592.8861067082935, 7593.506422082547, 7058.153021637437, 7190.712371505081, 7275.090613673291, 7290.890636640349, 7452.739154129579, 5737.512311453574, 6824.829379265558, 6827.21487028998, 6829.726810927507, 6844.21291551458, 4588.334691469785, 4831.541003604652, 4844.128056949642, 4854.708717476963, 4868.196747536616, 4748.857534273978, 4860.0, 4909.68087074339, 4926.187179115549, 5096.0], "value": 4538.320777448165, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.82398472908613, 312.7754839802175, 318.50949537711915, 326.58523674932826, 331.63685764088314, 5218.7651555679995, 5254.842354729355, 5271.604629652772, 5285.8942821143555, 5312.893742125155, 4213.262679031172, 4351.0, 4559.697352836813, 5217.399999000116, 5221.164613661815, 3428.9828550857274, 3538.044727923459, 3905.2775236581183, 3934.6655534279475, 4098.815553300094, 3388.9322213555715, 3965.246603145408, 4044.534878488982, 4072.796360181994, 4089.284375234337, 3681.4109742441215, 3997.5602683704915, 4003.4595329630565, 4015.0966032642714, 4034.596540345957, 3299.4720844664857, 3860.864869729546, 4027.51669799623, 4056.6349028587274, 4062.228176646457, 3159.557661927332, 3524.594671612746, 3534.91162720934, 3543.263800737646, 3587.246678197582, 5104.438511763703, 5122.84840367043, 5123.615728820316, 5145.0, 5147.639665223436, 4005.6595189408936, 4286.76422796746, 4293.098449325646, 4310.913781724348, 4317.266064768997, 5476.3702174250075, 5491.670499769986, 5492.258545096401, 5499.752511137009, 5501.779928802843, 3785.2240290740333, 3798.0, 3798.2593394288124, 3809.466674665521, 3810.657040866335, 5505.229267902497, 5760.164776107441, 5825.097109947965, 5832.096025116114, 5849.561282903799, 3523.9647603523636, 3786.67813235878, 3808.143167787281, 3827.885163445101, 3835.2137811748526, 3282.473649752829, 3495.528103705967, 3580.997320750194, 3829.0235989822972, 3849.1147036181833, 4489.326601009875, 4527.230370836965, 4529.479109902338, 4572.4055872736335, 4584.066197633517, 5224.947750522522, 5614.6631202128, 5637.802676906289, 5677.772889084473, 5684.943150568524, 1412.3220853989937, 1432.641839540115, 1447.29082749452, 1447.7755947828105, 1451.8620731030535, 896.121800635368, 916.4237511480243, 946.4936259101348, 948.966786162481, 964.4984608003799, 4953.777080031407, 5616.073347897551, 5618.690971996498, 5629.521490673339, 5687.544996400278, 5201.661891977009, 5427.755750991215, 5603.915941260802, 6220.968895155495, 6268.811935641938, 4799.056382165229, 5579.581531385081, 5607.355154157242, 5614.550835933115, 5637.295338082739, 3252.317013427207, 3270.3132342207928, 3281.819499927527, 3302.5871766029245, 3309.387763263804, 5699.401562835926, 6404.423601875854, 6457.225132984072, 6503.349665033554, 6504.861649211369, 5449.346078470529, 5654.74553645087, 6330.525210609223, 6358.078078678658, 6374.9681251594375, 5962.493188078975, 6439.195100612424, 6448.677566121675, 6515.446187074152, 6547.934520654732, 5893.764249429974, 6189.876202476015, 6196.690165491617, 6218.253809542884, 6233.844153896189, 5362.302900622894, 5584.806130298861, 5937.2578427696535, 6062.969685151546, 6111.572189946661, 6194.4115309045565, 6458.967705161444, 6481.157449531531, 6493.772717954849, 6499.870002599827, 4071.7556946582113, 4098.139390727981, 4101.215971052602, 4104.912198267401, 4114.835406583823, 5469.179623056414, 6175.197224360804, 6190.0, 6193.876122477615, 6242.500599952084, 5090.847274581768, 5293.682379057269, 5626.409227031103, 5670.319561652628, 5678.488935995781, 4961.776720047535, 5331.626786124934, 5580.330360356621, 5638.830835074954, 5662.0, 4976.601871850316, 5227.973860130827, 5309.628326017141, 5477.849651573214, 5515.972420137874, 4968.503149685002, 5415.6479828811, 5556.722163891708, 5647.943520564741, 5656.264685590847, 4959.851204463872, 5217.530422262014, 5461.170507879746, 5489.34127904638, 5510.602887743844], "value": 4196.908318498227, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.1970474102413, 717.103620474407, 738.1326940844508, 765.8085478630343, 777.3858651665183, 14133.0, 14588.416463341453, 14628.926855365708, 14642.560723178309, 14695.26523673816, 13379.197248165092, 13464.730705385886, 13524.526641567547, 13536.39086241119, 13541.458341666346, 726.1939247435342, 748.0761259844088, 749.0150452155425, 749.4491548711693, 890.6392910871091, 739.5045319635857, 744.1405177020523, 884.9867251991225, 926.7868390270241, 928.3594319919268, 855.2217482091298, 974.8927617962054, 976.6484065736329, 978.7699890525721, 979.211734553684, 970.5341436110671, 971.4317124482221, 974.2644303550844, 975.5756246032998, 976.9839367058322, 562.4207066721284, 702.6065403374075, 723.5730918757905, 728.5264578024273, 730.5397599512327, 14364.856351436561, 14446.638834029129, 14448.71102577953, 14452.638684032878, 14464.059836110619, 12084.697882552919, 12173.452194651174, 12230.327331996737, 12368.690782730413, 12426.813597796041, 9734.805303893952, 9945.500715272143, 10025.0, 10030.548625311878, 10341.741456463573, 3167.841607919595, 3198.4082944655315, 3227.951580726291, 3252.4633435483115, 3263.543103965447, 73406.53186936285, 73949.0, 74286.25713742901, 74866.62566687132, 76810.61594692047, 9200.723978280663, 9401.905980940102, 9548.809023819624, 9721.368111072758, 9836.901630983743, 20388.28640997558, 20709.792902070785, 20737.27419540309, 20750.169993200103, 20807.1677132916, 7063.187733410621, 7234.710611575478, 7252.709891604382, 7336.669849856769, 7417.851642967111, 3898.2398432305426, 3944.4872166618156, 3953.466282051886, 4034.495688038995, 4041.8989525261513, 3502.562179727534, 3573.9821300893327, 3580.212353282274, 3583.3191693578137, 3583.552055993001, 644.1561554363799, 651.4169818012851, 661.6327937994363, 663.5852592129919, 666.8366250268715, 501.16074008389296, 535.9973200134052, 590.6279044202125, 598.4285007817524, 601.2424345324922, 6871.415929645936, 7370.852582948418, 7380.261973802684, 7485.663145158481, 7507.324340809353, 512.6539585779584, 521.1193083688554, 578.8855461993253, 592.351375244107, 595.4432605513858, 2889.9711002889703, 3840.8655697050467, 3901.8634347797692, 3949.38784488399, 4049.595040495986, 63891.0, 85740.14259857322, 88591.0, 89632.0, 90184.0, 55018.0, 78474.0, 79498.60250698825, 79790.80313795297, 80168.59915700385, 71132.93300600495, 71536.64231678809, 71683.0, 72157.27842721611, 73138.0, 8097.906896946072, 8339.12439193876, 8363.372747043873, 8388.286995605442, 8443.408961372645, 40746.1850762989, 40885.540733683134, 42119.0, 42446.0, 43180.13639727251, 55411.72294138504, 59524.107138393825, 60259.0, 60422.79154416975, 60590.697046514484, 10778.407187604756, 10879.129669626253, 10949.945250274017, 11205.935436133554, 11267.098632109575, 11018.1185505161, 11651.0, 11889.405529723652, 11905.46425410876, 12134.878651213729, 11409.657710268706, 11429.657110286706, 11508.021818145551, 11525.538978440769, 11744.119191060534, 11383.0, 11405.0, 11526.423678816192, 11741.0, 11763.764724705628, 11256.831147532957, 11299.943500282447, 11482.311061336346, 11595.8260626089, 11633.360165190996, 8020.478668886737, 9347.989850130794, 9480.146786789222, 9543.522823858919, 9639.855402169112, 9428.434293942386, 9672.177864881283, 9678.903210967801, 9696.660616878375, 9849.655262065793], "value": 6678.545255071493, "unit": "score"}], "name": "dromaeo_css", "value": 6959.160411613355, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [112.0, 113.0, 108.0, 113.0, 113.0, 112.0, 112.0, 114.0, 103.0, 113.0], "value": 111.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 124.0, 144.0, 168.0, 120.0, 143.0, 141.0, 123.0, 169.0, 119.0], "value": 141.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [189.0, 187.0, 186.0, 185.0, 184.0, 185.0, 181.0, 182.0, 185.0, 184.0], "value": 184.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 150.0, 74.0, 81.0, 81.0, 94.0, 132.0, 55.0], "value": 89.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 95.0, 132.0, 77.0, 82.0, 84.0, 120.0, 80.0, 76.0, 124.0], "value": 96.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 88.0, 85.0, 86.0, 85.0, 89.0, 87.0, 88.0, 91.0], "value": 87.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 92.0, 92.0, 92.0, 92.0, 92.0, 92.0, 93.0, 92.0, 92.0], "value": 92.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 84.0, 86.0, 83.0, 86.0, 84.0, 85.0, 84.0, 85.0], "value": 84.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 58.0, 60.0, 59.0, 60.0, 60.0, 59.0, 74.0, 59.0, 56.0], "value": 60.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 75.0, 62.0, 71.0, 69.0, 67.0, 67.0, 69.0, 68.0], "value": 67.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 83.0, 83.0, 82.0, 82.0, 82.0, 82.0, 82.0, 83.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 148.0, 160.0, 156.0, 159.0, 151.0, 150.0, 142.0, 192.0, 162.0], "value": 154.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [196.0, 202.0, 197.0, 205.0, 201.0, 198.0, 197.0, 194.0, 199.0, 195.0], "value": 198.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 69.0, 71.0, 63.0, 58.0, 100.0, 99.0, 70.0, 69.0, 70.0], "value": 73.0, "unit": "score"}], "name": "kraken", "value": 1523.1000000000001, "alertThreshold": 2.0}]} 07:37:11 INFO - Return code: 0 07:37:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 07:37:11 ERROR - # TBPL SUCCESS # 07:37:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:37:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:37:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:37:11 INFO - 2016-04-27 07:37:11.190 screenresolution[1682:11602] starting screenresolution argv=screenresolution get 07:37:11 INFO - 2016-04-27 07:37:11.193 screenresolution[1682:11602] Display 0: 1600x1200x32@60 07:37:11 INFO - 2016-04-27 07:37:11.199 screenresolution[1683:11605] starting screenresolution argv=screenresolution list 07:37:11 INFO - Available Modes on Display 0 07:37:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:37:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:37:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:37:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:37:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:37:11 INFO - Intel Iris: 07:37:11 INFO - Chipset Model: Intel Iris 07:37:11 INFO - Type: GPU 07:37:11 INFO - Bus: Built-In 07:37:11 INFO - VRAM (Dynamic, Max): 1536 MB 07:37:11 INFO - Vendor: Intel (0x8086) 07:37:11 INFO - Device ID: 0x0a2e 07:37:11 INFO - Revision ID: 0x0009 07:37:11 INFO - Displays: 07:37:11 INFO - Display: 07:37:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:37:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:37:11 INFO - Display Serial Number: 1600x1200 60 07:37:11 INFO - Main Display: Yes 07:37:11 INFO - Mirror: Off 07:37:11 INFO - Online: Yes 07:37:11 INFO - Rotation: Supported 07:37:11 INFO - Return code: 0 07:37:11 INFO - Running post-action listener: _resource_record_post_action 07:37:11 INFO - Running post-run listener: _resource_record_post_run 07:37:12 INFO - Total resource usage - Wall time: 1209s; CPU: 54.0%; Read bytes: 32157184; Write bytes: 697226752; Read time: 377; Write time: 1881 07:37:12 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 387060224; Write bytes: 382328320; Read time: 28628; Write time: 735 07:37:12 INFO - run-tests - Wall time: 1176s; CPU: 54.0%; Read bytes: 30359040; Write bytes: 297195520; Read time: 301; Write time: 1107 07:37:12 INFO - Running post-run listener: _upload_blobber_files 07:37:12 INFO - Blob upload gear active. 07:37:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 07:37:12 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 07:37:12 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'] 07:37:12 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 07:37:12 INFO - (blobuploader) - INFO - Open directory for files ... 07:37:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 07:37:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:37:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:37:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 07:37:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:37:14 INFO - (blobuploader) - INFO - Done attempting. 07:37:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 07:37:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 07:37:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 07:37:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 07:37:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 07:37:14 INFO - (blobuploader) - INFO - Done attempting. 07:37:14 INFO - (blobuploader) - INFO - Iteration through files over. 07:37:14 INFO - Return code: 0 07:37:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 07:37:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 07:37:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a7d5019005c831c5c7e8e2147c4dfc2f7e8675423cf888ed34028a0168c4881ac19cd940c26dc42793f018273a7eae2932eac3372ab6afeec6a7496d59133fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34dc423a08a65f541dd0bbf06154de9eb21129f89778cbd1d760e7e903e3a2ca62b73ffc5dde819df037a58fa1aacfa66ac68d262c3641638e42b3428786d616"} 07:37:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 07:37:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 07:37:14 INFO - Contents: 07:37:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a7d5019005c831c5c7e8e2147c4dfc2f7e8675423cf888ed34028a0168c4881ac19cd940c26dc42793f018273a7eae2932eac3372ab6afeec6a7496d59133fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34dc423a08a65f541dd0bbf06154de9eb21129f89778cbd1d760e7e903e3a2ca62b73ffc5dde819df037a58fa1aacfa66ac68d262c3641638e42b3428786d616"} 07:37:14 INFO - Running post-run listener: copy_logs_to_upload_dir 07:37:14 INFO - Copying logs to upload dir... 07:37:14 INFO - mkdir: /builds/slave/test/build/upload/logs 07:37:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1292.846106 ========= master_lag: 27.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 59 secs) (at 2016-04-27 07:37:42.119278) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 11 secs) (at 2016-04-27 07:37:42.123344) ========= 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.eVnzz6s2wC/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.MtoXLDudoJ/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a7d5019005c831c5c7e8e2147c4dfc2f7e8675423cf888ed34028a0168c4881ac19cd940c26dc42793f018273a7eae2932eac3372ab6afeec6a7496d59133fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34dc423a08a65f541dd0bbf06154de9eb21129f89778cbd1d760e7e903e3a2ca62b73ffc5dde819df037a58fa1aacfa66ac68d262c3641638e42b3428786d616"} build_url:https://queue.taskcluster.net/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011277 build_url: 'https://queue.taskcluster.net/v1/task/CU8V7cHGQ9qsR1WGX3bxVw/artifacts/public/build/firefox-49.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2a7d5019005c831c5c7e8e2147c4dfc2f7e8675423cf888ed34028a0168c4881ac19cd940c26dc42793f018273a7eae2932eac3372ab6afeec6a7496d59133fe", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/34dc423a08a65f541dd0bbf06154de9eb21129f89778cbd1d760e7e903e3a2ca62b73ffc5dde819df037a58fa1aacfa66ac68d262c3641638e42b3428786d616"}' ========= master_lag: 11.41 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 11 secs) (at 2016-04-27 07:37:53.549022) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-04-27 07:37:53.549366) ========= 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.eVnzz6s2wC/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.MtoXLDudoJ/Listeners TMPDIR=/var/folders/t6/qpy_kfds3kz26lvtw39n2d7m00000w/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.005016 ========= master_lag: 3.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 3 secs) (at 2016-04-27 07:37:56.633215) ========= ========= Started reboot skipped (results: 3, elapsed: 1 secs) (at 2016-04-27 07:37:56.633515) ========= ========= Finished reboot skipped (results: 3, elapsed: 1 secs) (at 2016-04-27 07:37:57.963675) ========= ========= Total master_lag: 41.96 =========