builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0269 starttime: 1468009540.63 results: success (0) buildid: 20160708113726 builduid: 0e18ae00cb88446ba899f020b0a6a925 revision: 23d50da987261085138dab3f05eae49806d9bf1b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 13:25:40.630422) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-08 13:25:40.630886) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 13:25:40.631178) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-08 13:25:40.654542) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 13:25:40.654954) ========= 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.wrbyQxEPm7/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.g4Aq7uQanp/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:25:40-- 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% 8.36M=0.001s 2016-07-08 13:25:40 (8.36 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118386 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 13:25:40.795589) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 13:25:40.795929) ========= 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.wrbyQxEPm7/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.g4Aq7uQanp/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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.020456 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 13:25:40.845051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 13:25:40.845416) ========= 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.wrbyQxEPm7/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.g4Aq7uQanp/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:25:40,923 truncating revision to first 12 chars 2016-07-08 13:25:40,924 Setting DEBUG logging. 2016-07-08 13:25:40,924 attempt 1/10 2016-07-08 13:25:40,924 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:25:41,743 unpacking tar archive at: mozilla-beta-23d50da98726/testing/mozharness/ program finished with exit code 0 elapsedTime=1.076127 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-08 13:25:41.943673) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 13:25:41.944066) ========= script_repo_revision: 23d50da987261085138dab3f05eae49806d9bf1b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-08 13:25:41.944504) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 13:25:41.944796) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-08 13:25:41.963549) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-08 13:25:41.963953) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.wrbyQxEPm7/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.g4Aq7uQanp/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:25:42 INFO - MultiFileLogger online at 20160708 13:25:42 in /builds/slave/test 13:25:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 13:25:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 13:25:42 INFO - {'append_to_log': False, 13:25:42 INFO - 'base_work_dir': '/builds/slave/test', 13:25:42 INFO - 'blob_upload_branch': 'Mozilla-Beta', 13:25:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 13:25:42 INFO - 'branch': 'Mozilla-Beta', 13:25:42 INFO - 'buildbot_json_path': 'buildprops.json', 13:25:42 INFO - 'config_files': ('talos/mac_config.py',), 13:25:42 INFO - 'default_actions': ('clobber', 13:25:42 INFO - 'read-buildbot-config', 13:25:42 INFO - 'download-and-extract', 13:25:42 INFO - 'populate-webroot', 13:25:42 INFO - 'create-virtualenv', 13:25:42 INFO - 'install', 13:25:42 INFO - 'run-tests'), 13:25:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 13:25:42 INFO - 'download_minidump_stackwalk': True, 13:25:42 INFO - 'download_symbols': 'ondemand', 13:25:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 13:25:42 INFO - 'tooltool.py': '/tools/tooltool.py', 13:25:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 13:25:42 INFO - '/tools/misc-python/virtualenv.py')}, 13:25:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 13:25:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 13:25:42 INFO - 'installer_path': 'installer.exe', 13:25:42 INFO - 'log_level': 'info', 13:25:42 INFO - 'log_name': 'talos', 13:25:42 INFO - 'log_to_console': True, 13:25:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 13:25:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 13:25:42 INFO - 'opt_config_files': (), 13:25:42 INFO - 'pip_index': False, 13:25:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:25:42 INFO - 'cmd': ('bash', 13:25:42 INFO - '-c', 13:25:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:25:42 INFO - 'enabled': True, 13:25:42 INFO - 'halt_on_failure': False, 13:25:42 INFO - 'name': 'check_screen_resolution'},), 13:25:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 13:25:42 INFO - 'cmd': ('bash', 13:25:42 INFO - '-c', 13:25:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 13:25:42 INFO - 'enabled': True, 13:25:42 INFO - 'halt_on_failure': False, 13:25:42 INFO - 'name': 'check_screen_resolution'},), 13:25:42 INFO - 'run_cmd_checks_enabled': True, 13:25:42 INFO - 'sps_profile': False, 13:25:42 INFO - 'sps_profile_interval': 0, 13:25:42 INFO - 'suite': 'dromaeojs-e10s', 13:25:42 INFO - 'system_bits': '32', 13:25:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 13:25:42 INFO - 'title': 't-yosemite-r7-0269', 13:25:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 13:25:42 INFO - 'use_talos_json': True, 13:25:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 13:25:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 13:25:42 INFO - 'work_dir': 'build'} 13:25:42 INFO - ##### 13:25:42 INFO - ##### Running clobber step. 13:25:42 INFO - ##### 13:25:42 INFO - Running pre-action listener: _resource_record_pre_action 13:25:42 INFO - Running main action method: clobber 13:25:42 INFO - rmtree: /builds/slave/test/build 13:25:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 13:25:42 INFO - Running post-action listener: _resource_record_post_action 13:25:42 INFO - ##### 13:25:42 INFO - ##### Running read-buildbot-config step. 13:25:42 INFO - ##### 13:25:42 INFO - Running pre-action listener: _resource_record_pre_action 13:25:42 INFO - Running main action method: read_buildbot_config 13:25:42 INFO - Using buildbot properties: 13:25:42 INFO - { 13:25:42 INFO - "project": "", 13:25:42 INFO - "product": "firefox", 13:25:42 INFO - "script_repo_revision": "production", 13:25:42 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 13:25:42 INFO - "repository": "", 13:25:42 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 13:25:42 INFO - "buildid": "20160708113726", 13:25:42 INFO - "pgo_build": "False", 13:25:42 INFO - "basedir": "/builds/slave/test", 13:25:42 INFO - "buildnumber": 34, 13:25:42 INFO - "slavename": "t-yosemite-r7-0269", 13:25:42 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 13:25:42 INFO - "platform": "yosemite_r7", 13:25:42 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 13:25:42 INFO - "branch": "mozilla-beta", 13:25:42 INFO - "repo_path": "releases/mozilla-beta", 13:25:42 INFO - "revision": "23d50da987261085138dab3f05eae49806d9bf1b", 13:25:42 INFO - "stage_platform": "macosx64", 13:25:42 INFO - "builduid": "0e18ae00cb88446ba899f020b0a6a925", 13:25:42 INFO - "slavebuilddir": "test" 13:25:42 INFO - } 13:25:42 INFO - Found installer url https://queue.taskcluster.net/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 13:25:42 INFO - Running post-action listener: _resource_record_post_action 13:25:42 INFO - ##### 13:25:42 INFO - ##### Running download-and-extract step. 13:25:42 INFO - ##### 13:25:42 INFO - Running pre-action listener: _resource_record_pre_action 13:25:42 INFO - Running main action method: download_and_extract 13:25:42 INFO - mkdir: /builds/slave/test/build/tests 13:25:42 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:25:42 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:25:42 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:25:42 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:25:42 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:25:42 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:25:43 INFO - Downloaded 1165 bytes. 13:25:43 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 13:25:43 INFO - Using the following test package requirements: 13:25:43 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 13:25:43 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:25:43 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 13:25:43 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:25:43 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 13:25:43 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 13:25:43 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:25:43 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 13:25:43 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 13:25:43 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:25:43 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 13:25:43 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:25:43 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 13:25:43 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:25:43 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 13:25:43 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 13:25:43 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 13:25:43 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 13:25:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:43 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:25:43 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:25:43 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:25:43 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:25:43 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:25:45 INFO - Downloaded 18351509 bytes. 13:25:45 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:25:45 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:25:48 INFO - Return code: 0 13:25:48 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:25:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:48 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:25:48 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:25:48 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:25:48 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:25:48 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:25:49 INFO - Downloaded 18351509 bytes. 13:25:49 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:25:49 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:25:52 INFO - Return code: 0 13:25:52 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:25:52 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:25:52 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:25:52 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:25:52 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:25:52 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:25:53 INFO - Downloaded 10840145 bytes. 13:25:53 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:25:53 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:25:53 INFO - Return code: 0 13:25:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:25:53 INFO - https://queue.taskcluster.net/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 13:25:53 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:25:53 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:25:53 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:25:53 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:25:56 INFO - Downloaded 86184339 bytes. 13:25:56 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:25:56 INFO - mkdir: /builds/slave/test/properties 13:25:56 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 13:25:56 INFO - Writing to file /builds/slave/test/properties/build_url 13:25:56 INFO - Contents: 13:25:56 INFO - build_url:https://queue.taskcluster.net/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg 13:25:57 INFO - Running post-action listener: _resource_record_post_action 13:25:57 INFO - Running post-action listener: set_extra_try_arguments 13:25:57 INFO - ##### 13:25:57 INFO - ##### Running populate-webroot step. 13:25:57 INFO - ##### 13:25:57 INFO - Running pre-action listener: _resource_record_pre_action 13:25:57 INFO - Running main action method: populate_webroot 13:25:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 13:25:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 13:25:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 13:25:57 INFO - '--tppagecycles', 13:25:57 INFO - '7'], 13:25:57 INFO - 'tests': ['tsvgm']}}, 13:25:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 13:25:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 13:25:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 13:25:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 13:25:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 13:25:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 13:25:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:57 INFO - 'talos_options': ['--disable-e10s'], 13:25:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:25:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 13:25:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:57 INFO - 'talos_options': ['--disable-e10s'], 13:25:57 INFO - 'tests': ['damp', 'tps']}, 13:25:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:57 INFO - 'tests': ['damp', 'tps']}, 13:25:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 13:25:57 INFO - 'tests': ['dromaeo_dom']}, 13:25:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 13:25:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 13:25:57 INFO - 'tests': ['a11yr', 13:25:57 INFO - 'ts_paint', 13:25:57 INFO - 'tpaint', 13:25:57 INFO - 'sessionrestore', 13:25:57 INFO - 'sessionrestore_no_auto_restore', 13:25:57 INFO - 'tabpaint']}, 13:25:57 INFO - 'other-e10s': {'tests': ['a11yr', 13:25:57 INFO - 'ts_paint', 13:25:57 INFO - 'tpaint', 13:25:57 INFO - 'sessionrestore', 13:25:57 INFO - 'sessionrestore_no_auto_restore', 13:25:57 INFO - 'tabpaint']}, 13:25:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 13:25:57 INFO - 'ts_paint', 13:25:57 INFO - 'tpaint', 13:25:57 INFO - 'sessionrestore', 13:25:57 INFO - 'sessionrestore_no_auto_restore', 13:25:57 INFO - 'tabpaint']}, 13:25:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 13:25:57 INFO - 'ts_paint', 13:25:57 INFO - 'tpaint', 13:25:57 INFO - 'sessionrestore', 13:25:57 INFO - 'sessionrestore_no_auto_restore', 13:25:57 INFO - 'tabpaint']}, 13:25:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 13:25:57 INFO - 'tests': ['a11yr', 13:25:57 INFO - 'ts_paint', 13:25:57 INFO - 'tpaint', 13:25:57 INFO - 'sessionrestore', 13:25:57 INFO - 'sessionrestore_no_auto_restore', 13:25:57 INFO - 'tabpaint']}, 13:25:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 13:25:57 INFO - 'tests': ['a11yr', 13:25:57 INFO - 'ts_paint', 13:25:57 INFO - 'tpaint', 13:25:57 INFO - 'sessionrestore', 13:25:57 INFO - 'sessionrestore_no_auto_restore', 13:25:57 INFO - 'tabpaint']}, 13:25:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 13:25:57 INFO - 'tests': ['tsvgx', 13:25:57 INFO - 'tsvgr_opacity', 13:25:57 INFO - 'tart', 13:25:57 INFO - 'tscrollx', 13:25:57 INFO - 'cart']}, 13:25:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 13:25:57 INFO - 'tsvgr_opacity', 13:25:57 INFO - 'tart', 13:25:57 INFO - 'tscrollx', 13:25:57 INFO - 'cart']}, 13:25:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:57 INFO - 'talos_options': ['--disable-e10s'], 13:25:57 INFO - 'tests': ['tp5o']}, 13:25:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:57 INFO - 'tests': ['tp5o']}, 13:25:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:57 INFO - 'talos_options': ['--disable-e10s', 13:25:57 INFO - '--xperf_path', 13:25:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:25:57 INFO - 'tests': ['tp5n']}, 13:25:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 13:25:57 INFO - 'talos_options': ['--xperf_path', 13:25:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 13:25:57 INFO - 'tests': ['tp5n']}}, 13:25:57 INFO - 'talos.zip': {'path': '', 13:25:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 13:25:57 INFO - Running post-action listener: _resource_record_post_action 13:25:57 INFO - ##### 13:25:57 INFO - ##### Running create-virtualenv step. 13:25:57 INFO - ##### 13:25:57 INFO - Running pre-action listener: _resource_record_pre_action 13:25:57 INFO - Running main action method: create_virtualenv 13:25:57 INFO - Creating virtualenv /builds/slave/test/build/venv 13:25:57 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:25:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 13:25:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 13:25:57 INFO - Using real prefix '/tools/python27' 13:25:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 13:25:58 INFO - Installing distribute.............................................................................................................................................................................................done. 13:26:00 INFO - Installing pip.................done. 13:26:00 INFO - Return code: 0 13:26:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 13:26:00 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:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:00 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:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:00 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 0x100bf4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c04420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb978d75900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a93e00>, '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 0x1008fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a8eb20>, '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.wrbyQxEPm7/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.g4Aq7uQanp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:00 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:00 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:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wrbyQxEPm7/Render', 13:26:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:00 INFO - 'HOME': '/Users/cltbld', 13:26:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:00 INFO - 'LOGNAME': 'cltbld', 13:26:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:00 INFO - 'MOZ_NO_REMOTE': '1', 13:26:00 INFO - 'NO_EM_RESTART': '1', 13:26:00 INFO - 'PAGER': '/bin/cat', 13:26:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:00 INFO - 'PWD': '/builds/slave/test', 13:26:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:00 INFO - 'SHELL': '/bin/bash', 13:26:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g4Aq7uQanp/Listeners', 13:26:00 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 13:26:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:00 INFO - 'USER': 'cltbld', 13:26:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:00 INFO - 'XPC_FLAGS': '0x0', 13:26:00 INFO - 'XPC_SERVICE_NAME': '0', 13:26:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:01 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:01 INFO - Cleaning up... 13:26:01 INFO - Return code: 0 13:26:01 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 13:26:01 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:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:01 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:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:01 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 0x100bf4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c04420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb978d75900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a93e00>, '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 0x1008fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a8eb20>, '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.wrbyQxEPm7/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.g4Aq7uQanp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:01 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:01 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:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wrbyQxEPm7/Render', 13:26:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:01 INFO - 'HOME': '/Users/cltbld', 13:26:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:01 INFO - 'LOGNAME': 'cltbld', 13:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:01 INFO - 'MOZ_NO_REMOTE': '1', 13:26:01 INFO - 'NO_EM_RESTART': '1', 13:26:01 INFO - 'PAGER': '/bin/cat', 13:26:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:01 INFO - 'PWD': '/builds/slave/test', 13:26:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:01 INFO - 'SHELL': '/bin/bash', 13:26:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g4Aq7uQanp/Listeners', 13:26:01 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 13:26:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:01 INFO - 'USER': 'cltbld', 13:26:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:01 INFO - 'XPC_FLAGS': '0x0', 13:26:01 INFO - 'XPC_SERVICE_NAME': '0', 13:26:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:01 INFO - Downloading/unpacking psutil>=0.7.1 13:26: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:26: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:26: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:26: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:26: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:26: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:26:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 13:26:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:26:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:26:04 INFO - Installing collected packages: psutil 13:26:04 INFO - Running setup.py install for psutil 13:26:04 INFO - building 'psutil._psutil_osx' extension 13:26:04 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:04 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:04 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:05 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:05 INFO - building 'psutil._psutil_posix' extension 13:26:05 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:05 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 13:26:05 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 13:26:05 INFO - ^ 13:26:05 INFO - 1 warning generated. 13:26:05 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:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 13:26:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 13:26:05 INFO - Successfully installed psutil 13:26:05 INFO - Cleaning up... 13:26:05 INFO - Return code: 0 13:26:05 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 13:26:05 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:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:05 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:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:05 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 0x100bf4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c04420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb978d75900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a93e00>, '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 0x1008fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a8eb20>, '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.wrbyQxEPm7/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.g4Aq7uQanp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:05 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:05 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:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wrbyQxEPm7/Render', 13:26:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:05 INFO - 'HOME': '/Users/cltbld', 13:26:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:05 INFO - 'LOGNAME': 'cltbld', 13:26:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:05 INFO - 'MOZ_NO_REMOTE': '1', 13:26:05 INFO - 'NO_EM_RESTART': '1', 13:26:05 INFO - 'PAGER': '/bin/cat', 13:26:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:05 INFO - 'PWD': '/builds/slave/test', 13:26:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:05 INFO - 'SHELL': '/bin/bash', 13:26:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g4Aq7uQanp/Listeners', 13:26:05 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 13:26:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:05 INFO - 'USER': 'cltbld', 13:26:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:05 INFO - 'XPC_FLAGS': '0x0', 13:26:05 INFO - 'XPC_SERVICE_NAME': '0', 13:26:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:05 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 13:26:05 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:05 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:05 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:05 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:05 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:05 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:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 13:26:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 13:26:08 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:08 INFO - Installing collected packages: mozsystemmonitor 13:26:08 INFO - Running setup.py install for mozsystemmonitor 13:26:08 INFO - Successfully installed mozsystemmonitor 13:26:08 INFO - Cleaning up... 13:26:08 INFO - Return code: 0 13:26:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 13:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x100bf4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c04420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb978d75900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a93e00>, '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 0x1008fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a8eb20>, '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.wrbyQxEPm7/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.g4Aq7uQanp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 13:26:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 13:26:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wrbyQxEPm7/Render', 13:26:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:08 INFO - 'HOME': '/Users/cltbld', 13:26:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:08 INFO - 'LOGNAME': 'cltbld', 13:26:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:08 INFO - 'MOZ_NO_REMOTE': '1', 13:26:08 INFO - 'NO_EM_RESTART': '1', 13:26:08 INFO - 'PAGER': '/bin/cat', 13:26:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:08 INFO - 'PWD': '/builds/slave/test', 13:26:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:08 INFO - 'SHELL': '/bin/bash', 13:26:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g4Aq7uQanp/Listeners', 13:26:08 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 13:26:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:08 INFO - 'USER': 'cltbld', 13:26:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:08 INFO - 'XPC_FLAGS': '0x0', 13:26:08 INFO - 'XPC_SERVICE_NAME': '0', 13:26:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:08 INFO - Downloading/unpacking blobuploader==1.2.4 13:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:11 INFO - Downloading blobuploader-1.2.4.tar.gz 13:26:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 13:26:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 13:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 13:26:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 13:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:12 INFO - Downloading docopt-0.6.1.tar.gz 13:26:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 13:26:12 INFO - Installing collected packages: blobuploader, requests, docopt 13:26:12 INFO - Running setup.py install for blobuploader 13:26:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 13:26:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 13:26:12 INFO - Running setup.py install for requests 13:26:13 INFO - Running setup.py install for docopt 13:26:13 INFO - Successfully installed blobuploader requests docopt 13:26:13 INFO - Cleaning up... 13:26:13 INFO - Return code: 0 13:26:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 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 - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 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 - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:13 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 0x100bf4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c04420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb978d75900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a93e00>, '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 0x1008fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a8eb20>, '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.wrbyQxEPm7/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.g4Aq7uQanp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:13 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:13 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:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wrbyQxEPm7/Render', 13:26:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:13 INFO - 'HOME': '/Users/cltbld', 13:26:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:13 INFO - 'LOGNAME': 'cltbld', 13:26:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:13 INFO - 'MOZ_NO_REMOTE': '1', 13:26:13 INFO - 'NO_EM_RESTART': '1', 13:26:13 INFO - 'PAGER': '/bin/cat', 13:26:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:13 INFO - 'PWD': '/builds/slave/test', 13:26:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:13 INFO - 'SHELL': '/bin/bash', 13:26:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g4Aq7uQanp/Listeners', 13:26:13 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 13:26:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:13 INFO - 'USER': 'cltbld', 13:26:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:13 INFO - 'XPC_FLAGS': '0x0', 13:26:13 INFO - 'XPC_SERVICE_NAME': '0', 13:26:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:26:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-sl5U5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:26:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-Wn11aG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:26:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-CWBPqq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:26:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-COYkMA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:26:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:26:13 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-_PO301-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:26:14 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-ZugqSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:26:14 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-M4lbrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:26:14 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-sBLko4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:26:14 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-tx4akG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:26:14 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-QqmpUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:26:14 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-30wS0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:26:14 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-_ox4Wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:26:14 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-ci4iAw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:26:14 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-ZftY8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:26:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:14 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-O97IRJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:26:15 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-EGxjq_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:26:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:26:15 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-9uvXYy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:26:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 13:26:15 INFO - Running setup.py install for manifestparser 13:26:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 13:26:15 INFO - Running setup.py install for mozcrash 13:26:15 INFO - Running setup.py install for mozdebug 13:26:15 INFO - Running setup.py install for mozdevice 13:26:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 13:26:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 13:26:15 INFO - Running setup.py install for mozfile 13:26:15 INFO - Running setup.py install for mozhttpd 13:26:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 13:26:16 INFO - Running setup.py install for mozinfo 13:26:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 13:26:16 INFO - Running setup.py install for mozInstall 13:26:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 13:26:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 13:26:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 13:26:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 13:26:16 INFO - Running setup.py install for mozleak 13:26:16 INFO - Running setup.py install for mozlog 13:26:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 13:26:16 INFO - Running setup.py install for moznetwork 13:26:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 13:26:16 INFO - Running setup.py install for mozprocess 13:26:17 INFO - Running setup.py install for mozprofile 13:26:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 13:26:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 13:26:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 13:26:17 INFO - Running setup.py install for mozrunner 13:26:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 13:26:17 INFO - Running setup.py install for mozscreenshot 13:26:17 INFO - Running setup.py install for moztest 13:26:17 INFO - Running setup.py install for mozversion 13:26:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 13:26:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 13:26:17 INFO - Cleaning up... 13:26:17 INFO - Return code: 0 13:26:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:17 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 0x100bf4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c04420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb978d75900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a93e00>, '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 0x1008fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a8eb20>, '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.wrbyQxEPm7/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.g4Aq7uQanp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:17 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:17 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:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wrbyQxEPm7/Render', 13:26:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:17 INFO - 'HOME': '/Users/cltbld', 13:26:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:17 INFO - 'LOGNAME': 'cltbld', 13:26:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:17 INFO - 'MOZ_NO_REMOTE': '1', 13:26:17 INFO - 'NO_EM_RESTART': '1', 13:26:17 INFO - 'PAGER': '/bin/cat', 13:26:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:17 INFO - 'PWD': '/builds/slave/test', 13:26:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:17 INFO - 'SHELL': '/bin/bash', 13:26:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g4Aq7uQanp/Listeners', 13:26:17 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 13:26:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:17 INFO - 'USER': 'cltbld', 13:26:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:17 INFO - 'XPC_FLAGS': '0x0', 13:26:17 INFO - 'XPC_SERVICE_NAME': '0', 13:26:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 13:26:18 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-gXsa7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 13:26:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 13:26:18 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-hCdwpV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 13:26:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 13:26:18 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-aIQyos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 13:26:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 13:26:18 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-gtWyTZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 13:26:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 13:26:18 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-qs9ZJB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 13:26:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 13:26:18 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-CWpDEr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 13:26:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 13:26:18 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-pl_EdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 13:26:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 13:26:18 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-8fGQkn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 13:26:18 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:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 13:26:18 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-toUBTA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 13:26:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 13:26:19 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-nFjRTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 13:26:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 13:26:19 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-PGK10d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 13:26:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 13:26:19 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-TAdOPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 13:26:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 13:26:19 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-W4z1Te-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 13:26:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 13:26:19 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-rmgsRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 13:26:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:19 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-aTyYXU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 13:26:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 13:26:19 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-aGA6ps-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 13:26:19 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:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 13:26:19 INFO - Running setup.py (path:/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/pip-LZjKvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 13:26:19 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:19 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:19 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:19 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:19 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:19 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:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 13:26:19 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:19 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:19 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:19 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:19 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:19 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:22 INFO - Downloading blessings-1.6.tar.gz 13:26:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 13:26:22 INFO - Installing collected packages: blessings 13:26:22 INFO - Running setup.py install for blessings 13:26:22 INFO - Successfully installed blessings 13:26:22 INFO - Cleaning up... 13:26:22 INFO - Return code: 0 13:26:22 INFO - Done creating virtualenv /builds/slave/test/build/venv. 13:26:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:26:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:26:22 INFO - Reading from file tmpfile_stdout 13:26:22 INFO - Current package versions: 13:26:22 INFO - blessings == 1.6 13:26:22 INFO - blobuploader == 1.2.4 13:26:22 INFO - docopt == 0.6.1 13:26:22 INFO - manifestparser == 1.1 13:26:22 INFO - mozInstall == 1.12 13:26:22 INFO - mozcrash == 0.17 13:26:22 INFO - mozdebug == 0.1 13:26:22 INFO - mozdevice == 0.48 13:26:22 INFO - mozfile == 1.2 13:26:22 INFO - mozhttpd == 0.7 13:26:22 INFO - mozinfo == 0.9 13:26:22 INFO - mozleak == 0.1 13:26:22 INFO - mozlog == 3.1 13:26:22 INFO - moznetwork == 0.27 13:26:22 INFO - mozprocess == 0.22 13:26:22 INFO - mozprofile == 0.28 13:26:22 INFO - mozrunner == 6.11 13:26:22 INFO - mozscreenshot == 0.1 13:26:22 INFO - mozsystemmonitor == 0.0 13:26:22 INFO - moztest == 0.7 13:26:22 INFO - mozversion == 1.4 13:26:22 INFO - psutil == 3.1.1 13:26:22 INFO - requests == 1.2.3 13:26:22 INFO - wsgiref == 0.1.2 13:26:22 INFO - Installing None into virtualenv /builds/slave/test/build/venv 13:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:22 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 0x100bf4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c04420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb978d75900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a93e00>, '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 0x1008fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a8eb20>, '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.wrbyQxEPm7/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.g4Aq7uQanp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:22 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:22 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:22 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wrbyQxEPm7/Render', 13:26:22 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:22 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:22 INFO - 'HOME': '/Users/cltbld', 13:26:22 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:22 INFO - 'LOGNAME': 'cltbld', 13:26:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:22 INFO - 'MOZ_NO_REMOTE': '1', 13:26:22 INFO - 'NO_EM_RESTART': '1', 13:26:22 INFO - 'PAGER': '/bin/cat', 13:26:22 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:22 INFO - 'PWD': '/builds/slave/test', 13:26:22 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:22 INFO - 'SHELL': '/bin/bash', 13:26:22 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g4Aq7uQanp/Listeners', 13:26:22 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 13:26:22 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:22 INFO - 'USER': 'cltbld', 13:26:22 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:22 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:22 INFO - 'XPC_FLAGS': '0x0', 13:26:22 INFO - 'XPC_SERVICE_NAME': '0', 13:26:22 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:23 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:23 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:23 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:23 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:23 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:23 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:23 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:23 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:23 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:23 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:23 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:23 INFO - Cleaning up... 13:26:23 INFO - Return code: 0 13:26:23 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 13:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:23 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 0x100bf4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c04420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb978d75900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a93e00>, '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 0x1008fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a8eb20>, '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.wrbyQxEPm7/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.g4Aq7uQanp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:23 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:23 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:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wrbyQxEPm7/Render', 13:26:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:23 INFO - 'HOME': '/Users/cltbld', 13:26:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:23 INFO - 'LOGNAME': 'cltbld', 13:26:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:23 INFO - 'MOZ_NO_REMOTE': '1', 13:26:23 INFO - 'NO_EM_RESTART': '1', 13:26:23 INFO - 'PAGER': '/bin/cat', 13:26:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:23 INFO - 'PWD': '/builds/slave/test', 13:26:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:23 INFO - 'SHELL': '/bin/bash', 13:26:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g4Aq7uQanp/Listeners', 13:26:23 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 13:26:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:23 INFO - 'USER': 'cltbld', 13:26:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:23 INFO - 'XPC_FLAGS': '0x0', 13:26:23 INFO - 'XPC_SERVICE_NAME': '0', 13:26:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:23 INFO - Downloading/unpacking jsonschema 13:26:23 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:23 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:23 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:23 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:23 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:23 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:25 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 13:26:25 INFO - Downloading/unpacking functools32 (from jsonschema) 13:26:25 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:25 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:25 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:25 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:25 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:25 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:26 INFO - Downloading functools32-3.2.3-2.tar.gz 13:26:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 13:26:26 INFO - warning: no files found matching '*.txt' 13:26:26 INFO - no previously-included directories found matching 'build' 13:26:26 INFO - no previously-included directories found matching 'dist' 13:26:26 INFO - no previously-included directories found matching '.git*' 13:26:26 INFO - Installing collected packages: jsonschema, functools32 13:26:26 INFO - Running setup.py install for functools32 13:26:26 INFO - warning: no files found matching '*.txt' 13:26:26 INFO - no previously-included directories found matching 'build' 13:26:26 INFO - no previously-included directories found matching 'dist' 13:26:26 INFO - no previously-included directories found matching '.git*' 13:26:26 INFO - Successfully installed jsonschema functools32 13:26:26 INFO - Cleaning up... 13:26:26 INFO - Return code: 0 13:26:26 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 13:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 13:26:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 13:26:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 13:26:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 13:26:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100bf4a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100c04420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb978d75900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x100a93e00>, '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 0x1008fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a8eb20>, '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.wrbyQxEPm7/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.g4Aq7uQanp/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 13:26:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 13:26:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wrbyQxEPm7/Render', 13:26:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 13:26:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 13:26:26 INFO - 'HOME': '/Users/cltbld', 13:26:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 13:26:26 INFO - 'LOGNAME': 'cltbld', 13:26:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:26 INFO - 'MOZ_NO_REMOTE': '1', 13:26:26 INFO - 'NO_EM_RESTART': '1', 13:26:26 INFO - 'PAGER': '/bin/cat', 13:26:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 13:26:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 13:26:26 INFO - 'PWD': '/builds/slave/test', 13:26:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 13:26:26 INFO - 'SHELL': '/bin/bash', 13:26:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.g4Aq7uQanp/Listeners', 13:26:26 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/', 13:26:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 13:26:26 INFO - 'USER': 'cltbld', 13:26:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 13:26:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 13:26:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 13:26:26 INFO - 'XPC_FLAGS': '0x0', 13:26:26 INFO - 'XPC_SERVICE_NAME': '0', 13:26:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 13:26:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 13:26:26 INFO - Downloading/unpacking flake8 13:26:26 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:26 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:26 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:26 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:26 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:26 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:30 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 13:26:30 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 13:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:30 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 13:26:30 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 13:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:31 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 13:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 13:26:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 13:26:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 13:26:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 13:26:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:26:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:26:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:26:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:26:31 INFO - no previously-included directories found matching 'docs/_build' 13:26:31 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 13:26:31 INFO - Running setup.py install for pep8 13:26:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 13:26:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 13:26:31 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 13:26:31 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 13:26:31 INFO - no previously-included directories found matching 'docs/_build' 13:26:31 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 13:26:31 INFO - Successfully installed flake8 mccabe pyflakes pep8 13:26:31 INFO - Cleaning up... 13:26:31 INFO - Return code: 0 13:26:31 INFO - Running post-action listener: _resource_record_post_action 13:26:31 INFO - Running post-action listener: _start_resource_monitoring 13:26:31 INFO - Starting resource monitoring. 13:26:31 INFO - ##### 13:26:31 INFO - ##### Running install step. 13:26:31 INFO - ##### 13:26:31 INFO - Running pre-action listener: _resource_record_pre_action 13:26:31 INFO - Running main action method: install 13:26:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 13:26:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 13:26:32 INFO - Reading from file tmpfile_stdout 13:26:32 INFO - Detecting whether we're running mozinstall >=1.0... 13:26:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 13:26:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 13:26:32 INFO - Reading from file tmpfile_stdout 13:26:32 INFO - Output received: 13:26:32 INFO - Usage: mozinstall [options] installer 13:26:32 INFO - Options: 13:26:32 INFO - -h, --help show this help message and exit 13:26:32 INFO - -d DEST, --destination=DEST 13:26:32 INFO - Directory to install application into. [default: 13:26:32 INFO - "/builds/slave/test"] 13:26:32 INFO - --app=APP Application being installed. [default: firefox] 13:26:32 INFO - mkdir: /builds/slave/test/build/application 13:26:32 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:26:32 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:26:53 INFO - Reading from file tmpfile_stdout 13:26:53 INFO - Output received: 13:26:53 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 13:26:53 INFO - Running post-action listener: _resource_record_post_action 13:26:53 INFO - ##### 13:26:53 INFO - ##### Running run-tests step. 13:26:53 INFO - ##### 13:26:53 INFO - Running pre-action listener: _resource_record_pre_action 13:26:53 INFO - Running main action method: run_tests 13:26:53 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:26:53 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:26:53 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:26:53 INFO - 2016-07-08 13:26:53.798 screenresolution[2620:292872] starting screenresolution argv=screenresolution get 13:26:53 INFO - 2016-07-08 13:26:53.800 screenresolution[2620:292872] Display 0: 1600x1200x32@60 13:26:53 INFO - 2016-07-08 13:26:53.806 screenresolution[2621:292876] starting screenresolution argv=screenresolution list 13:26:53 INFO - Available Modes on Display 0 13:26:53 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:26:53 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:26:53 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:26:53 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:26:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:26:54 INFO - Intel Iris: 13:26:54 INFO - Chipset Model: Intel Iris 13:26:54 INFO - Type: GPU 13:26:54 INFO - Bus: Built-In 13:26:54 INFO - VRAM (Dynamic, Max): 1536 MB 13:26:54 INFO - Vendor: Intel (0x8086) 13:26:54 INFO - Device ID: 0x0a2e 13:26:54 INFO - Revision ID: 0x0009 13:26:54 INFO - Displays: 13:26:54 INFO - Display: 13:26:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:26:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:26:54 INFO - Display Serial Number: 1600x1200 60 13:26:54 INFO - Main Display: Yes 13:26:54 INFO - Mirror: Off 13:26:54 INFO - Online: Yes 13:26:54 INFO - Rotation: Supported 13:26:54 INFO - Return code: 0 13:26:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 13:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 13:26:54 INFO - Python 2.7.3 13:26:54 INFO - Return code: 0 13:26:54 INFO - grabbing minidump binary from tooltool 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 - 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 0x100a93e00>, '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 0x1008fcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x100a8eb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 13:26:54 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:26:54 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:26:54 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 13:26:54 INFO - Return code: 0 13:26:54 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 13:26:54 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 13:26:54 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 13:26:54 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 13:26:54 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 13:26:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 13:26:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 13:26:55 INFO - Return code: 0 13:26:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0269', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 13:26:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0269 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 13:26:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.wrbyQxEPm7/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 - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 13:26:55 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 13:26:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 13:26:55 INFO - 'MOZ_NO_REMOTE': '1', 13:26:55 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 13:26:55 INFO - 'NO_EM_RESTART': '1', 13:26:55 INFO - 'PAGER': '/bin/cat', 13:26:55 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/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 - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 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.g4Aq7uQanp/Listeners', 13:26:55 INFO - 'TMPDIR': '/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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 - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0269', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 13:26:55 INFO - mozversion application_buildid: 20160708113726 13:26:55 INFO - mozversion application_changeset: 23d50da987261085138dab3f05eae49806d9bf1b 13:26:55 INFO - mozversion application_display_name: Firefox 13:26:55 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 13:26:55 INFO - mozversion application_name: Firefox 13:26:55 INFO - mozversion application_remotingname: firefox 13:26:55 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 13:26:55 INFO - mozversion application_vendor: Mozilla 13:26:55 INFO - mozversion application_version: 48.0 13:26:55 INFO - mozversion platform_buildid: 20160708113726 13:26:55 INFO - mozversion platform_changeset: 23d50da987261085138dab3f05eae49806d9bf1b 13:26:55 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 13:26:55 INFO - mozversion platform_version: 48.0 13:26:55 INFO - using testdate: 1468009615 13:26:55 INFO - actual date: 1468009615 13:26:55 INFO - starting webserver on 'localhost:54279' 13:26:55 INFO - SUITE-START | Running 2 tests 13:26:55 INFO - TEST-START | dromaeo_css 13:26:55 INFO - operating with platform_type : mac_ 13:26:55 INFO - Initialising browser for dromaeo_css test... 13:26:55 INFO - TEST-INFO | started process 2639 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpBR4KAz/profile http://localhost:54279/getInfo.html) 13:26:58 INFO - PROCESS | 2639 | __metrics Screen width/height:1600/1200 13:26:58 INFO - PROCESS | 2639 | colorDepth:24 13:26:58 INFO - PROCESS | 2639 | Browser inner width/height: 1024/689 13:26:58 INFO - PROCESS | 2639 | __metrics 13:26:58 ERROR - PROCESS | 2639 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 13:26:58 INFO - TEST-INFO | 2639: exit 0 13:26:58 INFO - Browser initialized. 13:26:58 INFO - Running cycle 1/1 for dromaeo_css test... 13:26:58 INFO - TEST-INFO | started process 2643 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpBR4KAz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:27:10 INFO - PROCESS | 2643 | RSS: Main: 170905600 13:27:10 INFO - PROCESS | 2643 | 13:28:00 INFO - PROCESS | 2643 | 1468009680308 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:10 INFO - PROCESS | 2643 | Cycle 1(1): loaded http://localhost:54279/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54279/tests/dromaeo/cssquery-ext.html) 13:30:11 INFO - PROCESS | 2643 | RSS: Main: 183689216 13:30:11 INFO - PROCESS | 2643 | 13:33:14 INFO - PROCESS | 2643 | Cycle 1(1): loaded http://localhost:54279/tests/dromaeo/cssquery-ext.html (next: http://localhost:54279/tests/dromaeo/cssquery-jquery.html) 13:33:14 INFO - PROCESS | 2643 | RSS: Main: 194322432 13:33:14 INFO - PROCESS | 2643 | 13:36:16 INFO - PROCESS | 2643 | Cycle 1(1): loaded http://localhost:54279/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54279/tests/dromaeo/cssquery-mootools.html) 13:36:17 INFO - PROCESS | 2643 | RSS: Main: 196542464 13:36:17 INFO - PROCESS | 2643 | 13:39:18 INFO - PROCESS | 2643 | Cycle 1(1): loaded http://localhost:54279/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54279/tests/dromaeo/cssquery-prototype.html) 13:39:19 INFO - PROCESS | 2643 | RSS: Main: 200269824 13:39:19 INFO - PROCESS | 2643 | 13:42:21 INFO - PROCESS | 2643 | Cycle 1(1): loaded http://localhost:54279/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54279/tests/dromaeo/cssquery-yui.html) 13:42:22 INFO - PROCESS | 2643 | RSS: Main: 199233536 13:42:22 INFO - PROCESS | 2643 | 13:45:24 INFO - PROCESS | 2643 | Cycle 1(1): loaded http://localhost:54279/tests/dromaeo/cssquery-yui.html (next: http://localhost:54279/tests/dromaeo/cssquery-dojo.html) 13:45:25 INFO - PROCESS | 2643 | RSS: Main: 204627968 13:45:25 INFO - PROCESS | 2643 | 13:45:25 INFO - PROCESS | 2643 | __start_tp_report 13:45:25 INFO - PROCESS | 2643 | _x_x_mozilla_page_load 13:45:25 INFO - PROCESS | 2643 | _x_x_mozilla_page_load_details 13:45:25 INFO - PROCESS | 2643 | |i|pagename|runs| 13:45:25 INFO - PROCESS | 2643 | |0;dojo.html;3605.7475976681635;3621.130928577141;3640.3993341098685;3675.8162091895397;3693.9630603693954;5992.580519363646;5996.550258730602;6030.427109424598;6047.213862197914;6060.545459090564;4794.595836955757;5903.645781253117;5950.940107085045;6035.75856965722;6089.208402907627;5353.919691204625;5392.892142157155;5412.56699464042;5435.076037073687;5527.889442211153;5340.118880384752;5416.377116631578;5428.809991650293;5459.836204913859;5465.098258787295;5432.83701488954;5450.890982180354;5458.4541545845495;5460.153676180198;5470.699111548883;4391.912161756779;4439.4672639283335;5430.266913966603;5480.890382192374;5517.972410137963;5237.3453318335205;5377.838664840061;5388.084025715638;5404.864878378033;5440.537554307889;4761.357216775726;5853.853453873458;5933.2880054393745;5935.73289201987;5955.255593050869;6166.352532984017;6267.59260648061;6282.874342513124;6303.275123360826;6359.300476947532;5658.868226354704;6109.04313553752;6132.11084392765;6429.164208652892;6504.8699026019685;6082.726277317487;6130.049842274455;6154.230721159855;6166.7224974876235;6176.444120029174;5787.363390027093;6390.265119511223;6470.158879345655;6563.6389998549585;6632.071509988606;5251.711155886386;6258.530610204162;6277.968610157011;6305;6307.211598550181;6244.687765611701;6417;6417.96791016042;6433.74265029403;6437.742490300429;6215.906761398583;6254.655993920378;6303.401176888188;6303.432691057735;6328.493720502349;6282.937170628235;6294.087357333161;6309.3690630936535;6317.431431171217;6320.55756097078;4990.80036798524;5051.4695956924725;5072.061668591323;5146.4853514648985;5186.092433824066;4577.56513131252;4600.171969045604;4634.2585186370015;4635;4642.210824159901;6152.969235153795;6204.472619827275;6221.906671399842;6231.563790534709;6232.719527621268;6306.905396419057;6418.614883107029;6447.097406363113;6481.319461456574;6482.351764823574;6090.23872015998;6131.682521312696;6206.286277078194;6228.096925945803;6228.937710622836;5706.343770466449;5711;5720.48515633595;5731.971340143273;5740.741666625012;6553.737850486023;6669.799906002925;6747.190337159376;6774.119364482585;6798.694058767367;6427.228732552124;6467.514936379885;6475.158229430144;6485;6502.284748677547;6718.630475323904;6774.220964589135;6792.592444453348;6798.93201067983;6802.965985170043;5697.943020569907;6233.096201050913;6283.214598175228;6326.304106548184;6360.077788720702;6109.236345456818;6411.6153030818305;6440.774572889926;6445.16212892321;6462.1599192106605;6276.1840960676645;6293.496520278458;6300.275468321019;6308.211473565804;6309.33751956038;5988.820335389945;6241.095041219089;6256.843578910381;6257.2804127525915;6308.369163083655;6084;6113.205283313141;6213.9067913982235;6224.315325314303;6225.470834979077;6162.876742465215;6293.874122517615;6318.115463834974;6345.96827015862;6361.300256971637;6136.457808108435;6206.782762603287;6211.81364559064;6223.657698826608;6233.065040244 13:45:25 INFO - PROCESS | 2643 | |1;ext.html;512.1881817319546;526.1213772999092;584.9912251316231;589.6226415094337;601.2574470528896;38880.222395552075;39823.80088099559;39916;39974.800125999405;40057.198856022864;42101.36847947283;42664.14671706564;42679.78660106695;42713.57286427135;42750.786246068725;9725.854112188323;9908.900910990906;9929.851052234186;9973.800523989552;10041.347312424705;9748.122668959792;10007.899921000806;10023.498825058754;10047.447390393525;10073.546690398913;10021.44882031488;10080.09279164875;10134.037266459674;10148.289619726622;10158.339707918998;9941.801163976716;10011.699649010541;10029.899701003005;10060.39637621745;10113;9894.406335619886;10011.499425028793;10039.046290602455;10046.246531510165;10062.345947513462;39981.80009099936;40084;40634.59365406338;40877.182456351;40986;3402.6597340265776;3527.664871837171;3551.183227857581;3889.961100388988;3939.1333906540517;24950;29343.559846602104;29686.406271874657;29761.70238297611;30205.697943020507;2655.216711070239;2804.2288370698016;2804.9018284360154;2821.097248880359;2904.8983285585114;552275;552794;558250;559305;561492;60538.78922421527;60640.48398789977;60756;61319.38680613137;61597.38402616006;65272;65694.67152664301;73066.269337307;73811.26188738045;74775;18516.537086572942;18692.626147477247;18715.064246787606;18751.624967500848;18779.718304225447;14330.068545544505;14331;14402.351894164787;14432.855671443362;14450.205238711762;19687;20016.49958751043;20083.19667213295;20169.294074707315;20601.278955236496;8429.114942930904;8561.190270329767;8573.314134869195;8576;8576.313894888393;923.6074668266094;992.6128809764198;1051.7948999944938;1076.262760009396;1207.4626791078063;30455.390892182033;30572.235694107825;30770.69229307723;31123.599438025343;31336.68663313383;1016.5273147986222;1105.3312745788842;1147.6786499780076;1168.67861338131;1184.9763004739857;15736.898417110693;15774.842251577567;15783.447579334668;15794;16130.919345403197;566897;569951;570598;572079;577278;62735.6863215681;64246.678766606805;64624.35375646183;64919.70160596762;64988.35011649823;1525.862672359493;1540.7303721848407;1546.605615568023;1551.9146446945301;1552.9767053494206;30218.395632087675;30635.846820765753;30758.923437679572;31059.689403106582;31184.064478064785;47646.28530571975;48318.758406207744;53483.732581336844;54654.180187298014;55075;558887;559967.0008249826;560141;560950.1952490212;562499;27428;28103.57844632373;44169.77915110404;44855.43005994774;45633;44611.553884460736;46812.063758723954;47470.76264618655;47599.52400475951;48612.2708159385;38064;38948.41577376285;39119;39168.41247381234;39399.80300098481;35130;38410.42384364181;38499;38816.41775373315;39073;33903.3219335607;38262;39845.40231896582;40424;40560.39159412552;30796;32846.507302390004;32870.835645821615;32977.83511082429;33123;24749;25016.249512514652;25146.74853251444;25245.621315680648;25455.36361590901 13:45:25 INFO - PROCESS | 2643 | |2;jquery.html;382.4951064594735;384.91916697493525;416.2403613405536;416.708304187069;423.19170384565484;15841.762373564377;19106.61786764264;20756.688649670246;20867.791322086774;21330;20574.897125514388;20934.476638084056;21260.787392126073;21503;21511.247106351282;5845.976954033027;5925.940740592593;6150.354212807658;6157.415045570686;6180.412860778219;5556.16657501374;6074.754675291555;6153.107799369089;6165.63006219626;6183.505319574446;5448.45515448456;6052.878942421149;6186;6430.356964303579;6752.966235168818;6694.59832410057;6698.866022679544;6700.798976030678;6709.630970296632;6756.7635132770365;5615.1857980592995;5934.821955341346;5936.495397891184;5956.672383018932;5979.790707325266;11503.07975361969;14018.859811401857;14264.85735142656;22908.083676652914;23384.363094583387;2059.794020597928;2260.8756518391483;2293.1973809166825;2348.2368230325214;2378.203301893868;9954.900450995543;10048.899511004869;10079.44563049032;10365.37807731531;10432.530536125816;1609.3643011010702;1737.044625455994;1794.1926133240095;1810.592616661254;1849.7687789026372;110026.44986775015;122057.38971305176;123531.14703279459;124513;125393;11762.529498819951;11919.463624136935;12032;12038.939805300917;12100.394980251129;12951;14998;15173.924130379277;15197.468088617066;15368.308426120851;9166.358354915224;9192.632294708137;9224.30817688676;9232.95383523078;9352.392094513834;9331.626734930527;9338.346315757832;9384.577694003787;9421.858672119924;9429.90570094304;4357.891052723708;4727.149113159664;4815.638827087912;4817.373741413594;4899.069176856386;1659.8838081334432;2057.6296266672143;2089;2093.9371818845457;2098.5068508900395;947.8009617980164;993.6124911284605;1004.8794144702537;1035.5857656937135;1102.7518808268076;19060.71408928867;20234.898825506072;20436.693449598268;20459.897700511403;20491.79508204899;993.4536005197257;1018.4449475036123;1046.8691413573304;1059.9841002384971;1086.190787863047;6095.542834287447;6301.52738544611;6439.871202575922;6442.420182183626;10628.893711062945;605658;619555;636540;646799;659949;77193;122181;128579;135875.73444182493;140699;480.97114173149726;490.458043861535;492.2616075886171;493.2010143567444;494.9604031677457;11132.109431245319;11547.249428787101;11650.76698466009;11825.40872956366;11838.881611183779;53848.46151538435;56233;57381.71309143428;57984.710076449344;59753.701231493564;85019;85348;85805.57097214473;86272.56863715641;87541;8178.83642327162;8399.580020999048;8455.365847561334;8465.195806398382;8741.519216443157;9429.62281508732;12276.202046866925;12513.24814525949;12655.557055503014;12751.61745147647;10777.760557535983;11032.172587055842;11242;11311.925367090442;11336.263142895685;9483;10256.282060255711;10853.34879907208;11013.559457621606;11175.105991520497;11273.830892536454;11437.542498299976;11504;11604.333452821935;11738.178327516991;8213.589320534069;8247.422680412314;8434.578271086299;8469.957650211709;8482.406231563731;10387.37675739458;11099.445027748741;11359.148063895405;11430.599929002445;11571.305721656727 13:45:25 INFO - PROCESS | 2643 | |3;mootools.html;1628.8615467685247;1644.3915751172065;1917.9520511987207;2015.9899200503996;2026.3009261804673;8351.624176912039;8978.595963181657;9095.317851161164;9314.022027687097;9360.85958710619;9035.051319611444;9079.591418386171;9173.08269173084;9173.357864949456;9200.585973631187;2550.1966880432697;2572.2026171886682;2579.0199724104814;2584.0955665517013;2587.9094231701893;2526.646269522259;2599.5060938421734;2603.7916966642624;2605.7524535169223;2609.0476975903753;2128.265748316828;2560.2575253176556;2572.2026171886773;2573.665423494943;2611.268844723471;2197.626403511407;2558.104663367825;2588.120039186676;2597.467519158587;2597.571400718879;2260.7287125544876;2577.6262441946;2590.0157939982873;2618.711941686413;2627.9605805912734;9273;9322.30082743797;9369.625214991393;9405.670801521914;9416.670416535457;5681.715914204315;5852.707364631751;5855.033919403293;5858;5897.705114744245;3664.706823454117;3720.255948810249;3754.2491501699496;3786.6970642348547;3809.695224382043;1051.3429106808244;1067.0905884398458;1079.9784004319947;1081.2755453845941;1087.8096333141748;12560.497580096877;12577.496900123984;12585.937070314681;12587.93706031464;12600.68498287541;5021.096202683552;5061.645684802103;5122.385313762373;5178.766955487012;5234.319538459976;9370.85943710845;10139.847902281472;10663;10826.512806923707;10845.457727113771;5585.162225666101;5611.80358687444;5626.915596266059;5793.275840519935;5816.912746308809;4653.395058642355;5093.745312734349;5109.38687357512;5204.947950520522;5221.660592061504;4290.034742183047;4332.328489084197;4334.718243314238;4353.521112677603;4375.321825117112;1080.7406222506543;1401.7336706025822;1424.6936908564708;1429.8713115819626;1482.5552334299666;927.9211267042377;928.2898582584328;951.4291425144858;969.4759549039153;995.318207028188;6003.3996600339615;6034.5172386209;6168.414000669929;6211;6228.377162283826;475.2419890275006;490.4874406245411;495.38819557846034;1040.765827688764;1041.578160844859;3998.7000974926996;4038.2932986727205;4060.3706425504092;4068.247374235776;4127.6491498222385;11083.113350932068;11503.942480287546;11508.021818145551;11525.077993760478;11552.613686357523;11102.500387482583;11255.718607034889;11260.605878794202;11290.717732056764;11291;7622.31399174077;8386.203310685598;8506.064332923374;8737.56312184401;8806.647734090693;5932.733027013708;6042.818715438544;6072.939270607238;6147.231596050494;6192.938070619236;9931.106200441995;10012.849807253042;10096.596136154765;10113.747156321151;10313.432761198206;9385.108414700593;9979.650712225037;10476.161907047266;10542.209334299805;10743.89256107429;6963.199232088375;7668.6165691716305;7788.415868809749;7956.443048986747;8066.556339401389;8504;8654.091320411266;8656.091110433314;8717.520536370306;8745.169208925143;7587.848243034998;7777.805554861174;7789.493682910593;7814.944982427527;7906.367490600623;7026.754063607749;7074.196079999567;7660.233976602518;7675.923240767521;7679.731209407867;7348.1182258129365;7372;7389.556626602421;7396.482246242711;7402.074740657418;5009.649324547392;5023.949760502348;5129.717865517432;5184.896302073862;5203.973980130075;5144.871378215575;5174.27560141588;5257.211418287135;5323.041852466438;5330.120530112488 13:45:25 INFO - PROCESS | 2643 | |4;prototype.html;297.7479697870454;338.1647331092203;339.6756097926479;341.5355117040826;352.191720002594;7020.824479388018;7057.470689698274;7072.186698529671;7101.21886592475;7133.750318738845;6956.79129626112;6961.303869613036;6961.860762784741;6986.126734158231;6988.965055174717;4295.548967358429;4880.414350277972;5044.873878153057;5141.434442211354;5142.768575414116;5071.492850714936;5138.075146473633;5138.434772175057;5146.485351464861;5167.534921857032;5096.79612815487;5102.132637451624;5108.131617625013;5109.219177808413;5115.795368185287;4198.454200953887;5109.386873575158;5128.410192840212;5138.332016837787;5163.690178589297;4402.207602631525;4408.669349798746;4411.889702757457;4418.668599855024;4432.047109871361;6456.935430645727;6702.4302934250645;6739;6762.087118239024;6779.457643388517;5939.732712027969;5983.756091465701;5991.970040149771;6004.939950600482;6006.939930600725;7454;7466.029416175917;7495.512791668524;7496.43776716743;7504.099508059014;4775.832845850413;4782.689125206851;4788.688735232234;4791.904161916742;4800.327954086396;7745.6127193640095;7928.9603551982445;7963.8805417918775;7983.201679832028;8015.398845086642;4842.346283251716;4871.658983871095;4887.608991280689;4898.68158569699;4916.336294600254;4972.975135124374;4979.128652485801;4986.276989836453;4999.325091112726;5002.374703162105;4894.706317620954;5392.676439413648;5405.621606487587;5970.34326224115;5976.61152025117;7514.211007844207;7529.548227106391;7535.13345965221;7554.660040298199;7555.622218889033;1652.5455499737668;1711.5207741832307;1734.7571340012407;1736.47905628311;1739.8173191814676;915.8626206069143;949.1931857920712;1065.722912042859;1077.095239998405;1104.9613263535737;7142.142942846892;7152.284771522806;7188.424926005907;7202.783916482514;7242.384397326181;5756.856078598069;6593.406593406617;7528.682480565879;7550.207228241065;7803.960980195063;7283.308085731847;7306.561606303639;7334;7352.852942941111;7352.852942941218;4104.692148088905;4159.251334759711;4170.624643782075;4176.60322269384;4178.997040710268;8359.331253499706;8373.95813020931;8393.916060839436;8407.41148119638;8427.32581393487;7847.725329613436;8121.75634730959;8132.75601731949;8142.267195952392;8144.796380090426;8306.293965012921;8352.707655232038;8356.206160414751;8372.204640559137;8375.664973400995;7849.901013858179;7890.84218315619;7904.920950790649;7915.248051435105;7944.84110317802;7477.065366829146;7721.266479684421;7737.11023232313;7748.225177482207;7784.88322675149;8298.958505207434;8334.333253339839;8340.874886876823;8348.707795227137;8362.623681934449;4528.796204170886;4749.667523273338;4855.441624213261;4922.704637721605;4928.704277743203;7822.5697586631;7826.7651970440975;7834.334081603128;7840.960795195988;7841.451098423056;7267.527610705287;7450.329470347695;7508.361789247757;7551.697932082655;7559.622018898923;7499.962500187464;7515.624218788929;7545.320921116906;7559.848803024019;7562.168161502121;7346.6693998769115;7362.595057271901;7376.188619251985;7383.187849336461;7391.039164908528;7482.251774822692;7487.251274872687;7493.737719179802;7503.924960750541;7519.699212031457;5968.806238752354;7131.358177764027;7404.370628496638;7415.629218538944;7466.664000119899 13:45:25 INFO - PROCESS | 2643 | |5;yui.html;695.1623293930813;712.3482013957229;750.1673142811482;757.3184134279152;795.7055889320949;15362.69274614507;15524.22378881057;15571;15576;15607.375704971802;14421.783673244883;14436.206008669518;16062.27719752611;16415.343386264565;16461.176941152953;799.8520273749375;959.3859929645033;975.3611384543135;978.5938835383307;991.7371896447411;945.5319616789699;948.5684013773716;990.6285143071349;999.5202302894616;1000.6497725795986;1019.0879163148977;1056.6988408303635;1063.4310643805566;1064.2709743825465;1064.5369264369986;1000.934939228955;1028.2185538990345;1048.638219814163;1049.029647575993;1051.2431049644283;747.9252074792531;748.1471122919876;748.8352562436255;752.6838727734365;792.1009654042646;15326.540203793904;15378.077315361114;15406.152661603608;15692.76460853088;15998;13401.195928244337;13436.664083397896;13457.058005939589;13549.729005419837;13612.115212511155;10084.344517606332;10388.740281492948;10416.843747343795;10464.42445665488;10653.946730266376;3607.678619359572;3638.6725194732603;3640.9635903640888;3704.9629503704887;3744.120131769032;63386.68306658483;84069.15930840674;85484.71772923411;86078.5696071522;86141.98503052426;9867.259955503367;9914.504274786232;10029.04724051214;10074.748131296776;10192.694219173436;22405.439864003205;22440.66339004916;22745.203917862797;23133.07467701273;23335.2999410018;7606.961965190249;7719.189485104095;7737.458377913492;7923.12845586985;7991.640376183086;4131.772752498581;4183.309753890574;4188.958110418917;4197.4753155855515;4198.6641068714425;3797.905052373713;3854.2676891390547;3863.16941857502;3864.091938394475;3869.245497128033;586.8884911866731;675.2504719761159;680.1532092544813;695.151914664109;700.5971566349267;496.9950300497021;599.7151353107326;601.1793901324747;621.4034526854181;632.7184402940647;8264.338852891755;8314.916850831414;8608.569571521399;8633.136686331316;8799.604017819214;522.9764660590282;548.7859734703469;621.9502439804804;635.1076737184263;641.7176442365344;3808.352580061396;3866.4586957825927;3904.2581909437117;3980.905251055925;4000.0791115770066;87232.56383718041;90440;92341.0765892346;92463.0753692468;92877.56979441628;78095.65713028505;78203;78548.60725696335;78635.2136478628;78867.60566197132;70269;70400.94398584025;70978;71649.64175179091;71843.6407817968;7748.8450230996195;7862.2923936845955;7921.207879212033;7948.960255198918;8222.753317400488;46306.76846615745;46940;47063.76468117638;47357;47405.525944741494;49495.75252123716;60196;61483.07775383283;62572.748545027935;62728;8857.727431508456;10056.547455364673;10202;10967.670969870916;11099.667009989713;12013.699657508632;12031.398430078636;12269;12296;12335.50657973671;11330.716732081764;11815.704607384883;11820.645380638594;11851.170418070653;11907.761844762883;9530;10150.644727434505;11415.60045398407;11589.536418543501;11885.524579016743;9075.773105672411;10801.891981080089;10831.837522437012;11444.484998175269;11460.828087578526;8586.055533891393;9665.661701840401;9717.465539395402;9724.70825875225;9873.45695986699;9457.98254325511;9588.424694518351;9680.177184939359;9737.853932190881;9818.45998470091 13:45:25 INFO - PROCESS | 2643 | __end_tp_report 13:45:25 INFO - PROCESS | 2643 | __start_cc_report 13:45:25 INFO - PROCESS | 2643 | _x_x_mozilla_cycle_collect,391 13:45:25 INFO - PROCESS | 2643 | __end_cc_report 13:45:25 INFO - PROCESS | 2643 | __startTimestamp1468010725046__endTimestamp 13:45:25 INFO - PROCESS | 2643 | 13:45:25 INFO - PROCESS | 2643 | ------- Summary: start ------- 13:45:25 INFO - PROCESS | 2643 | Number of tests: 6 13:45:25 INFO - PROCESS | 2643 | 13:45:25 INFO - PROCESS | 2643 | [#0] dojo.html Cycles:165 Average:5932.76 Median:6206.29 stddev:664.46 (10.7%) stddev-sans-first:640.93 13:45:25 INFO - PROCESS | 2643 | Values: 3605.7 3621.1 3640.4 3675.8 3694.0 5992.6 5996.6 6030.4 6047.2 6060.5 4794.6 5903.6 5950.9 6035.8 6089.2 5353.9 5392.9 5412.6 5435.1 5527.9 5340.1 5416.4 5428.8 5459.8 5465.1 5432.8 5450.9 5458.5 5460.2 5470.7 4391.9 4439.5 5430.3 5480.9 5518.0 5237.3 5377.8 5388.1 5404.9 5440.5 4761.4 5853.9 5933.3 5935.7 5955.3 6166.4 6267.6 6282.9 6303.3 6359.3 5658.9 6109.0 6132.1 6429.2 6504.9 6082.7 6130.0 6154.2 6166.7 6176.4 5787.4 6390.3 6470.2 6563.6 6632.1 5251.7 6258.5 6278.0 6305.0 6307.2 6244.7 6417.0 6418.0 6433.7 6437.7 6215.9 6254.7 6303.4 6303.4 6328.5 6282.9 6294.1 6309.4 6317.4 6320.6 4990.8 5051.5 5072.1 5146.5 5186.1 4577.6 4600.2 4634.3 4635.0 4642.2 6153.0 6204.5 6221.9 6231.6 6232.7 6306.9 6418.6 6447.1 6481.3 6482.4 6090.2 6131.7 6206.3 6228.1 6228.9 5706.3 5711.0 5720.5 5732.0 5740.7 6553.7 6669.8 6747.2 6774.1 6798.7 6427.2 6467.5 6475.2 6485.0 6502.3 6718.6 6774.2 6792.6 6798.9 6803.0 5697.9 6233.1 6283.2 6326.3 6360.1 6109.2 6411.6 6440.8 6445.2 6462.2 6276.2 6293.5 6300.3 6308.2 6309.3 5988.8 6241.1 6256.8 6257.3 6308.4 6084.0 6113.2 6213.9 6224.3 6225.5 6162.9 6293.9 6318.1 6346.0 6361.3 6136.5 6206.8 6211.8 6223.7 6233.1 13:45:25 INFO - PROCESS | 2643 | 13:45:25 INFO - PROCESS | 2643 | [#1] ext.html Cycles:180 Average:70726.10 Median:38454.71 stddev:150009.00 (390.1%) stddev-sans-first:150337.18 13:45:25 INFO - PROCESS | 2643 | Values: 512.2 526.1 585.0 589.6 601.3 38880.2 39823.8 39916.0 39974.8 40057.2 42101.4 42664.1 42679.8 42713.6 42750.8 9725.9 9908.9 9929.9 9973.8 10041.3 9748.1 10007.9 10023.5 10047.4 10073.5 10021.4 10080.1 10134.0 10148.3 10158.3 9941.8 10011.7 10029.9 10060.4 10113.0 9894.4 10011.5 10039.0 10046.2 10062.3 39981.8 40084.0 40634.6 40877.2 40986.0 3402.7 3527.7 3551.2 3890.0 3939.1 24950.0 29343.6 29686.4 29761.7 30205.7 2655.2 2804.2 2804.9 2821.1 2904.9 552275.0 552794.0 558250.0 559305.0 561492.0 60538.8 60640.5 60756.0 61319.4 61597.4 65272.0 65694.7 73066.3 73811.3 74775.0 18516.5 18692.6 18715.1 18751.6 18779.7 14330.1 14331.0 14402.4 14432.9 14450.2 19687.0 20016.5 20083.2 20169.3 20601.3 8429.1 8561.2 8573.3 8576.0 8576.3 923.6 992.6 1051.8 1076.3 1207.5 30455.4 30572.2 30770.7 31123.6 31336.7 1016.5 1105.3 1147.7 1168.7 1185.0 15736.9 15774.8 15783.4 15794.0 16130.9 566897.0 569951.0 570598.0 572079.0 577278.0 62735.7 64246.7 64624.4 64919.7 64988.4 1525.9 1540.7 1546.6 1551.9 1553.0 30218.4 30635.8 30758.9 31059.7 31184.1 47646.3 48318.8 53483.7 54654.2 55075.0 558887.0 559967.0 560141.0 560950.2 562499.0 27428.0 28103.6 44169.8 44855.4 45633.0 44611.6 46812.1 47470.8 47599.5 48612.3 38064.0 38948.4 39119.0 39168.4 39399.8 35130.0 38410.4 38499.0 38816.4 39073.0 33903.3 38262.0 39845.4 40424.0 40560.4 30796.0 32846.5 32870.8 32977.8 33123.0 24749.0 25016.2 25146.7 25245.6 25455.4 13:45:25 INFO - PROCESS | 2643 | 13:45:25 INFO - PROCESS | 2643 | [#2] jquery.html Cycles:180 Average:35799.78 Median:12838.78 stddev:105662.58 (823.0%) stddev-sans-first:105925.52 13:45:25 INFO - PROCESS | 2643 | Values: 382.5 384.9 416.2 416.7 423.2 15841.8 19106.6 20756.7 20867.8 21330.0 20574.9 20934.5 21260.8 21503.0 21511.2 5846.0 5925.9 6150.4 6157.4 6180.4 5556.2 6074.8 6153.1 6165.6 6183.5 5448.5 6052.9 6186.0 6430.4 6753.0 6694.6 6698.9 6700.8 6709.6 6756.8 5615.2 5934.8 5936.5 5956.7 5979.8 11503.1 14018.9 14264.9 22908.1 23384.4 2059.8 2260.9 2293.2 2348.2 2378.2 9954.9 10048.9 10079.4 10365.4 10432.5 1609.4 1737.0 1794.2 1810.6 1849.8 110026.4 122057.4 123531.1 124513.0 125393.0 11762.5 11919.5 12032.0 12038.9 12100.4 12951.0 14998.0 15173.9 15197.5 15368.3 9166.4 9192.6 9224.3 9233.0 9352.4 9331.6 9338.3 9384.6 9421.9 9429.9 4357.9 4727.1 4815.6 4817.4 4899.1 1659.9 2057.6 2089.0 2093.9 2098.5 947.8 993.6 1004.9 1035.6 1102.8 19060.7 20234.9 20436.7 20459.9 20491.8 993.5 1018.4 1046.9 1060.0 1086.2 6095.5 6301.5 6439.9 6442.4 10628.9 605658.0 619555.0 636540.0 646799.0 659949.0 77193.0 122181.0 128579.0 135875.7 140699.0 481.0 490.5 492.3 493.2 495.0 11132.1 11547.2 11650.8 11825.4 11838.9 53848.5 56233.0 57381.7 57984.7 59753.7 85019.0 85348.0 85805.6 86272.6 87541.0 8178.8 8399.6 8455.4 8465.2 8741.5 9429.6 12276.2 12513.2 12655.6 12751.6 10777.8 11032.2 11242.0 11311.9 11336.3 9483.0 10256.3 10853.3 11013.6 11175.1 11273.8 11437.5 11504.0 11604.3 11738.2 8213.6 8247.4 8434.6 8470.0 8482.4 10387.4 11099.4 11359.1 11430.6 11571.3 13:45:25 INFO - PROCESS | 2643 | 13:45:25 INFO - PROCESS | 2643 | [#3] mootools.html Cycles:180 Average:5995.45 Median:5077.70 stddev:3341.22 (65.8%) stddev-sans-first:3334.48 13:45:25 INFO - PROCESS | 2643 | Values: 1628.9 1644.4 1918.0 2016.0 2026.3 8351.6 8978.6 9095.3 9314.0 9360.9 9035.1 9079.6 9173.1 9173.4 9200.6 2550.2 2572.2 2579.0 2584.1 2587.9 2526.6 2599.5 2603.8 2605.8 2609.0 2128.3 2560.3 2572.2 2573.7 2611.3 2197.6 2558.1 2588.1 2597.5 2597.6 2260.7 2577.6 2590.0 2618.7 2628.0 9273.0 9322.3 9369.6 9405.7 9416.7 5681.7 5852.7 5855.0 5858.0 5897.7 3664.7 3720.3 3754.2 3786.7 3809.7 1051.3 1067.1 1080.0 1081.3 1087.8 12560.5 12577.5 12585.9 12587.9 12600.7 5021.1 5061.6 5122.4 5178.8 5234.3 9370.9 10139.8 10663.0 10826.5 10845.5 5585.2 5611.8 5626.9 5793.3 5816.9 4653.4 5093.7 5109.4 5204.9 5221.7 4290.0 4332.3 4334.7 4353.5 4375.3 1080.7 1401.7 1424.7 1429.9 1482.6 927.9 928.3 951.4 969.5 995.3 6003.4 6034.5 6168.4 6211.0 6228.4 475.2 490.5 495.4 1040.8 1041.6 3998.7 4038.3 4060.4 4068.2 4127.6 11083.1 11503.9 11508.0 11525.1 11552.6 11102.5 11255.7 11260.6 11290.7 11291.0 7622.3 8386.2 8506.1 8737.6 8806.6 5932.7 6042.8 6072.9 6147.2 6192.9 9931.1 10012.8 10096.6 10113.7 10313.4 9385.1 9979.7 10476.2 10542.2 10743.9 6963.2 7668.6 7788.4 7956.4 8066.6 8504.0 8654.1 8656.1 8717.5 8745.2 7587.8 7777.8 7789.5 7814.9 7906.4 7026.8 7074.2 7660.2 7675.9 7679.7 7348.1 7372.0 7389.6 7396.5 7402.1 5009.6 5023.9 5129.7 5184.9 5204.0 5144.9 5174.3 5257.2 5323.0 5330.1 13:45:25 INFO - PROCESS | 2643 | 13:45:25 INFO - PROCESS | 2643 | [#4] prototype.html Cycles:180 Average:6152.30 Median:7132.55 stddev:2024.99 (28.4%) stddev-sans-first:1982.41 13:45:25 INFO - PROCESS | 2643 | Values: 297.7 338.2 339.7 341.5 352.2 7020.8 7057.5 7072.2 7101.2 7133.8 6956.8 6961.3 6961.9 6986.1 6989.0 4295.5 4880.4 5044.9 5141.4 5142.8 5071.5 5138.1 5138.4 5146.5 5167.5 5096.8 5102.1 5108.1 5109.2 5115.8 4198.5 5109.4 5128.4 5138.3 5163.7 4402.2 4408.7 4411.9 4418.7 4432.0 6456.9 6702.4 6739.0 6762.1 6779.5 5939.7 5983.8 5992.0 6004.9 6006.9 7454.0 7466.0 7495.5 7496.4 7504.1 4775.8 4782.7 4788.7 4791.9 4800.3 7745.6 7929.0 7963.9 7983.2 8015.4 4842.3 4871.7 4887.6 4898.7 4916.3 4973.0 4979.1 4986.3 4999.3 5002.4 4894.7 5392.7 5405.6 5970.3 5976.6 7514.2 7529.5 7535.1 7554.7 7555.6 1652.5 1711.5 1734.8 1736.5 1739.8 915.9 949.2 1065.7 1077.1 1105.0 7142.1 7152.3 7188.4 7202.8 7242.4 5756.9 6593.4 7528.7 7550.2 7804.0 7283.3 7306.6 7334.0 7352.9 7352.9 4104.7 4159.3 4170.6 4176.6 4179.0 8359.3 8374.0 8393.9 8407.4 8427.3 7847.7 8121.8 8132.8 8142.3 8144.8 8306.3 8352.7 8356.2 8372.2 8375.7 7849.9 7890.8 7904.9 7915.2 7944.8 7477.1 7721.3 7737.1 7748.2 7784.9 8299.0 8334.3 8340.9 8348.7 8362.6 4528.8 4749.7 4855.4 4922.7 4928.7 7822.6 7826.8 7834.3 7841.0 7841.5 7267.5 7450.3 7508.4 7551.7 7559.6 7500.0 7515.6 7545.3 7559.8 7562.2 7346.7 7362.6 7376.2 7383.2 7391.0 7482.3 7487.3 7493.7 7503.9 7519.7 5968.8 7131.4 7404.4 7415.6 7466.7 13:45:25 INFO - PROCESS | 2643 | 13:45:25 INFO - PROCESS | 2643 | [#5] yui.html Cycles:180 Average:18152.42 Median:48450.64 stddev:25207.45 (52.0%) stddev-sans-first:25244.08 13:45:25 INFO - PROCESS | 2643 | Values: 695.2 712.3 750.2 757.3 795.7 15362.7 15524.2 15571.0 15576.0 15607.4 14421.8 14436.2 16062.3 16415.3 16461.2 799.9 959.4 975.4 978.6 991.7 945.5 948.6 990.6 999.5 1000.6 1019.1 1056.7 1063.4 1064.3 1064.5 1000.9 1028.2 1048.6 1049.0 1051.2 747.9 748.1 748.8 752.7 792.1 15326.5 15378.1 15406.2 15692.8 15998.0 13401.2 13436.7 13457.1 13549.7 13612.1 10084.3 10388.7 10416.8 10464.4 10653.9 3607.7 3638.7 3641.0 3705.0 3744.1 63386.7 84069.2 85484.7 86078.6 86142.0 9867.3 9914.5 10029.0 10074.7 10192.7 22405.4 22440.7 22745.2 23133.1 23335.3 7607.0 7719.2 7737.5 7923.1 7991.6 4131.8 4183.3 4189.0 4197.5 4198.7 3797.9 3854.3 3863.2 3864.1 3869.2 586.9 675.3 680.2 695.2 700.6 497.0 599.7 601.2 621.4 632.7 8264.3 8314.9 8608.6 8633.1 8799.6 523.0 548.8 622.0 635.1 641.7 3808.4 3866.5 3904.3 3980.9 4000.1 87232.6 90440.0 92341.1 92463.1 92877.6 78095.7 78203.0 78548.6 78635.2 78867.6 70269.0 70400.9 70978.0 71649.6 71843.6 7748.8 7862.3 7921.2 7949.0 8222.8 46306.8 46940.0 47063.8 47357.0 47405.5 49495.8 60196.0 61483.1 62572.7 62728.0 8857.7 10056.5 10202.0 10967.7 11099.7 12013.7 12031.4 12269.0 12296.0 12335.5 11330.7 11815.7 11820.6 11851.2 11907.8 9530.0 10150.6 11415.6 11589.5 11885.5 9075.8 10801.9 10831.8 11444.5 11460.8 8586.1 9665.7 9717.5 9724.7 9873.5 9458.0 9588.4 9680.2 9737.9 9818.5 13:45:25 INFO - PROCESS | 2643 | -------- Summary: end -------- 13:45:25 INFO - PROCESS | 2643 | 13:45:25 INFO - TEST-INFO | 2643: exit 0 13:45:25 INFO - TEST-OK | dromaeo_css | took 1110123ms 13:45:25 INFO - TEST-START | kraken 13:45:25 INFO - operating with platform_type : mac_ 13:45:25 INFO - Initialising browser for kraken test... 13:45:25 INFO - TEST-INFO | started process 2648 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpPkMr0K/profile http://localhost:54279/getInfo.html) 13:45:28 INFO - PROCESS | 2648 | __metrics Screen width/height:1600/1200 13:45:28 INFO - PROCESS | 2648 | colorDepth:24 13:45:28 INFO - PROCESS | 2648 | Browser inner width/height: 1024/689 13:45:28 INFO - PROCESS | 2648 | __metrics 13:45:28 ERROR - PROCESS | 2648 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 13:45:29 INFO - TEST-INFO | 2648: exit 0 13:45:29 INFO - Browser initialized. 13:45:29 INFO - Running cycle 1/1 for kraken test... 13:45:29 INFO - TEST-INFO | started process 2652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/tmpPkMr0K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 13:45:41 INFO - PROCESS | 2652 | RSS: Main: 171212800 13:45:41 INFO - PROCESS | 2652 | 13:45:43 INFO - PROCESS | 2652 | Cycle 1(1): loaded http://localhost:54279/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54279/tests/kraken/driver.html?testName=audio-beat-detection) 13:45:44 INFO - PROCESS | 2652 | RSS: Main: 183713792 13:45:44 INFO - PROCESS | 2652 | 13:45:47 INFO - PROCESS | 2652 | Cycle 1(1): loaded http://localhost:54279/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54279/tests/kraken/driver.html?testName=audio-dft) 13:45:47 INFO - PROCESS | 2652 | RSS: Main: 193015808 13:45:47 INFO - PROCESS | 2652 | 13:45:50 INFO - PROCESS | 2652 | Cycle 1(1): loaded http://localhost:54279/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54279/tests/kraken/driver.html?testName=audio-fft) 13:45:51 INFO - PROCESS | 2652 | RSS: Main: 195944448 13:45:51 INFO - PROCESS | 2652 | 13:45:53 INFO - PROCESS | 2652 | Cycle 1(1): loaded http://localhost:54279/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54279/tests/kraken/driver.html?testName=audio-oscillator) 13:45:54 INFO - PROCESS | 2652 | RSS: Main: 197746688 13:45:54 INFO - PROCESS | 2652 | 13:45:56 INFO - PROCESS | 2652 | Cycle 1(1): loaded http://localhost:54279/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54279/tests/kraken/driver.html?testName=imaging-gaussian-blur) 13:45:56 INFO - PROCESS | 2652 | RSS: Main: 198004736 13:45:56 INFO - PROCESS | 2652 | 13:45:59 INFO - PROCESS | 2652 | Cycle 1(1): loaded http://localhost:54279/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54279/tests/kraken/driver.html?testName=imaging-darkroom) 13:46:00 INFO - PROCESS | 2652 | RSS: Main: 198217728 13:46:00 INFO - PROCESS | 2652 | 13:46:03 INFO - PROCESS | 2652 | Cycle 1(1): loaded http://localhost:54279/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54279/tests/kraken/driver.html?testName=imaging-desaturate) 13:46:03 INFO - PROCESS | 2652 | RSS: Main: 198221824 13:46:03 INFO - PROCESS | 2652 | 13:46:06 INFO - PROCESS | 2652 | Cycle 1(1): loaded http://localhost:54279/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54279/tests/kraken/driver.html?testName=json-parse-financial) 13:46:07 INFO - PROCESS | 2652 | RSS: Main: 198270976 13:46:07 INFO - PROCESS | 2652 | 13:46:08 INFO - PROCESS | 2652 | Cycle 1(1): loaded http://localhost:54279/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54279/tests/kraken/driver.html?testName=json-stringify-tinderbox) 13:46:09 INFO - PROCESS | 2652 | RSS: Main: 197685248 13:46:09 INFO - PROCESS | 2652 | 13:46:11 INFO - PROCESS | 2652 | Cycle 1(1): loaded http://localhost:54279/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54279/tests/kraken/driver.html?testName=stanford-crypto-aes) 13:46:12 INFO - PROCESS | 2652 | RSS: Main: 198213632 13:46:12 INFO - PROCESS | 2652 | 13:46:14 INFO - PROCESS | 2652 | Cycle 1(1): loaded http://localhost:54279/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54279/tests/kraken/driver.html?testName=stanford-crypto-ccm) 13:46:14 INFO - PROCESS | 2652 | RSS: Main: 198361088 13:46:14 INFO - PROCESS | 2652 | 13:46:17 INFO - PROCESS | 2652 | Cycle 1(1): loaded http://localhost:54279/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 13:46:18 INFO - PROCESS | 2652 | RSS: Main: 198250496 13:46:18 INFO - PROCESS | 2652 | 13:46:20 INFO - PROCESS | 2652 | Cycle 1(1): loaded http://localhost:54279/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 13:46:21 INFO - PROCESS | 2652 | RSS: Main: 198275072 13:46:21 INFO - PROCESS | 2652 | 13:46:23 INFO - PROCESS | 2652 | Cycle 1(1): loaded http://localhost:54279/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54279/tests/kraken/driver.html?testName=ai-astar) 13:46:23 INFO - PROCESS | 2652 | RSS: Main: 199925760 13:46:23 INFO - PROCESS | 2652 | 13:46:23 INFO - PROCESS | 2652 | __start_tp_report 13:46:23 INFO - PROCESS | 2652 | _x_x_mozilla_page_load 13:46:23 INFO - PROCESS | 2652 | _x_x_mozilla_page_load_details 13:46:23 INFO - PROCESS | 2652 | |i|pagename|runs| 13:46:23 INFO - PROCESS | 2652 | |0;ai-astar;113;118;106;115;117;117;105;113;116;117 13:46:23 INFO - PROCESS | 2652 | |1;audio-beat-detection;153;120;145;158;119;141;140;138;151;99 13:46:23 INFO - PROCESS | 2652 | |2;audio-dft;194;199;193;202;196;203;195;192;198;197 13:46:23 INFO - PROCESS | 2652 | |3;audio-fft;65;80;77;150;67;105;84;95;126;55 13:46:23 INFO - PROCESS | 2652 | |4;audio-oscillator;77;84;125;77;82;89;121;81;80;123 13:46:23 INFO - PROCESS | 2652 | |5;imaging-gaussian-blur;89;85;87;86;88;85;76;130;134;88 13:46:23 INFO - PROCESS | 2652 | |6;imaging-darkroom;93;102;153;152;100;102;138;94;93;94 13:46:23 INFO - PROCESS | 2652 | |7;imaging-desaturate;89;92;90;90;89;89;91;90;92;116 13:46:23 INFO - PROCESS | 2652 | |8;json-parse-financial;59;62;64;65;65;66;64;80;61;80 13:46:23 INFO - PROCESS | 2652 | |9;json-stringify-tinderbox;59;64;62;65;70;68;74;72;65;66 13:46:23 INFO - PROCESS | 2652 | |10;stanford-crypto-aes;81;80;74;78;76;78;78;78;86;80 13:46:23 INFO - PROCESS | 2652 | |11;stanford-crypto-ccm;128;123;141;110;169;115;146;152;177;137 13:46:23 INFO - PROCESS | 2652 | |12;stanford-crypto-pbkdf2;217;217;184;162;165;161;167;164;164;160 13:46:23 INFO - PROCESS | 2652 | |13;stanford-crypto-sha256-iterative;67;65;69;67;68;65;68;68;67;67 13:46:23 INFO - PROCESS | 2652 | __end_tp_report 13:46:23 INFO - PROCESS | 2652 | __start_cc_report 13:46:23 INFO - PROCESS | 2652 | _x_x_mozilla_cycle_collect,1021 13:46:23 INFO - PROCESS | 2652 | __end_cc_report 13:46:23 INFO - PROCESS | 2652 | __startTimestamp1468010783462__endTimestamp 13:46:23 INFO - PROCESS | 2652 | 13:46:23 INFO - PROCESS | 2652 | ------- Summary: start ------- 13:46:23 INFO - PROCESS | 2652 | Number of tests: 14 13:46:23 INFO - PROCESS | 2652 | 13:46:23 INFO - PROCESS | 2652 | [#0] ai-astar Cycles:10 Average:113.70 Median:116.50 stddev:4.64 (4.0%) stddev-sans-first:4.92 13:46:23 INFO - PROCESS | 2652 | Values: 113.0 118.0 106.0 115.0 117.0 117.0 105.0 113.0 116.0 117.0 13:46:23 INFO - PROCESS | 2652 | 13:46:23 INFO - PROCESS | 2652 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:148.00 stddev:18.37 (12.4%) stddev-sans-first:18.47 13:46:23 INFO - PROCESS | 2652 | Values: 153.0 120.0 145.0 158.0 119.0 141.0 140.0 138.0 151.0 99.0 13:46:23 INFO - PROCESS | 2652 | 13:46:23 INFO - PROCESS | 2652 | [#2] audio-dft Cycles:10 Average:196.90 Median:197.50 stddev:3.67 (1.9%) stddev-sans-first:3.73 13:46:23 INFO - PROCESS | 2652 | Values: 194.0 199.0 193.0 202.0 196.0 203.0 195.0 192.0 198.0 197.0 13:46:23 INFO - PROCESS | 2652 | 13:46:23 INFO - PROCESS | 2652 | [#3] audio-fft Cycles:10 Average:90.40 Median:72.00 stddev:29.49 (41.0%) stddev-sans-first:29.82 13:46:23 INFO - PROCESS | 2652 | Values: 65.0 80.0 77.0 150.0 67.0 105.0 84.0 95.0 126.0 55.0 13:46:23 INFO - PROCESS | 2652 | 13:46:23 INFO - PROCESS | 2652 | [#4] audio-oscillator Cycles:10 Average:93.90 Median:80.50 stddev:20.39 (25.3%) stddev-sans-first:20.69 13:46:23 INFO - PROCESS | 2652 | Values: 77.0 84.0 125.0 77.0 82.0 89.0 121.0 81.0 80.0 123.0 13:46:23 INFO - PROCESS | 2652 | 13:46:23 INFO - PROCESS | 2652 | [#5] imaging-gaussian-blur Cycles:10 Average:94.80 Median:86.50 stddev:19.96 (23.1%) stddev-sans-first:21.06 13:46:23 INFO - PROCESS | 2652 | Values: 89.0 85.0 87.0 86.0 88.0 85.0 76.0 130.0 134.0 88.0 13:46:23 INFO - PROCESS | 2652 | 13:46:23 INFO - PROCESS | 2652 | [#6] imaging-darkroom Cycles:10 Average:112.10 Median:123.00 stddev:25.10 (20.4%) stddev-sans-first:25.66 13:46:23 INFO - PROCESS | 2652 | Values: 93.0 102.0 153.0 152.0 100.0 102.0 138.0 94.0 93.0 94.0 13:46:23 INFO - PROCESS | 2652 | 13:46:23 INFO - PROCESS | 2652 | [#7] imaging-desaturate Cycles:10 Average:92.80 Median:90.00 stddev:8.23 (9.1%) stddev-sans-first:8.61 13:46:23 INFO - PROCESS | 2652 | Values: 89.0 92.0 90.0 90.0 89.0 89.0 91.0 90.0 92.0 116.0 13:46:23 INFO - PROCESS | 2652 | 13:46:23 INFO - PROCESS | 2652 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:65.00 stddev:7.37 (11.3%) stddev-sans-first:7.28 13:46:23 INFO - PROCESS | 2652 | Values: 59.0 62.0 64.0 65.0 65.0 66.0 64.0 80.0 61.0 80.0 13:46:23 INFO - PROCESS | 2652 | 13:46:23 INFO - PROCESS | 2652 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:4.58 (6.8%) stddev-sans-first:3.97 13:46:23 INFO - PROCESS | 2652 | Values: 59.0 64.0 62.0 65.0 70.0 68.0 74.0 72.0 65.0 66.0 13:46:23 INFO - PROCESS | 2652 | 13:46:23 INFO - PROCESS | 2652 | [#10] stanford-crypto-aes Cycles:10 Average:78.90 Median:79.00 stddev:3.21 (4.1%) stddev-sans-first:3.32 13:46:23 INFO - PROCESS | 2652 | Values: 81.0 80.0 74.0 78.0 76.0 78.0 78.0 78.0 86.0 80.0 13:46:23 INFO - PROCESS | 2652 | 13:46:23 INFO - PROCESS | 2652 | [#11] stanford-crypto-ccm Cycles:10 Average:139.80 Median:143.50 stddev:22.00 (15.3%) stddev-sans-first:22.92 13:46:23 INFO - PROCESS | 2652 | Values: 128.0 123.0 141.0 110.0 169.0 115.0 146.0 152.0 177.0 137.0 13:46:23 INFO - PROCESS | 2652 | 13:46:23 INFO - PROCESS | 2652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.10 Median:166.00 stddev:22.59 (13.6%) stddev-sans-first:18.49 13:46:23 INFO - PROCESS | 2652 | Values: 217.0 217.0 184.0 162.0 165.0 161.0 167.0 164.0 164.0 160.0 13:46:23 INFO - PROCESS | 2652 | 13:46:23 INFO - PROCESS | 2652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.50 stddev:1.29 (1.9%) stddev-sans-first:1.36 13:46:23 INFO - PROCESS | 2652 | Values: 67.0 65.0 69.0 67.0 68.0 65.0 68.0 68.0 67.0 67.0 13:46:23 INFO - PROCESS | 2652 | -------- Summary: end -------- 13:46:23 INFO - PROCESS | 2652 | 13:46:24 INFO - TEST-INFO | 2652: exit 0 13:46:24 INFO - TEST-OK | kraken | took 58610ms 13:46:24 INFO - SUITE-END | took 1168s 13:46:24 INFO - Completed test suite (00:19:29) 13:46:24 INFO - javascript benchmark 13:46:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3605.7475976681635, 3621.130928577141, 3640.3993341098685, 3675.8162091895397, 3693.9630603693954, 5992.580519363646, 5996.550258730602, 6030.427109424598, 6047.213862197914, 6060.545459090564, 4794.595836955757, 5903.645781253117, 5950.940107085045, 6035.75856965722, 6089.208402907627, 5353.919691204625, 5392.892142157155, 5412.56699464042, 5435.076037073687, 5527.889442211153, 5340.118880384752, 5416.377116631578, 5428.809991650293, 5459.836204913859, 5465.098258787295, 5432.83701488954, 5450.890982180354, 5458.4541545845495, 5460.153676180198, 5470.699111548883, 4391.912161756779, 4439.4672639283335, 5430.266913966603, 5480.890382192374, 5517.972410137963, 5237.3453318335205, 5377.838664840061, 5388.084025715638, 5404.864878378033, 5440.537554307889, 4761.357216775726, 5853.853453873458, 5933.2880054393745, 5935.73289201987, 5955.255593050869, 6166.352532984017, 6267.59260648061, 6282.874342513124, 6303.275123360826, 6359.300476947532, 5658.868226354704, 6109.04313553752, 6132.11084392765, 6429.164208652892, 6504.8699026019685, 6082.726277317487, 6130.049842274455, 6154.230721159855, 6166.7224974876235, 6176.444120029174, 5787.363390027093, 6390.265119511223, 6470.158879345655, 6563.6389998549585, 6632.071509988606, 5251.711155886386, 6258.530610204162, 6277.968610157011, 6305.0, 6307.211598550181, 6244.687765611701, 6417.0, 6417.96791016042, 6433.74265029403, 6437.742490300429, 6215.906761398583, 6254.655993920378, 6303.401176888188, 6303.432691057735, 6328.493720502349, 6282.937170628235, 6294.087357333161, 6309.3690630936535, 6317.431431171217, 6320.55756097078, 4990.80036798524, 5051.4695956924725, 5072.061668591323, 5146.4853514648985, 5186.092433824066, 4577.56513131252, 4600.171969045604, 4634.2585186370015, 4635.0, 4642.210824159901, 6152.969235153795, 6204.472619827275, 6221.906671399842, 6231.563790534709, 6232.719527621268, 6306.905396419057, 6418.614883107029, 6447.097406363113, 6481.319461456574, 6482.351764823574, 6090.23872015998, 6131.682521312696, 6206.286277078194, 6228.096925945803, 6228.937710622836, 5706.343770466449, 5711.0, 5720.48515633595, 5731.971340143273, 5740.741666625012, 6553.737850486023, 6669.799906002925, 6747.190337159376, 6774.119364482585, 6798.694058767367, 6427.228732552124, 6467.514936379885, 6475.158229430144, 6485.0, 6502.284748677547, 6718.630475323904, 6774.220964589135, 6792.592444453348, 6798.93201067983, 6802.965985170043, 5697.943020569907, 6233.096201050913, 6283.214598175228, 6326.304106548184, 6360.077788720702, 6109.236345456818, 6411.6153030818305, 6440.774572889926, 6445.16212892321, 6462.1599192106605, 6276.1840960676645, 6293.496520278458, 6300.275468321019, 6308.211473565804, 6309.33751956038, 5988.820335389945, 6241.095041219089, 6256.843578910381, 6257.2804127525915, 6308.369163083655, 6084.0, 6113.205283313141, 6213.9067913982235, 6224.315325314303, 6225.470834979077, 6162.876742465215, 6293.874122517615, 6318.115463834974, 6345.96827015862, 6361.300256971637, 6136.457808108435, 6206.782762603287, 6211.81364559064, 6223.657698826608, 6233.065040244], "value": 5893.321413618537, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [512.1881817319546, 526.1213772999092, 584.9912251316231, 589.6226415094337, 601.2574470528896, 38880.222395552075, 39823.80088099559, 39916.0, 39974.800125999405, 40057.198856022864, 42101.36847947283, 42664.14671706564, 42679.78660106695, 42713.57286427135, 42750.786246068725, 9725.854112188323, 9908.900910990906, 9929.851052234186, 9973.800523989552, 10041.347312424705, 9748.122668959792, 10007.899921000806, 10023.498825058754, 10047.447390393525, 10073.546690398913, 10021.44882031488, 10080.09279164875, 10134.037266459674, 10148.289619726622, 10158.339707918998, 9941.801163976716, 10011.699649010541, 10029.899701003005, 10060.39637621745, 10113.0, 9894.406335619886, 10011.499425028793, 10039.046290602455, 10046.246531510165, 10062.345947513462, 39981.80009099936, 40084.0, 40634.59365406338, 40877.182456351, 40986.0, 3402.6597340265776, 3527.664871837171, 3551.183227857581, 3889.961100388988, 3939.1333906540517, 24950.0, 29343.559846602104, 29686.406271874657, 29761.70238297611, 30205.697943020507, 2655.216711070239, 2804.2288370698016, 2804.9018284360154, 2821.097248880359, 2904.8983285585114, 552275.0, 552794.0, 558250.0, 559305.0, 561492.0, 60538.78922421527, 60640.48398789977, 60756.0, 61319.38680613137, 61597.38402616006, 65272.0, 65694.67152664301, 73066.269337307, 73811.26188738045, 74775.0, 18516.537086572942, 18692.626147477247, 18715.064246787606, 18751.624967500848, 18779.718304225447, 14330.068545544505, 14331.0, 14402.351894164787, 14432.855671443362, 14450.205238711762, 19687.0, 20016.49958751043, 20083.19667213295, 20169.294074707315, 20601.278955236496, 8429.114942930904, 8561.190270329767, 8573.314134869195, 8576.0, 8576.313894888393, 923.6074668266094, 992.6128809764198, 1051.7948999944938, 1076.262760009396, 1207.4626791078063, 30455.390892182033, 30572.235694107825, 30770.69229307723, 31123.599438025343, 31336.68663313383, 1016.5273147986222, 1105.3312745788842, 1147.6786499780076, 1168.67861338131, 1184.9763004739857, 15736.898417110693, 15774.842251577567, 15783.447579334668, 15794.0, 16130.919345403197, 566897.0, 569951.0, 570598.0, 572079.0, 577278.0, 62735.6863215681, 64246.678766606805, 64624.35375646183, 64919.70160596762, 64988.35011649823, 1525.862672359493, 1540.7303721848407, 1546.605615568023, 1551.9146446945301, 1552.9767053494206, 30218.395632087675, 30635.846820765753, 30758.923437679572, 31059.689403106582, 31184.064478064785, 47646.28530571975, 48318.758406207744, 53483.732581336844, 54654.180187298014, 55075.0, 558887.0, 559967.0008249826, 560141.0, 560950.1952490212, 562499.0, 27428.0, 28103.57844632373, 44169.77915110404, 44855.43005994774, 45633.0, 44611.553884460736, 46812.063758723954, 47470.76264618655, 47599.52400475951, 48612.2708159385, 38064.0, 38948.41577376285, 39119.0, 39168.41247381234, 39399.80300098481, 35130.0, 38410.42384364181, 38499.0, 38816.41775373315, 39073.0, 33903.3219335607, 38262.0, 39845.40231896582, 40424.0, 40560.39159412552, 30796.0, 32846.507302390004, 32870.835645821615, 32977.83511082429, 33123.0, 24749.0, 25016.249512514652, 25146.74853251444, 25245.621315680648, 25455.36361590901], "value": 20855.367481098172, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [382.4951064594735, 384.91916697493525, 416.2403613405536, 416.708304187069, 423.19170384565484, 15841.762373564377, 19106.61786764264, 20756.688649670246, 20867.791322086774, 21330.0, 20574.897125514388, 20934.476638084056, 21260.787392126073, 21503.0, 21511.247106351282, 5845.976954033027, 5925.940740592593, 6150.354212807658, 6157.415045570686, 6180.412860778219, 5556.16657501374, 6074.754675291555, 6153.107799369089, 6165.63006219626, 6183.505319574446, 5448.45515448456, 6052.878942421149, 6186.0, 6430.356964303579, 6752.966235168818, 6694.59832410057, 6698.866022679544, 6700.798976030678, 6709.630970296632, 6756.7635132770365, 5615.1857980592995, 5934.821955341346, 5936.495397891184, 5956.672383018932, 5979.790707325266, 11503.07975361969, 14018.859811401857, 14264.85735142656, 22908.083676652914, 23384.363094583387, 2059.794020597928, 2260.8756518391483, 2293.1973809166825, 2348.2368230325214, 2378.203301893868, 9954.900450995543, 10048.899511004869, 10079.44563049032, 10365.37807731531, 10432.530536125816, 1609.3643011010702, 1737.044625455994, 1794.1926133240095, 1810.592616661254, 1849.7687789026372, 110026.44986775015, 122057.38971305176, 123531.14703279459, 124513.0, 125393.0, 11762.529498819951, 11919.463624136935, 12032.0, 12038.939805300917, 12100.394980251129, 12951.0, 14998.0, 15173.924130379277, 15197.468088617066, 15368.308426120851, 9166.358354915224, 9192.632294708137, 9224.30817688676, 9232.95383523078, 9352.392094513834, 9331.626734930527, 9338.346315757832, 9384.577694003787, 9421.858672119924, 9429.90570094304, 4357.891052723708, 4727.149113159664, 4815.638827087912, 4817.373741413594, 4899.069176856386, 1659.8838081334432, 2057.6296266672143, 2089.0, 2093.9371818845457, 2098.5068508900395, 947.8009617980164, 993.6124911284605, 1004.8794144702537, 1035.5857656937135, 1102.7518808268076, 19060.71408928867, 20234.898825506072, 20436.693449598268, 20459.897700511403, 20491.79508204899, 993.4536005197257, 1018.4449475036123, 1046.8691413573304, 1059.9841002384971, 1086.190787863047, 6095.542834287447, 6301.52738544611, 6439.871202575922, 6442.420182183626, 10628.893711062945, 605658.0, 619555.0, 636540.0, 646799.0, 659949.0, 77193.0, 122181.0, 128579.0, 135875.73444182493, 140699.0, 480.97114173149726, 490.458043861535, 492.2616075886171, 493.2010143567444, 494.9604031677457, 11132.109431245319, 11547.249428787101, 11650.76698466009, 11825.40872956366, 11838.881611183779, 53848.46151538435, 56233.0, 57381.71309143428, 57984.710076449344, 59753.701231493564, 85019.0, 85348.0, 85805.57097214473, 86272.56863715641, 87541.0, 8178.83642327162, 8399.580020999048, 8455.365847561334, 8465.195806398382, 8741.519216443157, 9429.62281508732, 12276.202046866925, 12513.24814525949, 12655.557055503014, 12751.61745147647, 10777.760557535983, 11032.172587055842, 11242.0, 11311.925367090442, 11336.263142895685, 9483.0, 10256.282060255711, 10853.34879907208, 11013.559457621606, 11175.105991520497, 11273.830892536454, 11437.542498299976, 11504.0, 11604.333452821935, 11738.178327516991, 8213.589320534069, 8247.422680412314, 8434.578271086299, 8469.957650211709, 8482.406231563731, 10387.37675739458, 11099.445027748741, 11359.148063895405, 11430.599929002445, 11571.305721656727], "value": 9311.186763428808, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1628.8615467685247, 1644.3915751172065, 1917.9520511987207, 2015.9899200503996, 2026.3009261804673, 8351.624176912039, 8978.595963181657, 9095.317851161164, 9314.022027687097, 9360.85958710619, 9035.051319611444, 9079.591418386171, 9173.08269173084, 9173.357864949456, 9200.585973631187, 2550.1966880432697, 2572.2026171886682, 2579.0199724104814, 2584.0955665517013, 2587.9094231701893, 2526.646269522259, 2599.5060938421734, 2603.7916966642624, 2605.7524535169223, 2609.0476975903753, 2128.265748316828, 2560.2575253176556, 2572.2026171886773, 2573.665423494943, 2611.268844723471, 2197.626403511407, 2558.104663367825, 2588.120039186676, 2597.467519158587, 2597.571400718879, 2260.7287125544876, 2577.6262441946, 2590.0157939982873, 2618.711941686413, 2627.9605805912734, 9273.0, 9322.30082743797, 9369.625214991393, 9405.670801521914, 9416.670416535457, 5681.715914204315, 5852.707364631751, 5855.033919403293, 5858.0, 5897.705114744245, 3664.706823454117, 3720.255948810249, 3754.2491501699496, 3786.6970642348547, 3809.695224382043, 1051.3429106808244, 1067.0905884398458, 1079.9784004319947, 1081.2755453845941, 1087.8096333141748, 12560.497580096877, 12577.496900123984, 12585.937070314681, 12587.93706031464, 12600.68498287541, 5021.096202683552, 5061.645684802103, 5122.385313762373, 5178.766955487012, 5234.319538459976, 9370.85943710845, 10139.847902281472, 10663.0, 10826.512806923707, 10845.457727113771, 5585.162225666101, 5611.80358687444, 5626.915596266059, 5793.275840519935, 5816.912746308809, 4653.395058642355, 5093.745312734349, 5109.38687357512, 5204.947950520522, 5221.660592061504, 4290.034742183047, 4332.328489084197, 4334.718243314238, 4353.521112677603, 4375.321825117112, 1080.7406222506543, 1401.7336706025822, 1424.6936908564708, 1429.8713115819626, 1482.5552334299666, 927.9211267042377, 928.2898582584328, 951.4291425144858, 969.4759549039153, 995.318207028188, 6003.3996600339615, 6034.5172386209, 6168.414000669929, 6211.0, 6228.377162283826, 475.2419890275006, 490.4874406245411, 495.38819557846034, 1040.765827688764, 1041.578160844859, 3998.7000974926996, 4038.2932986727205, 4060.3706425504092, 4068.247374235776, 4127.6491498222385, 11083.113350932068, 11503.942480287546, 11508.021818145551, 11525.077993760478, 11552.613686357523, 11102.500387482583, 11255.718607034889, 11260.605878794202, 11290.717732056764, 11291.0, 7622.31399174077, 8386.203310685598, 8506.064332923374, 8737.56312184401, 8806.647734090693, 5932.733027013708, 6042.818715438544, 6072.939270607238, 6147.231596050494, 6192.938070619236, 9931.106200441995, 10012.849807253042, 10096.596136154765, 10113.747156321151, 10313.432761198206, 9385.108414700593, 9979.650712225037, 10476.161907047266, 10542.209334299805, 10743.89256107429, 6963.199232088375, 7668.6165691716305, 7788.415868809749, 7956.443048986747, 8066.556339401389, 8504.0, 8654.091320411266, 8656.091110433314, 8717.520536370306, 8745.169208925143, 7587.848243034998, 7777.805554861174, 7789.493682910593, 7814.944982427527, 7906.367490600623, 7026.754063607749, 7074.196079999567, 7660.233976602518, 7675.923240767521, 7679.731209407867, 7348.1182258129365, 7372.0, 7389.556626602421, 7396.482246242711, 7402.074740657418, 5009.649324547392, 5023.949760502348, 5129.717865517432, 5184.896302073862, 5203.973980130075, 5144.871378215575, 5174.27560141588, 5257.211418287135, 5323.041852466438, 5330.120530112488], "value": 4805.304066671386, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.7479697870454, 338.1647331092203, 339.6756097926479, 341.5355117040826, 352.191720002594, 7020.824479388018, 7057.470689698274, 7072.186698529671, 7101.21886592475, 7133.750318738845, 6956.79129626112, 6961.303869613036, 6961.860762784741, 6986.126734158231, 6988.965055174717, 4295.548967358429, 4880.414350277972, 5044.873878153057, 5141.434442211354, 5142.768575414116, 5071.492850714936, 5138.075146473633, 5138.434772175057, 5146.485351464861, 5167.534921857032, 5096.79612815487, 5102.132637451624, 5108.131617625013, 5109.219177808413, 5115.795368185287, 4198.454200953887, 5109.386873575158, 5128.410192840212, 5138.332016837787, 5163.690178589297, 4402.207602631525, 4408.669349798746, 4411.889702757457, 4418.668599855024, 4432.047109871361, 6456.935430645727, 6702.4302934250645, 6739.0, 6762.087118239024, 6779.457643388517, 5939.732712027969, 5983.756091465701, 5991.970040149771, 6004.939950600482, 6006.939930600725, 7454.0, 7466.029416175917, 7495.512791668524, 7496.43776716743, 7504.099508059014, 4775.832845850413, 4782.689125206851, 4788.688735232234, 4791.904161916742, 4800.327954086396, 7745.6127193640095, 7928.9603551982445, 7963.8805417918775, 7983.201679832028, 8015.398845086642, 4842.346283251716, 4871.658983871095, 4887.608991280689, 4898.68158569699, 4916.336294600254, 4972.975135124374, 4979.128652485801, 4986.276989836453, 4999.325091112726, 5002.374703162105, 4894.706317620954, 5392.676439413648, 5405.621606487587, 5970.34326224115, 5976.61152025117, 7514.211007844207, 7529.548227106391, 7535.13345965221, 7554.660040298199, 7555.622218889033, 1652.5455499737668, 1711.5207741832307, 1734.7571340012407, 1736.47905628311, 1739.8173191814676, 915.8626206069143, 949.1931857920712, 1065.722912042859, 1077.095239998405, 1104.9613263535737, 7142.142942846892, 7152.284771522806, 7188.424926005907, 7202.783916482514, 7242.384397326181, 5756.856078598069, 6593.406593406617, 7528.682480565879, 7550.207228241065, 7803.960980195063, 7283.308085731847, 7306.561606303639, 7334.0, 7352.852942941111, 7352.852942941218, 4104.692148088905, 4159.251334759711, 4170.624643782075, 4176.60322269384, 4178.997040710268, 8359.331253499706, 8373.95813020931, 8393.916060839436, 8407.41148119638, 8427.32581393487, 7847.725329613436, 8121.75634730959, 8132.75601731949, 8142.267195952392, 8144.796380090426, 8306.293965012921, 8352.707655232038, 8356.206160414751, 8372.204640559137, 8375.664973400995, 7849.901013858179, 7890.84218315619, 7904.920950790649, 7915.248051435105, 7944.84110317802, 7477.065366829146, 7721.266479684421, 7737.11023232313, 7748.225177482207, 7784.88322675149, 8298.958505207434, 8334.333253339839, 8340.874886876823, 8348.707795227137, 8362.623681934449, 4528.796204170886, 4749.667523273338, 4855.441624213261, 4922.704637721605, 4928.704277743203, 7822.5697586631, 7826.7651970440975, 7834.334081603128, 7840.960795195988, 7841.451098423056, 7267.527610705287, 7450.329470347695, 7508.361789247757, 7551.697932082655, 7559.622018898923, 7499.962500187464, 7515.624218788929, 7545.320921116906, 7559.848803024019, 7562.168161502121, 7346.6693998769115, 7362.595057271901, 7376.188619251985, 7383.187849336461, 7391.039164908528, 7482.251774822692, 7487.251274872687, 7493.737719179802, 7503.924960750541, 7519.699212031457, 5968.806238752354, 7131.358177764027, 7404.370628496638, 7415.629218538944, 7466.664000119899], "value": 5458.963367850429, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [695.1623293930813, 712.3482013957229, 750.1673142811482, 757.3184134279152, 795.7055889320949, 15362.69274614507, 15524.22378881057, 15571.0, 15576.0, 15607.375704971802, 14421.783673244883, 14436.206008669518, 16062.27719752611, 16415.343386264565, 16461.176941152953, 799.8520273749375, 959.3859929645033, 975.3611384543135, 978.5938835383307, 991.7371896447411, 945.5319616789699, 948.5684013773716, 990.6285143071349, 999.5202302894616, 1000.6497725795986, 1019.0879163148977, 1056.6988408303635, 1063.4310643805566, 1064.2709743825465, 1064.5369264369986, 1000.934939228955, 1028.2185538990345, 1048.638219814163, 1049.029647575993, 1051.2431049644283, 747.9252074792531, 748.1471122919876, 748.8352562436255, 752.6838727734365, 792.1009654042646, 15326.540203793904, 15378.077315361114, 15406.152661603608, 15692.76460853088, 15998.0, 13401.195928244337, 13436.664083397896, 13457.058005939589, 13549.729005419837, 13612.115212511155, 10084.344517606332, 10388.740281492948, 10416.843747343795, 10464.42445665488, 10653.946730266376, 3607.678619359572, 3638.6725194732603, 3640.9635903640888, 3704.9629503704887, 3744.120131769032, 63386.68306658483, 84069.15930840674, 85484.71772923411, 86078.5696071522, 86141.98503052426, 9867.259955503367, 9914.504274786232, 10029.04724051214, 10074.748131296776, 10192.694219173436, 22405.439864003205, 22440.66339004916, 22745.203917862797, 23133.07467701273, 23335.2999410018, 7606.961965190249, 7719.189485104095, 7737.458377913492, 7923.12845586985, 7991.640376183086, 4131.772752498581, 4183.309753890574, 4188.958110418917, 4197.4753155855515, 4198.6641068714425, 3797.905052373713, 3854.2676891390547, 3863.16941857502, 3864.091938394475, 3869.245497128033, 586.8884911866731, 675.2504719761159, 680.1532092544813, 695.151914664109, 700.5971566349267, 496.9950300497021, 599.7151353107326, 601.1793901324747, 621.4034526854181, 632.7184402940647, 8264.338852891755, 8314.916850831414, 8608.569571521399, 8633.136686331316, 8799.604017819214, 522.9764660590282, 548.7859734703469, 621.9502439804804, 635.1076737184263, 641.7176442365344, 3808.352580061396, 3866.4586957825927, 3904.2581909437117, 3980.905251055925, 4000.0791115770066, 87232.56383718041, 90440.0, 92341.0765892346, 92463.0753692468, 92877.56979441628, 78095.65713028505, 78203.0, 78548.60725696335, 78635.2136478628, 78867.60566197132, 70269.0, 70400.94398584025, 70978.0, 71649.64175179091, 71843.6407817968, 7748.8450230996195, 7862.2923936845955, 7921.207879212033, 7948.960255198918, 8222.753317400488, 46306.76846615745, 46940.0, 47063.76468117638, 47357.0, 47405.525944741494, 49495.75252123716, 60196.0, 61483.07775383283, 62572.748545027935, 62728.0, 8857.727431508456, 10056.547455364673, 10202.0, 10967.670969870916, 11099.667009989713, 12013.699657508632, 12031.398430078636, 12269.0, 12296.0, 12335.50657973671, 11330.716732081764, 11815.704607384883, 11820.645380638594, 11851.170418070653, 11907.761844762883, 9530.0, 10150.644727434505, 11415.60045398407, 11589.536418543501, 11885.524579016743, 9075.773105672411, 10801.891981080089, 10831.837522437012, 11444.484998175269, 11460.828087578526, 8586.055533891393, 9665.661701840401, 9717.465539395402, 9724.70825875225, 9873.45695986699, 9457.98254325511, 9588.424694518351, 9680.177184939359, 9737.853932190881, 9818.45998470091], "value": 7056.261780406448, "unit": "score"}], "name": "dromaeo_css", "value": 7720.948368287786, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 118.0, 106.0, 115.0, 117.0, 117.0, 105.0, 113.0, 116.0, 117.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 120.0, 145.0, 158.0, 119.0, 141.0, 140.0, 138.0, 151.0, 99.0], "value": 136.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [194.0, 199.0, 193.0, 202.0, 196.0, 203.0, 195.0, 192.0, 198.0, 197.0], "value": 196.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 80.0, 77.0, 150.0, 67.0, 105.0, 84.0, 95.0, 126.0, 55.0], "value": 90.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 84.0, 125.0, 77.0, 82.0, 89.0, 121.0, 81.0, 80.0, 123.0], "value": 93.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 87.0, 86.0, 88.0, 85.0, 76.0, 130.0, 134.0, 88.0], "value": 94.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 102.0, 153.0, 152.0, 100.0, 102.0, 138.0, 94.0, 93.0, 94.0], "value": 112.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 92.0, 90.0, 90.0, 89.0, 89.0, 91.0, 90.0, 92.0, 116.0], "value": 92.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 62.0, 64.0, 65.0, 65.0, 66.0, 64.0, 80.0, 61.0, 80.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 64.0, 62.0, 65.0, 70.0, 68.0, 74.0, 72.0, 65.0, 66.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 74.0, 78.0, 76.0, 78.0, 78.0, 78.0, 86.0, 80.0], "value": 78.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 123.0, 141.0, 110.0, 169.0, 115.0, 146.0, 152.0, 177.0, 137.0], "value": 139.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [217.0, 217.0, 184.0, 162.0, 165.0, 161.0, 167.0, 164.0, 164.0, 160.0], "value": 176.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 69.0, 67.0, 68.0, 65.0, 68.0, 68.0, 67.0, 67.0], "value": 67.1, "unit": "score"}], "name": "kraken", "value": 1525.9999999999998, "alertThreshold": 2.0}]} 13:46:24 INFO - Return code: 0 13:46:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 13:46:24 ERROR - # TBPL SUCCESS # 13:46:24 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 13:46:24 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 13:46:24 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 13:46:24 INFO - 2016-07-08 13:46:24.800 screenresolution[2657:295487] starting screenresolution argv=screenresolution get 13:46:24 INFO - 2016-07-08 13:46:24.803 screenresolution[2657:295487] Display 0: 1600x1200x32@60 13:46:24 INFO - 2016-07-08 13:46:24.808 screenresolution[2658:295490] starting screenresolution argv=screenresolution list 13:46:24 INFO - Available Modes on Display 0 13:46:24 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 13:46:24 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 13:46:24 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 13:46:24 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 13:46:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 13:46:25 INFO - Intel Iris: 13:46:25 INFO - Chipset Model: Intel Iris 13:46:25 INFO - Type: GPU 13:46:25 INFO - Bus: Built-In 13:46:25 INFO - VRAM (Dynamic, Max): 1536 MB 13:46:25 INFO - Vendor: Intel (0x8086) 13:46:25 INFO - Device ID: 0x0a2e 13:46:25 INFO - Revision ID: 0x0009 13:46:25 INFO - Displays: 13:46:25 INFO - Display: 13:46:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 13:46:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 13:46:25 INFO - Display Serial Number: 1600x1200 60 13:46:25 INFO - Main Display: Yes 13:46:25 INFO - Mirror: Off 13:46:25 INFO - Online: Yes 13:46:25 INFO - Rotation: Supported 13:46:25 INFO - Return code: 0 13:46:25 INFO - Running post-action listener: _resource_record_post_action 13:46:25 INFO - Running post-run listener: _resource_record_post_run 13:46:26 INFO - Total resource usage - Wall time: 1192s; CPU: 53.0%; Read bytes: 233472; Write bytes: 494876672; Read time: 1; Write time: 1562 13:46:26 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 185352704; Write bytes: 187045888; Read time: 16529; Write time: 399 13:46:26 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 233472; Write bytes: 297873408; Read time: 1; Write time: 1127 13:46:26 INFO - Running post-run listener: _upload_blobber_files 13:46:26 INFO - Blob upload gear active. 13:46:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 13:46:26 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:26 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:26 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:26 INFO - (blobuploader) - INFO - Open directory for files ... 13:46:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 13:46:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 13:46:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:27 INFO - (blobuploader) - INFO - Done attempting. 13:46:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 13:46:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 13:46:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 13:46:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 13:46:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 13:46:28 INFO - (blobuploader) - INFO - Done attempting. 13:46:28 INFO - (blobuploader) - INFO - Iteration through files over. 13:46:28 INFO - Return code: 0 13:46:28 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 13:46:28 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 13:46:28 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9f78995f4bfa0f14b331a02a8cbfda2d1f8b23af9527da14404d188ad309690df475f5be40d128bca060cca2967bf6ab11e9db952b2825dc092c51cef8e08cde", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/067d1b7d4aac36a9a716f175bb8a500e610ceb0ff4c36ff1e78393fed2f427bd335503403b09ad9c98e469fcb7f02a724ac79fe564a85965075afbfe99442fa3"} 13:46:28 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 13:46:28 INFO - Writing to file /builds/slave/test/properties/blobber_files 13:46:28 INFO - Contents: 13:46:28 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9f78995f4bfa0f14b331a02a8cbfda2d1f8b23af9527da14404d188ad309690df475f5be40d128bca060cca2967bf6ab11e9db952b2825dc092c51cef8e08cde", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/067d1b7d4aac36a9a716f175bb8a500e610ceb0ff4c36ff1e78393fed2f427bd335503403b09ad9c98e469fcb7f02a724ac79fe564a85965075afbfe99442fa3"} 13:46:28 INFO - Running post-run listener: copy_logs_to_upload_dir 13:46:28 INFO - Copying logs to upload dir... 13:46:28 INFO - mkdir: /builds/slave/test/build/upload/logs 13:46:28 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.481560 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-07-08 13:46:28.480215) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 13:46:28.485492) ========= 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.wrbyQxEPm7/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.g4Aq7uQanp/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9f78995f4bfa0f14b331a02a8cbfda2d1f8b23af9527da14404d188ad309690df475f5be40d128bca060cca2967bf6ab11e9db952b2825dc092c51cef8e08cde", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/067d1b7d4aac36a9a716f175bb8a500e610ceb0ff4c36ff1e78393fed2f427bd335503403b09ad9c98e469fcb7f02a724ac79fe564a85965075afbfe99442fa3"} 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.011204 build_url: 'https://queue.taskcluster.net/v1/task/PTnJNB3dRXmgBohAhEqBzQ/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/9f78995f4bfa0f14b331a02a8cbfda2d1f8b23af9527da14404d188ad309690df475f5be40d128bca060cca2967bf6ab11e9db952b2825dc092c51cef8e08cde", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/067d1b7d4aac36a9a716f175bb8a500e610ceb0ff4c36ff1e78393fed2f427bd335503403b09ad9c98e469fcb7f02a724ac79fe564a85965075afbfe99442fa3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-08 13:46:28.518180) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 13:46:28.518519) ========= 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.wrbyQxEPm7/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.g4Aq7uQanp/Listeners TMPDIR=/var/folders/zz/4qkjslm927v9zkk_2tfqzwtm00000w/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.005300 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-08 13:46:28.566939) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 13:46:28.567262) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-08 13:46:28.567592) ========= ========= Total master_lag: 0.17 =========