builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0387 starttime: 1468009570.44 results: success (0) buildid: 20160708113726 builduid: 0e18ae00cb88446ba899f020b0a6a925 revision: 23d50da987261085138dab3f05eae49806d9bf1b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 13:26:10.438861) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 13:26:10.440346) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 13:26:10.441314) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 13:26:10.467804) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 13:26:10.468133) ========= 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.pXgBcj7Kur/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.6EITWfu3kk/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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-07-08 13:26:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 10.7M=0.001s 2016-07-08 13:26:10 (10.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117110 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 13:26:10.611454) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 13:26:10.612029) ========= 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.pXgBcj7Kur/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.6EITWfu3kk/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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.026050 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 13:26:10.660930) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 13:26:10.661328) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 23d50da987261085138dab3f05eae49806d9bf1b --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 23d50da987261085138dab3f05eae49806d9bf1b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.pXgBcj7Kur/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.6EITWfu3kk/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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-07-08 13:26:10,743 truncating revision to first 12 chars 2016-07-08 13:26:10,743 Setting DEBUG logging. 2016-07-08 13:26:10,743 attempt 1/10 2016-07-08 13:26:10,743 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/23d50da98726?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-08 13:26:11,442 unpacking tar archive at: mozilla-beta-23d50da98726/testing/mozharness/ program finished with exit code 0 elapsedTime=0.986612 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 13:26:11.670290) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 13:26:11.670682) ========= script_repo_revision: 23d50da987261085138dab3f05eae49806d9bf1b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 13:26:11.671155) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 13:26:11.671517) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 13:26:11.689894) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-08 13:26:11.690442) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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.pXgBcj7Kur/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.6EITWfu3kk/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 13:26:11 INFO - MultiFileLogger online at 20160708 13:26:11 in /builds/slave/test 13:26:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:26:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:26:11 INFO - {'append_to_log': False, 13:26:11 INFO - 'base_work_dir': '/builds/slave/test', 13:26:11 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:26:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:26:11 INFO - 'branch': 'Mozilla-Beta', 13:26:11 INFO - 'buildbot_json_path': 'buildprops.json', 13:26:11 INFO - 'config_files': ('talos/mac_config.py',), 13:26:11 INFO - 'default_actions': ('clobber', 13:26:11 INFO - 'read-buildbot-config', 13:26:11 INFO - 'download-and-extract', 13:26:11 INFO - 'populate-webroot', 13:26:11 INFO - 'create-virtualenv', 13:26:11 INFO - 'install', 13:26:11 INFO - 'run-tests'), 13:26:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:26:11 INFO - 'download_minidump_stackwalk': True, 13:26:11 INFO - 'download_symbols': 'ondemand', 13:26:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:26:11 INFO - 'tooltool.py': '/tools/tooltool.py', 13:26:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:26:11 INFO - '/tools/misc-python/virtualenv.py')}, 13:26:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:26:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:26:11 INFO - 'installer_path': 'installer.exe', 13:26:11 INFO - 'log_level': 'info', 13:26:11 INFO - 'log_name': 'talos', 13:26:11 INFO - 'log_to_console': True, 13:26:11 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:26:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:26:11 INFO - 'opt_config_files': (), 13:26:11 INFO - 'pip_index': False, 13:26:11 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:26:11 INFO - 'cmd': ('bash', 13:26:11 INFO - '-c', 13:26:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:26:11 INFO - 'enabled': True, 13:26:11 INFO - 'halt_on_failure': False, 13:26:11 INFO - 'name': 'check_screen_resolution'},), 13:26:11 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:26:11 INFO - 'cmd': ('bash', 13:26:11 INFO - '-c', 13:26:11 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:26:11 INFO - 'enabled': True, 13:26:11 INFO - 'halt_on_failure': False, 13:26:11 INFO - 'name': 'check_screen_resolution'},), 13:26:11 INFO - 'run_cmd_checks_enabled': True, 13:26:11 INFO - 'sps_profile': False, 13:26:11 INFO - 'sps_profile_interval': 0, 13:26:11 INFO - 'suite': 'dromaeojs', 13:26:11 INFO - 'system_bits': '32', 13:26:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:26:11 INFO - 'title': 't-yosemite-r7-0387', 13:26:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:26:11 INFO - 'use_talos_json': True, 13:26:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:26:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:26:11 INFO - 'work_dir': 'build'} 13:26:11 INFO - ##### 13:26:11 INFO - ##### Running clobber step. 13:26:11 INFO - ##### 13:26:11 INFO - Running pre-action listener: _resource_record_pre_action 13:26:11 INFO - Running main action method: clobber 13:26:11 INFO - rmtree: /builds/slave/test/build 13:26:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:26:13 INFO - Running post-action listener: _resource_record_post_action 13:26:13 INFO - ##### 13:26:13 INFO - ##### Running read-buildbot-config step. 13:26:13 INFO - ##### 13:26:13 INFO - Running pre-action listener: _resource_record_pre_action 13:26:13 INFO - Running main action method: read_buildbot_config 13:26:13 INFO - Using buildbot properties: 13:26:13 INFO - { 13:26:13 INFO - "project": "", 13:26:13 INFO - "product": "firefox", 13:26:13 INFO - "script_repo_revision": "production", 13:26:13 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 13:26:13 INFO - "repository": "", 13:26:13 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 13:26:13 INFO - "buildid": "20160708113726", 13:26:13 INFO - "pgo_build": "False", 13:26:13 INFO - "basedir": "/builds/slave/test", 13:26:13 INFO - "buildnumber": 36, 13:26:13 INFO - "slavename": "t-yosemite-r7-0387", 13:26:13 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 13:26:13 INFO - "platform": "yosemite_r7", 13:26:13 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:26:13 INFO - "branch": "mozilla-beta", 13:26:13 INFO - "repo_path": "releases/mozilla-beta", 13:26:13 INFO - "revision": "23d50da987261085138dab3f05eae49806d9bf1b", 13:26:13 INFO - "stage_platform": "macosx64", 13:26:13 INFO - "builduid": "0e18ae00cb88446ba899f020b0a6a925", 13:26:13 INFO - "slavebuilddir": "test" 13:26:13 INFO - } 13:26:13 INFO - Found installer url https://queue.taskcluster.net/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 13:26:13 INFO - Running post-action listener: _resource_record_post_action 13:26:13 INFO - ##### 13:26:13 INFO - ##### Running download-and-extract step. 13:26:13 INFO - ##### 13:26:13 INFO - Running pre-action listener: _resource_record_pre_action 13:26:13 INFO - Running main action method: download_and_extract 13:26:13 INFO - mkdir: /builds/slave/test/build/tests 13:26:13 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')]} 13:26:13 INFO - https://queue.taskcluster.net/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 13:26:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 13:26:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 13:26:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTnJNB3dRXmgBohAhEqBzQ/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 13:26:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTnJNB3dRXmgBohAhEqBzQ/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 13:26:15 INFO - Downloaded 1165 bytes. 13:26:15 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 13:26:15 INFO - Using the following test package requirements: 13:26:15 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 13:26:15 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:26:15 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 13:26:15 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:26:15 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 13:26:15 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:26:15 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:26:15 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 13:26:15 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 13:26:15 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:26:15 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 13:26:15 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:26:15 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 13:26:15 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:26:15 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 13:26:15 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:26:15 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 13:26:15 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 13:26:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:15 INFO - https://queue.taskcluster.net/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:26:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 13:26:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 13:26:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTnJNB3dRXmgBohAhEqBzQ/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 13:26:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTnJNB3dRXmgBohAhEqBzQ/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 13:26:16 INFO - Downloaded 18351509 bytes. 13:26:16 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'] 13:26:16 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 13:26:19 INFO - Return code: 0 13:26:19 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 13:26:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:19 INFO - https://queue.taskcluster.net/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 13:26:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 13:26:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 13:26:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTnJNB3dRXmgBohAhEqBzQ/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 13:26:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTnJNB3dRXmgBohAhEqBzQ/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 13:26:20 INFO - Downloaded 18351509 bytes. 13:26:20 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'] 13:26:20 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 13:26:24 INFO - Return code: 0 13:26:24 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')]} 13:26:24 INFO - https://queue.taskcluster.net/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 13:26:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 13:26:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 13:26:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTnJNB3dRXmgBohAhEqBzQ/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 13:26:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTnJNB3dRXmgBohAhEqBzQ/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 13:26:25 INFO - Downloaded 10840145 bytes. 13:26:25 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'] 13:26:25 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 13:26:25 INFO - Return code: 0 13:26:25 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')]} 13:26:25 INFO - https://queue.taskcluster.net/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 13:26:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 13:26:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 13:26:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 13:26:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/PTnJNB3dRXmgBohAhEqBzQ/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 13:26:28 INFO - Downloaded 86184339 bytes. 13:26:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 13:26:28 INFO - mkdir: /builds/slave/test/properties 13:26:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:26:28 INFO - Writing to file /builds/slave/test/properties/build_url 13:26:28 INFO - Contents: 13:26:28 INFO - build_url:https://queue.taskcluster.net/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 13:26:28 INFO - Running post-action listener: _resource_record_post_action 13:26:28 INFO - Running post-action listener: set_extra_try_arguments 13:26:28 INFO - ##### 13:26:28 INFO - ##### Running populate-webroot step. 13:26:28 INFO - ##### 13:26:28 INFO - Running pre-action listener: _resource_record_pre_action 13:26:28 INFO - Running main action method: populate_webroot 13:26:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:26:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:26:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:26:28 INFO - '--tppagecycles', 13:26:28 INFO - '7'], 13:26:28 INFO - 'tests': ['tsvgm']}}, 13:26:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:26:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:26:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:26:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:26:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:26:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:26:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:28 INFO - 'talos_options': ['--disable-e10s'], 13:26:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:26:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:26:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:28 INFO - 'talos_options': ['--disable-e10s'], 13:26:28 INFO - 'tests': ['damp', 'tps']}, 13:26:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:28 INFO - 'tests': ['damp', 'tps']}, 13:26:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:26:28 INFO - 'tests': ['dromaeo_dom']}, 13:26:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:26:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:26:28 INFO - 'tests': ['a11yr', 13:26:28 INFO - 'ts_paint', 13:26:28 INFO - 'tpaint', 13:26:28 INFO - 'sessionrestore', 13:26:28 INFO - 'sessionrestore_no_auto_restore', 13:26:28 INFO - 'tabpaint']}, 13:26:28 INFO - 'other-e10s': {'tests': ['a11yr', 13:26:28 INFO - 'ts_paint', 13:26:28 INFO - 'tpaint', 13:26:28 INFO - 'sessionrestore', 13:26:28 INFO - 'sessionrestore_no_auto_restore', 13:26:28 INFO - 'tabpaint']}, 13:26:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:26:28 INFO - 'ts_paint', 13:26:28 INFO - 'tpaint', 13:26:28 INFO - 'sessionrestore', 13:26:28 INFO - 'sessionrestore_no_auto_restore', 13:26:28 INFO - 'tabpaint']}, 13:26:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:26:28 INFO - 'ts_paint', 13:26:28 INFO - 'tpaint', 13:26:28 INFO - 'sessionrestore', 13:26:28 INFO - 'sessionrestore_no_auto_restore', 13:26:28 INFO - 'tabpaint']}, 13:26:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:26:28 INFO - 'tests': ['a11yr', 13:26:28 INFO - 'ts_paint', 13:26:28 INFO - 'tpaint', 13:26:28 INFO - 'sessionrestore', 13:26:28 INFO - 'sessionrestore_no_auto_restore', 13:26:28 INFO - 'tabpaint']}, 13:26:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:26:28 INFO - 'tests': ['a11yr', 13:26:28 INFO - 'ts_paint', 13:26:28 INFO - 'tpaint', 13:26:28 INFO - 'sessionrestore', 13:26:28 INFO - 'sessionrestore_no_auto_restore', 13:26:28 INFO - 'tabpaint']}, 13:26:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:26:28 INFO - 'tests': ['tsvgx', 13:26:28 INFO - 'tsvgr_opacity', 13:26:28 INFO - 'tart', 13:26:28 INFO - 'tscrollx', 13:26:28 INFO - 'cart']}, 13:26:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:26:28 INFO - 'tsvgr_opacity', 13:26:28 INFO - 'tart', 13:26:28 INFO - 'tscrollx', 13:26:28 INFO - 'cart']}, 13:26:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:28 INFO - 'talos_options': ['--disable-e10s'], 13:26:28 INFO - 'tests': ['tp5o']}, 13:26:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:28 INFO - 'tests': ['tp5o']}, 13:26:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:28 INFO - 'talos_options': ['--disable-e10s', 13:26:28 INFO - '--xperf_path', 13:26:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:26:28 INFO - 'tests': ['tp5n']}, 13:26:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:26:28 INFO - 'talos_options': ['--xperf_path', 13:26:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:26:28 INFO - 'tests': ['tp5n']}}, 13:26:28 INFO - 'talos.zip': {'path': '', 13:26:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:26:28 INFO - Running post-action listener: _resource_record_post_action 13:26:28 INFO - ##### 13:26:28 INFO - ##### Running create-virtualenv step. 13:26:28 INFO - ##### 13:26:28 INFO - Running pre-action listener: _resource_record_pre_action 13:26:28 INFO - Running main action method: create_virtualenv 13:26:28 INFO - Creating virtualenv /builds/slave/test/build/venv 13:26:28 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 13:26:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:26:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:26:29 INFO - Using real prefix '/tools/python27' 13:26:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:26:29 INFO - Installing distribute.............................................................................................................................................................................................done. 13:26:32 INFO - Installing pip.................done. 13:26:32 INFO - Return code: 0 13:26:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:26:32 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')]} 13:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:32 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')]} 13:26:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:32 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 0x1039d9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a8d7a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103878e00>, '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 0x1036e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103873b20>, '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.pXgBcj7Kur/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.6EITWfu3kk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 13:26:32 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 13:26:32 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 13:26:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pXgBcj7Kur/Render', 13:26:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:32 INFO - 'HOME': '/Users/cltbld', 13:26:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:32 INFO - 'LOGNAME': 'cltbld', 13:26:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:32 INFO - 'MOZ_NO_REMOTE': '1', 13:26:32 INFO - 'NO_EM_RESTART': '1', 13:26:32 INFO - 'PAGER': '/bin/cat', 13:26:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:32 INFO - 'PWD': '/builds/slave/test', 13:26:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:32 INFO - 'SHELL': '/bin/bash', 13:26:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6EITWfu3kk/Listeners', 13:26:32 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 13:26:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:32 INFO - 'USER': 'cltbld', 13:26:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:32 INFO - 'XPC_FLAGS': '0x0', 13:26:32 INFO - 'XPC_SERVICE_NAME': '0', 13:26:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:32 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 13:26:32 INFO - Cleaning up... 13:26:32 INFO - Return code: 0 13:26:32 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:26:32 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')]} 13:26:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:32 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')]} 13:26:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:32 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 0x1039d9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a8d7a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103878e00>, '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 0x1036e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103873b20>, '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.pXgBcj7Kur/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.6EITWfu3kk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 13:26:32 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 13:26:32 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 13:26:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pXgBcj7Kur/Render', 13:26:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:33 INFO - 'HOME': '/Users/cltbld', 13:26:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:33 INFO - 'LOGNAME': 'cltbld', 13:26:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:33 INFO - 'MOZ_NO_REMOTE': '1', 13:26:33 INFO - 'NO_EM_RESTART': '1', 13:26:33 INFO - 'PAGER': '/bin/cat', 13:26:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:33 INFO - 'PWD': '/builds/slave/test', 13:26:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:33 INFO - 'SHELL': '/bin/bash', 13:26:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6EITWfu3kk/Listeners', 13:26:33 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 13:26:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:33 INFO - 'USER': 'cltbld', 13:26:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:33 INFO - 'XPC_FLAGS': '0x0', 13:26:33 INFO - 'XPC_SERVICE_NAME': '0', 13:26:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:33 INFO - Downloading/unpacking psutil>=0.7.1 13:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:26:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:26:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:26:36 INFO - Installing collected packages: psutil 13:26:36 INFO - Running setup.py install for psutil 13:26:36 INFO - building 'psutil._psutil_osx' extension 13:26:36 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 13:26:36 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 13:26:36 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 13:26:37 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 13:26:37 INFO - building 'psutil._psutil_posix' extension 13:26:37 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 13:26:37 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:26:37 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:26:37 INFO - ^ 13:26:37 INFO - 1 warning generated. 13:26:37 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 13:26:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:26:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:26:37 INFO - Successfully installed psutil 13:26:37 INFO - Cleaning up... 13:26:37 INFO - Return code: 0 13:26:37 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1039d9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a8d7a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103878e00>, '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 0x1036e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103873b20>, '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.pXgBcj7Kur/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.6EITWfu3kk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 13:26:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 13:26:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 13:26:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pXgBcj7Kur/Render', 13:26:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:37 INFO - 'HOME': '/Users/cltbld', 13:26:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:37 INFO - 'LOGNAME': 'cltbld', 13:26:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:37 INFO - 'MOZ_NO_REMOTE': '1', 13:26:37 INFO - 'NO_EM_RESTART': '1', 13:26:37 INFO - 'PAGER': '/bin/cat', 13:26:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:37 INFO - 'PWD': '/builds/slave/test', 13:26:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:37 INFO - 'SHELL': '/bin/bash', 13:26:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6EITWfu3kk/Listeners', 13:26:37 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 13:26:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:37 INFO - 'USER': 'cltbld', 13:26:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:37 INFO - 'XPC_FLAGS': '0x0', 13:26:37 INFO - 'XPC_SERVICE_NAME': '0', 13:26:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:37 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:40 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:26:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:26:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 13:26:40 INFO - Installing collected packages: mozsystemmonitor 13:26:40 INFO - Running setup.py install for mozsystemmonitor 13:26:40 INFO - Successfully installed mozsystemmonitor 13:26:40 INFO - Cleaning up... 13:26:40 INFO - Return code: 0 13:26:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1039d9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a8d7a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103878e00>, '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 0x1036e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103873b20>, '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.pXgBcj7Kur/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.6EITWfu3kk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 13:26:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:26:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:26:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pXgBcj7Kur/Render', 13:26:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:40 INFO - 'HOME': '/Users/cltbld', 13:26:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:40 INFO - 'LOGNAME': 'cltbld', 13:26:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:40 INFO - 'MOZ_NO_REMOTE': '1', 13:26:40 INFO - 'NO_EM_RESTART': '1', 13:26:40 INFO - 'PAGER': '/bin/cat', 13:26:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:40 INFO - 'PWD': '/builds/slave/test', 13:26:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:40 INFO - 'SHELL': '/bin/bash', 13:26:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6EITWfu3kk/Listeners', 13:26:40 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 13:26:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:40 INFO - 'USER': 'cltbld', 13:26:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:40 INFO - 'XPC_FLAGS': '0x0', 13:26:40 INFO - 'XPC_SERVICE_NAME': '0', 13:26:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:40 INFO - Downloading/unpacking blobuploader==1.2.4 13:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:43 INFO - Downloading blobuploader-1.2.4.tar.gz 13:26:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:26:43 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:26:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:44 INFO - Downloading docopt-0.6.1.tar.gz 13:26:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:26:44 INFO - Installing collected packages: blobuploader, requests, docopt 13:26:44 INFO - Running setup.py install for blobuploader 13:26:44 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:26:44 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:26:44 INFO - Running setup.py install for requests 13:26:45 INFO - Running setup.py install for docopt 13:26:45 INFO - Successfully installed blobuploader requests docopt 13:26:45 INFO - Cleaning up... 13:26:45 INFO - Return code: 0 13:26:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26: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')]} 13:26:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26: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')]} 13:26:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:45 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 0x1039d9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a8d7a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103878e00>, '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 0x1036e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103873b20>, '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.pXgBcj7Kur/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.6EITWfu3kk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 13:26:45 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 13:26:45 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 13:26:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pXgBcj7Kur/Render', 13:26:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:45 INFO - 'HOME': '/Users/cltbld', 13:26:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:45 INFO - 'LOGNAME': 'cltbld', 13:26:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:45 INFO - 'MOZ_NO_REMOTE': '1', 13:26:45 INFO - 'NO_EM_RESTART': '1', 13:26:45 INFO - 'PAGER': '/bin/cat', 13:26:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:45 INFO - 'PWD': '/builds/slave/test', 13:26:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:45 INFO - 'SHELL': '/bin/bash', 13:26:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6EITWfu3kk/Listeners', 13:26:45 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 13:26:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:45 INFO - 'USER': 'cltbld', 13:26:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:45 INFO - 'XPC_FLAGS': '0x0', 13:26:45 INFO - 'XPC_SERVICE_NAME': '0', 13:26:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:26:45 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-CGEyYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:26:45 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-7HPG55-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:26:45 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-73uhbg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:26:45 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-ru1euT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:26:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:26:45 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-CdvBt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:26:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-mthV5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:26:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-hjfA4F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:26:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-018j96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:26:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-QAEVu3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:26:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-IJ39KT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:26:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-_18mzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:26:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-QJuOkQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:26:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-ji1HTX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:26:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-HXF10T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:26:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:46 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-krIwUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:26:47 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-MTRL_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:26:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:26:47 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-2GSGT_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:26:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:26:47 INFO - Running setup.py install for manifestparser 13:26:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:26:47 INFO - Running setup.py install for mozcrash 13:26:47 INFO - Running setup.py install for mozdebug 13:26:47 INFO - Running setup.py install for mozdevice 13:26:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:26:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:26:47 INFO - Running setup.py install for mozfile 13:26:48 INFO - Running setup.py install for mozhttpd 13:26:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:26:48 INFO - Running setup.py install for mozinfo 13:26:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:26:48 INFO - Running setup.py install for mozInstall 13:26:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:26:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:26:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:26:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:26:48 INFO - Running setup.py install for mozleak 13:26:48 INFO - Running setup.py install for mozlog 13:26:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:26:48 INFO - Running setup.py install for moznetwork 13:26:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:26:48 INFO - Running setup.py install for mozprocess 13:26:49 INFO - Running setup.py install for mozprofile 13:26:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:26:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:26:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:26:49 INFO - Running setup.py install for mozrunner 13:26:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:26:49 INFO - Running setup.py install for mozscreenshot 13:26:49 INFO - Running setup.py install for moztest 13:26:49 INFO - Running setup.py install for mozversion 13:26:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:26:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:26:49 INFO - Cleaning up... 13:26:49 INFO - Return code: 0 13:26:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:49 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 0x1039d9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a8d7a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103878e00>, '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 0x1036e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103873b20>, '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.pXgBcj7Kur/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.6EITWfu3kk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 13:26:49 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 13:26:49 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 13:26:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pXgBcj7Kur/Render', 13:26:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:49 INFO - 'HOME': '/Users/cltbld', 13:26:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:49 INFO - 'LOGNAME': 'cltbld', 13:26:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:49 INFO - 'MOZ_NO_REMOTE': '1', 13:26:49 INFO - 'NO_EM_RESTART': '1', 13:26:49 INFO - 'PAGER': '/bin/cat', 13:26:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:49 INFO - 'PWD': '/builds/slave/test', 13:26:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:49 INFO - 'SHELL': '/bin/bash', 13:26:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6EITWfu3kk/Listeners', 13:26:49 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 13:26:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:49 INFO - 'USER': 'cltbld', 13:26:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:49 INFO - 'XPC_FLAGS': '0x0', 13:26:49 INFO - 'XPC_SERVICE_NAME': '0', 13:26:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:26:50 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-hIhUlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:26:50 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)) 13:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:26:50 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-HfaDxg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:26:50 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)) 13:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:26:50 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-xZNgEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:26:50 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)) 13:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:26:50 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-gDaQSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:26:50 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)) 13:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:26:50 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-ZExfYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:26:50 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)) 13:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:26:50 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-b35BlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:26:50 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)) 13:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:26:50 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-JoVcCo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:26:50 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)) 13:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:26:50 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-6ZdYzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:26:50 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)) 13:26:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:26:50 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-0VxrPQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:26:51 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)) 13:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:26:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-R6C09v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:26:51 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)) 13:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:26:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-Rz5Ekj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:26:51 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)) 13:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:26:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-u9VUwO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:26:51 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)) 13:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:26:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-zbrgOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:26:51 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)) 13:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:26:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-q5h5Wx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:26:51 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)) 13:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-Wc15PX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:51 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)) 13:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:26:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-QxWHSR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:26:51 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)) 13:26:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:26:51 INFO - Running setup.py (path:/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/pip-xazswZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:26:51 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)) 13:26:51 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)) 13:26:51 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)) 13:26:51 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)) 13:26:51 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)) 13:26:51 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)) 13:26:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:26:51 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 13:26:51 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 13:26:51 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 13:26:51 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 13:26:51 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 13:26:51 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 13:26:54 INFO - Downloading blessings-1.6.tar.gz 13:26:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:26:54 INFO - Installing collected packages: blessings 13:26:54 INFO - Running setup.py install for blessings 13:26:54 INFO - Successfully installed blessings 13:26:54 INFO - Cleaning up... 13:26:54 INFO - Return code: 0 13:26:54 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:26:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:26:54 INFO - Reading from file tmpfile_stdout 13:26:54 INFO - Current package versions: 13:26:54 INFO - blessings == 1.6 13:26:54 INFO - blobuploader == 1.2.4 13:26:54 INFO - docopt == 0.6.1 13:26:54 INFO - manifestparser == 1.1 13:26:54 INFO - mozInstall == 1.12 13:26:54 INFO - mozcrash == 0.17 13:26:54 INFO - mozdebug == 0.1 13:26:54 INFO - mozdevice == 0.48 13:26:54 INFO - mozfile == 1.2 13:26:54 INFO - mozhttpd == 0.7 13:26:54 INFO - mozinfo == 0.9 13:26:54 INFO - mozleak == 0.1 13:26:54 INFO - mozlog == 3.1 13:26:54 INFO - moznetwork == 0.27 13:26:54 INFO - mozprocess == 0.22 13:26:54 INFO - mozprofile == 0.28 13:26:54 INFO - mozrunner == 6.11 13:26:54 INFO - mozscreenshot == 0.1 13:26:54 INFO - mozsystemmonitor == 0.0 13:26:54 INFO - moztest == 0.7 13:26:54 INFO - mozversion == 1.4 13:26:54 INFO - psutil == 3.1.1 13:26:54 INFO - requests == 1.2.3 13:26:54 INFO - wsgiref == 0.1.2 13:26:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:54 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')]} 13:26:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:54 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')]} 13:26:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:54 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 0x1039d9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a8d7a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103878e00>, '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 0x1036e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103873b20>, '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.pXgBcj7Kur/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.6EITWfu3kk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 13:26:54 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 13:26:54 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 13:26:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pXgBcj7Kur/Render', 13:26:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:54 INFO - 'HOME': '/Users/cltbld', 13:26:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:54 INFO - 'LOGNAME': 'cltbld', 13:26:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:54 INFO - 'MOZ_NO_REMOTE': '1', 13:26:54 INFO - 'NO_EM_RESTART': '1', 13:26:54 INFO - 'PAGER': '/bin/cat', 13:26:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:54 INFO - 'PWD': '/builds/slave/test', 13:26:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:54 INFO - 'SHELL': '/bin/bash', 13:26:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6EITWfu3kk/Listeners', 13:26:54 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 13:26:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:54 INFO - 'USER': 'cltbld', 13:26:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:54 INFO - 'XPC_FLAGS': '0x0', 13:26:54 INFO - 'XPC_SERVICE_NAME': '0', 13:26:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:55 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)) 13:26:55 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)) 13:26:55 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)) 13:26:55 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)) 13:26:55 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)) 13:26:55 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)) 13:26:55 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)) 13:26:55 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)) 13:26:55 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)) 13:26:55 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)) 13:26:55 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)) 13:26:55 INFO - Cleaning up... 13:26:55 INFO - Return code: 0 13:26:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:55 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 0x1039d9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a8d7a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103878e00>, '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 0x1036e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103873b20>, '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.pXgBcj7Kur/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.6EITWfu3kk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 13:26:55 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 13:26:55 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 13:26:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pXgBcj7Kur/Render', 13:26:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:55 INFO - 'HOME': '/Users/cltbld', 13:26:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:55 INFO - 'LOGNAME': 'cltbld', 13:26:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:55 INFO - 'MOZ_NO_REMOTE': '1', 13:26:55 INFO - 'NO_EM_RESTART': '1', 13:26:55 INFO - 'PAGER': '/bin/cat', 13:26:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:55 INFO - 'PWD': '/builds/slave/test', 13:26:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:55 INFO - 'SHELL': '/bin/bash', 13:26:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6EITWfu3kk/Listeners', 13:26:55 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 13:26:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:55 INFO - 'USER': 'cltbld', 13:26:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:55 INFO - 'XPC_FLAGS': '0x0', 13:26:55 INFO - 'XPC_SERVICE_NAME': '0', 13:26:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:55 INFO - Downloading/unpacking jsonschema 13:26:55 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 13:26:55 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 13:26:55 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 13:26:55 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 13:26:55 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 13:26:55 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 13:26:57 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:26:57 INFO - Downloading/unpacking functools32 (from jsonschema) 13:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:58 INFO - Downloading functools32-3.2.3-2.tar.gz 13:26:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:26:58 INFO - warning: no files found matching '*.txt' 13:26:58 INFO - no previously-included directories found matching 'build' 13:26:58 INFO - no previously-included directories found matching 'dist' 13:26:58 INFO - no previously-included directories found matching '.git*' 13:26:58 INFO - Installing collected packages: jsonschema, functools32 13:26:58 INFO - Running setup.py install for functools32 13:26:58 INFO - warning: no files found matching '*.txt' 13:26:58 INFO - no previously-included directories found matching 'build' 13:26:58 INFO - no previously-included directories found matching 'dist' 13:26:58 INFO - no previously-included directories found matching '.git*' 13:26:58 INFO - Successfully installed jsonschema functools32 13:26:58 INFO - Cleaning up... 13:26:58 INFO - Return code: 0 13:26:58 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:26: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')]} 13:26:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26: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')]} 13:26:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:58 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 0x1039d9a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1039e9420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe5a8d7a8d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103878e00>, '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 0x1036e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103873b20>, '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.pXgBcj7Kur/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.6EITWfu3kk/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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 13:26:58 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 13:26:58 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 13:26:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pXgBcj7Kur/Render', 13:26:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:58 INFO - 'HOME': '/Users/cltbld', 13:26:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:58 INFO - 'LOGNAME': 'cltbld', 13:26:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:58 INFO - 'MOZ_NO_REMOTE': '1', 13:26:58 INFO - 'NO_EM_RESTART': '1', 13:26:58 INFO - 'PAGER': '/bin/cat', 13:26:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:58 INFO - 'PWD': '/builds/slave/test', 13:26:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:58 INFO - 'SHELL': '/bin/bash', 13:26:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6EITWfu3kk/Listeners', 13:26:58 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 13:26:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:58 INFO - 'USER': 'cltbld', 13:26:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:58 INFO - 'XPC_FLAGS': '0x0', 13:26:58 INFO - 'XPC_SERVICE_NAME': '0', 13:26:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:58 INFO - Downloading/unpacking flake8 13:26:58 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 13:26:58 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 13:26:58 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 13:26:58 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 13:26:58 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 13:26:58 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 13:27:01 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:27:01 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:27:01 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 13:27:01 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 13:27:01 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 13:27:01 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 13:27:01 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 13:27:01 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 13:27:01 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:27:01 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:27:01 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 13:27:01 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 13:27:01 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 13:27:01 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 13:27:01 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 13:27:01 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 13:27:02 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:27:02 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 13:27:02 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 13:27:02 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 13:27:02 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 13:27:02 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 13:27:02 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 13:27:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:27:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:27:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:27:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:27:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:27:02 INFO - no previously-included directories found matching 'docs/_build' 13:27:02 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:27:02 INFO - Running setup.py install for pep8 13:27:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:27:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:27:02 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:27:02 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:27:02 INFO - no previously-included directories found matching 'docs/_build' 13:27:02 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:27:02 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:27:02 INFO - Cleaning up... 13:27:02 INFO - Return code: 0 13:27:02 INFO - Running post-action listener: _resource_record_post_action 13:27:02 INFO - Running post-action listener: _start_resource_monitoring 13:27:02 INFO - Starting resource monitoring. 13:27:02 INFO - ##### 13:27:02 INFO - ##### Running install step. 13:27:02 INFO - ##### 13:27:02 INFO - Running pre-action listener: _resource_record_pre_action 13:27:02 INFO - Running main action method: install 13:27:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:27:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:27:03 INFO - Reading from file tmpfile_stdout 13:27:03 INFO - Detecting whether we're running mozinstall >=1.0... 13:27:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:27:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:27:03 INFO - Reading from file tmpfile_stdout 13:27:03 INFO - Output received: 13:27:03 INFO - Usage: mozinstall [options] installer 13:27:03 INFO - Options: 13:27:03 INFO - -h, --help show this help message and exit 13:27:03 INFO - -d DEST, --destination=DEST 13:27:03 INFO - Directory to install application into. [default: 13:27:03 INFO - "/builds/slave/test"] 13:27:03 INFO - --app=APP Application being installed. [default: firefox] 13:27:03 INFO - mkdir: /builds/slave/test/build/application 13:27:03 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'] 13:27:03 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 13:27:25 INFO - Reading from file tmpfile_stdout 13:27:25 INFO - Output received: 13:27:25 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:27:25 INFO - Running post-action listener: _resource_record_post_action 13:27:25 INFO - ##### 13:27:25 INFO - ##### Running run-tests step. 13:27:25 INFO - ##### 13:27:25 INFO - Running pre-action listener: _resource_record_pre_action 13:27:25 INFO - Running main action method: run_tests 13:27:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:27:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:27:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:27:25 INFO - 2016-07-08 13:27:25.020 screenresolution[1641:7378] starting screenresolution argv=screenresolution get 13:27:25 INFO - 2016-07-08 13:27:25.023 screenresolution[1641:7378] Display 0: 1600x1200x32@60 13:27:25 INFO - 2016-07-08 13:27:25.029 screenresolution[1642:7381] starting screenresolution argv=screenresolution list 13:27:25 INFO - Available Modes on Display 0 13:27:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:27:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:27:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:27:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:27:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:27:25 INFO - Intel Iris: 13:27:25 INFO - Chipset Model: Intel Iris 13:27:25 INFO - Type: GPU 13:27:25 INFO - Bus: Built-In 13:27:25 INFO - VRAM (Dynamic, Max): 1536 MB 13:27:25 INFO - Vendor: Intel (0x8086) 13:27:25 INFO - Device ID: 0x0a2e 13:27:25 INFO - Revision ID: 0x0009 13:27:25 INFO - Displays: 13:27:25 INFO - Display: 13:27:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:27:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:27:25 INFO - Display Serial Number: 1600x1200 60 13:27:25 INFO - Main Display: Yes 13:27:25 INFO - Mirror: Off 13:27:25 INFO - Online: Yes 13:27:25 INFO - Rotation: Supported 13:27:25 INFO - Return code: 0 13:27:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:27:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:27:25 INFO - Python 2.7.3 13:27:25 INFO - Return code: 0 13:27:25 INFO - grabbing minidump binary from tooltool 13:27:25 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')]} 13:27:25 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 0x103878e00>, '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 0x1036e1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103873b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:27:25 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 13:27:25 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 13:27:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:27:25 INFO - Return code: 0 13:27:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:27:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:27:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:27:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:27:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:27:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:27:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:27:26 INFO - Return code: 0 13:27:26 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', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0387', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 13:27:26 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 --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0387 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 13:27:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.pXgBcj7Kur/Render', 13:27:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:27:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:27:26 INFO - 'HOME': '/Users/cltbld', 13:27:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:27:26 INFO - 'LOGNAME': 'cltbld', 13:27:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:27:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:27:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:27:26 INFO - 'MOZ_NO_REMOTE': '1', 13:27:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:27:26 INFO - 'NO_EM_RESTART': '1', 13:27:26 INFO - 'PAGER': '/bin/cat', 13:27:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:27:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:27:26 INFO - 'PWD': '/builds/slave/test', 13:27:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 13:27:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:27:26 INFO - 'SHELL': '/bin/bash', 13:27:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.6EITWfu3kk/Listeners', 13:27:26 INFO - 'TMPDIR': '/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/', 13:27:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:27:26 INFO - 'USER': 'cltbld', 13:27:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:27:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:27:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:27:26 INFO - 'XPC_FLAGS': '0x0', 13:27:26 INFO - 'XPC_SERVICE_NAME': '0', 13:27:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:27:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0387', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 13:27:26 INFO - mozversion application_buildid: 20160708113726 13:27:26 INFO - mozversion application_changeset: 23d50da987261085138dab3f05eae49806d9bf1b 13:27:26 INFO - mozversion application_display_name: Firefox 13:27:26 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:27:26 INFO - mozversion application_name: Firefox 13:27:26 INFO - mozversion application_remotingname: firefox 13:27:26 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:27:26 INFO - mozversion application_vendor: Mozilla 13:27:26 INFO - mozversion application_version: 48.0 13:27:26 INFO - mozversion platform_buildid: 20160708113726 13:27:26 INFO - mozversion platform_changeset: 23d50da987261085138dab3f05eae49806d9bf1b 13:27:26 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:27:26 INFO - mozversion platform_version: 48.0 13:27:26 INFO - using testdate: 1468009646 13:27:26 INFO - actual date: 1468009646 13:27:26 INFO - starting webserver on 'localhost:49275' 13:27:26 INFO - SUITE-START | Running 2 tests 13:27:26 INFO - TEST-START | dromaeo_css 13:27:26 INFO - operating with platform_type : mac_ 13:27:26 INFO - Initialising browser for dromaeo_css test... 13:27:26 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmp6ppVfX/profile http://localhost:49275/getInfo.html) 13:27:29 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 13:27:29 INFO - PROCESS | 1660 | colorDepth:24 13:27:29 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 13:27:29 INFO - PROCESS | 1660 | __metrics 13:27:29 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:27:29 ERROR - PROCESS | 1660 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:27:29 INFO - TEST-INFO | 1660: exit 0 13:27:29 INFO - Browser initialized. 13:27:29 INFO - Running cycle 1/1 for dromaeo_css test... 13:27:29 INFO - TEST-INFO | started process 1663 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmp6ppVfX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:27:41 INFO - PROCESS | 1663 | RSS: Main: 161607680 13:27:41 INFO - PROCESS | 1663 | 13:28:33 INFO - PROCESS | 1663 | 1468009713187 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] 13:30:42 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 13:30:44 INFO - PROCESS | 1663 | RSS: Main: 253497344 13:30:44 INFO - PROCESS | 1663 | 13:33:46 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 13:33:47 INFO - PROCESS | 1663 | RSS: Main: 305254400 13:33:47 INFO - PROCESS | 1663 | 13:36:49 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 13:36:49 INFO - PROCESS | 1663 | RSS: Main: 308031488 13:36:49 INFO - PROCESS | 1663 | 13:39:51 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 13:39:52 INFO - PROCESS | 1663 | RSS: Main: 310738944 13:39:52 INFO - PROCESS | 1663 | 13:42:55 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 13:42:56 INFO - PROCESS | 1663 | RSS: Main: 282185728 13:42:56 INFO - PROCESS | 1663 | 13:45:58 INFO - PROCESS | 1663 | Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 13:45:59 INFO - PROCESS | 1663 | RSS: Main: 317083648 13:45:59 INFO - PROCESS | 1663 | 13:45:59 INFO - PROCESS | 1663 | __start_tp_report 13:45:59 INFO - PROCESS | 1663 | _x_x_mozilla_page_load 13:45:59 INFO - PROCESS | 1663 | _x_x_mozilla_page_load_details 13:45:59 INFO - PROCESS | 1663 | |i|pagename|runs| 13:45:59 INFO - PROCESS | 1663 | |0;dojo.html;3346.4143774839404;3612.6929211017064;3613.873514426994;3631.9092022699438;3690.778553286803;4876.2198048312275;5892.086726557385;5897.46922776951;5907.232059832216;5915.846409950062;4428.914915845614;5753.769849206037;5960.165576819238;5960.821175364736;5979.222701048869;5253.159494480874;5274.973625131869;5297.602679799012;5372.086745253317;5389.407165211824;5331;5388.595855310848;5398.109311963541;5401.972990135044;5403.243545903577;5272.947270527303;5310.468953104678;5354.785808567653;5360.463953604647;5392.433794451585;5342.519173274424;5356.303680521546;5357.705326207057;5374.838754837361;5401.351837779453;5132.384113906318;5238.423773384925;5284.365876094855;5312.787488500456;5313.9637770634745;5691.117876729114;5711.171880077365;5742;5760.481556659921;5788.623739456922;6287.151234583364;6290;6297.244330680302;6301.558890877594;6311.08489269058;6236.189295391616;6273.184486016834;6296.212973378328;6296.590721603081;6320.399562041599;5934.5252379809945;5939.46544810969;5941.138534912414;5944.702764861783;5996.760129594767;6346.904796428057;6360.6501642409185;6365.713542890581;6375.968120159369;6378.202724659418;6165.229346331708;6191.473724733448;6299;6304.779332723333;6308.179936608303;6302.306746257908;6302.873942521124;6308.7476500940365;6309.432151106423;6323.462505686976;6280.717367718372;6347.143135676624;6354.8411289717205;6355.332690067568;6364;6232.532560058014;6340.778072767431;6343.777967771198;6348.587341822767;6350.047492876013;4975.800967961313;5047.015831912742;5051.924221136685;5066.189409694432;5098.566621837112;4525.660575456854;4536.97917968461;4538.591526762541;4545.681802273809;4575.519570445122;4864.586510146606;5917.112433135064;6075.2405949256345;6081.7871374502565;6116.938830611637;6236.282827474898;6304.148939893055;6308.621482711052;6313.305536390993;6316.557840951181;5999.430054144849;6009.729562169713;6023.728932198062;6049.820285044462;6087;5434.809781657623;5449.264349312792;5528.640638358494;5548.334199895958;5567.9977604031665;5411.78352865881;5462.945370546323;6462.644554549545;6481.611103333815;6493.253275873335;5299.655522391032;6290.937090629218;6294.3076261612105;6295.307516173309;6307.022411526221;6331.9366806331345;6368.554201205871;6456.903146452713;6460.418562329413;6482.157319548429;5315.6279060465395;6346.968265158829;6362.172917520693;6364.904526432199;6367.267764207176;6265.060240963892;6299.433051025429;6324.4940404766585;6325.462335701332;6334.714937827716;6184.938150618436;6207.472364848858;6258.968705156445;6312.936870631419;6332.588381755171;6069.696515174312;6245.96877015612;6287.182666253358;6297.244330680348;6311.0217916223055;6149;6171.691415429121;6187.3503282154725;6190;6209.59637623553;6123.969380153071;6183.041628547582;6257.624542527463;6300.117983482224;6319.399657032574;6127.908081378872;6169.475594574512;6189.226346706661;6189.876202476015;6197.1324014638885 13:45:59 INFO - PROCESS | 1663 | |1;ext.html;531.542873129109;540.7972010496064;579.111064515968;586.2671660424469;621.871303583995;27971.720282797167;32463;32514.0245792626;32567;32600.347993040155;33592.49611255833;34063.65936340636;34104.829475852646;34182;38812;9558.378705384162;9738.464384458852;9741.853872191923;9753.756156096084;9770.364926279804;9589.520523973808;9702.466364349957;9707.126358627722;9714.319997600136;9722.659706910259;8214.794630134234;9129.771755706093;9315.347925645208;9324.347295689304;11755.7061073473;11496;11597.304161750322;11617;11621.6513504595;11626.767464650744;11530.42347882611;11639.243449175776;11646.534138634444;11647.184697071209;11650.708732281675;38993.61006389928;39294.60705392966;39298;39329.80335098335;39360.80319598383;3148.307372378073;3215;3220.5652236947944;3392.6607339266125;3485.8082805445692;28558.571621425694;28686.282842928886;29319.853400733075;29843.701562984526;30528;2344.8510229987182;2750.4499100180046;2776.1810265971385;2792.5531914893722;2996.9400611987858;545841;546224;546405.2679736615;547296;557129;37112.62887371146;37592.81203593964;37650;59528.40471595229;59537;35882;35964.64035359665;35987.640123598954;36013;36140.277194455964;16092.356305747873;16252.83747162537;16253.756193657104;16271.593210169603;16292.592685182728;13745;13811.102278351875;13812.37844297009;13819.930900345435;13822.723545529034;8362.45644033136;8483.406161568631;8485.406021578554;8545.572721363907;8565.52889591066;3361.7057432888514;3456.2741824217196;3510.8946731598094;3579.6062433132333;3609.314230296235;907.3829795738961;1002.5288114586133;1018.5772904244656;1117.279354816139;1198.4876938327204;30764.230894227825;30828.38343233123;30880.073597792103;31258.68741312558;31503.684963150532;1102.6416414665266;1179.1922533064878;1184.3012622552562;1223.5228260978226;1248.6940699528493;15705.45030923935;15849.683006339808;15910.363585456684;16153.596160095856;16165.838341616669;638971;639931;646732;649537;650184;55276.723616382464;62134;62703.059454108225;62727;63110;1558.454540910695;1560.360252296553;1567.7334853075004;1574.1106274954614;1575.7242482565734;28269.29326766765;29403.970861019763;29543.55684664775;30096.398072038875;30268.54597181;47650.76174619105;48183.75908120437;48594.51405486041;48602.5139748598;48723.75638121787;383071;634793;668660;669534;671571;26454;26517.734822651528;26773.866130669223;27032;27199.04803331874;43274.35088473612;46120.30819537643;46284.7685761569;46331.30503042389;46408.76795616;36085.45871811872;37768.81115594514;38149.80925095357;38955.80522097485;40806.38790418087;35174.296514069065;38066;38078.23843523059;38087;38757.22485550329;37130.6286937138;37256.44115338218;37880.24239515139;38125;38305.6169438302;32781;32873.506897397034;33432.66567334393;33783.662163379035;34012.659873400946;24970.691091588353;25184.748152518972;25241.368965776004;25710.871445642653;25744.8712756435 13:45:59 INFO - PROCESS | 1663 | |2;jquery.html;414.20472692430536;421.38688208656407;421.56368158955485;427.6236911517866;432.3212556286629;20258.189672413122;20764.480887977807;20840.583188336244;21259.68110478344;21439.249626263085;20203.59592808143;20412.775233486;22536.323910282677;22595.209167679135;22597.435064123405;6016.789412370557;6070.605410648316;6232.750689972396;6275.717592708339;6284.27730810958;6065.909011364833;6147.969260153693;6303.905441418382;6304.873902521947;6311.905321420182;6211.751529938797;6259.374062593727;6272.090546870701;6276.027215781562;6284.528660350469;6029.282518376485;6199.132121502993;6253.405926436982;6293.276273228568;6309.990401535778;5423.29497165366;5460.235567020581;5468.808591699311;5471.50756431923;5472.699001554913;25299.87350063238;25465.872670636712;25605.231843044738;25659.871700641565;26489.47021059568;2204.206485665159;2210.9889450552646;2227.855189412683;2612.673415823022;2666.6933302670245;12736.80894786579;12901.58082610912;14942.402303907831;15520.5343839685;15699.843001570067;1777.9111044447725;1785.6875046866876;1822.599028213791;1888.8016758240462;1891.886486810782;110608.89391106147;111924;112805;114015;114762.42618786937;11236.381998989971;11574.247673901169;11708.70728231784;11783.587574435025;11816.881831181578;14619.92690036543;14652.267386630625;14687.853121468648;14695.26523673812;14723.631909202355;7437.367823735043;8742.606582703793;9049.457032577935;9179.0820917909;9179.714839922417;9156.496392698333;9156.816863662823;9170.220531254785;9178.632854685871;9193.63225470987;4599;4730.942040212519;4736.194846876039;4746.5728084471875;4754.23932170851;1737.0967097109685;1937.6318499485335;2011.406635042666;2021.6259991901545;2031.918723251083;876.3602570123845;907.584168696835;1095.4194277033184;1129.3844854554122;1136.886311368873;16768.41310554149;20507.794922050885;20529.447322539312;21189.89405052965;21190.682139767916;1009.9040591143829;1045.0698877998586;1048.224314007629;1060.3849767135043;1085.2837127495816;11035.83446248307;11294;11302.039326657326;11334.263272887236;11340.149488788375;609335;613386;613698;616397;639129;106836;121569.17646235313;122276;127398.72601274055;128350.71649283574;1007.5415685862915;1023.0741179232806;1035.6427032673716;1036.098594223031;1040.7294103533136;18378.72431913549;18454.169562369992;18768.436946891616;19645.705314420582;19741.703874441606;56345.02792402246;57131;57419.99999999833;59216.81566368735;59519;75980;78727.60636196782;78937.60531197308;79414;79416.60291698505;8117.025956885212;8202.097769245498;8429.283510901641;8474.74575762728;8706.085860984505;12004.879951200726;12770.042246831339;12797.8080328797;13130.606081817561;13133.802992955305;10055.145312648214;11100.944495277796;11138.55445782192;11173.217874748689;11339.206255562032;11052.889471105185;11064.668059958214;11162.218644694793;11319.547218111184;11369.602063928054;11186.161037922351;11543.942280288546;11699.590514331958;11799.233049851731;11907.82138267944;8239.423240373357;8285.295749861089;8345.082040975367;8396.916030839613;8633.870491942751;8475.915240847513;10773;10982.176336774934;11263.605773797877;11611.187216895074 13:45:59 INFO - PROCESS | 1663 | |3;mootools.html;1485.0347274271728;1612.7661489084082;1635.8200597934228;1913.5407502199469;2026.655468570343;8441.155884411564;8694.608742606573;8696.217340439367;9088.000319964814;9255;9114.997350291462;9186.219171370425;9305.209057230126;9309.674161404353;9345.859812102824;2576.4460640962143;2601.9349516262055;2607.191770551126;2607.960880586793;2609.2563619368484;2484.0808900706766;2595.065776320523;2600.154949641374;2600.3239157819007;2602.1803132013356;2555.4250293683867;2581.6901971763414;2605.8436493810336;2606.0748434305833;2606.947861042778;2564.525562770884;2593.5201987632254;2602.7917766578817;2609.7520735530093;2610.386559158606;2543.3260186050525;2574.897004119833;2584.3926677230834;2588.262345231619;2597.6623039005;9343.39267947588;9388.483633400161;9417.293702972236;9430.151286384258;9432.386894851812;5752.741126649311;5761;5864.266966629171;5943.197668314765;5955;3666.2484190740834;3740.36413809653;3776.9055773605605;3821.407681809324;3835.4822099016556;1112;1665.7334826427834;1693.1365003848002;1708.1459270364817;1739.339051160551;12386.442610082568;12483.75032499354;12489.812652810215;12496.562620308245;12503.249805011637;4765.499622539653;4804.568376153563;4847.684900481458;4882.170031094723;4903.632227582945;9828.606855725691;9829.4102353859;9850.950745246228;9855.950720246496;9866.408015518948;5696.060150075191;5701.486866182064;5713.74288157034;5726.513246374105;5757.971210144006;4721.315409265637;4732.739699316502;4830.6135509159185;4878.219484882473;5340.519353258225;4037.253108174997;4051.2707712612014;4115.218108559364;4149.937750933738;4162.4796900387455;1118.0999295566985;1257.5975687779824;1297.9935100324437;1306.679863433446;1308.2869835939437;869.482657818597;950.1875896108866;962.8008752735146;966.9129778319844;997.5311603546321;5416.566674666017;6084.817455476343;6143.38566143391;6235.469985051231;6300.842478938063;466.7339616418609;482.91548978928546;485.37629146546516;495.56637941800926;498.41934146719393;3960.4257382679352;4069.3895915612893;4080.081981554186;4101.835926562904;4161.9583804161575;11352.716182095513;11483.71290717722;11721.882781172078;11721.88278117225;11731.589394371156;11383.430828458544;11549.6535103947;11559.884401155881;11562.479688414041;11577.479013444416;8296.751097467086;8794.472331660121;8806.119388061143;9003.369764116449;9003.954980225057;5982.491488223375;6031.5476339273855;6169.043798211284;6188.907166392598;6199.5040396767245;10247.180225582084;10256.897431025594;10325.32885362449;10507.106895913934;10520.158387328842;10287.897121028695;10454.895451045391;10548.736281592715;10725.141988640735;10783.083437907866;7204.56772593646;7396.260373962561;7929.048514178336;8060;8470.872936906075;8728.952525696957;8729.91270087291;8802.559872006246;8817.867731984154;8835.911640883509;7169.426445884213;7667.194944530744;7687.9231207689445;7749.690012399441;7970.641321140447;7494.5503269803985;7562.319391254813;7617.42869284817;7773.028371453568;7822.921770782447;7252.2747725227055;7358.374538164102;7368.447366447431;7389.298016688406;7401.148867880047;5039.974800125976;5061.544460998381;5099.439061703136;5194.7922083116255;5200.037992971313;5192.584593232456;5209.114450543492;5269.920951185812;5434.2935418395355;5468.671879687232 13:45:59 INFO - PROCESS | 1663 | |4;prototype.html;326.6358010817937;332.64573229510574;342.14805135213317;343.0275169893352;346.4577935530894;6205.875882482348;6389.424951754341;6463.547551671385;6488.4809215262785;6526.412622863942;6512.902306465407;6554.180727409074;6555.41001309882;6605.83485412865;6669.19969603647;4937.876553086184;4952.529509696573;4956.265307142489;4958.925616115761;4962.975185124069;4701.78841952113;4785.760711964405;4867.902641947159;4954.7522623868845;4961.5286547777905;4868.659193856432;4907.386576677915;4910.656254062217;4927.753612319388;4948.876278093058;4227.154569086195;4693.474620748253;4914.827981020683;4927.211646136637;4928.7782049807665;3582.946255806165;4142.544320124784;4212.978935105336;4220.873373798791;4222.85220017301;6405.0072238802595;6418.06937993993;6418.582792118497;6463.159789227418;6472.611643301417;5777.62445441045;5791.160281759164;5796.217510636052;5808.244928159313;5817.767289308423;6990.54561453509;7009.964950175267;7011.193712723051;7031.332023457763;7038.260982596856;4697.8355757548325;4700.670953033289;4704.200285951397;4714.882127946795;4719.056188762227;7094.787156385317;7334.009908662316;7460.813479662997;7487.737929172453;7497.587632680201;4638.165130276582;4788.257820037899;4794.352762377104;4795.928061079087;4811.663183577116;4816.831410900601;4889.559939605381;4896.95103048972;4897.902041959141;4914.631402644816;4687.812487500461;5775.884482310415;5810.070388737781;5810.157527158538;5857.677827719431;7047.40097091753;7056.964715176391;7057.611831349325;7058.329458701415;7066.50534462593;1565.6790357976588;1637.5496738397037;1646.9505914822576;1696.0756387768695;1721.1050253868168;1025.8307379282485;1029.156092004549;1037.5227395398201;1045.4511381524608;1045.5033858917106;6672.232693240242;6777.559458635173;6805.3875151236625;6807.591544507345;6816.62508562024;6099.3900609938655;7212.567245965259;7467.589282589401;7472;7533.623318834037;5592.468715472024;6892.586444813327;6901.896471552931;6909.792706218822;6921.446284297244;3904.550976637723;3958.426028225891;3960.663343615767;3966.2662407454136;3970.047188674755;7574.697012119564;7854;7867.134615192324;7880.881786773203;7898.565578893101;7603;7603.201663825329;7620.695172193161;7631.3513351365755;7644.655990480442;7679.462437629312;7777.57223352721;7790.948221989959;7821.413393995587;7825.726099586601;7392.519486233377;7421.443391745749;7421.591812450367;7427.7771666850085;7440.888386674096;6895.6552172390175;7012.03662974368;7262.237465066303;7267.927320726725;7281.781546553612;7111.217766045835;7759.6120193988945;7800.687972481264;7804.6878124874365;7814.57019863913;4436.9334459983775;4529.162105010583;4663.836765713184;4729.574338309569;4735.668503204743;7179.8564028720175;7226.783196504113;7237.493375463667;7242;7248.347648711641;7136.892946605909;7148.606826624377;7168.319009694071;7172.641367931478;7188.101487314086;7140.9285907140265;7142.785716428515;7144.857102858018;7157.427405807627;7166.964165179141;6731.124953755981;6963.9303606963285;6987.895181572382;6990.61551614666;6997.47518936092;7095.9645201773665;7103.431725462054;7108.431325493844;7137.1435427749;7154.248803875518;6996.825079373057;6998;7004.3696067354185;7004.929950700632;7024.121984751906 13:45:59 INFO - PROCESS | 1663 | |5;yui.html;741.836795904901;767.9824232891414;792.2750683124941;799.0291795468509;801.3629164813974;13070.496892857323;14144.363503642335;15620.843791562082;15735.921320393381;15737.763933540977;14456.710865782705;14542.491012814553;14548.709025819477;14555.78166327506;14564.927175364135;800.7157459102023;815.3680897304607;956.4500412262942;965.1506674126776;983.2576404814355;915.8597546055138;953.9887719017863;960.3373672166218;969.3117886300735;969.8981606931242;1037.258360272405;1039.173856783855;1044.4934206909643;1048.1457612046158;1048.9108425783818;734.9412047036225;1009.2783659683325;1023.8720159980003;1030.2788048366174;1030.695944696309;772.2933515833006;772.4631381190076;774.531408497862;775.7517594369804;777.1373775109623;15144.93985421021;15191.696166076617;15202.46791362308;15231.61920951974;15269.61825954349;11565.61212654487;12044.39778011096;12805.807912881315;12849.35753212345;13129.60611181666;11171.44142792857;11277.943610281978;11303.095752339794;11539.48072336747;11763.058955283557;3450.1719587299117;3526.823658817049;3540;3547.0600290922926;3651.6165802590613;83335;83706.58146709288;83732;83759.06843260456;84063;9487.762805929908;9572.712818615453;9619.374740641835;9669.129778319984;9703.9029609703;21467.463313416978;21540.13839446436;21543;21543.67684484734;21610.243641472473;7697.615119244016;7726.768196953988;7734.381249500027;7800.960995194988;7952.483088599222;4212.094399704079;4225.767582782915;4266.957330426656;4366.8034938427845;4547.931781023287;3726.832292546842;3785.6971442284553;3785.981070094687;3787.3561494545993;3788.318102741478;650.9544331896722;671.53328436736;671.5936858200719;676.7732809508772;693.8889777635554;559.6474221240593;609.8597322615823;621.1056079245961;622.1072760588479;630.6058713304185;8196.30331421824;8228.42401031934;8267.958660206661;8324.001119865656;8425.73613957899;550.8650380656685;619.5446346935089;621.7015832400383;624.5769035018744;630.8959021761358;3833.5208098987628;3883.203943191639;3899.66852817508;3947.111899822517;4045.453863728359;90415.54792225997;90758.54620726986;91648;92207;92268;63958.68020659867;64571;70462.29537704558;74255;80175;67755;68809.65595172092;68884.6555767228;69447.44420446453;70108;7688;7753.379729621504;7928.960355198187;7943.721969731032;7982.08206056311;50989.49010509996;51225;51391;51418;51702.22446663379;62259;65098;70243.29756702571;70653;71458.64270678614;9946;10105.797884042426;10150.086492215736;10220.540075696463;10293.639722609672;10749.086327662237;11360.488778004845;11383.317000979967;11394.544218231178;11626.70933226676;9339.53302334867;10098.899011009797;10125.139363154214;10485.161187105166;10570.947145264225;10182.083612474617;10587.947060264649;10737.248392612442;10772.084372828398;10952.890471095187;10437.373757574569;10567.89432105669;10575.524101415609;10604.469776511298;10637.414942178255;7312.744053958086;8663.39356245082;8838.690645827364;8993;9198.310126740387;7645.88531172044;8758.255548278468;9092.863607045767;9143.222826059859;9150.40522366044 13:45:59 INFO - PROCESS | 1663 | __end_tp_report 13:45:59 INFO - PROCESS | 1663 | __start_cc_report 13:45:59 INFO - PROCESS | 1663 | _x_x_mozilla_cycle_collect,1220 13:45:59 INFO - PROCESS | 1663 | __end_cc_report 13:45:59 INFO - PROCESS | 1663 | __startTimestamp1468010759112__endTimestamp 13:45:59 INFO - PROCESS | 1663 | 13:45:59 INFO - PROCESS | 1663 | ------- Summary: start ------- 13:45:59 INFO - PROCESS | 1663 | Number of tests: 6 13:45:59 INFO - PROCESS | 1663 | 13:45:59 INFO - PROCESS | 1663 | [#0] dojo.html Cycles:165 Average:5842.29 Median:6149.00 stddev:644.66 (10.5%) stddev-sans-first:616.19 13:45:59 INFO - PROCESS | 1663 | Values: 3346.4 3612.7 3613.9 3631.9 3690.8 4876.2 5892.1 5897.5 5907.2 5915.8 4428.9 5753.8 5960.2 5960.8 5979.2 5253.2 5275.0 5297.6 5372.1 5389.4 5331.0 5388.6 5398.1 5402.0 5403.2 5272.9 5310.5 5354.8 5360.5 5392.4 5342.5 5356.3 5357.7 5374.8 5401.4 5132.4 5238.4 5284.4 5312.8 5314.0 5691.1 5711.2 5742.0 5760.5 5788.6 6287.2 6290.0 6297.2 6301.6 6311.1 6236.2 6273.2 6296.2 6296.6 6320.4 5934.5 5939.5 5941.1 5944.7 5996.8 6346.9 6360.7 6365.7 6376.0 6378.2 6165.2 6191.5 6299.0 6304.8 6308.2 6302.3 6302.9 6308.7 6309.4 6323.5 6280.7 6347.1 6354.8 6355.3 6364.0 6232.5 6340.8 6343.8 6348.6 6350.0 4975.8 5047.0 5051.9 5066.2 5098.6 4525.7 4537.0 4538.6 4545.7 4575.5 4864.6 5917.1 6075.2 6081.8 6116.9 6236.3 6304.1 6308.6 6313.3 6316.6 5999.4 6009.7 6023.7 6049.8 6087.0 5434.8 5449.3 5528.6 5548.3 5568.0 5411.8 5462.9 6462.6 6481.6 6493.3 5299.7 6290.9 6294.3 6295.3 6307.0 6331.9 6368.6 6456.9 6460.4 6482.2 5315.6 6347.0 6362.2 6364.9 6367.3 6265.1 6299.4 6324.5 6325.5 6334.7 6184.9 6207.5 6259.0 6312.9 6332.6 6069.7 6246.0 6287.2 6297.2 6311.0 6149.0 6171.7 6187.4 6190.0 6209.6 6124.0 6183.0 6257.6 6300.1 6319.4 6127.9 6169.5 6189.2 6189.9 6197.1 13:45:59 INFO - PROCESS | 1663 | 13:45:59 INFO - PROCESS | 1663 | [#1] ext.html Cycles:180 Average:70896.59 Median:3498.35 stddev:162189.16 (4636.2%) stddev-sans-first:162558.10 13:45:59 INFO - PROCESS | 1663 | Values: 531.5 540.8 579.1 586.3 621.9 27971.7 32463.0 32514.0 32567.0 32600.3 33592.5 34063.7 34104.8 34182.0 38812.0 9558.4 9738.5 9741.9 9753.8 9770.4 9589.5 9702.5 9707.1 9714.3 9722.7 8214.8 9129.8 9315.3 9324.3 11755.7 11496.0 11597.3 11617.0 11621.7 11626.8 11530.4 11639.2 11646.5 11647.2 11650.7 38993.6 39294.6 39298.0 39329.8 39360.8 3148.3 3215.0 3220.6 3392.7 3485.8 28558.6 28686.3 29319.9 29843.7 30528.0 2344.9 2750.4 2776.2 2792.6 2996.9 545841.0 546224.0 546405.3 547296.0 557129.0 37112.6 37592.8 37650.0 59528.4 59537.0 35882.0 35964.6 35987.6 36013.0 36140.3 16092.4 16252.8 16253.8 16271.6 16292.6 13745.0 13811.1 13812.4 13819.9 13822.7 8362.5 8483.4 8485.4 8545.6 8565.5 3361.7 3456.3 3510.9 3579.6 3609.3 907.4 1002.5 1018.6 1117.3 1198.5 30764.2 30828.4 30880.1 31258.7 31503.7 1102.6 1179.2 1184.3 1223.5 1248.7 15705.5 15849.7 15910.4 16153.6 16165.8 638971.0 639931.0 646732.0 649537.0 650184.0 55276.7 62134.0 62703.1 62727.0 63110.0 1558.5 1560.4 1567.7 1574.1 1575.7 28269.3 29404.0 29543.6 30096.4 30268.5 47650.8 48183.8 48594.5 48602.5 48723.8 383071.0 634793.0 668660.0 669534.0 671571.0 26454.0 26517.7 26773.9 27032.0 27199.0 43274.4 46120.3 46284.8 46331.3 46408.8 36085.5 37768.8 38149.8 38955.8 40806.4 35174.3 38066.0 38078.2 38087.0 38757.2 37130.6 37256.4 37880.2 38125.0 38305.6 32781.0 32873.5 33432.7 33783.7 34012.7 24970.7 25184.7 25241.4 25710.9 25744.9 13:45:59 INFO - PROCESS | 1663 | 13:45:59 INFO - PROCESS | 1663 | [#2] jquery.html Cycles:180 Average:35687.16 Median:21190.29 stddev:102740.71 (484.8%) stddev-sans-first:102994.79 13:45:59 INFO - PROCESS | 1663 | Values: 414.2 421.4 421.6 427.6 432.3 20258.2 20764.5 20840.6 21259.7 21439.2 20203.6 20412.8 22536.3 22595.2 22597.4 6016.8 6070.6 6232.8 6275.7 6284.3 6065.9 6148.0 6303.9 6304.9 6311.9 6211.8 6259.4 6272.1 6276.0 6284.5 6029.3 6199.1 6253.4 6293.3 6310.0 5423.3 5460.2 5468.8 5471.5 5472.7 25299.9 25465.9 25605.2 25659.9 26489.5 2204.2 2211.0 2227.9 2612.7 2666.7 12736.8 12901.6 14942.4 15520.5 15699.8 1777.9 1785.7 1822.6 1888.8 1891.9 110608.9 111924.0 112805.0 114015.0 114762.4 11236.4 11574.2 11708.7 11783.6 11816.9 14619.9 14652.3 14687.9 14695.3 14723.6 7437.4 8742.6 9049.5 9179.1 9179.7 9156.5 9156.8 9170.2 9178.6 9193.6 4599.0 4730.9 4736.2 4746.6 4754.2 1737.1 1937.6 2011.4 2021.6 2031.9 876.4 907.6 1095.4 1129.4 1136.9 16768.4 20507.8 20529.4 21189.9 21190.7 1009.9 1045.1 1048.2 1060.4 1085.3 11035.8 11294.0 11302.0 11334.3 11340.1 609335.0 613386.0 613698.0 616397.0 639129.0 106836.0 121569.2 122276.0 127398.7 128350.7 1007.5 1023.1 1035.6 1036.1 1040.7 18378.7 18454.2 18768.4 19645.7 19741.7 56345.0 57131.0 57420.0 59216.8 59519.0 75980.0 78727.6 78937.6 79414.0 79416.6 8117.0 8202.1 8429.3 8474.7 8706.1 12004.9 12770.0 12797.8 13130.6 13133.8 10055.1 11100.9 11138.6 11173.2 11339.2 11052.9 11064.7 11162.2 11319.5 11369.6 11186.2 11543.9 11699.6 11799.2 11907.8 8239.4 8285.3 8345.1 8396.9 8633.9 8475.9 10773.0 10982.2 11263.6 11611.2 13:45:59 INFO - PROCESS | 1663 | 13:45:59 INFO - PROCESS | 1663 | [#3] mootools.html Cycles:180 Average:6019.47 Median:4892.90 stddev:3367.95 (68.8%) stddev-sans-first:3360.15 13:45:59 INFO - PROCESS | 1663 | Values: 1485.0 1612.8 1635.8 1913.5 2026.7 8441.2 8694.6 8696.2 9088.0 9255.0 9115.0 9186.2 9305.2 9309.7 9345.9 2576.4 2601.9 2607.2 2608.0 2609.3 2484.1 2595.1 2600.2 2600.3 2602.2 2555.4 2581.7 2605.8 2606.1 2606.9 2564.5 2593.5 2602.8 2609.8 2610.4 2543.3 2574.9 2584.4 2588.3 2597.7 9343.4 9388.5 9417.3 9430.2 9432.4 5752.7 5761.0 5864.3 5943.2 5955.0 3666.2 3740.4 3776.9 3821.4 3835.5 1112.0 1665.7 1693.1 1708.1 1739.3 12386.4 12483.8 12489.8 12496.6 12503.2 4765.5 4804.6 4847.7 4882.2 4903.6 9828.6 9829.4 9851.0 9856.0 9866.4 5696.1 5701.5 5713.7 5726.5 5758.0 4721.3 4732.7 4830.6 4878.2 5340.5 4037.3 4051.3 4115.2 4149.9 4162.5 1118.1 1257.6 1298.0 1306.7 1308.3 869.5 950.2 962.8 966.9 997.5 5416.6 6084.8 6143.4 6235.5 6300.8 466.7 482.9 485.4 495.6 498.4 3960.4 4069.4 4080.1 4101.8 4162.0 11352.7 11483.7 11721.9 11721.9 11731.6 11383.4 11549.7 11559.9 11562.5 11577.5 8296.8 8794.5 8806.1 9003.4 9004.0 5982.5 6031.5 6169.0 6188.9 6199.5 10247.2 10256.9 10325.3 10507.1 10520.2 10287.9 10454.9 10548.7 10725.1 10783.1 7204.6 7396.3 7929.0 8060.0 8470.9 8729.0 8729.9 8802.6 8817.9 8835.9 7169.4 7667.2 7687.9 7749.7 7970.6 7494.6 7562.3 7617.4 7773.0 7822.9 7252.3 7358.4 7368.4 7389.3 7401.1 5040.0 5061.5 5099.4 5194.8 5200.0 5192.6 5209.1 5269.9 5434.3 5468.7 13:45:59 INFO - PROCESS | 1663 | 13:45:59 INFO - PROCESS | 1663 | [#4] prototype.html Cycles:180 Average:5843.61 Median:6637.52 stddev:1868.79 (28.2%) stddev-sans-first:1827.58 13:45:59 INFO - PROCESS | 1663 | Values: 326.6 332.6 342.1 343.0 346.5 6205.9 6389.4 6463.5 6488.5 6526.4 6512.9 6554.2 6555.4 6605.8 6669.2 4937.9 4952.5 4956.3 4958.9 4963.0 4701.8 4785.8 4867.9 4954.8 4961.5 4868.7 4907.4 4910.7 4927.8 4948.9 4227.2 4693.5 4914.8 4927.2 4928.8 3582.9 4142.5 4213.0 4220.9 4222.9 6405.0 6418.1 6418.6 6463.2 6472.6 5777.6 5791.2 5796.2 5808.2 5817.8 6990.5 7010.0 7011.2 7031.3 7038.3 4697.8 4700.7 4704.2 4714.9 4719.1 7094.8 7334.0 7460.8 7487.7 7497.6 4638.2 4788.3 4794.4 4795.9 4811.7 4816.8 4889.6 4897.0 4897.9 4914.6 4687.8 5775.9 5810.1 5810.2 5857.7 7047.4 7057.0 7057.6 7058.3 7066.5 1565.7 1637.5 1647.0 1696.1 1721.1 1025.8 1029.2 1037.5 1045.5 1045.5 6672.2 6777.6 6805.4 6807.6 6816.6 6099.4 7212.6 7467.6 7472.0 7533.6 5592.5 6892.6 6901.9 6909.8 6921.4 3904.6 3958.4 3960.7 3966.3 3970.0 7574.7 7854.0 7867.1 7880.9 7898.6 7603.0 7603.2 7620.7 7631.4 7644.7 7679.5 7777.6 7790.9 7821.4 7825.7 7392.5 7421.4 7421.6 7427.8 7440.9 6895.7 7012.0 7262.2 7267.9 7281.8 7111.2 7759.6 7800.7 7804.7 7814.6 4436.9 4529.2 4663.8 4729.6 4735.7 7179.9 7226.8 7237.5 7242.0 7248.3 7136.9 7148.6 7168.3 7172.6 7188.1 7140.9 7142.8 7144.9 7157.4 7167.0 6731.1 6963.9 6987.9 6990.6 6997.5 7096.0 7103.4 7108.4 7137.1 7154.2 6996.8 6998.0 7004.4 7004.9 7024.1 13:45:59 INFO - PROCESS | 1663 | 13:45:59 INFO - PROCESS | 1663 | [#5] yui.html Cycles:180 Average:18076.23 Median:620.33 stddev:25427.84 (4099.1%) stddev-sans-first:25465.86 13:45:59 INFO - PROCESS | 1663 | Values: 741.8 768.0 792.3 799.0 801.4 13070.5 14144.4 15620.8 15735.9 15737.8 14456.7 14542.5 14548.7 14555.8 14564.9 800.7 815.4 956.5 965.2 983.3 915.9 954.0 960.3 969.3 969.9 1037.3 1039.2 1044.5 1048.1 1048.9 734.9 1009.3 1023.9 1030.3 1030.7 772.3 772.5 774.5 775.8 777.1 15144.9 15191.7 15202.5 15231.6 15269.6 11565.6 12044.4 12805.8 12849.4 13129.6 11171.4 11277.9 11303.1 11539.5 11763.1 3450.2 3526.8 3540.0 3547.1 3651.6 83335.0 83706.6 83732.0 83759.1 84063.0 9487.8 9572.7 9619.4 9669.1 9703.9 21467.5 21540.1 21543.0 21543.7 21610.2 7697.6 7726.8 7734.4 7801.0 7952.5 4212.1 4225.8 4267.0 4366.8 4547.9 3726.8 3785.7 3786.0 3787.4 3788.3 651.0 671.5 671.6 676.8 693.9 559.6 609.9 621.1 622.1 630.6 8196.3 8228.4 8268.0 8324.0 8425.7 550.9 619.5 621.7 624.6 630.9 3833.5 3883.2 3899.7 3947.1 4045.5 90415.5 90758.5 91648.0 92207.0 92268.0 63958.7 64571.0 70462.3 74255.0 80175.0 67755.0 68809.7 68884.7 69447.4 70108.0 7688.0 7753.4 7929.0 7943.7 7982.1 50989.5 51225.0 51391.0 51418.0 51702.2 62259.0 65098.0 70243.3 70653.0 71458.6 9946.0 10105.8 10150.1 10220.5 10293.6 10749.1 11360.5 11383.3 11394.5 11626.7 9339.5 10098.9 10125.1 10485.2 10570.9 10182.1 10587.9 10737.2 10772.1 10952.9 10437.4 10567.9 10575.5 10604.5 10637.4 7312.7 8663.4 8838.7 8993.0 9198.3 7645.9 8758.3 9092.9 9143.2 9150.4 13:45:59 INFO - PROCESS | 1663 | -------- Summary: end -------- 13:45:59 INFO - PROCESS | 1663 | 13:45:59 INFO - TEST-INFO | 1663: exit 0 13:45:59 INFO - TEST-OK | dromaeo_css | took 1112978ms 13:45:59 INFO - TEST-START | kraken 13:45:59 INFO - operating with platform_type : mac_ 13:45:59 INFO - Initialising browser for kraken test... 13:45:59 INFO - TEST-INFO | started process 1674 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpIJfxUA/profile http://localhost:49275/getInfo.html) 13:46:01 INFO - PROCESS | 1674 | __metrics Screen width/height:1600/1200 13:46:01 INFO - PROCESS | 1674 | colorDepth:24 13:46:01 INFO - PROCESS | 1674 | Browser inner width/height: 1024/689 13:46:01 INFO - PROCESS | 1674 | __metrics 13:46:01 INFO - PROCESS | 1674 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 13:46:01 ERROR - PROCESS | 1674 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 13:46:02 INFO - TEST-INFO | 1674: exit 0 13:46:02 INFO - Browser initialized. 13:46:02 INFO - Running cycle 1/1 for kraken test... 13:46:02 INFO - TEST-INFO | started process 1677 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/tmpIJfxUA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:46:14 INFO - PROCESS | 1677 | RSS: Main: 161173504 13:46:14 INFO - PROCESS | 1677 | 13:46:16 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 13:46:17 INFO - PROCESS | 1677 | RSS: Main: 223883264 13:46:17 INFO - PROCESS | 1677 | 13:46:20 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 13:46:21 INFO - PROCESS | 1677 | RSS: Main: 239300608 13:46:21 INFO - PROCESS | 1677 | 13:46:24 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 13:46:24 INFO - PROCESS | 1677 | RSS: Main: 326160384 13:46:24 INFO - PROCESS | 1677 | 13:46:26 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 13:46:27 INFO - PROCESS | 1677 | RSS: Main: 230412288 13:46:27 INFO - PROCESS | 1677 | 13:46:29 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:46:30 INFO - PROCESS | 1677 | RSS: Main: 232853504 13:46:30 INFO - PROCESS | 1677 | 13:46:33 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 13:46:33 INFO - PROCESS | 1677 | RSS: Main: 269041664 13:46:33 INFO - PROCESS | 1677 | 13:46:36 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 13:46:37 INFO - PROCESS | 1677 | RSS: Main: 270389248 13:46:37 INFO - PROCESS | 1677 | 13:46:40 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 13:46:40 INFO - PROCESS | 1677 | RSS: Main: 268337152 13:46:40 INFO - PROCESS | 1677 | 13:46:42 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:46:42 INFO - PROCESS | 1677 | RSS: Main: 260730880 13:46:42 INFO - PROCESS | 1677 | 13:46:44 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:46:45 INFO - PROCESS | 1677 | RSS: Main: 267784192 13:46:45 INFO - PROCESS | 1677 | 13:46:47 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:46:48 INFO - PROCESS | 1677 | RSS: Main: 271241216 13:46:48 INFO - PROCESS | 1677 | 13:46:50 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:46:51 INFO - PROCESS | 1677 | RSS: Main: 278069248 13:46:51 INFO - PROCESS | 1677 | 13:46:54 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:46:54 INFO - PROCESS | 1677 | RSS: Main: 275034112 13:46:54 INFO - PROCESS | 1677 | 13:46:56 INFO - PROCESS | 1677 | Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 13:46:56 INFO - PROCESS | 1677 | RSS: Main: 335847424 13:46:56 INFO - PROCESS | 1677 | 13:46:56 INFO - PROCESS | 1677 | __start_tp_report 13:46:56 INFO - PROCESS | 1677 | _x_x_mozilla_page_load 13:46:56 INFO - PROCESS | 1677 | _x_x_mozilla_page_load_details 13:46:56 INFO - PROCESS | 1677 | |i|pagename|runs| 13:46:56 INFO - PROCESS | 1677 | |0;ai-astar;113;113;121;112;111;113;113;114;111;135 13:46:56 INFO - PROCESS | 1677 | |1;audio-beat-detection;156;126;174;198;103;162;166;151;183;119 13:46:56 INFO - PROCESS | 1677 | |2;audio-dft;179;187;185;184;183;185;183;184;185;185 13:46:56 INFO - PROCESS | 1677 | |3;audio-fft;70;78;74;151;59;55;54;62;130;55 13:46:56 INFO - PROCESS | 1677 | |4;audio-oscillator;92;91;139;80;92;86;126;79;82;138 13:46:56 INFO - PROCESS | 1677 | |5;imaging-gaussian-blur;87;85;87;98;110;128;133;90;88;84 13:46:56 INFO - PROCESS | 1677 | |6;imaging-darkroom;92;93;91;92;93;92;93;93;92;93 13:46:56 INFO - PROCESS | 1677 | |7;imaging-desaturate;86;86;87;86;85;104;140;136;85;85 13:46:56 INFO - PROCESS | 1677 | |8;json-parse-financial;59;62;64;65;63;63;62;78;72;78 13:46:56 INFO - PROCESS | 1677 | |9;json-stringify-tinderbox;63;62;61;72;75;71;65;66;66;68 13:46:56 INFO - PROCESS | 1677 | |10;stanford-crypto-aes;81;80;79;79;79;79;79;78;79;83 13:46:56 INFO - PROCESS | 1677 | |11;stanford-crypto-ccm;124;129;137;142;121;120;126;125;143;127 13:46:56 INFO - PROCESS | 1677 | |12;stanford-crypto-pbkdf2;163;165;166;162;162;162;162;162;162;157 13:46:56 INFO - PROCESS | 1677 | |13;stanford-crypto-sha256-iterative;66;67;67;66;67;71;71;92;86;66 13:46:56 INFO - PROCESS | 1677 | __end_tp_report 13:46:56 INFO - PROCESS | 1677 | __start_cc_report 13:46:56 INFO - PROCESS | 1677 | _x_x_mozilla_cycle_collect,1867 13:46:56 INFO - PROCESS | 1677 | __end_cc_report 13:46:56 INFO - PROCESS | 1677 | __startTimestamp1468010816686__endTimestamp 13:46:56 INFO - PROCESS | 1677 | 13:46:56 INFO - PROCESS | 1677 | ------- Summary: start ------- 13:46:56 INFO - PROCESS | 1677 | Number of tests: 14 13:46:56 INFO - PROCESS | 1677 | 13:46:56 INFO - PROCESS | 1677 | [#0] ai-astar Cycles:10 Average:115.60 Median:113.00 stddev:7.38 (6.5%) stddev-sans-first:7.77 13:46:56 INFO - PROCESS | 1677 | Values: 113.0 113.0 121.0 112.0 111.0 113.0 113.0 114.0 111.0 135.0 13:46:56 INFO - PROCESS | 1677 | 13:46:56 INFO - PROCESS | 1677 | [#1] audio-beat-detection Cycles:10 Average:153.80 Median:164.00 stddev:29.83 (18.2%) stddev-sans-first:31.63 13:46:56 INFO - PROCESS | 1677 | Values: 156.0 126.0 174.0 198.0 103.0 162.0 166.0 151.0 183.0 119.0 13:46:56 INFO - PROCESS | 1677 | 13:46:56 INFO - PROCESS | 1677 | [#2] audio-dft Cycles:10 Average:184.00 Median:185.00 stddev:2.11 (1.1%) stddev-sans-first:1.24 13:46:56 INFO - PROCESS | 1677 | Values: 179.0 187.0 185.0 184.0 183.0 185.0 183.0 184.0 185.0 185.0 13:46:56 INFO - PROCESS | 1677 | 13:46:56 INFO - PROCESS | 1677 | [#3] audio-fft Cycles:10 Average:78.80 Median:60.50 stddev:33.92 (56.1%) stddev-sans-first:35.83 13:46:56 INFO - PROCESS | 1677 | Values: 70.0 78.0 74.0 151.0 59.0 55.0 54.0 62.0 130.0 55.0 13:46:56 INFO - PROCESS | 1677 | 13:46:56 INFO - PROCESS | 1677 | [#4] audio-oscillator Cycles:10 Average:100.50 Median:84.00 stddev:24.06 (28.6%) stddev-sans-first:25.32 13:46:56 INFO - PROCESS | 1677 | Values: 92.0 91.0 139.0 80.0 92.0 86.0 126.0 79.0 82.0 138.0 13:46:56 INFO - PROCESS | 1677 | 13:46:56 INFO - PROCESS | 1677 | [#5] imaging-gaussian-blur Cycles:10 Average:99.00 Median:87.00 stddev:18.35 (21.1%) stddev-sans-first:18.94 13:46:56 INFO - PROCESS | 1677 | Values: 87.0 85.0 87.0 98.0 110.0 128.0 133.0 90.0 88.0 84.0 13:46:56 INFO - PROCESS | 1677 | 13:46:56 INFO - PROCESS | 1677 | [#6] imaging-darkroom Cycles:10 Average:92.40 Median:93.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 13:46:56 INFO - PROCESS | 1677 | Values: 92.0 93.0 91.0 92.0 93.0 92.0 93.0 93.0 92.0 93.0 13:46:56 INFO - PROCESS | 1677 | 13:46:56 INFO - PROCESS | 1677 | [#7] imaging-desaturate Cycles:10 Average:98.00 Median:85.50 stddev:21.87 (25.6%) stddev-sans-first:22.76 13:46:56 INFO - PROCESS | 1677 | Values: 86.0 86.0 87.0 86.0 85.0 104.0 140.0 136.0 85.0 85.0 13:46:56 INFO - PROCESS | 1677 | 13:46:56 INFO - PROCESS | 1677 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:64.50 stddev:6.87 (10.6%) stddev-sans-first:6.71 13:46:56 INFO - PROCESS | 1677 | Values: 59.0 62.0 64.0 65.0 63.0 63.0 62.0 78.0 72.0 78.0 13:46:56 INFO - PROCESS | 1677 | 13:46:56 INFO - PROCESS | 1677 | [#9] json-stringify-tinderbox Cycles:10 Average:66.90 Median:67.00 stddev:4.58 (6.8%) stddev-sans-first:4.64 13:46:56 INFO - PROCESS | 1677 | Values: 63.0 62.0 61.0 72.0 75.0 71.0 65.0 66.0 66.0 68.0 13:46:56 INFO - PROCESS | 1677 | 13:46:56 INFO - PROCESS | 1677 | [#10] stanford-crypto-aes Cycles:10 Average:79.60 Median:79.00 stddev:1.43 (1.8%) stddev-sans-first:1.42 13:46:56 INFO - PROCESS | 1677 | Values: 81.0 80.0 79.0 79.0 79.0 79.0 79.0 78.0 79.0 83.0 13:46:56 INFO - PROCESS | 1677 | 13:46:56 INFO - PROCESS | 1677 | [#11] stanford-crypto-ccm Cycles:10 Average:129.40 Median:128.00 stddev:8.34 (6.5%) stddev-sans-first:8.62 13:46:56 INFO - PROCESS | 1677 | Values: 124.0 129.0 137.0 142.0 121.0 120.0 126.0 125.0 143.0 127.0 13:46:56 INFO - PROCESS | 1677 | 13:46:56 INFO - PROCESS | 1677 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:162.30 Median:162.00 stddev:2.36 (1.5%) stddev-sans-first:2.49 13:46:56 INFO - PROCESS | 1677 | Values: 163.0 165.0 166.0 162.0 162.0 162.0 162.0 162.0 162.0 157.0 13:46:56 INFO - PROCESS | 1677 | 13:46:56 INFO - PROCESS | 1677 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.90 Median:69.00 stddev:9.31 (13.5%) stddev-sans-first:9.63 13:46:56 INFO - PROCESS | 1677 | Values: 66.0 67.0 67.0 66.0 67.0 71.0 71.0 92.0 86.0 66.0 13:46:56 INFO - PROCESS | 1677 | -------- Summary: end -------- 13:46:56 INFO - PROCESS | 1677 | 13:46:57 INFO - TEST-INFO | 1677: exit 0 13:46:57 INFO - TEST-OK | kraken | took 57908ms 13:46:57 INFO - SUITE-END | took 1170s 13:46:57 INFO - Completed test suite (00:19:31) 13:46:57 INFO - javascript benchmark 13:46:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3346.4143774839404, 3612.6929211017064, 3613.873514426994, 3631.9092022699438, 3690.778553286803, 4876.2198048312275, 5892.086726557385, 5897.46922776951, 5907.232059832216, 5915.846409950062, 4428.914915845614, 5753.769849206037, 5960.165576819238, 5960.821175364736, 5979.222701048869, 5253.159494480874, 5274.973625131869, 5297.602679799012, 5372.086745253317, 5389.407165211824, 5331.0, 5388.595855310848, 5398.109311963541, 5401.972990135044, 5403.243545903577, 5272.947270527303, 5310.468953104678, 5354.785808567653, 5360.463953604647, 5392.433794451585, 5342.519173274424, 5356.303680521546, 5357.705326207057, 5374.838754837361, 5401.351837779453, 5132.384113906318, 5238.423773384925, 5284.365876094855, 5312.787488500456, 5313.9637770634745, 5691.117876729114, 5711.171880077365, 5742.0, 5760.481556659921, 5788.623739456922, 6287.151234583364, 6290.0, 6297.244330680302, 6301.558890877594, 6311.08489269058, 6236.189295391616, 6273.184486016834, 6296.212973378328, 6296.590721603081, 6320.399562041599, 5934.5252379809945, 5939.46544810969, 5941.138534912414, 5944.702764861783, 5996.760129594767, 6346.904796428057, 6360.6501642409185, 6365.713542890581, 6375.968120159369, 6378.202724659418, 6165.229346331708, 6191.473724733448, 6299.0, 6304.779332723333, 6308.179936608303, 6302.306746257908, 6302.873942521124, 6308.7476500940365, 6309.432151106423, 6323.462505686976, 6280.717367718372, 6347.143135676624, 6354.8411289717205, 6355.332690067568, 6364.0, 6232.532560058014, 6340.778072767431, 6343.777967771198, 6348.587341822767, 6350.047492876013, 4975.800967961313, 5047.015831912742, 5051.924221136685, 5066.189409694432, 5098.566621837112, 4525.660575456854, 4536.97917968461, 4538.591526762541, 4545.681802273809, 4575.519570445122, 4864.586510146606, 5917.112433135064, 6075.2405949256345, 6081.7871374502565, 6116.938830611637, 6236.282827474898, 6304.148939893055, 6308.621482711052, 6313.305536390993, 6316.557840951181, 5999.430054144849, 6009.729562169713, 6023.728932198062, 6049.820285044462, 6087.0, 5434.809781657623, 5449.264349312792, 5528.640638358494, 5548.334199895958, 5567.9977604031665, 5411.78352865881, 5462.945370546323, 6462.644554549545, 6481.611103333815, 6493.253275873335, 5299.655522391032, 6290.937090629218, 6294.3076261612105, 6295.307516173309, 6307.022411526221, 6331.9366806331345, 6368.554201205871, 6456.903146452713, 6460.418562329413, 6482.157319548429, 5315.6279060465395, 6346.968265158829, 6362.172917520693, 6364.904526432199, 6367.267764207176, 6265.060240963892, 6299.433051025429, 6324.4940404766585, 6325.462335701332, 6334.714937827716, 6184.938150618436, 6207.472364848858, 6258.968705156445, 6312.936870631419, 6332.588381755171, 6069.696515174312, 6245.96877015612, 6287.182666253358, 6297.244330680348, 6311.0217916223055, 6149.0, 6171.691415429121, 6187.3503282154725, 6190.0, 6209.59637623553, 6123.969380153071, 6183.041628547582, 6257.624542527463, 6300.117983482224, 6319.399657032574, 6127.908081378872, 6169.475594574512, 6189.226346706661, 6189.876202476015, 6197.1324014638885], "value": 5805.079976528109, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [531.542873129109, 540.7972010496064, 579.111064515968, 586.2671660424469, 621.871303583995, 27971.720282797167, 32463.0, 32514.0245792626, 32567.0, 32600.347993040155, 33592.49611255833, 34063.65936340636, 34104.829475852646, 34182.0, 38812.0, 9558.378705384162, 9738.464384458852, 9741.853872191923, 9753.756156096084, 9770.364926279804, 9589.520523973808, 9702.466364349957, 9707.126358627722, 9714.319997600136, 9722.659706910259, 8214.794630134234, 9129.771755706093, 9315.347925645208, 9324.347295689304, 11755.7061073473, 11496.0, 11597.304161750322, 11617.0, 11621.6513504595, 11626.767464650744, 11530.42347882611, 11639.243449175776, 11646.534138634444, 11647.184697071209, 11650.708732281675, 38993.61006389928, 39294.60705392966, 39298.0, 39329.80335098335, 39360.80319598383, 3148.307372378073, 3215.0, 3220.5652236947944, 3392.6607339266125, 3485.8082805445692, 28558.571621425694, 28686.282842928886, 29319.853400733075, 29843.701562984526, 30528.0, 2344.8510229987182, 2750.4499100180046, 2776.1810265971385, 2792.5531914893722, 2996.9400611987858, 545841.0, 546224.0, 546405.2679736615, 547296.0, 557129.0, 37112.62887371146, 37592.81203593964, 37650.0, 59528.40471595229, 59537.0, 35882.0, 35964.64035359665, 35987.640123598954, 36013.0, 36140.277194455964, 16092.356305747873, 16252.83747162537, 16253.756193657104, 16271.593210169603, 16292.592685182728, 13745.0, 13811.102278351875, 13812.37844297009, 13819.930900345435, 13822.723545529034, 8362.45644033136, 8483.406161568631, 8485.406021578554, 8545.572721363907, 8565.52889591066, 3361.7057432888514, 3456.2741824217196, 3510.8946731598094, 3579.6062433132333, 3609.314230296235, 907.3829795738961, 1002.5288114586133, 1018.5772904244656, 1117.279354816139, 1198.4876938327204, 30764.230894227825, 30828.38343233123, 30880.073597792103, 31258.68741312558, 31503.684963150532, 1102.6416414665266, 1179.1922533064878, 1184.3012622552562, 1223.5228260978226, 1248.6940699528493, 15705.45030923935, 15849.683006339808, 15910.363585456684, 16153.596160095856, 16165.838341616669, 638971.0, 639931.0, 646732.0, 649537.0, 650184.0, 55276.723616382464, 62134.0, 62703.059454108225, 62727.0, 63110.0, 1558.454540910695, 1560.360252296553, 1567.7334853075004, 1574.1106274954614, 1575.7242482565734, 28269.29326766765, 29403.970861019763, 29543.55684664775, 30096.398072038875, 30268.54597181, 47650.76174619105, 48183.75908120437, 48594.51405486041, 48602.5139748598, 48723.75638121787, 383071.0, 634793.0, 668660.0, 669534.0, 671571.0, 26454.0, 26517.734822651528, 26773.866130669223, 27032.0, 27199.04803331874, 43274.35088473612, 46120.30819537643, 46284.7685761569, 46331.30503042389, 46408.76795616, 36085.45871811872, 37768.81115594514, 38149.80925095357, 38955.80522097485, 40806.38790418087, 35174.296514069065, 38066.0, 38078.23843523059, 38087.0, 38757.22485550329, 37130.6286937138, 37256.44115338218, 37880.24239515139, 38125.0, 38305.6169438302, 32781.0, 32873.506897397034, 33432.66567334393, 33783.662163379035, 34012.659873400946, 24970.691091588353, 25184.748152518972, 25241.368965776004, 25710.871445642653, 25744.8712756435], "value": 18904.74793699982, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [414.20472692430536, 421.38688208656407, 421.56368158955485, 427.6236911517866, 432.3212556286629, 20258.189672413122, 20764.480887977807, 20840.583188336244, 21259.68110478344, 21439.249626263085, 20203.59592808143, 20412.775233486, 22536.323910282677, 22595.209167679135, 22597.435064123405, 6016.789412370557, 6070.605410648316, 6232.750689972396, 6275.717592708339, 6284.27730810958, 6065.909011364833, 6147.969260153693, 6303.905441418382, 6304.873902521947, 6311.905321420182, 6211.751529938797, 6259.374062593727, 6272.090546870701, 6276.027215781562, 6284.528660350469, 6029.282518376485, 6199.132121502993, 6253.405926436982, 6293.276273228568, 6309.990401535778, 5423.29497165366, 5460.235567020581, 5468.808591699311, 5471.50756431923, 5472.699001554913, 25299.87350063238, 25465.872670636712, 25605.231843044738, 25659.871700641565, 26489.47021059568, 2204.206485665159, 2210.9889450552646, 2227.855189412683, 2612.673415823022, 2666.6933302670245, 12736.80894786579, 12901.58082610912, 14942.402303907831, 15520.5343839685, 15699.843001570067, 1777.9111044447725, 1785.6875046866876, 1822.599028213791, 1888.8016758240462, 1891.886486810782, 110608.89391106147, 111924.0, 112805.0, 114015.0, 114762.42618786937, 11236.381998989971, 11574.247673901169, 11708.70728231784, 11783.587574435025, 11816.881831181578, 14619.92690036543, 14652.267386630625, 14687.853121468648, 14695.26523673812, 14723.631909202355, 7437.367823735043, 8742.606582703793, 9049.457032577935, 9179.0820917909, 9179.714839922417, 9156.496392698333, 9156.816863662823, 9170.220531254785, 9178.632854685871, 9193.63225470987, 4599.0, 4730.942040212519, 4736.194846876039, 4746.5728084471875, 4754.23932170851, 1737.0967097109685, 1937.6318499485335, 2011.406635042666, 2021.6259991901545, 2031.918723251083, 876.3602570123845, 907.584168696835, 1095.4194277033184, 1129.3844854554122, 1136.886311368873, 16768.41310554149, 20507.794922050885, 20529.447322539312, 21189.89405052965, 21190.682139767916, 1009.9040591143829, 1045.0698877998586, 1048.224314007629, 1060.3849767135043, 1085.2837127495816, 11035.83446248307, 11294.0, 11302.039326657326, 11334.263272887236, 11340.149488788375, 609335.0, 613386.0, 613698.0, 616397.0, 639129.0, 106836.0, 121569.17646235313, 122276.0, 127398.72601274055, 128350.71649283574, 1007.5415685862915, 1023.0741179232806, 1035.6427032673716, 1036.098594223031, 1040.7294103533136, 18378.72431913549, 18454.169562369992, 18768.436946891616, 19645.705314420582, 19741.703874441606, 56345.02792402246, 57131.0, 57419.99999999833, 59216.81566368735, 59519.0, 75980.0, 78727.60636196782, 78937.60531197308, 79414.0, 79416.60291698505, 8117.025956885212, 8202.097769245498, 8429.283510901641, 8474.74575762728, 8706.085860984505, 12004.879951200726, 12770.042246831339, 12797.8080328797, 13130.606081817561, 13133.802992955305, 10055.145312648214, 11100.944495277796, 11138.55445782192, 11173.217874748689, 11339.206255562032, 11052.889471105185, 11064.668059958214, 11162.218644694793, 11319.547218111184, 11369.602063928054, 11186.161037922351, 11543.942280288546, 11699.590514331958, 11799.233049851731, 11907.82138267944, 8239.423240373357, 8285.295749861089, 8345.082040975367, 8396.916030839613, 8633.870491942751, 8475.915240847513, 10773.0, 10982.176336774934, 11263.605773797877, 11611.187216895074], "value": 9936.132674361923, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1485.0347274271728, 1612.7661489084082, 1635.8200597934228, 1913.5407502199469, 2026.655468570343, 8441.155884411564, 8694.608742606573, 8696.217340439367, 9088.000319964814, 9255.0, 9114.997350291462, 9186.219171370425, 9305.209057230126, 9309.674161404353, 9345.859812102824, 2576.4460640962143, 2601.9349516262055, 2607.191770551126, 2607.960880586793, 2609.2563619368484, 2484.0808900706766, 2595.065776320523, 2600.154949641374, 2600.3239157819007, 2602.1803132013356, 2555.4250293683867, 2581.6901971763414, 2605.8436493810336, 2606.0748434305833, 2606.947861042778, 2564.525562770884, 2593.5201987632254, 2602.7917766578817, 2609.7520735530093, 2610.386559158606, 2543.3260186050525, 2574.897004119833, 2584.3926677230834, 2588.262345231619, 2597.6623039005, 9343.39267947588, 9388.483633400161, 9417.293702972236, 9430.151286384258, 9432.386894851812, 5752.741126649311, 5761.0, 5864.266966629171, 5943.197668314765, 5955.0, 3666.2484190740834, 3740.36413809653, 3776.9055773605605, 3821.407681809324, 3835.4822099016556, 1112.0, 1665.7334826427834, 1693.1365003848002, 1708.1459270364817, 1739.339051160551, 12386.442610082568, 12483.75032499354, 12489.812652810215, 12496.562620308245, 12503.249805011637, 4765.499622539653, 4804.568376153563, 4847.684900481458, 4882.170031094723, 4903.632227582945, 9828.606855725691, 9829.4102353859, 9850.950745246228, 9855.950720246496, 9866.408015518948, 5696.060150075191, 5701.486866182064, 5713.74288157034, 5726.513246374105, 5757.971210144006, 4721.315409265637, 4732.739699316502, 4830.6135509159185, 4878.219484882473, 5340.519353258225, 4037.253108174997, 4051.2707712612014, 4115.218108559364, 4149.937750933738, 4162.4796900387455, 1118.0999295566985, 1257.5975687779824, 1297.9935100324437, 1306.679863433446, 1308.2869835939437, 869.482657818597, 950.1875896108866, 962.8008752735146, 966.9129778319844, 997.5311603546321, 5416.566674666017, 6084.817455476343, 6143.38566143391, 6235.469985051231, 6300.842478938063, 466.7339616418609, 482.91548978928546, 485.37629146546516, 495.56637941800926, 498.41934146719393, 3960.4257382679352, 4069.3895915612893, 4080.081981554186, 4101.835926562904, 4161.9583804161575, 11352.716182095513, 11483.71290717722, 11721.882781172078, 11721.88278117225, 11731.589394371156, 11383.430828458544, 11549.6535103947, 11559.884401155881, 11562.479688414041, 11577.479013444416, 8296.751097467086, 8794.472331660121, 8806.119388061143, 9003.369764116449, 9003.954980225057, 5982.491488223375, 6031.5476339273855, 6169.043798211284, 6188.907166392598, 6199.5040396767245, 10247.180225582084, 10256.897431025594, 10325.32885362449, 10507.106895913934, 10520.158387328842, 10287.897121028695, 10454.895451045391, 10548.736281592715, 10725.141988640735, 10783.083437907866, 7204.56772593646, 7396.260373962561, 7929.048514178336, 8060.0, 8470.872936906075, 8728.952525696957, 8729.91270087291, 8802.559872006246, 8817.867731984154, 8835.911640883509, 7169.426445884213, 7667.194944530744, 7687.9231207689445, 7749.690012399441, 7970.641321140447, 7494.5503269803985, 7562.319391254813, 7617.42869284817, 7773.028371453568, 7822.921770782447, 7252.2747725227055, 7358.374538164102, 7368.447366447431, 7389.298016688406, 7401.148867880047, 5039.974800125976, 5061.544460998381, 5099.439061703136, 5194.7922083116255, 5200.037992971313, 5192.584593232456, 5209.114450543492, 5269.920951185812, 5434.2935418395355, 5468.671879687232], "value": 4800.042376770329, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [326.6358010817937, 332.64573229510574, 342.14805135213317, 343.0275169893352, 346.4577935530894, 6205.875882482348, 6389.424951754341, 6463.547551671385, 6488.4809215262785, 6526.412622863942, 6512.902306465407, 6554.180727409074, 6555.41001309882, 6605.83485412865, 6669.19969603647, 4937.876553086184, 4952.529509696573, 4956.265307142489, 4958.925616115761, 4962.975185124069, 4701.78841952113, 4785.760711964405, 4867.902641947159, 4954.7522623868845, 4961.5286547777905, 4868.659193856432, 4907.386576677915, 4910.656254062217, 4927.753612319388, 4948.876278093058, 4227.154569086195, 4693.474620748253, 4914.827981020683, 4927.211646136637, 4928.7782049807665, 3582.946255806165, 4142.544320124784, 4212.978935105336, 4220.873373798791, 4222.85220017301, 6405.0072238802595, 6418.06937993993, 6418.582792118497, 6463.159789227418, 6472.611643301417, 5777.62445441045, 5791.160281759164, 5796.217510636052, 5808.244928159313, 5817.767289308423, 6990.54561453509, 7009.964950175267, 7011.193712723051, 7031.332023457763, 7038.260982596856, 4697.8355757548325, 4700.670953033289, 4704.200285951397, 4714.882127946795, 4719.056188762227, 7094.787156385317, 7334.009908662316, 7460.813479662997, 7487.737929172453, 7497.587632680201, 4638.165130276582, 4788.257820037899, 4794.352762377104, 4795.928061079087, 4811.663183577116, 4816.831410900601, 4889.559939605381, 4896.95103048972, 4897.902041959141, 4914.631402644816, 4687.812487500461, 5775.884482310415, 5810.070388737781, 5810.157527158538, 5857.677827719431, 7047.40097091753, 7056.964715176391, 7057.611831349325, 7058.329458701415, 7066.50534462593, 1565.6790357976588, 1637.5496738397037, 1646.9505914822576, 1696.0756387768695, 1721.1050253868168, 1025.8307379282485, 1029.156092004549, 1037.5227395398201, 1045.4511381524608, 1045.5033858917106, 6672.232693240242, 6777.559458635173, 6805.3875151236625, 6807.591544507345, 6816.62508562024, 6099.3900609938655, 7212.567245965259, 7467.589282589401, 7472.0, 7533.623318834037, 5592.468715472024, 6892.586444813327, 6901.896471552931, 6909.792706218822, 6921.446284297244, 3904.550976637723, 3958.426028225891, 3960.663343615767, 3966.2662407454136, 3970.047188674755, 7574.697012119564, 7854.0, 7867.134615192324, 7880.881786773203, 7898.565578893101, 7603.0, 7603.201663825329, 7620.695172193161, 7631.3513351365755, 7644.655990480442, 7679.462437629312, 7777.57223352721, 7790.948221989959, 7821.413393995587, 7825.726099586601, 7392.519486233377, 7421.443391745749, 7421.591812450367, 7427.7771666850085, 7440.888386674096, 6895.6552172390175, 7012.03662974368, 7262.237465066303, 7267.927320726725, 7281.781546553612, 7111.217766045835, 7759.6120193988945, 7800.687972481264, 7804.6878124874365, 7814.57019863913, 4436.9334459983775, 4529.162105010583, 4663.836765713184, 4729.574338309569, 4735.668503204743, 7179.8564028720175, 7226.783196504113, 7237.493375463667, 7242.0, 7248.347648711641, 7136.892946605909, 7148.606826624377, 7168.319009694071, 7172.641367931478, 7188.101487314086, 7140.9285907140265, 7142.785716428515, 7144.857102858018, 7157.427405807627, 7166.964165179141, 6731.124953755981, 6963.9303606963285, 6987.895181572382, 6990.61551614666, 6997.47518936092, 7095.9645201773665, 7103.431725462054, 7108.431325493844, 7137.1435427749, 7154.248803875518, 6996.825079373057, 6998.0, 7004.3696067354185, 7004.929950700632, 7024.121984751906], "value": 5214.812759344991, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.836795904901, 767.9824232891414, 792.2750683124941, 799.0291795468509, 801.3629164813974, 13070.496892857323, 14144.363503642335, 15620.843791562082, 15735.921320393381, 15737.763933540977, 14456.710865782705, 14542.491012814553, 14548.709025819477, 14555.78166327506, 14564.927175364135, 800.7157459102023, 815.3680897304607, 956.4500412262942, 965.1506674126776, 983.2576404814355, 915.8597546055138, 953.9887719017863, 960.3373672166218, 969.3117886300735, 969.8981606931242, 1037.258360272405, 1039.173856783855, 1044.4934206909643, 1048.1457612046158, 1048.9108425783818, 734.9412047036225, 1009.2783659683325, 1023.8720159980003, 1030.2788048366174, 1030.695944696309, 772.2933515833006, 772.4631381190076, 774.531408497862, 775.7517594369804, 777.1373775109623, 15144.93985421021, 15191.696166076617, 15202.46791362308, 15231.61920951974, 15269.61825954349, 11565.61212654487, 12044.39778011096, 12805.807912881315, 12849.35753212345, 13129.60611181666, 11171.44142792857, 11277.943610281978, 11303.095752339794, 11539.48072336747, 11763.058955283557, 3450.1719587299117, 3526.823658817049, 3540.0, 3547.0600290922926, 3651.6165802590613, 83335.0, 83706.58146709288, 83732.0, 83759.06843260456, 84063.0, 9487.762805929908, 9572.712818615453, 9619.374740641835, 9669.129778319984, 9703.9029609703, 21467.463313416978, 21540.13839446436, 21543.0, 21543.67684484734, 21610.243641472473, 7697.615119244016, 7726.768196953988, 7734.381249500027, 7800.960995194988, 7952.483088599222, 4212.094399704079, 4225.767582782915, 4266.957330426656, 4366.8034938427845, 4547.931781023287, 3726.832292546842, 3785.6971442284553, 3785.981070094687, 3787.3561494545993, 3788.318102741478, 650.9544331896722, 671.53328436736, 671.5936858200719, 676.7732809508772, 693.8889777635554, 559.6474221240593, 609.8597322615823, 621.1056079245961, 622.1072760588479, 630.6058713304185, 8196.30331421824, 8228.42401031934, 8267.958660206661, 8324.001119865656, 8425.73613957899, 550.8650380656685, 619.5446346935089, 621.7015832400383, 624.5769035018744, 630.8959021761358, 3833.5208098987628, 3883.203943191639, 3899.66852817508, 3947.111899822517, 4045.453863728359, 90415.54792225997, 90758.54620726986, 91648.0, 92207.0, 92268.0, 63958.68020659867, 64571.0, 70462.29537704558, 74255.0, 80175.0, 67755.0, 68809.65595172092, 68884.6555767228, 69447.44420446453, 70108.0, 7688.0, 7753.379729621504, 7928.960355198187, 7943.721969731032, 7982.08206056311, 50989.49010509996, 51225.0, 51391.0, 51418.0, 51702.22446663379, 62259.0, 65098.0, 70243.29756702571, 70653.0, 71458.64270678614, 9946.0, 10105.797884042426, 10150.086492215736, 10220.540075696463, 10293.639722609672, 10749.086327662237, 11360.488778004845, 11383.317000979967, 11394.544218231178, 11626.70933226676, 9339.53302334867, 10098.899011009797, 10125.139363154214, 10485.161187105166, 10570.947145264225, 10182.083612474617, 10587.947060264649, 10737.248392612442, 10772.084372828398, 10952.890471095187, 10437.373757574569, 10567.89432105669, 10575.524101415609, 10604.469776511298, 10637.414942178255, 7312.744053958086, 8663.39356245082, 8838.690645827364, 8993.0, 9198.310126740387, 7645.88531172044, 8758.255548278468, 9092.863607045767, 9143.222826059859, 9150.40522366044], "value": 6934.286248241994, "unit": "score"}], "name": "dromaeo_css", "value": 7577.384708834484, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 113.0, 121.0, 112.0, 111.0, 113.0, 113.0, 114.0, 111.0, 135.0], "value": 115.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 126.0, 174.0, 198.0, 103.0, 162.0, 166.0, 151.0, 183.0, 119.0], "value": 153.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [179.0, 187.0, 185.0, 184.0, 183.0, 185.0, 183.0, 184.0, 185.0, 185.0], "value": 184.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 78.0, 74.0, 151.0, 59.0, 55.0, 54.0, 62.0, 130.0, 55.0], "value": 78.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 91.0, 139.0, 80.0, 92.0, 86.0, 126.0, 79.0, 82.0, 138.0], "value": 100.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 87.0, 98.0, 110.0, 128.0, 133.0, 90.0, 88.0, 84.0], "value": 99.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 93.0, 91.0, 92.0, 93.0, 92.0, 93.0, 93.0, 92.0, 93.0], "value": 92.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 86.0, 85.0, 104.0, 140.0, 136.0, 85.0, 85.0], "value": 98.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 64.0, 65.0, 63.0, 63.0, 62.0, 78.0, 72.0, 78.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 61.0, 72.0, 75.0, 71.0, 65.0, 66.0, 66.0, 68.0], "value": 66.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 79.0, 79.0, 79.0, 79.0, 79.0, 78.0, 79.0, 83.0], "value": 79.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [124.0, 129.0, 137.0, 142.0, 121.0, 120.0, 126.0, 125.0, 143.0, 127.0], "value": 129.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 166.0, 162.0, 162.0, 162.0, 162.0, 162.0, 162.0, 157.0], "value": 162.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 67.0, 66.0, 67.0, 71.0, 71.0, 92.0, 86.0, 66.0], "value": 71.9, "unit": "score"}], "name": "kraken", "value": 1498.8, "alertThreshold": 2.0}]} 13:46:57 INFO - Return code: 0 13:46:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:46:58 ERROR - # TBPL SUCCESS # 13:46:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:46:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:46:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:46:58 INFO - 2016-07-08 13:46:58.035 screenresolution[1681:9716] starting screenresolution argv=screenresolution get 13:46:58 INFO - 2016-07-08 13:46:58.038 screenresolution[1681:9716] Display 0: 1600x1200x32@60 13:46:58 INFO - 2016-07-08 13:46:58.044 screenresolution[1682:9719] starting screenresolution argv=screenresolution list 13:46:58 INFO - Available Modes on Display 0 13:46:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:46:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:46:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:46:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:46:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:46:58 INFO - Intel Iris: 13:46:58 INFO - Chipset Model: Intel Iris 13:46:58 INFO - Type: GPU 13:46:58 INFO - Bus: Built-In 13:46:58 INFO - VRAM (Dynamic, Max): 1536 MB 13:46:58 INFO - Vendor: Intel (0x8086) 13:46:58 INFO - Device ID: 0x0a2e 13:46:58 INFO - Revision ID: 0x0009 13:46:58 INFO - Displays: 13:46:58 INFO - Display: 13:46:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:46:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:46:58 INFO - Display Serial Number: 1600x1200 60 13:46:58 INFO - Main Display: Yes 13:46:58 INFO - Mirror: Off 13:46:58 INFO - Online: Yes 13:46:58 INFO - Rotation: Supported 13:46:58 INFO - Return code: 0 13:46:58 INFO - Running post-action listener: _resource_record_post_action 13:46:58 INFO - Running post-run listener: _resource_record_post_run 13:46:59 INFO - Total resource usage - Wall time: 1194s; CPU: 53.0%; Read bytes: 37152256; Write bytes: 489924096; Read time: 241; Write time: 1524 13:46:59 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194916864; Write bytes: 194715648; Read time: 17578; Write time: 444 13:46:59 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 35370496; Write bytes: 294360576; Read time: 226; Write time: 1078 13:46:59 INFO - Running post-run listener: _upload_blobber_files 13:46:59 INFO - Blob upload gear active. 13:46:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:46:59 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 13:46:59 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'] 13:46:59 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 13:46:59 INFO - (blobuploader) - INFO - Open directory for files ... 13:46:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 13:46:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:47:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 13:47:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:47:00 INFO - (blobuploader) - INFO - Done attempting. 13:47:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 13:47:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:47:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:47:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 13:47:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:47:01 INFO - (blobuploader) - INFO - Done attempting. 13:47:01 INFO - (blobuploader) - INFO - Iteration through files over. 13:47:01 INFO - Return code: 0 13:47:01 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:47:01 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:47:01 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9bfa9a27880f475f3d895632653a00057a25030dbf2e94b9f6db76ec86c181c5c7c373d23dd8b6004941769b7875328604be3d7162df6d0060074c83c0fe1139", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f634606fb9d0680941b6dff0aed43337bde4a2a27f4243365651c754807618569894bd828800208ae9d01a032f3b7037183f01e62fef45b4d14b226102334c74"} 13:47:01 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:47:01 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:47:01 INFO - Contents: 13:47:01 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9bfa9a27880f475f3d895632653a00057a25030dbf2e94b9f6db76ec86c181c5c7c373d23dd8b6004941769b7875328604be3d7162df6d0060074c83c0fe1139", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f634606fb9d0680941b6dff0aed43337bde4a2a27f4243365651c754807618569894bd828800208ae9d01a032f3b7037183f01e62fef45b4d14b226102334c74"} 13:47:01 INFO - Running post-run listener: copy_logs_to_upload_dir 13:47:01 INFO - Copying logs to upload dir... 13:47:01 INFO - mkdir: /builds/slave/test/build/upload/logs 13:47:01 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.264665 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-07-08 13:47:01.995105) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 13:47:01.999250) ========= 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.pXgBcj7Kur/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.6EITWfu3kk/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9bfa9a27880f475f3d895632653a00057a25030dbf2e94b9f6db76ec86c181c5c7c373d23dd8b6004941769b7875328604be3d7162df6d0060074c83c0fe1139", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f634606fb9d0680941b6dff0aed43337bde4a2a27f4243365651c754807618569894bd828800208ae9d01a032f3b7037183f01e62fef45b4d14b226102334c74"} build_url:https://queue.taskcluster.net/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011064 build_url: 'https://queue.taskcluster.net/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9bfa9a27880f475f3d895632653a00057a25030dbf2e94b9f6db76ec86c181c5c7c373d23dd8b6004941769b7875328604be3d7162df6d0060074c83c0fe1139", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/f634606fb9d0680941b6dff0aed43337bde4a2a27f4243365651c754807618569894bd828800208ae9d01a032f3b7037183f01e62fef45b4d14b226102334c74"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 13:47:02.032548) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 13:47:02.032939) ========= 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.pXgBcj7Kur/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.6EITWfu3kk/Listeners TMPDIR=/var/folders/fh/x511n7yj7hb7h81n2245hgqc00000w/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.005013 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 13:47:02.081655) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 13:47:02.081982) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 13:47:02.082335) ========= ========= Total master_lag: 0.18 =========