builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0276 starttime: 1465288639.73 results: success (0) buildid: 20160606120332 builduid: 394ff36afaaf47b0a5ccdc9e3ac607e3 revision: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:19.730977) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:19.731432) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:19.731734) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:19.765556) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:19.765920) ========= 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.z0RRhP6lt1/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.59m5V9PePZ/Listeners TMPDIR=/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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-06-07 01:37:19-- 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% 60.6M=0s 2016-06-07 01:37:19 (60.6 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.114158 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:19.901911) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:19.902512) ========= 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.z0RRhP6lt1/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.59m5V9PePZ/Listeners TMPDIR=/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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.026541 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:19.951626) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 01:37:19.951989) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.z0RRhP6lt1/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.59m5V9PePZ/Listeners TMPDIR=/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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-06-07 01:37:20,036 truncating revision to first 12 chars 2016-06-07 01:37:20,037 Setting DEBUG logging. 2016-06-07 01:37:20,037 attempt 1/10 2016-06-07 01:37:20,037 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/46d72a56c57d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-07 01:37:20,761 unpacking tar archive at: mozilla-beta-46d72a56c57d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.999138 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-07 01:37:20.972979) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:20.973297) ========= script_repo_revision: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:20.973685) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:20.974049) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-07 01:37:20.992097) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-07 01:37:20.992462) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.z0RRhP6lt1/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.59m5V9PePZ/Listeners TMPDIR=/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 01:37:21 INFO - MultiFileLogger online at 20160607 01:37:21 in /builds/slave/test 01:37:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 01:37:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:37:21 INFO - {'append_to_log': False, 01:37:21 INFO - 'base_work_dir': '/builds/slave/test', 01:37:21 INFO - 'blob_upload_branch': 'Mozilla-Beta', 01:37:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:37:21 INFO - 'branch': 'Mozilla-Beta', 01:37:21 INFO - 'buildbot_json_path': 'buildprops.json', 01:37:21 INFO - 'config_files': ('talos/mac_config.py',), 01:37:21 INFO - 'default_actions': ('clobber', 01:37:21 INFO - 'read-buildbot-config', 01:37:21 INFO - 'download-and-extract', 01:37:21 INFO - 'populate-webroot', 01:37:21 INFO - 'create-virtualenv', 01:37:21 INFO - 'install', 01:37:21 INFO - 'run-tests'), 01:37:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:37:21 INFO - 'download_minidump_stackwalk': True, 01:37:21 INFO - 'download_symbols': 'ondemand', 01:37:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:37:21 INFO - 'tooltool.py': '/tools/tooltool.py', 01:37:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:37:21 INFO - '/tools/misc-python/virtualenv.py')}, 01:37:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:37:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:37:21 INFO - 'installer_path': 'installer.exe', 01:37:21 INFO - 'log_level': 'info', 01:37:21 INFO - 'log_name': 'talos', 01:37:21 INFO - 'log_to_console': True, 01:37:21 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 01:37:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 01:37:21 INFO - 'opt_config_files': (), 01:37:21 INFO - 'pip_index': False, 01:37:21 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:37:21 INFO - 'cmd': ('bash', 01:37:21 INFO - '-c', 01:37:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:37:21 INFO - 'enabled': True, 01:37:21 INFO - 'halt_on_failure': False, 01:37:21 INFO - 'name': 'check_screen_resolution'},), 01:37:21 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 01:37:21 INFO - 'cmd': ('bash', 01:37:21 INFO - '-c', 01:37:21 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 01:37:21 INFO - 'enabled': True, 01:37:21 INFO - 'halt_on_failure': False, 01:37:21 INFO - 'name': 'check_screen_resolution'},), 01:37:21 INFO - 'run_cmd_checks_enabled': True, 01:37:21 INFO - 'sps_profile': False, 01:37:21 INFO - 'sps_profile_interval': 0, 01:37:21 INFO - 'suite': 'dromaeojs-e10s', 01:37:21 INFO - 'system_bits': '32', 01:37:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:37:21 INFO - 'title': 't-yosemite-r7-0276', 01:37:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:37:21 INFO - 'use_talos_json': True, 01:37:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:37:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:37:21 INFO - 'work_dir': 'build'} 01:37:21 INFO - ##### 01:37:21 INFO - ##### Running clobber step. 01:37:21 INFO - ##### 01:37:21 INFO - Running pre-action listener: _resource_record_pre_action 01:37:21 INFO - Running main action method: clobber 01:37:21 INFO - rmtree: /builds/slave/test/build 01:37:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:37:23 INFO - Running post-action listener: _resource_record_post_action 01:37:23 INFO - ##### 01:37:23 INFO - ##### Running read-buildbot-config step. 01:37:23 INFO - ##### 01:37:23 INFO - Running pre-action listener: _resource_record_pre_action 01:37:23 INFO - Running main action method: read_buildbot_config 01:37:23 INFO - Using buildbot properties: 01:37:23 INFO - { 01:37:23 INFO - "project": "", 01:37:23 INFO - "product": "firefox", 01:37:23 INFO - "script_repo_revision": "production", 01:37:23 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 01:37:23 INFO - "repository": "", 01:37:23 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 01:37:23 INFO - "buildid": "20160606120332", 01:37:23 INFO - "pgo_build": "False", 01:37:23 INFO - "basedir": "/builds/slave/test", 01:37:23 INFO - "buildnumber": 32, 01:37:23 INFO - "slavename": "t-yosemite-r7-0276", 01:37:23 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 01:37:23 INFO - "platform": "yosemite_r7", 01:37:23 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 01:37:23 INFO - "branch": "mozilla-beta", 01:37:23 INFO - "repo_path": "releases/mozilla-beta", 01:37:23 INFO - "revision": "46d72a56c57dafb4dc1061d4741a3e1181ac3d68", 01:37:23 INFO - "stage_platform": "macosx64", 01:37:23 INFO - "builduid": "394ff36afaaf47b0a5ccdc9e3ac607e3", 01:37:23 INFO - "slavebuilddir": "test" 01:37:23 INFO - } 01:37:23 INFO - Found installer url https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 01:37:23 INFO - Running post-action listener: _resource_record_post_action 01:37:23 INFO - ##### 01:37:23 INFO - ##### Running download-and-extract step. 01:37:23 INFO - ##### 01:37:23 INFO - Running pre-action listener: _resource_record_pre_action 01:37:23 INFO - Running main action method: download_and_extract 01:37:23 INFO - mkdir: /builds/slave/test/build/tests 01:37: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')]} 01:37:23 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 01:37:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 01:37:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 01:37:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 01:37:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 01:37:23 INFO - Downloaded 1165 bytes. 01:37:23 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 01:37:23 INFO - Using the following test package requirements: 01:37:23 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 01:37:23 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:23 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 01:37:23 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:23 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 01:37:23 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 01:37:23 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:23 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 01:37:23 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 01:37:23 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:23 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 01:37:23 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:23 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 01:37:23 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:23 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 01:37:23 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 01:37:23 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 01:37:23 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 01:37: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')]} 01:37:23 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:37:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 01:37:25 INFO - Downloaded 18292404 bytes. 01:37:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:37:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:37:28 INFO - Return code: 0 01:37:28 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 01:37:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:28 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 01:37:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 01:37:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 01:37:33 INFO - Downloaded 18292404 bytes. 01:37:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:37:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 01:37:36 INFO - Return code: 0 01:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:36 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 01:37:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 01:37:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 01:37:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 01:37:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 01:37:37 INFO - Downloaded 10840145 bytes. 01:37:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:37:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 01:37:38 INFO - Return code: 0 01:37: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')]} 01:37:38 INFO - https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 01:37:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:37:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:37:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 01:37:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 01:37:40 INFO - Downloaded 86246253 bytes. 01:37:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:37:40 INFO - mkdir: /builds/slave/test/properties 01:37:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:37:40 INFO - Writing to file /builds/slave/test/properties/build_url 01:37:40 INFO - Contents: 01:37:40 INFO - build_url:https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg 01:37:41 INFO - Running post-action listener: _resource_record_post_action 01:37:41 INFO - Running post-action listener: set_extra_try_arguments 01:37:41 INFO - ##### 01:37:41 INFO - ##### Running populate-webroot step. 01:37:41 INFO - ##### 01:37:41 INFO - Running pre-action listener: _resource_record_pre_action 01:37:41 INFO - Running main action method: populate_webroot 01:37:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:37:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:37:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:37:41 INFO - '--tppagecycles', 01:37:41 INFO - '7'], 01:37:41 INFO - 'tests': ['tsvgm']}}, 01:37:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:37:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:37:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:37:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:37:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:37:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:37:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:41 INFO - 'talos_options': ['--disable-e10s'], 01:37:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:37:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:37:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:41 INFO - 'talos_options': ['--disable-e10s'], 01:37:41 INFO - 'tests': ['damp', 'tps']}, 01:37:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:41 INFO - 'tests': ['damp', 'tps']}, 01:37:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:37:41 INFO - 'tests': ['dromaeo_dom']}, 01:37:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:37:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:37:41 INFO - 'tests': ['a11yr', 01:37:41 INFO - 'ts_paint', 01:37:41 INFO - 'tpaint', 01:37:41 INFO - 'sessionrestore', 01:37:41 INFO - 'sessionrestore_no_auto_restore', 01:37:41 INFO - 'tabpaint']}, 01:37:41 INFO - 'other-e10s': {'tests': ['a11yr', 01:37:41 INFO - 'ts_paint', 01:37:41 INFO - 'tpaint', 01:37:41 INFO - 'sessionrestore', 01:37:41 INFO - 'sessionrestore_no_auto_restore', 01:37:41 INFO - 'tabpaint']}, 01:37:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:37:41 INFO - 'ts_paint', 01:37:41 INFO - 'tpaint', 01:37:41 INFO - 'sessionrestore', 01:37:41 INFO - 'sessionrestore_no_auto_restore', 01:37:41 INFO - 'tabpaint']}, 01:37:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:37:41 INFO - 'ts_paint', 01:37:41 INFO - 'tpaint', 01:37:41 INFO - 'sessionrestore', 01:37:41 INFO - 'sessionrestore_no_auto_restore', 01:37:41 INFO - 'tabpaint']}, 01:37:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:37:41 INFO - 'tests': ['a11yr', 01:37:41 INFO - 'ts_paint', 01:37:41 INFO - 'tpaint', 01:37:41 INFO - 'sessionrestore', 01:37:41 INFO - 'sessionrestore_no_auto_restore', 01:37:41 INFO - 'tabpaint']}, 01:37:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:37:41 INFO - 'tests': ['a11yr', 01:37:41 INFO - 'ts_paint', 01:37:41 INFO - 'tpaint', 01:37:41 INFO - 'sessionrestore', 01:37:41 INFO - 'sessionrestore_no_auto_restore', 01:37:41 INFO - 'tabpaint']}, 01:37:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:37:41 INFO - 'tests': ['tsvgx', 01:37:41 INFO - 'tsvgr_opacity', 01:37:41 INFO - 'tart', 01:37:41 INFO - 'tscrollx', 01:37:41 INFO - 'cart']}, 01:37:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:37:41 INFO - 'tsvgr_opacity', 01:37:41 INFO - 'tart', 01:37:41 INFO - 'tscrollx', 01:37:41 INFO - 'cart']}, 01:37:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:41 INFO - 'talos_options': ['--disable-e10s'], 01:37:41 INFO - 'tests': ['tp5o']}, 01:37:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:41 INFO - 'tests': ['tp5o']}, 01:37:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:41 INFO - 'talos_options': ['--disable-e10s', 01:37:41 INFO - '--xperf_path', 01:37:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:37:41 INFO - 'tests': ['tp5n']}, 01:37:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:37:41 INFO - 'talos_options': ['--xperf_path', 01:37:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:37:41 INFO - 'tests': ['tp5n']}}, 01:37:41 INFO - 'talos.zip': {'path': '', 01:37:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:37:41 INFO - Running post-action listener: _resource_record_post_action 01:37:41 INFO - ##### 01:37:41 INFO - ##### Running create-virtualenv step. 01:37:41 INFO - ##### 01:37:41 INFO - Running pre-action listener: _resource_record_pre_action 01:37:41 INFO - Running main action method: create_virtualenv 01:37:41 INFO - Creating virtualenv /builds/slave/test/build/venv 01:37:41 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:37:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:37:42 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:37:42 INFO - Using real prefix '/tools/python27' 01:37:42 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:37:42 INFO - Installing distribute.............................................................................................................................................................................................done. 01:37:45 INFO - Installing pip.................done. 01:37:45 INFO - Return code: 0 01:37:45 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e0ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e1e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba2d95530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cade00>, '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 0x104b16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ca8b20>, '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.z0RRhP6lt1/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.59m5V9PePZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:37:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:37:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:37:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z0RRhP6lt1/Render', 01:37:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:45 INFO - 'HOME': '/Users/cltbld', 01:37:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:45 INFO - 'LOGNAME': 'cltbld', 01:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:45 INFO - 'MOZ_NO_REMOTE': '1', 01:37:45 INFO - 'NO_EM_RESTART': '1', 01:37:45 INFO - 'PAGER': '/bin/cat', 01:37:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:45 INFO - 'PWD': '/builds/slave/test', 01:37:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:45 INFO - 'SHELL': '/bin/bash', 01:37:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.59m5V9PePZ/Listeners', 01:37:45 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 01:37:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:45 INFO - 'USER': 'cltbld', 01:37:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:45 INFO - 'XPC_FLAGS': '0x0', 01:37:45 INFO - 'XPC_SERVICE_NAME': '0', 01:37:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:45 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:37:45 INFO - Cleaning up... 01:37:45 INFO - Return code: 0 01:37:45 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 01:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104e0ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e1e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba2d95530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cade00>, '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 0x104b16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ca8b20>, '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.z0RRhP6lt1/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.59m5V9PePZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:37:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 01:37:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 01:37:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z0RRhP6lt1/Render', 01:37:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:45 INFO - 'HOME': '/Users/cltbld', 01:37:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:45 INFO - 'LOGNAME': 'cltbld', 01:37:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:45 INFO - 'MOZ_NO_REMOTE': '1', 01:37:45 INFO - 'NO_EM_RESTART': '1', 01:37:45 INFO - 'PAGER': '/bin/cat', 01:37:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:45 INFO - 'PWD': '/builds/slave/test', 01:37:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:45 INFO - 'SHELL': '/bin/bash', 01:37:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.59m5V9PePZ/Listeners', 01:37:45 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 01:37:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:45 INFO - 'USER': 'cltbld', 01:37:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:45 INFO - 'XPC_FLAGS': '0x0', 01:37:45 INFO - 'XPC_SERVICE_NAME': '0', 01:37:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:46 INFO - Downloading/unpacking psutil>=0.7.1 01:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:37:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:37:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:37:49 INFO - Installing collected packages: psutil 01:37:49 INFO - Running setup.py install for psutil 01:37:49 INFO - building 'psutil._psutil_osx' extension 01:37:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 01:37:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 01:37:49 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 01:37:49 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 01:37:50 INFO - building 'psutil._psutil_posix' extension 01:37:50 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 01:37:50 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 01:37:50 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 01:37:50 INFO - ^ 01:37:50 INFO - 1 warning generated. 01:37:50 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 01:37:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:37:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:37:50 INFO - Successfully installed psutil 01:37:50 INFO - Cleaning up... 01:37:50 INFO - Return code: 0 01:37:50 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 01:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e0ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e1e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba2d95530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cade00>, '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 0x104b16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ca8b20>, '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.z0RRhP6lt1/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.59m5V9PePZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:37:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 01:37:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 01:37:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z0RRhP6lt1/Render', 01:37:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:50 INFO - 'HOME': '/Users/cltbld', 01:37:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:50 INFO - 'LOGNAME': 'cltbld', 01:37:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:50 INFO - 'MOZ_NO_REMOTE': '1', 01:37:50 INFO - 'NO_EM_RESTART': '1', 01:37:50 INFO - 'PAGER': '/bin/cat', 01:37:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:50 INFO - 'PWD': '/builds/slave/test', 01:37:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:50 INFO - 'SHELL': '/bin/bash', 01:37:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.59m5V9PePZ/Listeners', 01:37:50 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 01:37:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:50 INFO - 'USER': 'cltbld', 01:37:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:50 INFO - 'XPC_FLAGS': '0x0', 01:37:50 INFO - 'XPC_SERVICE_NAME': '0', 01:37:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:50 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 01:37:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:37:53 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 01:37:53 INFO - Installing collected packages: mozsystemmonitor 01:37:53 INFO - Running setup.py install for mozsystemmonitor 01:37:53 INFO - Successfully installed mozsystemmonitor 01:37:53 INFO - Cleaning up... 01:37:53 INFO - Return code: 0 01:37:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:37: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')]} 01:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37: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')]} 01:37:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e0ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e1e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba2d95530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cade00>, '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 0x104b16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ca8b20>, '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.z0RRhP6lt1/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.59m5V9PePZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:37:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:37:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:37:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z0RRhP6lt1/Render', 01:37:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:53 INFO - 'HOME': '/Users/cltbld', 01:37:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:53 INFO - 'LOGNAME': 'cltbld', 01:37:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:53 INFO - 'MOZ_NO_REMOTE': '1', 01:37:53 INFO - 'NO_EM_RESTART': '1', 01:37:53 INFO - 'PAGER': '/bin/cat', 01:37:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:53 INFO - 'PWD': '/builds/slave/test', 01:37:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:53 INFO - 'SHELL': '/bin/bash', 01:37:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.59m5V9PePZ/Listeners', 01:37:53 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 01:37:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:53 INFO - 'USER': 'cltbld', 01:37:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:53 INFO - 'XPC_FLAGS': '0x0', 01:37:53 INFO - 'XPC_SERVICE_NAME': '0', 01:37:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:53 INFO - Downloading/unpacking blobuploader==1.2.4 01:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:37:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:37:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:37:55 INFO - Downloading blobuploader-1.2.4.tar.gz 01:37:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:37:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:37:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37: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 01:37:57 INFO - Downloading docopt-0.6.1.tar.gz 01:37:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:37:57 INFO - Installing collected packages: blobuploader, requests, docopt 01:37:57 INFO - Running setup.py install for blobuploader 01:37:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:37:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:37:57 INFO - Running setup.py install for requests 01:37:57 INFO - Running setup.py install for docopt 01:37:58 INFO - Successfully installed blobuploader requests docopt 01:37:58 INFO - Cleaning up... 01:37:58 INFO - Return code: 0 01:37:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:37:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:37:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:37:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:37:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:37:58 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 0x104e0ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e1e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba2d95530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cade00>, '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 0x104b16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ca8b20>, '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.z0RRhP6lt1/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.59m5V9PePZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:37:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:37:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:37:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z0RRhP6lt1/Render', 01:37:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:37:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:37:58 INFO - 'HOME': '/Users/cltbld', 01:37:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:37:58 INFO - 'LOGNAME': 'cltbld', 01:37:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:37:58 INFO - 'MOZ_NO_REMOTE': '1', 01:37:58 INFO - 'NO_EM_RESTART': '1', 01:37:58 INFO - 'PAGER': '/bin/cat', 01:37:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:37:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:37:58 INFO - 'PWD': '/builds/slave/test', 01:37:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:37:58 INFO - 'SHELL': '/bin/bash', 01:37:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.59m5V9PePZ/Listeners', 01:37:58 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 01:37:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:37:58 INFO - 'USER': 'cltbld', 01:37:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:37:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:37:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:37:58 INFO - 'XPC_FLAGS': '0x0', 01:37:58 INFO - 'XPC_SERVICE_NAME': '0', 01:37:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:37:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:37:58 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-qwaIeS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:37:58 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-yTvEJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:37:58 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-ISo6Tu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:37:58 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-r9QSGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:37:58 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-LeDOYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:37:58 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-tkLGFC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:37:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:37:58 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-rKE8Bk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:37:59 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-28olLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:37:59 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-7i3Gt5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:37:59 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-uJjLtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:37:59 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-xUdtze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:37:59 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-zBKGAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:37:59 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-sPpp7i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:37:59 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-objYU3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:59 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-3iBbDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:37:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:37:59 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-IomtUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:38:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:38:00 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-wqQMtt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:38:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:38:00 INFO - Running setup.py install for manifestparser 01:38:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:38:00 INFO - Running setup.py install for mozcrash 01:38:00 INFO - Running setup.py install for mozdebug 01:38:00 INFO - Running setup.py install for mozdevice 01:38:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:38:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:38:00 INFO - Running setup.py install for mozfile 01:38:00 INFO - Running setup.py install for mozhttpd 01:38:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:38:00 INFO - Running setup.py install for mozinfo 01:38:01 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:38:01 INFO - Running setup.py install for mozInstall 01:38:01 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:38:01 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:38:01 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:38:01 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:38:01 INFO - Running setup.py install for mozleak 01:38:01 INFO - Running setup.py install for mozlog 01:38:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:38:01 INFO - Running setup.py install for moznetwork 01:38:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:38:01 INFO - Running setup.py install for mozprocess 01:38:01 INFO - Running setup.py install for mozprofile 01:38:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:38:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:38:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:38:02 INFO - Running setup.py install for mozrunner 01:38:02 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:38:02 INFO - Running setup.py install for mozscreenshot 01:38:02 INFO - Running setup.py install for moztest 01:38:02 INFO - Running setup.py install for mozversion 01:38:02 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:38:02 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:38:02 INFO - Cleaning up... 01:38:02 INFO - Return code: 0 01:38:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e0ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e1e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba2d95530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cade00>, '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 0x104b16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ca8b20>, '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.z0RRhP6lt1/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.59m5V9PePZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:38:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:38:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:38:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z0RRhP6lt1/Render', 01:38:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:02 INFO - 'HOME': '/Users/cltbld', 01:38:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:02 INFO - 'LOGNAME': 'cltbld', 01:38:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:02 INFO - 'MOZ_NO_REMOTE': '1', 01:38:02 INFO - 'NO_EM_RESTART': '1', 01:38:02 INFO - 'PAGER': '/bin/cat', 01:38:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:02 INFO - 'PWD': '/builds/slave/test', 01:38:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:02 INFO - 'SHELL': '/bin/bash', 01:38:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.59m5V9PePZ/Listeners', 01:38:02 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 01:38:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:02 INFO - 'USER': 'cltbld', 01:38:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:02 INFO - 'XPC_FLAGS': '0x0', 01:38:02 INFO - 'XPC_SERVICE_NAME': '0', 01:38:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:38:02 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-feYP3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:38:03 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-l4XDj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:38:03 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-9z5qiP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:38:03 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-_bPjvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:38:03 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-gKomhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:38:03 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-Bqc5UE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:38:03 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-Hcxadx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:38:03 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-_IU_zr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:38:03 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-iegI2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:38:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:38:03 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-BeYRa5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:38:04 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-L5XN1b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:38:04 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-94m0nn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:38:04 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-7nqgnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:38:04 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-Ya6ksh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:38:04 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-qTv3Ej-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:38:04 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-_KhylN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:38:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:38:04 INFO - Running setup.py (path:/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/pip-KwWQmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:38:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:38:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:07 INFO - Downloading blessings-1.6.tar.gz 01:38:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:38:07 INFO - Installing collected packages: blessings 01:38:07 INFO - Running setup.py install for blessings 01:38:07 INFO - Successfully installed blessings 01:38:07 INFO - Cleaning up... 01:38:07 INFO - Return code: 0 01:38:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:38:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:38:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:38:07 INFO - Reading from file tmpfile_stdout 01:38:07 INFO - Current package versions: 01:38:07 INFO - blessings == 1.6 01:38:07 INFO - blobuploader == 1.2.4 01:38:07 INFO - docopt == 0.6.1 01:38:07 INFO - manifestparser == 1.1 01:38:07 INFO - mozInstall == 1.12 01:38:07 INFO - mozcrash == 0.17 01:38:07 INFO - mozdebug == 0.1 01:38:07 INFO - mozdevice == 0.48 01:38:07 INFO - mozfile == 1.2 01:38:07 INFO - mozhttpd == 0.7 01:38:07 INFO - mozinfo == 0.9 01:38:07 INFO - mozleak == 0.1 01:38:07 INFO - mozlog == 3.1 01:38:07 INFO - moznetwork == 0.27 01:38:07 INFO - mozprocess == 0.22 01:38:07 INFO - mozprofile == 0.28 01:38:07 INFO - mozrunner == 6.11 01:38:07 INFO - mozscreenshot == 0.1 01:38:07 INFO - mozsystemmonitor == 0.0 01:38:07 INFO - moztest == 0.7 01:38:07 INFO - mozversion == 1.4 01:38:07 INFO - psutil == 3.1.1 01:38:07 INFO - requests == 1.2.3 01:38:07 INFO - wsgiref == 0.1.2 01:38:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e0ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e1e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba2d95530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cade00>, '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 0x104b16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ca8b20>, '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.z0RRhP6lt1/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.59m5V9PePZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:38:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:38:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:38:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z0RRhP6lt1/Render', 01:38:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:07 INFO - 'HOME': '/Users/cltbld', 01:38:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:07 INFO - 'LOGNAME': 'cltbld', 01:38:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:07 INFO - 'MOZ_NO_REMOTE': '1', 01:38:07 INFO - 'NO_EM_RESTART': '1', 01:38:07 INFO - 'PAGER': '/bin/cat', 01:38:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:07 INFO - 'PWD': '/builds/slave/test', 01:38:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:07 INFO - 'SHELL': '/bin/bash', 01:38:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.59m5V9PePZ/Listeners', 01:38:07 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 01:38:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:07 INFO - 'USER': 'cltbld', 01:38:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:07 INFO - 'XPC_FLAGS': '0x0', 01:38:07 INFO - 'XPC_SERVICE_NAME': '0', 01:38:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:38:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:38:08 INFO - Cleaning up... 01:38:08 INFO - Return code: 0 01:38:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:08 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 0x104e0ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e1e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba2d95530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cade00>, '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 0x104b16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ca8b20>, '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.z0RRhP6lt1/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.59m5V9PePZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:38:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:38:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:38:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z0RRhP6lt1/Render', 01:38:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:08 INFO - 'HOME': '/Users/cltbld', 01:38:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:08 INFO - 'LOGNAME': 'cltbld', 01:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:08 INFO - 'MOZ_NO_REMOTE': '1', 01:38:08 INFO - 'NO_EM_RESTART': '1', 01:38:08 INFO - 'PAGER': '/bin/cat', 01:38:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:08 INFO - 'PWD': '/builds/slave/test', 01:38:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:08 INFO - 'SHELL': '/bin/bash', 01:38:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.59m5V9PePZ/Listeners', 01:38:08 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 01:38:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:08 INFO - 'USER': 'cltbld', 01:38:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:08 INFO - 'XPC_FLAGS': '0x0', 01:38:08 INFO - 'XPC_SERVICE_NAME': '0', 01:38:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:08 INFO - Downloading/unpacking jsonschema 01:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:38:10 INFO - Downloading/unpacking functools32 (from jsonschema) 01:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:11 INFO - Downloading functools32-3.2.3-2.tar.gz 01:38:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:38:11 INFO - warning: no files found matching '*.txt' 01:38:11 INFO - no previously-included directories found matching 'build' 01:38:11 INFO - no previously-included directories found matching 'dist' 01:38:11 INFO - no previously-included directories found matching '.git*' 01:38:11 INFO - Installing collected packages: jsonschema, functools32 01:38:11 INFO - Running setup.py install for functools32 01:38:11 INFO - warning: no files found matching '*.txt' 01:38:11 INFO - no previously-included directories found matching 'build' 01:38:11 INFO - no previously-included directories found matching 'dist' 01:38:11 INFO - no previously-included directories found matching '.git*' 01:38:11 INFO - Successfully installed jsonschema functools32 01:38:11 INFO - Cleaning up... 01:38:11 INFO - Return code: 0 01:38:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 01:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:38:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:38:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:38:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e0ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104e1e420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffba2d95530>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104cade00>, '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 0x104b16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ca8b20>, '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.z0RRhP6lt1/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.59m5V9PePZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 01:38:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 01:38:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 01:38:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z0RRhP6lt1/Render', 01:38:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:11 INFO - 'HOME': '/Users/cltbld', 01:38:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:11 INFO - 'LOGNAME': 'cltbld', 01:38:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:11 INFO - 'MOZ_NO_REMOTE': '1', 01:38:11 INFO - 'NO_EM_RESTART': '1', 01:38:11 INFO - 'PAGER': '/bin/cat', 01:38:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:11 INFO - 'PWD': '/builds/slave/test', 01:38:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:11 INFO - 'SHELL': '/bin/bash', 01:38:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.59m5V9PePZ/Listeners', 01:38:11 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 01:38:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:11 INFO - 'USER': 'cltbld', 01:38:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:11 INFO - 'XPC_FLAGS': '0x0', 01:38:11 INFO - 'XPC_SERVICE_NAME': '0', 01:38:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:38:11 INFO - Downloading/unpacking flake8 01:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:14 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 01:38:14 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 01:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 01:38:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 01:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:15 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 01:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:38:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:38:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:38:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 01:38:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:38:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:38:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:38:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:38:15 INFO - no previously-included directories found matching 'docs/_build' 01:38:15 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 01:38:15 INFO - Running setup.py install for pep8 01:38:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 01:38:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 01:38:15 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 01:38:15 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 01:38:15 INFO - no previously-included directories found matching 'docs/_build' 01:38:15 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 01:38:15 INFO - Successfully installed flake8 mccabe pyflakes pep8 01:38:15 INFO - Cleaning up... 01:38:15 INFO - Return code: 0 01:38:15 INFO - Running post-action listener: _resource_record_post_action 01:38:15 INFO - Running post-action listener: _start_resource_monitoring 01:38:15 INFO - Starting resource monitoring. 01:38:15 INFO - ##### 01:38:15 INFO - ##### Running install step. 01:38:15 INFO - ##### 01:38:15 INFO - Running pre-action listener: _resource_record_pre_action 01:38:15 INFO - Running main action method: install 01:38:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:38:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:38:16 INFO - Reading from file tmpfile_stdout 01:38:16 INFO - Detecting whether we're running mozinstall >=1.0... 01:38:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:38:16 INFO - Reading from file tmpfile_stdout 01:38:16 INFO - Output received: 01:38:16 INFO - Usage: mozinstall [options] installer 01:38:16 INFO - Options: 01:38:16 INFO - -h, --help show this help message and exit 01:38:16 INFO - -d DEST, --destination=DEST 01:38:16 INFO - Directory to install application into. [default: 01:38:16 INFO - "/builds/slave/test"] 01:38:16 INFO - --app=APP Application being installed. [default: firefox] 01:38:16 INFO - mkdir: /builds/slave/test/build/application 01:38:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 01:38:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 01:38:38 INFO - Reading from file tmpfile_stdout 01:38:38 INFO - Output received: 01:38:38 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 01:38:38 INFO - Running post-action listener: _resource_record_post_action 01:38:38 INFO - ##### 01:38:38 INFO - ##### Running run-tests step. 01:38:38 INFO - ##### 01:38:38 INFO - Running pre-action listener: _resource_record_pre_action 01:38:38 INFO - Running main action method: run_tests 01:38:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:38:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:38:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:38:38 INFO - 2016-06-07 01:38:38.978 screenresolution[1643:7364] starting screenresolution argv=screenresolution get 01:38:38 INFO - 2016-06-07 01:38:38.981 screenresolution[1643:7364] Display 0: 1600x1200x32@60 01:38:38 INFO - 2016-06-07 01:38:38.987 screenresolution[1644:7366] starting screenresolution argv=screenresolution list 01:38:38 INFO - Available Modes on Display 0 01:38:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:38:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:38:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:38:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:38:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:38:39 INFO - Intel Iris: 01:38:39 INFO - Chipset Model: Intel Iris 01:38:39 INFO - Type: GPU 01:38:39 INFO - Bus: Built-In 01:38:39 INFO - VRAM (Dynamic, Max): 1536 MB 01:38:39 INFO - Vendor: Intel (0x8086) 01:38:39 INFO - Device ID: 0x0a2e 01:38:39 INFO - Revision ID: 0x0009 01:38:39 INFO - Displays: 01:38:39 INFO - Display: 01:38:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:38:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:38:39 INFO - Display Serial Number: 1600x1200 60 01:38:39 INFO - Main Display: Yes 01:38:39 INFO - Mirror: Off 01:38:39 INFO - Online: Yes 01:38:39 INFO - Rotation: Supported 01:38:39 INFO - Return code: 0 01:38:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:38:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:38:39 INFO - Python 2.7.3 01:38:39 INFO - Return code: 0 01:38:39 INFO - grabbing minidump binary from tooltool 01:38:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:38:39 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 0x104cade00>, '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 0x104b16db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104ca8b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:38:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:38:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 01:38:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:38:39 INFO - Return code: 0 01:38:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 01:38:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:38:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:38:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 01:38:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:38:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 01:38:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 01:38:40 INFO - Return code: 0 01:38:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0276', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:38:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0276 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:38:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z0RRhP6lt1/Render', 01:38:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 01:38:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 01:38:40 INFO - 'HOME': '/Users/cltbld', 01:38:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 01:38:40 INFO - 'LOGNAME': 'cltbld', 01:38:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:38:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 01:38:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:38:40 INFO - 'MOZ_NO_REMOTE': '1', 01:38:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:38:40 INFO - 'NO_EM_RESTART': '1', 01:38:40 INFO - 'PAGER': '/bin/cat', 01:38:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 01:38:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:38:40 INFO - 'PWD': '/builds/slave/test', 01:38:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:38:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 01:38:40 INFO - 'SHELL': '/bin/bash', 01:38:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.59m5V9PePZ/Listeners', 01:38:40 INFO - 'TMPDIR': '/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/', 01:38:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 01:38:40 INFO - 'USER': 'cltbld', 01:38:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 01:38:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 01:38:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:38:40 INFO - 'XPC_FLAGS': '0x0', 01:38:40 INFO - 'XPC_SERVICE_NAME': '0', 01:38:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 01:38:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0276', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:38:40 INFO - mozversion application_buildid: 20160606120332 01:38:40 INFO - mozversion application_changeset: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 01:38:40 INFO - mozversion application_display_name: Firefox 01:38:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:38:40 INFO - mozversion application_name: Firefox 01:38:40 INFO - mozversion application_remotingname: firefox 01:38:40 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 01:38:40 INFO - mozversion application_vendor: Mozilla 01:38:40 INFO - mozversion application_version: 48.0 01:38:40 INFO - mozversion platform_buildid: 20160606120332 01:38:40 INFO - mozversion platform_changeset: 46d72a56c57dafb4dc1061d4741a3e1181ac3d68 01:38:40 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 01:38:40 INFO - mozversion platform_version: 48.0 01:38:40 INFO - using testdate: 1465288720 01:38:40 INFO - actual date: 1465288720 01:38:40 INFO - starting webserver on 'localhost:49273' 01:38:40 INFO - SUITE-START | Running 2 tests 01:38:40 INFO - TEST-START | dromaeo_css 01:38:40 INFO - operating with platform_type : mac_ 01:38:40 INFO - Initialising browser for dromaeo_css test... 01:38:40 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/tmpIw198M/profile http://localhost:49273/getInfo.html) 01:38:43 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 01:38:43 INFO - PROCESS | 1662 | colorDepth:24 01:38:43 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 01:38:43 INFO - PROCESS | 1662 | __metrics 01:38:43 ERROR - PROCESS | 1662 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 01:38:44 INFO - TEST-INFO | 1662: exit 0 01:38:44 INFO - Browser initialized. 01:38:44 INFO - Running cycle 1/1 for dromaeo_css test... 01:38:44 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/tmpIw198M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:38:56 INFO - PROCESS | 1666 | RSS: Main: 170749952 01:38:56 INFO - PROCESS | 1666 | 01:39:45 INFO - PROCESS | 1666 | 1465288785875 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:41:56 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49273/tests/dromaeo/cssquery-ext.html) 01:41:57 INFO - PROCESS | 1666 | RSS: Main: 186621952 01:41:57 INFO - PROCESS | 1666 | 01:44:59 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-ext.html (next: http://localhost:49273/tests/dromaeo/cssquery-jquery.html) 01:45:00 INFO - PROCESS | 1666 | RSS: Main: 197181440 01:45:00 INFO - PROCESS | 1666 | 01:48:01 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49273/tests/dromaeo/cssquery-mootools.html) 01:48:02 INFO - PROCESS | 1666 | RSS: Main: 199286784 01:48:02 INFO - PROCESS | 1666 | 01:51:04 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49273/tests/dromaeo/cssquery-prototype.html) 01:51:04 INFO - PROCESS | 1666 | RSS: Main: 203173888 01:51:04 INFO - PROCESS | 1666 | 01:54:07 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49273/tests/dromaeo/cssquery-yui.html) 01:54:07 INFO - PROCESS | 1666 | RSS: Main: 202088448 01:54:07 INFO - PROCESS | 1666 | 01:57:10 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49273/tests/dromaeo/cssquery-yui.html (next: http://localhost:49273/tests/dromaeo/cssquery-dojo.html) 01:57:10 INFO - PROCESS | 1666 | RSS: Main: 207822848 01:57:10 INFO - PROCESS | 1666 | 01:57:10 INFO - PROCESS | 1666 | __start_tp_report 01:57:10 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 01:57:10 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 01:57:10 INFO - PROCESS | 1666 | |i|pagename|runs| 01:57:10 INFO - PROCESS | 1666 | |0;dojo.html;2854.7430731234185;3124.453220686379;3322.501624756286;3649.872254471094;3656.0859785053726;4736.407949006374;5870.442307980746;5900.3214630317525;5912.113183022549;5933.643981361121;5812.447817457345;5861.120831875211;5891.469767720904;5906.0845568936775;5922.644641321513;5296.655717378368;5336.839894803162;5342.1452567589195;5379.919301210485;5391.083515802304;5302.44324345942;5313.388960269561;5378.784848606051;5382.8923421531745;5437.429069947658;5330.600204984642;5370.248165256867;5378.408375078758;5389.056915039852;5390.757415916293;5366.774541531843;5370.91943620846;5390.676559406428;5392.460753924615;5468.179773034037;5180.740962951837;5187.247849061865;5294.708791016493;5299.54953828925;5312.734363281859;4577.473590537064;5731.684757338345;5759.769609215627;5762.308522977228;5763.6253643513455;6202.875942481171;6211.068339749028;6277.089821975834;6297.905531417033;6314.273858506284;6181.134641150243;6188.628682279033;6209.782657607007;6236.345183755686;6314.179156709644;6000.279966404059;6023.759049638053;6040.4124040442275;6041.1240370146525;6043.758249670052;6240.469560087444;6327;6338.809835704937;6360.745570177233;6363.777267795697;6207.34822843604;6241.469475094577;6279.560430769802;6289.937100629027;6296;6286.308506064329;6287.811365659038;6292.528060395489;6298.779542715983;6298.874022519524;5204.9739751301;6125.723854043132;6175.042868355412;6259.217597800275;6289.528285378615;6231.813045608639;6250.1874756281395;6260.280067792262;6262.029385445263;6265.71804268809;5010.649254552146;5018.447970723218;5039.924401133986;5059.064073146406;5067.442581316052;4403;4415.911681766411;4510.977445112753;4539.954600453953;4586.633069354443;5795.710214489259;5855.268091488564;5894.410558944071;5958.523318134538;5999.100134979788;6218.22272215973;6219.533534984895;6294.370562943669;6300.9684951574945;6309.3690630936535;5831.387704290988;5923.466887980103;6018.879622407528;6028.849278767978;6070.817875463743;5487.396386397493;5511.421300763443;5516.3380394352935;5532.6680399176175;5561.721913904288;6408.871822563523;6427.903581446282;6428.871422571616;6455.934770762866;6469.741210351627;6179.938200618116;6198.597091189058;6233.158523599437;6264.718087685974;6296.905546416716;6380.074889140956;6381.744730210925;6409.519286053472;6465.256495502889;6503.349665033459;6174.876502470015;6222.408871157233;6273.686315684289;6278.686065696788;6293.118963345044;5317.707526085947;6203.906941395973;6288.465480434032;6307.085472606538;6315.242170939517;6212.254529456313;6217.09852071438;6240.219972503437;6256.843578910563;6331.5251356147555;5810.912836307543;5868.7088840455035;6127.84680382994;6188.938110618837;6267.185265915402;6020.6688632123905;6063.969125248806;6122.438808008548;6137.140800288053;6168.074788781719;6175.135481032748;6243.594166379171;6271.96864015677;6275.058741188858;6284.402981716729;6027.849303767441;6100.206973093469;6119.959572021022;6153.753849845956;6154.1999540059505 01:57:10 INFO - PROCESS | 1666 | |1;ext.html;532.5606374740839;562.016471175443;564.8206788168789;590.9763609455622;614.6342925959053;30992.225194370152;35358.646413535855;37844.81077594615;38841.80579097104;39614.40578391319;34447.31105377891;36404.907852764394;41145.971350716245;42379.364309535384;42435.575644243545;9612.423254604728;9779.315447918649;9809.705708828747;9824.459654718987;9833.803323933516;9646.228301735879;9758.902410975907;9817.852732209023;9859.161971232454;9941.850872236922;9838.901610983907;9892.30753847231;9921.702348929544;9952.154066904322;9970.850437243447;8298.585070746469;9809.362391444605;9888.555015024342;9917.950410247902;9936.801263974752;9799.608015679365;9937.354071985297;9958.601655933753;9980.850287245625;10005.499725013793;33926.66073339284;40811;40854.795726021475;41200.175996479906;41964.790176048926;3152.274976755336;3341.2649217172184;3347.397468455677;3355.245069859262;3502.6497350265026;25920.8703956479;26567.202983910513;26652;27679.169624911287;28137.718622813714;2588.715241323453;2647.6822781266374;2653.3234025323613;2716.2258756254373;2780.0964686476977;342558;343728;345618;347177;349572;35545.822270888995;35733.1066723334;35868.46197307042;38021.42967855484;38879.22241555153;35992;36020.459693104625;36550.634493654725;37073.629263707015;37194.81402593024;16012.199390030684;16022.599435014217;16031;16467.34130634785;16719.49841504757;13738.10702304347;13910.791338129937;14144.080634758708;14160.221187834562;14323.427062917366;8344.582770861432;8406.873896891551;8480.109588493242;8573.18554737299;8598.183172598594;3155.7790954633415;3616.367135751286;3637.8726744563814;3639.909002274964;3659.908502287464;893.0221407558713;1048.9632862849764;1087.5649740104022;1102.2119184782919;1110.3448965110624;29798.808047678285;30070.699293007227;30280.394392112034;30713;30896.69103308983;1096.2381145104237;1135.7387800805861;1179.728662407634;1237.975240495203;1240.503798480615;13917.23455209953;15182.089074655556;15567;15614.45349412765;16014.959027663164;330530;331325;333799;334187;335030;63871;64789.67605161944;65077.349226507125;65322;65374.673126634065;1553.5417051969696;1572.072477238412;1578.8973716708376;1581.5808810665183;1592.8327525609875;28116;30238.54642180413;30593.828015606894;30645.080647579718;30702.771889124186;54993;55621.1656825156;55735.72132139313;55919;56006.15990760223;606081;608546;609543;610752;610841;26562.335941601614;27568.724312756614;27973.580396293666;28248.29379265535;44690.3296450547;45025.09949801051;45571;45644.54355456536;46353.76823115998;46409.535904641874;38417.61582384141;38751.6124838748;39134.804325978184;40553.391699125124;41070.79464602658;40203.59796401999;40516.59483405246;40755.7962210187;41010.589894100674;41851;34303.14242143966;37260;40381;41026.76919692414;41083.58916410798;31505;33394.83302583471;33710.48302826428;33759.49360759542;34379;25779.226623201335;25824;25846.612300815126;25920.96316147333;26132.8693356532 01:57:10 INFO - PROCESS | 1666 | |2;jquery.html;351.8469465782385;408.92230476209517;411.734431291817;423.94064830923674;423.9936400953985;17025.744613830804;20136.798632013677;21281.36155915321;21647;21892.233771817988;21636;21868.562628747415;21894.795786231753;22469.876506174707;22552;5297.364316282042;5611.7474713637985;5612.550995920337;5612.635178713391;5633.60564760467;5412.810551630694;5498.45015498449;5605.411431799643;5613.550915926737;5759.625624334426;5597.188407680884;5614.410486898878;5706.1726049722765;5726.455986681259;5737.885242295151;4461.576150265736;5608.663480191201;5617.634853734494;5691.174779656947;5743.712814359265;4818.204996175627;5461.18082287656;5523.061079616475;5556.972215138899;5592.189132575753;13878.514252001132;14170.787438188436;14394.352254148589;14515.346809393497;25030.499390012097;2235.3070548129967;2410.1805386168785;2618.1621880998086;2638.234911875573;2712.362594790223;10183.949080254626;10482;10643.893561064446;10716.571337146504;15178.544643660598;1838.090145378033;1866.7759868815829;1900.9714854277197;1937.602791427754;1960.470672918304;118701;121740;122103.16845247328;123206;123834.9999999991;12037;12152.756944861054;12394.62816115518;12415.503379864886;12484.75030499385;14271.643208919653;15500.92249538745;16079.115648639437;16082.517524474284;16114.355425783071;8709.259712924346;8841.823163536821;9602.519874006412;9611.183049440737;9671.274654400808;7666.4633475656165;9672.371295865747;9682.951585242028;9786.902130978599;9800.803983920281;4039.434479172918;4797.688150270221;4898.338724272177;4953.306537084811;4993.950060499348;2018.636645403812;2114.6510825713895;2131.477787941964;2143.389134096806;2161.729783777028;893.647009431271;942.0297093993198;949.8717673114041;1021.4228960637216;1069.6256310291492;20009.399718008484;20655.380338589865;20657;20897.05963231658;20918.47703807417;989.1888651306004;1011.4133802394593;1023.2121266624657;1040.458961340099;1071.8767341755643;11086;11163.888361116286;11174.21780475375;11217;11254.94372528132;583498;647690;648575;663913;670944;111000.22499437579;118471.40764296123;125562;125745;126236.73763262434;870.9477431354139;998.4708104704519;1016.4765145949842;1020.4693559349097;1057.5082586597268;17976.983046652644;18447.077646117374;18587.44237672872;18600.906995464935;18766.906165469085;41776.58223417727;51125;51957;53122.73438632782;58819.41180588139;77689.2231077682;80587.3882522358;81125;81451.18548814436;82599;8156.9184308156155;8457.238848503664;8492.74521764348;8597.011343695305;8630.611622476878;9802.460864652512;13028;13157.53948611794;13295.335233238493;13607.455701772215;11344.20590558653;11348.489317980546;11380.772384552429;11419.714507137056;11891.405429728306;11276.436178191221;11325.15061370384;11346.546138154712;11363.659090226976;11576.536938522364;11600.94199528997;11801.232919860182;11903.166778325434;11918.404079795802;11969.222000569935;6924.788162071718;7858.882116768139;8402.831943361221;8509.872351914602;8872.512011839412;10931.672049838518;11594.884051159717;11610.94194529022;11685;11871.703207419883 01:57:10 INFO - PROCESS | 1666 | |3;mootools.html;1555.1913005237277;1566.670999090191;1838.1085173690758;1983.8016198380164;2060.639388107081;8298.668053277861;8707.782305442368;9158.81682366353;9215.493147876865;9394.436333819976;9018;9041.864372034408;9063.818723625523;9186.127317904788;9214.815703685923;2535.2901187667435;2535.822492425531;2576.8453892766493;2586.5990771430365;2588.2752829207852;2570.884310206045;2574.2792018234923;2613.621024951381;2630.552806022981;2635.2094371688513;2562.052040744927;2566.2686134451683;2571.0615625296728;2577.742225777426;2610.4648547047905;2489.2034548944343;2493.7880280176205;2518.4333524956924;2573.575360065587;2587.430765231646;2604.73952604738;2609.929928729231;2619.6856377234662;2625.7111717711036;2643.6563246777987;9088.636454541811;9135.40619859707;9211.447313161232;9262.166405023512;9263.21262692672;5618.185363122365;5661.886762264731;5688.288963879515;5807.390224026459;5816.796412125597;3607.098225443639;3740.7007439405056;3742.1018955450495;3744.5319335083113;3780.621937806225;1040.8907064758166;1047.5809676129609;1074.6775967209885;1074.6990842564094;1076.6447072466067;11983.10126740498;11997.580084696994;12130.757384852253;12138.635840924786;12173.634790956374;4916.901661966741;4945.109880221523;5008.724520151427;5053.418856831438;5073.7716802743225;8952.507612081268;10469.37183768961;10511.369317840954;10524.210684198715;10583.788324233472;5532.3914369419335;5560.7219639017885;5656.91514627281;5672.177534257509;5703.230063941398;4605.470370907322;4971.527704868032;5083.212102124176;5084.847454576368;5151.021305951857;4285.3786201000685;4294.9785251073545;4302.892427689333;4383.60547550722;4387.5393083726385;1212.7392610588765;1386.81278027467;1418.3759145975737;1421.86492283235;1428.071753360324;816.1158050456277;938.3431597881511;962.1917589225085;1002.2733518199393;1014.1582486536157;6116.174316467309;6186.659733714599;6279.183706118267;6297.811065668037;6324.114623952651;409.4738261334171;476.46397802472217;480.3083559674128;1076.2896488317672;1110.4725255503572;3498.965010349915;4028.234635419261;4080.3267460868624;4104.4664193655235;4128.174365126986;10968.561257549769;11036;11282.492287847066;11393.544258229578;11508.136889733303;9424.246060315158;11005.119590432747;11042.834357484644;11321.773564528663;11375.31748095117;8501.19238672325;8608.913910860936;8713.302935765123;8831.64673413069;8836;5809.390014048633;5959.433853784057;6015.0375939851165;6027.879442411039;6091.385782767482;8682.739517814476;9281.67514137002;9531.237501000041;9617.855732163884;9617.855732164164;9479.573419196015;9720.465374404193;9764.80470390574;9803.970583088672;9819.85270220933;7111.7866464006165;7410.9258907412395;7587.544747315179;7718.652660630173;7787.649555769891;8262.917370826455;8302.54336011501;8321.6671333146;8339.749807505785;8355.080941096354;7322.450816188913;7425.628718563942;7512.173660897406;7543.0948286206;7563.659635316314;7449.925500744923;7464.738734144496;7514.661840217313;7587.62061896914;7607.619619018917;7176.102987126609;7218;7233.240509746401;7255.709771609077;7304.890426643711;4993.625478089085;5028.195488721787;5131.820386286462;5198.714070725995;5251.6586421883985;5111.309973153725;5125.538701516882;5147.510986456281;5202.869928251673;5284.524392804666 01:57:10 INFO - PROCESS | 1666 | |4;prototype.html;288.5657086085441;335.01004531609095;336.71379327571566;342.3290350912211;345.97924124552543;7135.429165666747;7137.9286207137975;7140.071790667213;7143.499955003152;7160.248173941739;7024.051753013342;7030.683619237134;7049.788506344805;7079.716811327554;7103.573785572869;4952.653314268012;5059.797608095671;5167.147420675584;5179.974100129494;5198.402183748861;5118.820841270556;5157.922631160535;5217.869553261161;5224.399194092671;5240.213967904807;5198.8700282493055;5208.479152084799;5212.556932660709;5216.374035115791;5242.18746094356;5217.34783152106;5237.266782650432;5240.161574148156;5241.2400201970695;5252.422233554306;3755.511783468159;4359.498657654379;4445.222086134946;4448.955510444886;4450.666200035011;4473.597376236155;5557.305336832896;5811.767529298823;6568.8357791055605;6785.9660701696175;5917.704114794243;5947.345791962881;5964.552658550626;5974.820755377345;5997.8800423991715;6191.9690401547705;7535.2464753524755;7549.433792465587;7569.470137090406;7576.848463030708;4765.7140571565815;4775.5701986821;4785.95214047862;4794;4796;6378.4578310843635;7591.468597198198;7871.252231038099;7949.006374203224;7960.283574478325;4859.198232291703;4859.95140048602;4867.634927380461;4878.463369029404;4887.36464259644;4902.730349830722;4945.357103576512;4949.604031677457;4953.72754498506;4959.20652695567;5942;5949.732262048218;5953.672548009815;5972.850678733066;5978.402159784074;7516.135644400854;7521.398288136936;7538.057742782153;7552;7567.356774674105;1699.7960244770459;1726.326732574297;1730.550056985193;1731.5844197392535;1733.679269335177;1039.8856125826153;1082.7401423658266;1086.8099431122907;1088.5591335509132;1088.7060493666825;6315.273743519554;6603.735850565923;7056.6118863463;7153.60655163971;7156.463265255126;7626.161122276545;7758.107817600935;7800.726974555863;7850.607469626496;7878.566678832604;7226.6386680665755;7229.34935855765;7229.566226026455;7231.963840180765;7252.2385149559595;4195.517515485758;4217.451731274976;4233.364995250676;4235.8729238122905;4242.936355954663;6703.698333575001;8257.339412846957;8303.95848020756;8339.749807505785;8370.790730231793;7900.960495197487;8224.465409748347;8272.627731752085;8285.58572071394;8302.418830681914;8285.95857020711;8299.253067223979;8318.41771076031;8330.875036874451;8344.332453403713;6846.246912839683;7609.727817038505;7993.240642138988;7993.240642138988;8004.319632831274;5616.241807355955;6766.93233067663;7024.051753013277;7188;7899.605019749105;6769.661516924036;8220.917790822015;8349.749507514784;8355.370702712913;8358.331333493428;4903.950960490492;4927.655064145475;4936.2102063669645;4937.23472861707;4942.678725882806;7190.712371505081;7952.681892724227;7962.442629015914;7985.321247693779;7989.041315042232;6211.875762484816;7458.366038886756;7676.577788221702;7725;7736.497127686683;7615.124260710089;7695.307422332017;7701;7713.498622589738;7741.806454838674;7392.55644661322;7441.181470038183;7471.439642026979;7473.88789168152;7510.624468776648;7366.742164024234;7627.618619068913;7686.961565192139;7706.922930770621;7709.113451952873;6340.778072767431;7530.736424225126;7550.791873300245;7555.471117021756;7560.735374261874 01:57:10 INFO - PROCESS | 1666 | |5;yui.html;713.254648891908;770.5761830992952;771.1941021632393;786.988195177072;789.329070290253;15319.540413787576;15330.46343377982;15655.373785048612;15666.373345066198;15702.214889255534;14242.501512447066;14249.78625320621;14262.215578143197;14280.357383917722;14289.499867504639;768.1435199752264;922.23454532738;931.9440833549992;943.7451887990272;944.7165850244934;932.9673461428852;939.4504215034179;948.1892981500821;948.3740731117464;957.34421920984;949.8480243161096;966.4249771386014;985.2462865907586;990.9990909181743;999.4952548962764;947.7630592351912;956.2350119904049;972.0182615558266;977.8777652793436;992.4293531219541;716.2908720366852;722.3931897206319;723.1828034321184;723.971041158353;745.7725393754903;14904.031237969497;14941.028833125813;14998.850011499855;15056.171910544916;15250.23748812555;13068.823805857422;13126.540571079966;13185.538506152334;13222.338883055809;13348.132371395925;10044.849327260097;10319.79360412795;10351;10364.948175259151;10375.273730838844;3368.427367347557;3610.295992281506;3621.963780362189;3734.850605975758;3878.1274213302063;67254.65490690208;85021.72467412932;85098.57450712769;85103.5744821272;85240;9583.377080489747;9628.66299679508;9693.563789629483;9850.802983940424;9862.408255504693;21871.12515499362;21924.23265185711;21999.780002200092;22029;22534;6654.800355989328;7547.698092076255;7575.204603516661;7675.270849269311;7707.190744971809;4103.4050062740735;4177.603127702863;4185.267578173807;4195.307774217281;4292.849750258726;3737.5328083989502;3758.3047136279874;3786.6213378661914;3787.3750831113107;3788.9431658525145;586.8298193523916;665.4809248785955;684.6234570985938;688.9517733758589;703.5708217987024;569.7066011004337;598.9548238324152;606.9241344831896;614.1432701381548;625.337142628815;7129.643517824088;8004.159563245776;8171.83656326882;8378.371622128365;8562.186592273723;427.5403940763691;575.4245754245754;618.8978818494988;639.7984634840011;658.558765627031;3638.890833275006;3689.9631003690156;3834.3673293906195;4016.9555915461606;4036.777977211223;72734.63632681803;91380;92224.53887730652;92555;100359;87173;87660;88041.23917521742;88288.55855720809;88905;73180.26819731841;74854;74872.5025499487;75038.62480687561;75554.24445755473;7890.092639346319;8088.514689118671;8129.593520323841;8191.549464779494;8237.284920607122;40976.79511602542;41899.79050104852;50771;52471.47528524818;53084.73457632687;69667.3033269681;74474.62762686369;74894.62552687201;75191.24808751843;76473.23526764884;9879.703608891745;9949;9956.303058785816;10069.69790906274;10456.843147352643;10870.324363694528;11106.666799996014;11132.05377542918;11135.053520450529;11365.886341136484;10212.744681383025;10547.103496202908;10591.94704026475;10783.676489705322;11145.665630031112;10249.9487502562;10288.559601655925;10498.580056797642;10750;11046.226764126433;10399.792004160026;10501.684949451528;10661.307015043998;10677.466126693478;11120.88879111231;9001.504917229615;9125.908740912506;9198.67804626835;9448.244140468883;9524.904750952403;9236.353455258068;9244.583993720164;9263.212626926786;9340.626374944926;9379.718608441757 01:57:10 INFO - PROCESS | 1666 | __end_tp_report 01:57:10 INFO - PROCESS | 1666 | __start_cc_report 01:57:10 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,395 01:57:10 INFO - PROCESS | 1666 | __end_cc_report 01:57:10 INFO - PROCESS | 1666 | __startTimestamp1465289830369__endTimestamp 01:57:10 INFO - PROCESS | 1666 | 01:57:10 INFO - PROCESS | 1666 | ------- Summary: start ------- 01:57:10 INFO - PROCESS | 1666 | Number of tests: 6 01:57:10 INFO - PROCESS | 1666 | 01:57:10 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5823.94 Median:6100.21 stddev:657.78 (10.8%) stddev-sans-first:617.19 01:57:10 INFO - PROCESS | 1666 | Values: 2854.7 3124.5 3322.5 3649.9 3656.1 4736.4 5870.4 5900.3 5912.1 5933.6 5812.4 5861.1 5891.5 5906.1 5922.6 5296.7 5336.8 5342.1 5379.9 5391.1 5302.4 5313.4 5378.8 5382.9 5437.4 5330.6 5370.2 5378.4 5389.1 5390.8 5366.8 5370.9 5390.7 5392.5 5468.2 5180.7 5187.2 5294.7 5299.5 5312.7 4577.5 5731.7 5759.8 5762.3 5763.6 6202.9 6211.1 6277.1 6297.9 6314.3 6181.1 6188.6 6209.8 6236.3 6314.2 6000.3 6023.8 6040.4 6041.1 6043.8 6240.5 6327.0 6338.8 6360.7 6363.8 6207.3 6241.5 6279.6 6289.9 6296.0 6286.3 6287.8 6292.5 6298.8 6298.9 5205.0 6125.7 6175.0 6259.2 6289.5 6231.8 6250.2 6260.3 6262.0 6265.7 5010.6 5018.4 5039.9 5059.1 5067.4 4403.0 4415.9 4511.0 4540.0 4586.6 5795.7 5855.3 5894.4 5958.5 5999.1 6218.2 6219.5 6294.4 6301.0 6309.4 5831.4 5923.5 6018.9 6028.8 6070.8 5487.4 5511.4 5516.3 5532.7 5561.7 6408.9 6427.9 6428.9 6455.9 6469.7 6179.9 6198.6 6233.2 6264.7 6296.9 6380.1 6381.7 6409.5 6465.3 6503.3 6174.9 6222.4 6273.7 6278.7 6293.1 5317.7 6203.9 6288.5 6307.1 6315.2 6212.3 6217.1 6240.2 6256.8 6331.5 5810.9 5868.7 6127.8 6188.9 6267.2 6020.7 6064.0 6122.4 6137.1 6168.1 6175.1 6243.6 6272.0 6275.1 6284.4 6027.8 6100.2 6120.0 6153.8 6154.2 01:57:10 INFO - PROCESS | 1666 | 01:57:10 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:57142.35 Median:3627.12 stddev:119579.00 (3296.8%) stddev-sans-first:119838.91 01:57:10 INFO - PROCESS | 1666 | Values: 532.6 562.0 564.8 591.0 614.6 30992.2 35358.6 37844.8 38841.8 39614.4 34447.3 36404.9 41146.0 42379.4 42435.6 9612.4 9779.3 9809.7 9824.5 9833.8 9646.2 9758.9 9817.9 9859.2 9941.9 9838.9 9892.3 9921.7 9952.2 9970.9 8298.6 9809.4 9888.6 9918.0 9936.8 9799.6 9937.4 9958.6 9980.9 10005.5 33926.7 40811.0 40854.8 41200.2 41964.8 3152.3 3341.3 3347.4 3355.2 3502.6 25920.9 26567.2 26652.0 27679.2 28137.7 2588.7 2647.7 2653.3 2716.2 2780.1 342558.0 343728.0 345618.0 347177.0 349572.0 35545.8 35733.1 35868.5 38021.4 38879.2 35992.0 36020.5 36550.6 37073.6 37194.8 16012.2 16022.6 16031.0 16467.3 16719.5 13738.1 13910.8 14144.1 14160.2 14323.4 8344.6 8406.9 8480.1 8573.2 8598.2 3155.8 3616.4 3637.9 3639.9 3659.9 893.0 1049.0 1087.6 1102.2 1110.3 29798.8 30070.7 30280.4 30713.0 30896.7 1096.2 1135.7 1179.7 1238.0 1240.5 13917.2 15182.1 15567.0 15614.5 16015.0 330530.0 331325.0 333799.0 334187.0 335030.0 63871.0 64789.7 65077.3 65322.0 65374.7 1553.5 1572.1 1578.9 1581.6 1592.8 28116.0 30238.5 30593.8 30645.1 30702.8 54993.0 55621.2 55735.7 55919.0 56006.2 606081.0 608546.0 609543.0 610752.0 610841.0 26562.3 27568.7 27973.6 28248.3 44690.3 45025.1 45571.0 45644.5 46353.8 46409.5 38417.6 38751.6 39134.8 40553.4 41070.8 40203.6 40516.6 40755.8 41010.6 41851.0 34303.1 37260.0 40381.0 41026.8 41083.6 31505.0 33394.8 33710.5 33759.5 34379.0 25779.2 25824.0 25846.6 25921.0 26132.9 01:57:10 INFO - PROCESS | 1666 | 01:57:10 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:36197.22 Median:21641.50 stddev:106988.24 (494.4%) stddev-sans-first:107254.52 01:57:10 INFO - PROCESS | 1666 | Values: 351.8 408.9 411.7 423.9 424.0 17025.7 20136.8 21281.4 21647.0 21892.2 21636.0 21868.6 21894.8 22469.9 22552.0 5297.4 5611.7 5612.6 5612.6 5633.6 5412.8 5498.5 5605.4 5613.6 5759.6 5597.2 5614.4 5706.2 5726.5 5737.9 4461.6 5608.7 5617.6 5691.2 5743.7 4818.2 5461.2 5523.1 5557.0 5592.2 13878.5 14170.8 14394.4 14515.3 25030.5 2235.3 2410.2 2618.2 2638.2 2712.4 10183.9 10482.0 10643.9 10716.6 15178.5 1838.1 1866.8 1901.0 1937.6 1960.5 118701.0 121740.0 122103.2 123206.0 123835.0 12037.0 12152.8 12394.6 12415.5 12484.8 14271.6 15500.9 16079.1 16082.5 16114.4 8709.3 8841.8 9602.5 9611.2 9671.3 7666.5 9672.4 9683.0 9786.9 9800.8 4039.4 4797.7 4898.3 4953.3 4994.0 2018.6 2114.7 2131.5 2143.4 2161.7 893.6 942.0 949.9 1021.4 1069.6 20009.4 20655.4 20657.0 20897.1 20918.5 989.2 1011.4 1023.2 1040.5 1071.9 11086.0 11163.9 11174.2 11217.0 11254.9 583498.0 647690.0 648575.0 663913.0 670944.0 111000.2 118471.4 125562.0 125745.0 126236.7 870.9 998.5 1016.5 1020.5 1057.5 17977.0 18447.1 18587.4 18600.9 18766.9 41776.6 51125.0 51957.0 53122.7 58819.4 77689.2 80587.4 81125.0 81451.2 82599.0 8156.9 8457.2 8492.7 8597.0 8630.6 9802.5 13028.0 13157.5 13295.3 13607.5 11344.2 11348.5 11380.8 11419.7 11891.4 11276.4 11325.2 11346.5 11363.7 11576.5 11600.9 11801.2 11903.2 11918.4 11969.2 6924.8 7858.9 8402.8 8509.9 8872.5 10931.7 11594.9 11610.9 11685.0 11871.7 01:57:10 INFO - PROCESS | 1666 | 01:57:10 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:5891.95 Median:5098.08 stddev:3226.29 (63.3%) stddev-sans-first:3218.88 01:57:10 INFO - PROCESS | 1666 | Values: 1555.2 1566.7 1838.1 1983.8 2060.6 8298.7 8707.8 9158.8 9215.5 9394.4 9018.0 9041.9 9063.8 9186.1 9214.8 2535.3 2535.8 2576.8 2586.6 2588.3 2570.9 2574.3 2613.6 2630.6 2635.2 2562.1 2566.3 2571.1 2577.7 2610.5 2489.2 2493.8 2518.4 2573.6 2587.4 2604.7 2609.9 2619.7 2625.7 2643.7 9088.6 9135.4 9211.4 9262.2 9263.2 5618.2 5661.9 5688.3 5807.4 5816.8 3607.1 3740.7 3742.1 3744.5 3780.6 1040.9 1047.6 1074.7 1074.7 1076.6 11983.1 11997.6 12130.8 12138.6 12173.6 4916.9 4945.1 5008.7 5053.4 5073.8 8952.5 10469.4 10511.4 10524.2 10583.8 5532.4 5560.7 5656.9 5672.2 5703.2 4605.5 4971.5 5083.2 5084.8 5151.0 4285.4 4295.0 4302.9 4383.6 4387.5 1212.7 1386.8 1418.4 1421.9 1428.1 816.1 938.3 962.2 1002.3 1014.2 6116.2 6186.7 6279.2 6297.8 6324.1 409.5 476.5 480.3 1076.3 1110.5 3499.0 4028.2 4080.3 4104.5 4128.2 10968.6 11036.0 11282.5 11393.5 11508.1 9424.2 11005.1 11042.8 11321.8 11375.3 8501.2 8608.9 8713.3 8831.6 8836.0 5809.4 5959.4 6015.0 6027.9 6091.4 8682.7 9281.7 9531.2 9617.9 9617.9 9479.6 9720.5 9764.8 9804.0 9819.9 7111.8 7410.9 7587.5 7718.7 7787.6 8262.9 8302.5 8321.7 8339.7 8355.1 7322.5 7425.6 7512.2 7543.1 7563.7 7449.9 7464.7 7514.7 7587.6 7607.6 7176.1 7218.0 7233.2 7255.7 7304.9 4993.6 5028.2 5131.8 5198.7 5251.7 5111.3 5125.5 5147.5 5202.9 5284.5 01:57:10 INFO - PROCESS | 1666 | 01:57:10 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:6125.06 Median:6935.15 stddev:1993.82 (28.7%) stddev-sans-first:1950.70 01:57:10 INFO - PROCESS | 1666 | Values: 288.6 335.0 336.7 342.3 346.0 7135.4 7137.9 7140.1 7143.5 7160.2 7024.1 7030.7 7049.8 7079.7 7103.6 4952.7 5059.8 5167.1 5180.0 5198.4 5118.8 5157.9 5217.9 5224.4 5240.2 5198.9 5208.5 5212.6 5216.4 5242.2 5217.3 5237.3 5240.2 5241.2 5252.4 3755.5 4359.5 4445.2 4449.0 4450.7 4473.6 5557.3 5811.8 6568.8 6786.0 5917.7 5947.3 5964.6 5974.8 5997.9 6192.0 7535.2 7549.4 7569.5 7576.8 4765.7 4775.6 4786.0 4794.0 4796.0 6378.5 7591.5 7871.3 7949.0 7960.3 4859.2 4860.0 4867.6 4878.5 4887.4 4902.7 4945.4 4949.6 4953.7 4959.2 5942.0 5949.7 5953.7 5972.9 5978.4 7516.1 7521.4 7538.1 7552.0 7567.4 1699.8 1726.3 1730.6 1731.6 1733.7 1039.9 1082.7 1086.8 1088.6 1088.7 6315.3 6603.7 7056.6 7153.6 7156.5 7626.2 7758.1 7800.7 7850.6 7878.6 7226.6 7229.3 7229.6 7232.0 7252.2 4195.5 4217.5 4233.4 4235.9 4242.9 6703.7 8257.3 8304.0 8339.7 8370.8 7901.0 8224.5 8272.6 8285.6 8302.4 8286.0 8299.3 8318.4 8330.9 8344.3 6846.2 7609.7 7993.2 7993.2 8004.3 5616.2 6766.9 7024.1 7188.0 7899.6 6769.7 8220.9 8349.7 8355.4 8358.3 4904.0 4927.7 4936.2 4937.2 4942.7 7190.7 7952.7 7962.4 7985.3 7989.0 6211.9 7458.4 7676.6 7725.0 7736.5 7615.1 7695.3 7701.0 7713.5 7741.8 7392.6 7441.2 7471.4 7473.9 7510.6 7366.7 7627.6 7687.0 7706.9 7709.1 6340.8 7530.7 7550.8 7555.5 7560.7 01:57:10 INFO - PROCESS | 1666 | 01:57:10 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:18722.38 Median:36954.73 stddev:26900.19 (72.8%) stddev-sans-first:26941.67 01:57:10 INFO - PROCESS | 1666 | Values: 713.3 770.6 771.2 787.0 789.3 15319.5 15330.5 15655.4 15666.4 15702.2 14242.5 14249.8 14262.2 14280.4 14289.5 768.1 922.2 931.9 943.7 944.7 933.0 939.5 948.2 948.4 957.3 949.8 966.4 985.2 991.0 999.5 947.8 956.2 972.0 977.9 992.4 716.3 722.4 723.2 724.0 745.8 14904.0 14941.0 14998.9 15056.2 15250.2 13068.8 13126.5 13185.5 13222.3 13348.1 10044.8 10319.8 10351.0 10364.9 10375.3 3368.4 3610.3 3622.0 3734.9 3878.1 67254.7 85021.7 85098.6 85103.6 85240.0 9583.4 9628.7 9693.6 9850.8 9862.4 21871.1 21924.2 21999.8 22029.0 22534.0 6654.8 7547.7 7575.2 7675.3 7707.2 4103.4 4177.6 4185.3 4195.3 4292.8 3737.5 3758.3 3786.6 3787.4 3788.9 586.8 665.5 684.6 689.0 703.6 569.7 599.0 606.9 614.1 625.3 7129.6 8004.2 8171.8 8378.4 8562.2 427.5 575.4 618.9 639.8 658.6 3638.9 3690.0 3834.4 4017.0 4036.8 72734.6 91380.0 92224.5 92555.0 100359.0 87173.0 87660.0 88041.2 88288.6 88905.0 73180.3 74854.0 74872.5 75038.6 75554.2 7890.1 8088.5 8129.6 8191.5 8237.3 40976.8 41899.8 50771.0 52471.5 53084.7 69667.3 74474.6 74894.6 75191.2 76473.2 9879.7 9949.0 9956.3 10069.7 10456.8 10870.3 11106.7 11132.1 11135.1 11365.9 10212.7 10547.1 10591.9 10783.7 11145.7 10249.9 10288.6 10498.6 10750.0 11046.2 10399.8 10501.7 10661.3 10677.5 11120.9 9001.5 9125.9 9198.7 9448.2 9524.9 9236.4 9244.6 9263.2 9340.6 9379.7 01:57:10 INFO - PROCESS | 1666 | -------- Summary: end -------- 01:57:10 INFO - PROCESS | 1666 | 01:57:10 INFO - TEST-INFO | 1666: exit 0 01:57:10 INFO - TEST-OK | dromaeo_css | took 1110271ms 01:57:10 INFO - TEST-START | kraken 01:57:10 INFO - operating with platform_type : mac_ 01:57:10 INFO - Initialising browser for kraken test... 01:57:10 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/tmpkMR4xX/profile http://localhost:49273/getInfo.html) 01:57:13 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 01:57:13 INFO - PROCESS | 1678 | colorDepth:24 01:57:13 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 01:57:13 INFO - PROCESS | 1678 | __metrics 01:57:13 ERROR - PROCESS | 1678 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2940: TypeError: this.tabs is undefined 01:57:14 INFO - TEST-INFO | 1678: exit 0 01:57:14 INFO - Browser initialized. 01:57:14 INFO - Running cycle 1/1 for kraken test... 01:57:14 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/tmpkMR4xX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:57:26 INFO - PROCESS | 1682 | RSS: Main: 171122688 01:57:26 INFO - PROCESS | 1682 | 01:57:28 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection) 01:57:29 INFO - PROCESS | 1682 | RSS: Main: 183529472 01:57:29 INFO - PROCESS | 1682 | 01:57:32 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-dft) 01:57:32 INFO - PROCESS | 1682 | RSS: Main: 192225280 01:57:32 INFO - PROCESS | 1682 | 01:57:35 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-fft) 01:57:36 INFO - PROCESS | 1682 | RSS: Main: 195641344 01:57:36 INFO - PROCESS | 1682 | 01:57:38 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator) 01:57:39 INFO - PROCESS | 1682 | RSS: Main: 195960832 01:57:39 INFO - PROCESS | 1682 | 01:57:41 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:57:41 INFO - PROCESS | 1682 | RSS: Main: 196259840 01:57:41 INFO - PROCESS | 1682 | 01:57:44 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom) 01:57:45 INFO - PROCESS | 1682 | RSS: Main: 197369856 01:57:45 INFO - PROCESS | 1682 | 01:57:48 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate) 01:57:49 INFO - PROCESS | 1682 | RSS: Main: 198316032 01:57:49 INFO - PROCESS | 1682 | 01:57:51 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial) 01:57:52 INFO - PROCESS | 1682 | RSS: Main: 198496256 01:57:52 INFO - PROCESS | 1682 | 01:57:54 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:57:54 INFO - PROCESS | 1682 | RSS: Main: 197623808 01:57:54 INFO - PROCESS | 1682 | 01:57:56 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:57:57 INFO - PROCESS | 1682 | RSS: Main: 197668864 01:57:57 INFO - PROCESS | 1682 | 01:57:59 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:58:00 INFO - PROCESS | 1682 | RSS: Main: 197795840 01:58:00 INFO - PROCESS | 1682 | 01:58:02 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:58:03 INFO - PROCESS | 1682 | RSS: Main: 197820416 01:58:03 INFO - PROCESS | 1682 | 01:58:06 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:58:07 INFO - PROCESS | 1682 | RSS: Main: 197799936 01:58:07 INFO - PROCESS | 1682 | 01:58:08 INFO - PROCESS | 1682 | Cycle 1(1): loaded http://localhost:49273/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49273/tests/kraken/driver.html?testName=ai-astar) 01:58:08 INFO - PROCESS | 1682 | RSS: Main: 199753728 01:58:08 INFO - PROCESS | 1682 | 01:58:08 INFO - PROCESS | 1682 | __start_tp_report 01:58:08 INFO - PROCESS | 1682 | _x_x_mozilla_page_load 01:58:08 INFO - PROCESS | 1682 | _x_x_mozilla_page_load_details 01:58:08 INFO - PROCESS | 1682 | |i|pagename|runs| 01:58:08 INFO - PROCESS | 1682 | |0;ai-astar;117;117;116;118;117;132;116;116;117;116 01:58:08 INFO - PROCESS | 1682 | |1;audio-beat-detection;155;120;140;158;134;178;153;151;156;115 01:58:08 INFO - PROCESS | 1682 | |2;audio-dft;193;196;198;196;197;194;194;195;201;196 01:58:08 INFO - PROCESS | 1682 | |3;audio-fft;67;71;93;138;75;80;83;73;124;55 01:58:08 INFO - PROCESS | 1682 | |4;audio-oscillator;68;92;114;72;63;103;103;89;114;159 01:58:08 INFO - PROCESS | 1682 | |5;imaging-gaussian-blur;91;107;115;131;135;88;104;109;92;102 01:58:08 INFO - PROCESS | 1682 | |6;imaging-darkroom;96;97;106;149;151;97;97;96;96;97 01:58:08 INFO - PROCESS | 1682 | |7;imaging-desaturate;94;94;94;93;130;94;134;146;131;93 01:58:08 INFO - PROCESS | 1682 | |8;json-parse-financial;57;64;75;98;94;67;63;79;63;67 01:58:08 INFO - PROCESS | 1682 | |9;json-stringify-tinderbox;63;67;71;73;74;70;65;63;64;64 01:58:08 INFO - PROCESS | 1682 | |10;stanford-crypto-aes;81;78;81;80;79;80;95;94;96;83 01:58:08 INFO - PROCESS | 1682 | |11;stanford-crypto-ccm;144;142;116;141;131;130;130;127;143;158 01:58:08 INFO - PROCESS | 1682 | |12;stanford-crypto-pbkdf2;160;161;173;162;160;213;219;155;221;205 01:58:08 INFO - PROCESS | 1682 | |13;stanford-crypto-sha256-iterative;68;66;68;68;67;65;66;68;69;67 01:58:08 INFO - PROCESS | 1682 | __end_tp_report 01:58:08 INFO - PROCESS | 1682 | __start_cc_report 01:58:08 INFO - PROCESS | 1682 | _x_x_mozilla_cycle_collect,1041 01:58:08 INFO - PROCESS | 1682 | __end_cc_report 01:58:08 INFO - PROCESS | 1682 | __startTimestamp1465289888960__endTimestamp 01:58:08 INFO - PROCESS | 1682 | 01:58:08 INFO - PROCESS | 1682 | ------- Summary: start ------- 01:58:08 INFO - PROCESS | 1682 | Number of tests: 14 01:58:08 INFO - PROCESS | 1682 | 01:58:08 INFO - PROCESS | 1682 | [#0] ai-astar Cycles:10 Average:118.20 Median:117.00 stddev:4.89 (4.2%) stddev-sans-first:5.17 01:58:08 INFO - PROCESS | 1682 | Values: 117.0 117.0 116.0 118.0 117.0 132.0 116.0 116.0 117.0 116.0 01:58:08 INFO - PROCESS | 1682 | 01:58:08 INFO - PROCESS | 1682 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:154.00 stddev:18.97 (12.3%) stddev-sans-first:19.84 01:58:08 INFO - PROCESS | 1682 | Values: 155.0 120.0 140.0 158.0 134.0 178.0 153.0 151.0 156.0 115.0 01:58:08 INFO - PROCESS | 1682 | 01:58:08 INFO - PROCESS | 1682 | [#2] audio-dft Cycles:10 Average:196.00 Median:196.00 stddev:2.31 (1.2%) stddev-sans-first:2.18 01:58:08 INFO - PROCESS | 1682 | Values: 193.0 196.0 198.0 196.0 197.0 194.0 194.0 195.0 201.0 196.0 01:58:08 INFO - PROCESS | 1682 | 01:58:08 INFO - PROCESS | 1682 | [#3] audio-fft Cycles:10 Average:85.90 Median:74.00 stddev:25.99 (35.1%) stddev-sans-first:26.65 01:58:08 INFO - PROCESS | 1682 | Values: 67.0 71.0 93.0 138.0 75.0 80.0 83.0 73.0 124.0 55.0 01:58:08 INFO - PROCESS | 1682 | 01:58:08 INFO - PROCESS | 1682 | [#4] audio-oscillator Cycles:10 Average:97.70 Median:65.50 stddev:28.28 (43.2%) stddev-sans-first:27.88 01:58:08 INFO - PROCESS | 1682 | Values: 68.0 92.0 114.0 72.0 63.0 103.0 103.0 89.0 114.0 159.0 01:58:08 INFO - PROCESS | 1682 | 01:58:08 INFO - PROCESS | 1682 | [#5] imaging-gaussian-blur Cycles:10 Average:107.40 Median:133.00 stddev:15.99 (12.0%) stddev-sans-first:15.83 01:58:08 INFO - PROCESS | 1682 | Values: 91.0 107.0 115.0 131.0 135.0 88.0 104.0 109.0 92.0 102.0 01:58:08 INFO - PROCESS | 1682 | 01:58:08 INFO - PROCESS | 1682 | [#6] imaging-darkroom Cycles:10 Average:108.20 Median:96.50 stddev:22.24 (23.0%) stddev-sans-first:23.14 01:58:08 INFO - PROCESS | 1682 | Values: 96.0 97.0 106.0 149.0 151.0 97.0 97.0 96.0 96.0 97.0 01:58:08 INFO - PROCESS | 1682 | 01:58:08 INFO - PROCESS | 1682 | [#7] imaging-desaturate Cycles:10 Average:110.30 Median:93.50 stddev:21.89 (23.4%) stddev-sans-first:22.41 01:58:08 INFO - PROCESS | 1682 | Values: 94.0 94.0 94.0 93.0 130.0 94.0 134.0 146.0 131.0 93.0 01:58:08 INFO - PROCESS | 1682 | 01:58:08 INFO - PROCESS | 1682 | [#8] json-parse-financial Cycles:10 Average:72.70 Median:71.00 stddev:13.80 (19.4%) stddev-sans-first:13.42 01:58:08 INFO - PROCESS | 1682 | Values: 57.0 64.0 75.0 98.0 94.0 67.0 63.0 79.0 63.0 67.0 01:58:08 INFO - PROCESS | 1682 | 01:58:08 INFO - PROCESS | 1682 | [#9] json-stringify-tinderbox Cycles:10 Average:67.40 Median:68.50 stddev:4.25 (6.2%) stddev-sans-first:4.20 01:58:08 INFO - PROCESS | 1682 | Values: 63.0 67.0 71.0 73.0 74.0 70.0 65.0 63.0 64.0 64.0 01:58:08 INFO - PROCESS | 1682 | 01:58:08 INFO - PROCESS | 1682 | [#10] stanford-crypto-aes Cycles:10 Average:84.70 Median:82.00 stddev:7.24 (8.8%) stddev-sans-first:7.56 01:58:08 INFO - PROCESS | 1682 | Values: 81.0 78.0 81.0 80.0 79.0 80.0 95.0 94.0 96.0 83.0 01:58:08 INFO - PROCESS | 1682 | 01:58:08 INFO - PROCESS | 1682 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:141.50 stddev:11.72 (8.3%) stddev-sans-first:12.08 01:58:08 INFO - PROCESS | 1682 | Values: 144.0 142.0 116.0 141.0 131.0 130.0 130.0 127.0 143.0 158.0 01:58:08 INFO - PROCESS | 1682 | 01:58:08 INFO - PROCESS | 1682 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.90 Median:189.00 stddev:27.87 (14.7%) stddev-sans-first:28.30 01:58:08 INFO - PROCESS | 1682 | Values: 160.0 161.0 173.0 162.0 160.0 213.0 219.0 155.0 221.0 205.0 01:58:08 INFO - PROCESS | 1682 | 01:58:08 INFO - PROCESS | 1682 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:68.00 stddev:1.23 (1.8%) stddev-sans-first:1.27 01:58:08 INFO - PROCESS | 1682 | Values: 68.0 66.0 68.0 68.0 67.0 65.0 66.0 68.0 69.0 67.0 01:58:08 INFO - PROCESS | 1682 | -------- Summary: end -------- 01:58:08 INFO - PROCESS | 1682 | 01:58:09 INFO - TEST-INFO | 1682: exit 0 01:58:09 INFO - TEST-OK | kraken | took 58783ms 01:58:09 INFO - SUITE-END | took 1169s 01:58:10 INFO - Completed test suite (00:19:29) 01:58:10 INFO - javascript benchmark 01:58:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2854.7430731234185, 3124.453220686379, 3322.501624756286, 3649.872254471094, 3656.0859785053726, 4736.407949006374, 5870.442307980746, 5900.3214630317525, 5912.113183022549, 5933.643981361121, 5812.447817457345, 5861.120831875211, 5891.469767720904, 5906.0845568936775, 5922.644641321513, 5296.655717378368, 5336.839894803162, 5342.1452567589195, 5379.919301210485, 5391.083515802304, 5302.44324345942, 5313.388960269561, 5378.784848606051, 5382.8923421531745, 5437.429069947658, 5330.600204984642, 5370.248165256867, 5378.408375078758, 5389.056915039852, 5390.757415916293, 5366.774541531843, 5370.91943620846, 5390.676559406428, 5392.460753924615, 5468.179773034037, 5180.740962951837, 5187.247849061865, 5294.708791016493, 5299.54953828925, 5312.734363281859, 4577.473590537064, 5731.684757338345, 5759.769609215627, 5762.308522977228, 5763.6253643513455, 6202.875942481171, 6211.068339749028, 6277.089821975834, 6297.905531417033, 6314.273858506284, 6181.134641150243, 6188.628682279033, 6209.782657607007, 6236.345183755686, 6314.179156709644, 6000.279966404059, 6023.759049638053, 6040.4124040442275, 6041.1240370146525, 6043.758249670052, 6240.469560087444, 6327.0, 6338.809835704937, 6360.745570177233, 6363.777267795697, 6207.34822843604, 6241.469475094577, 6279.560430769802, 6289.937100629027, 6296.0, 6286.308506064329, 6287.811365659038, 6292.528060395489, 6298.779542715983, 6298.874022519524, 5204.9739751301, 6125.723854043132, 6175.042868355412, 6259.217597800275, 6289.528285378615, 6231.813045608639, 6250.1874756281395, 6260.280067792262, 6262.029385445263, 6265.71804268809, 5010.649254552146, 5018.447970723218, 5039.924401133986, 5059.064073146406, 5067.442581316052, 4403.0, 4415.911681766411, 4510.977445112753, 4539.954600453953, 4586.633069354443, 5795.710214489259, 5855.268091488564, 5894.410558944071, 5958.523318134538, 5999.100134979788, 6218.22272215973, 6219.533534984895, 6294.370562943669, 6300.9684951574945, 6309.3690630936535, 5831.387704290988, 5923.466887980103, 6018.879622407528, 6028.849278767978, 6070.817875463743, 5487.396386397493, 5511.421300763443, 5516.3380394352935, 5532.6680399176175, 5561.721913904288, 6408.871822563523, 6427.903581446282, 6428.871422571616, 6455.934770762866, 6469.741210351627, 6179.938200618116, 6198.597091189058, 6233.158523599437, 6264.718087685974, 6296.905546416716, 6380.074889140956, 6381.744730210925, 6409.519286053472, 6465.256495502889, 6503.349665033459, 6174.876502470015, 6222.408871157233, 6273.686315684289, 6278.686065696788, 6293.118963345044, 5317.707526085947, 6203.906941395973, 6288.465480434032, 6307.085472606538, 6315.242170939517, 6212.254529456313, 6217.09852071438, 6240.219972503437, 6256.843578910563, 6331.5251356147555, 5810.912836307543, 5868.7088840455035, 6127.84680382994, 6188.938110618837, 6267.185265915402, 6020.6688632123905, 6063.969125248806, 6122.438808008548, 6137.140800288053, 6168.074788781719, 6175.135481032748, 6243.594166379171, 6271.96864015677, 6275.058741188858, 6284.402981716729, 6027.849303767441, 6100.206973093469, 6119.959572021022, 6153.753849845956, 6154.1999540059505], "value": 5781.843824806585, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [532.5606374740839, 562.016471175443, 564.8206788168789, 590.9763609455622, 614.6342925959053, 30992.225194370152, 35358.646413535855, 37844.81077594615, 38841.80579097104, 39614.40578391319, 34447.31105377891, 36404.907852764394, 41145.971350716245, 42379.364309535384, 42435.575644243545, 9612.423254604728, 9779.315447918649, 9809.705708828747, 9824.459654718987, 9833.803323933516, 9646.228301735879, 9758.902410975907, 9817.852732209023, 9859.161971232454, 9941.850872236922, 9838.901610983907, 9892.30753847231, 9921.702348929544, 9952.154066904322, 9970.850437243447, 8298.585070746469, 9809.362391444605, 9888.555015024342, 9917.950410247902, 9936.801263974752, 9799.608015679365, 9937.354071985297, 9958.601655933753, 9980.850287245625, 10005.499725013793, 33926.66073339284, 40811.0, 40854.795726021475, 41200.175996479906, 41964.790176048926, 3152.274976755336, 3341.2649217172184, 3347.397468455677, 3355.245069859262, 3502.6497350265026, 25920.8703956479, 26567.202983910513, 26652.0, 27679.169624911287, 28137.718622813714, 2588.715241323453, 2647.6822781266374, 2653.3234025323613, 2716.2258756254373, 2780.0964686476977, 342558.0, 343728.0, 345618.0, 347177.0, 349572.0, 35545.822270888995, 35733.1066723334, 35868.46197307042, 38021.42967855484, 38879.22241555153, 35992.0, 36020.459693104625, 36550.634493654725, 37073.629263707015, 37194.81402593024, 16012.199390030684, 16022.599435014217, 16031.0, 16467.34130634785, 16719.49841504757, 13738.10702304347, 13910.791338129937, 14144.080634758708, 14160.221187834562, 14323.427062917366, 8344.582770861432, 8406.873896891551, 8480.109588493242, 8573.18554737299, 8598.183172598594, 3155.7790954633415, 3616.367135751286, 3637.8726744563814, 3639.909002274964, 3659.908502287464, 893.0221407558713, 1048.9632862849764, 1087.5649740104022, 1102.2119184782919, 1110.3448965110624, 29798.808047678285, 30070.699293007227, 30280.394392112034, 30713.0, 30896.69103308983, 1096.2381145104237, 1135.7387800805861, 1179.728662407634, 1237.975240495203, 1240.503798480615, 13917.23455209953, 15182.089074655556, 15567.0, 15614.45349412765, 16014.959027663164, 330530.0, 331325.0, 333799.0, 334187.0, 335030.0, 63871.0, 64789.67605161944, 65077.349226507125, 65322.0, 65374.673126634065, 1553.5417051969696, 1572.072477238412, 1578.8973716708376, 1581.5808810665183, 1592.8327525609875, 28116.0, 30238.54642180413, 30593.828015606894, 30645.080647579718, 30702.771889124186, 54993.0, 55621.1656825156, 55735.72132139313, 55919.0, 56006.15990760223, 606081.0, 608546.0, 609543.0, 610752.0, 610841.0, 26562.335941601614, 27568.724312756614, 27973.580396293666, 28248.29379265535, 44690.3296450547, 45025.09949801051, 45571.0, 45644.54355456536, 46353.76823115998, 46409.535904641874, 38417.61582384141, 38751.6124838748, 39134.804325978184, 40553.391699125124, 41070.79464602658, 40203.59796401999, 40516.59483405246, 40755.7962210187, 41010.589894100674, 41851.0, 34303.14242143966, 37260.0, 40381.0, 41026.76919692414, 41083.58916410798, 31505.0, 33394.83302583471, 33710.48302826428, 33759.49360759542, 34379.0, 25779.226623201335, 25824.0, 25846.612300815126, 25920.96316147333, 26132.8693356532], "value": 18412.622023845586, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.8469465782385, 408.92230476209517, 411.734431291817, 423.94064830923674, 423.9936400953985, 17025.744613830804, 20136.798632013677, 21281.36155915321, 21647.0, 21892.233771817988, 21636.0, 21868.562628747415, 21894.795786231753, 22469.876506174707, 22552.0, 5297.364316282042, 5611.7474713637985, 5612.550995920337, 5612.635178713391, 5633.60564760467, 5412.810551630694, 5498.45015498449, 5605.411431799643, 5613.550915926737, 5759.625624334426, 5597.188407680884, 5614.410486898878, 5706.1726049722765, 5726.455986681259, 5737.885242295151, 4461.576150265736, 5608.663480191201, 5617.634853734494, 5691.174779656947, 5743.712814359265, 4818.204996175627, 5461.18082287656, 5523.061079616475, 5556.972215138899, 5592.189132575753, 13878.514252001132, 14170.787438188436, 14394.352254148589, 14515.346809393497, 25030.499390012097, 2235.3070548129967, 2410.1805386168785, 2618.1621880998086, 2638.234911875573, 2712.362594790223, 10183.949080254626, 10482.0, 10643.893561064446, 10716.571337146504, 15178.544643660598, 1838.090145378033, 1866.7759868815829, 1900.9714854277197, 1937.602791427754, 1960.470672918304, 118701.0, 121740.0, 122103.16845247328, 123206.0, 123834.9999999991, 12037.0, 12152.756944861054, 12394.62816115518, 12415.503379864886, 12484.75030499385, 14271.643208919653, 15500.92249538745, 16079.115648639437, 16082.517524474284, 16114.355425783071, 8709.259712924346, 8841.823163536821, 9602.519874006412, 9611.183049440737, 9671.274654400808, 7666.4633475656165, 9672.371295865747, 9682.951585242028, 9786.902130978599, 9800.803983920281, 4039.434479172918, 4797.688150270221, 4898.338724272177, 4953.306537084811, 4993.950060499348, 2018.636645403812, 2114.6510825713895, 2131.477787941964, 2143.389134096806, 2161.729783777028, 893.647009431271, 942.0297093993198, 949.8717673114041, 1021.4228960637216, 1069.6256310291492, 20009.399718008484, 20655.380338589865, 20657.0, 20897.05963231658, 20918.47703807417, 989.1888651306004, 1011.4133802394593, 1023.2121266624657, 1040.458961340099, 1071.8767341755643, 11086.0, 11163.888361116286, 11174.21780475375, 11217.0, 11254.94372528132, 583498.0, 647690.0, 648575.0, 663913.0, 670944.0, 111000.22499437579, 118471.40764296123, 125562.0, 125745.0, 126236.73763262434, 870.9477431354139, 998.4708104704519, 1016.4765145949842, 1020.4693559349097, 1057.5082586597268, 17976.983046652644, 18447.077646117374, 18587.44237672872, 18600.906995464935, 18766.906165469085, 41776.58223417727, 51125.0, 51957.0, 53122.73438632782, 58819.41180588139, 77689.2231077682, 80587.3882522358, 81125.0, 81451.18548814436, 82599.0, 8156.9184308156155, 8457.238848503664, 8492.74521764348, 8597.011343695305, 8630.611622476878, 9802.460864652512, 13028.0, 13157.53948611794, 13295.335233238493, 13607.455701772215, 11344.20590558653, 11348.489317980546, 11380.772384552429, 11419.714507137056, 11891.405429728306, 11276.436178191221, 11325.15061370384, 11346.546138154712, 11363.659090226976, 11576.536938522364, 11600.94199528997, 11801.232919860182, 11903.166778325434, 11918.404079795802, 11969.222000569935, 6924.788162071718, 7858.882116768139, 8402.831943361221, 8509.872351914602, 8872.512011839412, 10931.672049838518, 11594.884051159717, 11610.94194529022, 11685.0, 11871.703207419883], "value": 9722.42725381633, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1555.1913005237277, 1566.670999090191, 1838.1085173690758, 1983.8016198380164, 2060.639388107081, 8298.668053277861, 8707.782305442368, 9158.81682366353, 9215.493147876865, 9394.436333819976, 9018.0, 9041.864372034408, 9063.818723625523, 9186.127317904788, 9214.815703685923, 2535.2901187667435, 2535.822492425531, 2576.8453892766493, 2586.5990771430365, 2588.2752829207852, 2570.884310206045, 2574.2792018234923, 2613.621024951381, 2630.552806022981, 2635.2094371688513, 2562.052040744927, 2566.2686134451683, 2571.0615625296728, 2577.742225777426, 2610.4648547047905, 2489.2034548944343, 2493.7880280176205, 2518.4333524956924, 2573.575360065587, 2587.430765231646, 2604.73952604738, 2609.929928729231, 2619.6856377234662, 2625.7111717711036, 2643.6563246777987, 9088.636454541811, 9135.40619859707, 9211.447313161232, 9262.166405023512, 9263.21262692672, 5618.185363122365, 5661.886762264731, 5688.288963879515, 5807.390224026459, 5816.796412125597, 3607.098225443639, 3740.7007439405056, 3742.1018955450495, 3744.5319335083113, 3780.621937806225, 1040.8907064758166, 1047.5809676129609, 1074.6775967209885, 1074.6990842564094, 1076.6447072466067, 11983.10126740498, 11997.580084696994, 12130.757384852253, 12138.635840924786, 12173.634790956374, 4916.901661966741, 4945.109880221523, 5008.724520151427, 5053.418856831438, 5073.7716802743225, 8952.507612081268, 10469.37183768961, 10511.369317840954, 10524.210684198715, 10583.788324233472, 5532.3914369419335, 5560.7219639017885, 5656.91514627281, 5672.177534257509, 5703.230063941398, 4605.470370907322, 4971.527704868032, 5083.212102124176, 5084.847454576368, 5151.021305951857, 4285.3786201000685, 4294.9785251073545, 4302.892427689333, 4383.60547550722, 4387.5393083726385, 1212.7392610588765, 1386.81278027467, 1418.3759145975737, 1421.86492283235, 1428.071753360324, 816.1158050456277, 938.3431597881511, 962.1917589225085, 1002.2733518199393, 1014.1582486536157, 6116.174316467309, 6186.659733714599, 6279.183706118267, 6297.811065668037, 6324.114623952651, 409.4738261334171, 476.46397802472217, 480.3083559674128, 1076.2896488317672, 1110.4725255503572, 3498.965010349915, 4028.234635419261, 4080.3267460868624, 4104.4664193655235, 4128.174365126986, 10968.561257549769, 11036.0, 11282.492287847066, 11393.544258229578, 11508.136889733303, 9424.246060315158, 11005.119590432747, 11042.834357484644, 11321.773564528663, 11375.31748095117, 8501.19238672325, 8608.913910860936, 8713.302935765123, 8831.64673413069, 8836.0, 5809.390014048633, 5959.433853784057, 6015.0375939851165, 6027.879442411039, 6091.385782767482, 8682.739517814476, 9281.67514137002, 9531.237501000041, 9617.855732163884, 9617.855732164164, 9479.573419196015, 9720.465374404193, 9764.80470390574, 9803.970583088672, 9819.85270220933, 7111.7866464006165, 7410.9258907412395, 7587.544747315179, 7718.652660630173, 7787.649555769891, 8262.917370826455, 8302.54336011501, 8321.6671333146, 8339.749807505785, 8355.080941096354, 7322.450816188913, 7425.628718563942, 7512.173660897406, 7543.0948286206, 7563.659635316314, 7449.925500744923, 7464.738734144496, 7514.661840217313, 7587.62061896914, 7607.619619018917, 7176.102987126609, 7218.0, 7233.240509746401, 7255.709771609077, 7304.890426643711, 4993.625478089085, 5028.195488721787, 5131.820386286462, 5198.714070725995, 5251.6586421883985, 5111.309973153725, 5125.538701516882, 5147.510986456281, 5202.869928251673, 5284.524392804666], "value": 4751.718272302464, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [288.5657086085441, 335.01004531609095, 336.71379327571566, 342.3290350912211, 345.97924124552543, 7135.429165666747, 7137.9286207137975, 7140.071790667213, 7143.499955003152, 7160.248173941739, 7024.051753013342, 7030.683619237134, 7049.788506344805, 7079.716811327554, 7103.573785572869, 4952.653314268012, 5059.797608095671, 5167.147420675584, 5179.974100129494, 5198.402183748861, 5118.820841270556, 5157.922631160535, 5217.869553261161, 5224.399194092671, 5240.213967904807, 5198.8700282493055, 5208.479152084799, 5212.556932660709, 5216.374035115791, 5242.18746094356, 5217.34783152106, 5237.266782650432, 5240.161574148156, 5241.2400201970695, 5252.422233554306, 3755.511783468159, 4359.498657654379, 4445.222086134946, 4448.955510444886, 4450.666200035011, 4473.597376236155, 5557.305336832896, 5811.767529298823, 6568.8357791055605, 6785.9660701696175, 5917.704114794243, 5947.345791962881, 5964.552658550626, 5974.820755377345, 5997.8800423991715, 6191.9690401547705, 7535.2464753524755, 7549.433792465587, 7569.470137090406, 7576.848463030708, 4765.7140571565815, 4775.5701986821, 4785.95214047862, 4794.0, 4796.0, 6378.4578310843635, 7591.468597198198, 7871.252231038099, 7949.006374203224, 7960.283574478325, 4859.198232291703, 4859.95140048602, 4867.634927380461, 4878.463369029404, 4887.36464259644, 4902.730349830722, 4945.357103576512, 4949.604031677457, 4953.72754498506, 4959.20652695567, 5942.0, 5949.732262048218, 5953.672548009815, 5972.850678733066, 5978.402159784074, 7516.135644400854, 7521.398288136936, 7538.057742782153, 7552.0, 7567.356774674105, 1699.7960244770459, 1726.326732574297, 1730.550056985193, 1731.5844197392535, 1733.679269335177, 1039.8856125826153, 1082.7401423658266, 1086.8099431122907, 1088.5591335509132, 1088.7060493666825, 6315.273743519554, 6603.735850565923, 7056.6118863463, 7153.60655163971, 7156.463265255126, 7626.161122276545, 7758.107817600935, 7800.726974555863, 7850.607469626496, 7878.566678832604, 7226.6386680665755, 7229.34935855765, 7229.566226026455, 7231.963840180765, 7252.2385149559595, 4195.517515485758, 4217.451731274976, 4233.364995250676, 4235.8729238122905, 4242.936355954663, 6703.698333575001, 8257.339412846957, 8303.95848020756, 8339.749807505785, 8370.790730231793, 7900.960495197487, 8224.465409748347, 8272.627731752085, 8285.58572071394, 8302.418830681914, 8285.95857020711, 8299.253067223979, 8318.41771076031, 8330.875036874451, 8344.332453403713, 6846.246912839683, 7609.727817038505, 7993.240642138988, 7993.240642138988, 8004.319632831274, 5616.241807355955, 6766.93233067663, 7024.051753013277, 7188.0, 7899.605019749105, 6769.661516924036, 8220.917790822015, 8349.749507514784, 8355.370702712913, 8358.331333493428, 4903.950960490492, 4927.655064145475, 4936.2102063669645, 4937.23472861707, 4942.678725882806, 7190.712371505081, 7952.681892724227, 7962.442629015914, 7985.321247693779, 7989.041315042232, 6211.875762484816, 7458.366038886756, 7676.577788221702, 7725.0, 7736.497127686683, 7615.124260710089, 7695.307422332017, 7701.0, 7713.498622589738, 7741.806454838674, 7392.55644661322, 7441.181470038183, 7471.439642026979, 7473.88789168152, 7510.624468776648, 7366.742164024234, 7627.618619068913, 7686.961565192139, 7706.922930770621, 7709.113451952873, 6340.778072767431, 7530.736424225126, 7550.791873300245, 7555.471117021756, 7560.735374261874], "value": 5451.384307233645, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.254648891908, 770.5761830992952, 771.1941021632393, 786.988195177072, 789.329070290253, 15319.540413787576, 15330.46343377982, 15655.373785048612, 15666.373345066198, 15702.214889255534, 14242.501512447066, 14249.78625320621, 14262.215578143197, 14280.357383917722, 14289.499867504639, 768.1435199752264, 922.23454532738, 931.9440833549992, 943.7451887990272, 944.7165850244934, 932.9673461428852, 939.4504215034179, 948.1892981500821, 948.3740731117464, 957.34421920984, 949.8480243161096, 966.4249771386014, 985.2462865907586, 990.9990909181743, 999.4952548962764, 947.7630592351912, 956.2350119904049, 972.0182615558266, 977.8777652793436, 992.4293531219541, 716.2908720366852, 722.3931897206319, 723.1828034321184, 723.971041158353, 745.7725393754903, 14904.031237969497, 14941.028833125813, 14998.850011499855, 15056.171910544916, 15250.23748812555, 13068.823805857422, 13126.540571079966, 13185.538506152334, 13222.338883055809, 13348.132371395925, 10044.849327260097, 10319.79360412795, 10351.0, 10364.948175259151, 10375.273730838844, 3368.427367347557, 3610.295992281506, 3621.963780362189, 3734.850605975758, 3878.1274213302063, 67254.65490690208, 85021.72467412932, 85098.57450712769, 85103.5744821272, 85240.0, 9583.377080489747, 9628.66299679508, 9693.563789629483, 9850.802983940424, 9862.408255504693, 21871.12515499362, 21924.23265185711, 21999.780002200092, 22029.0, 22534.0, 6654.800355989328, 7547.698092076255, 7575.204603516661, 7675.270849269311, 7707.190744971809, 4103.4050062740735, 4177.603127702863, 4185.267578173807, 4195.307774217281, 4292.849750258726, 3737.5328083989502, 3758.3047136279874, 3786.6213378661914, 3787.3750831113107, 3788.9431658525145, 586.8298193523916, 665.4809248785955, 684.6234570985938, 688.9517733758589, 703.5708217987024, 569.7066011004337, 598.9548238324152, 606.9241344831896, 614.1432701381548, 625.337142628815, 7129.643517824088, 8004.159563245776, 8171.83656326882, 8378.371622128365, 8562.186592273723, 427.5403940763691, 575.4245754245754, 618.8978818494988, 639.7984634840011, 658.558765627031, 3638.890833275006, 3689.9631003690156, 3834.3673293906195, 4016.9555915461606, 4036.777977211223, 72734.63632681803, 91380.0, 92224.53887730652, 92555.0, 100359.0, 87173.0, 87660.0, 88041.23917521742, 88288.55855720809, 88905.0, 73180.26819731841, 74854.0, 74872.5025499487, 75038.62480687561, 75554.24445755473, 7890.092639346319, 8088.514689118671, 8129.593520323841, 8191.549464779494, 8237.284920607122, 40976.79511602542, 41899.79050104852, 50771.0, 52471.47528524818, 53084.73457632687, 69667.3033269681, 74474.62762686369, 74894.62552687201, 75191.24808751843, 76473.23526764884, 9879.703608891745, 9949.0, 9956.303058785816, 10069.69790906274, 10456.843147352643, 10870.324363694528, 11106.666799996014, 11132.05377542918, 11135.053520450529, 11365.886341136484, 10212.744681383025, 10547.103496202908, 10591.94704026475, 10783.676489705322, 11145.665630031112, 10249.9487502562, 10288.559601655925, 10498.580056797642, 10750.0, 11046.226764126433, 10399.792004160026, 10501.684949451528, 10661.307015043998, 10677.466126693478, 11120.88879111231, 9001.504917229615, 9125.908740912506, 9198.67804626835, 9448.244140468883, 9524.904750952403, 9236.353455258068, 9244.583993720164, 9263.212626926786, 9340.626374944926, 9379.718608441757], "value": 6963.256873465886, "unit": "score"}], "name": "dromaeo_css", "value": 7560.081074401639, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 118.0, 117.0, 132.0, 116.0, 116.0, 117.0, 116.0], "value": 118.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [155.0, 120.0, 140.0, 158.0, 134.0, 178.0, 153.0, 151.0, 156.0, 115.0], "value": 146.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [193.0, 196.0, 198.0, 196.0, 197.0, 194.0, 194.0, 195.0, 201.0, 196.0], "value": 196.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 93.0, 138.0, 75.0, 80.0, 83.0, 73.0, 124.0, 55.0], "value": 85.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 92.0, 114.0, 72.0, 63.0, 103.0, 103.0, 89.0, 114.0, 159.0], "value": 97.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 107.0, 115.0, 131.0, 135.0, 88.0, 104.0, 109.0, 92.0, 102.0], "value": 107.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 106.0, 149.0, 151.0, 97.0, 97.0, 96.0, 96.0, 97.0], "value": 108.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 93.0, 130.0, 94.0, 134.0, 146.0, 131.0, 93.0], "value": 110.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 64.0, 75.0, 98.0, 94.0, 67.0, 63.0, 79.0, 63.0, 67.0], "value": 72.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 67.0, 71.0, 73.0, 74.0, 70.0, 65.0, 63.0, 64.0, 64.0], "value": 67.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 78.0, 81.0, 80.0, 79.0, 80.0, 95.0, 94.0, 96.0, 83.0], "value": 84.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 142.0, 116.0, 141.0, 131.0, 130.0, 130.0, 127.0, 143.0, 158.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 173.0, 162.0, 160.0, 213.0, 219.0, 155.0, 221.0, 205.0], "value": 182.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 66.0, 68.0, 68.0, 67.0, 65.0, 66.0, 68.0, 69.0, 67.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1580.8000000000004, "alertThreshold": 2.0}]} 01:58:10 INFO - Return code: 0 01:58:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:58:10 ERROR - # TBPL SUCCESS # 01:58:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 01:58:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 01:58:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 01:58:10 INFO - 2016-06-07 01:58:10.289 screenresolution[1687:10268] starting screenresolution argv=screenresolution get 01:58:10 INFO - 2016-06-07 01:58:10.291 screenresolution[1687:10268] Display 0: 1600x1200x32@60 01:58:10 INFO - 2016-06-07 01:58:10.297 screenresolution[1688:10271] starting screenresolution argv=screenresolution list 01:58:10 INFO - Available Modes on Display 0 01:58:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 01:58:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 01:58:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 01:58:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 01:58:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 01:58:10 INFO - Intel Iris: 01:58:10 INFO - Chipset Model: Intel Iris 01:58:10 INFO - Type: GPU 01:58:10 INFO - Bus: Built-In 01:58:10 INFO - VRAM (Dynamic, Max): 1536 MB 01:58:10 INFO - Vendor: Intel (0x8086) 01:58:10 INFO - Device ID: 0x0a2e 01:58:10 INFO - Revision ID: 0x0009 01:58:10 INFO - Displays: 01:58:10 INFO - Display: 01:58:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 01:58:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 01:58:10 INFO - Display Serial Number: 1600x1200 60 01:58:10 INFO - Main Display: Yes 01:58:10 INFO - Mirror: Off 01:58:10 INFO - Online: Yes 01:58:10 INFO - Rotation: Supported 01:58:10 INFO - Return code: 0 01:58:10 INFO - Running post-action listener: _resource_record_post_action 01:58:10 INFO - Running post-run listener: _resource_record_post_run 01:58:11 INFO - Total resource usage - Wall time: 1194s; CPU: 54.0%; Read bytes: 36902400; Write bytes: 495768064; Read time: 240; Write time: 1563 01:58:11 INFO - install - Wall time: 23s; CPU: 54.0%; Read bytes: 194869760; Write bytes: 196445696; Read time: 18599; Write time: 442 01:58:11 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 35087872; Write bytes: 298474496; Read time: 224; Write time: 1119 01:58:11 INFO - Running post-run listener: _upload_blobber_files 01:58:11 INFO - Blob upload gear active. 01:58:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:58:11 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:58:11 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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:58:11 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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:58:12 INFO - (blobuploader) - INFO - Open directory for files ... 01:58:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:58:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:58:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:58:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:58:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:58:13 INFO - (blobuploader) - INFO - Done attempting. 01:58:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:58:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:58:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:58:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:58:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:58:13 INFO - (blobuploader) - INFO - Done attempting. 01:58:13 INFO - (blobuploader) - INFO - Iteration through files over. 01:58:14 INFO - Return code: 0 01:58:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:58:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:58:14 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6517c7e5e25b9c2e945c1516e852e8a17d347e272c8cf50fb6de4758541a1004ee6c4285bed33866c50b998c4c3254e808a7b34e8d9984187ec0e36711f675a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ac5fcec63802abd675fb237023a337bb06f20b8f16ad5d6400badbc8c938dff71ba9371d8a7bb843ff840a035a07fd955a81177db2b9ff9b00282bb4fbd7d2e3"} 01:58:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:58:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:58:14 INFO - Contents: 01:58:14 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6517c7e5e25b9c2e945c1516e852e8a17d347e272c8cf50fb6de4758541a1004ee6c4285bed33866c50b998c4c3254e808a7b34e8d9984187ec0e36711f675a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ac5fcec63802abd675fb237023a337bb06f20b8f16ad5d6400badbc8c938dff71ba9371d8a7bb843ff840a035a07fd955a81177db2b9ff9b00282bb4fbd7d2e3"} 01:58:14 INFO - Running post-run listener: copy_logs_to_upload_dir 01:58:14 INFO - Copying logs to upload dir... 01:58:14 INFO - mkdir: /builds/slave/test/build/upload/logs 01:58:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.029541 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 53 secs) (at 2016-06-07 01:58:14.058597) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 01:58:14.062138) ========= 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.z0RRhP6lt1/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.59m5V9PePZ/Listeners TMPDIR=/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6517c7e5e25b9c2e945c1516e852e8a17d347e272c8cf50fb6de4758541a1004ee6c4285bed33866c50b998c4c3254e808a7b34e8d9984187ec0e36711f675a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ac5fcec63802abd675fb237023a337bb06f20b8f16ad5d6400badbc8c938dff71ba9371d8a7bb843ff840a035a07fd955a81177db2b9ff9b00282bb4fbd7d2e3"} build_url:https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011162 build_url: 'https://queue.taskcluster.net/v1/task/OFqC62uQSLWm-v2RyXJlUw/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/6517c7e5e25b9c2e945c1516e852e8a17d347e272c8cf50fb6de4758541a1004ee6c4285bed33866c50b998c4c3254e808a7b34e8d9984187ec0e36711f675a1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/ac5fcec63802abd675fb237023a337bb06f20b8f16ad5d6400badbc8c938dff71ba9371d8a7bb843ff840a035a07fd955a81177db2b9ff9b00282bb4fbd7d2e3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-07 01:58:14.093586) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:58:14.093932) ========= 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.z0RRhP6lt1/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.59m5V9PePZ/Listeners TMPDIR=/var/folders/vd/gwz783gs6snbfbbmm1cw7rnw00000w/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.005154 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-07 01:58:14.142607) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 01:58:14.142930) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-07 01:58:14.143277) ========= ========= Total master_lag: 0.17 =========